Console Output

14:36:37 [2019-09-16T14:36:37.514Z] + docker run --rm -t --privileged -v /home/jenkins/workspace/engine_PR-366/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr1 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=46f949eb193ee1f1437418ed792b4eed85b043e2 -e DOCKER_GRAPHDRIVER -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT docker:46f949eb193ee1f1437418ed792b4eed85b043e2 hack/make.sh dynbinary test-integration
14:36:37 [2019-09-16T14:36:37.514Z] 
14:36:37 [2019-09-16T14:36:37.514Z] Removing bundles/
14:36:37 [2019-09-16T14:36:37.514Z] 
14:36:37 [2019-09-16T14:36:37.514Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
14:36:37 [2019-09-16T14:36:37.514Z] Building: bundles/dynbinary-daemon/dockerd-dev
14:36:37 [2019-09-16T14:36:37.514Z] GOOS="" GOARCH="" GOARM=""
14:37:36 [2019-09-16T14:37:36.520Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
14:37:36 [2019-09-16T14:37:36.520Z] 
14:37:36 [2019-09-16T14:37:36.520Z] ---> Making bundle: test-integration (in bundles/test-integration)
14:37:36 [2019-09-16T14:37:36.520Z] PKG_CONFIG=pkg-config
14:37:36 [2019-09-16T14:37:36.520Z] GOLANG_VERSION=1.12.9
14:37:36 [2019-09-16T14:37:36.520Z] HOSTNAME=26ff76a31303
14:37:36 [2019-09-16T14:37:36.520Z] DOCKER_EXPERIMENTAL=1
14:37:36 [2019-09-16T14:37:36.520Z] container=docker
14:37:36 [2019-09-16T14:37:36.520Z] TEST_SKIP_INTEGRATION_CLI=1
14:37:36 [2019-09-16T14:37:36.520Z] GOMETALINTER_OPTS=--deadline=2m
14:37:36 [2019-09-16T14:37:36.520Z] GOPATH=/go
14:37:36 [2019-09-16T14:37:36.520Z] PWD=/go/src/github.com/docker/docker
14:37:36 [2019-09-16T14:37:36.520Z] HOME=/root
14:37:36 [2019-09-16T14:37:36.520Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
14:37:36 [2019-09-16T14:37:36.520Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
14:37:36 [2019-09-16T14:37:36.520Z] DOCKER_GITCOMMIT=46f949eb193ee1f1437418ed792b4eed85b043e2
14:37:36 [2019-09-16T14:37:36.520Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
14:37:36 [2019-09-16T14:37:36.520Z] DOCKER_GRAPHDRIVER=overlay2
14:37:36 [2019-09-16T14:37:36.520Z] TERM=xterm
14:37:36 [2019-09-16T14:37:36.520Z] DEST=bundles/test-integration
14:37:36 [2019-09-16T14:37:36.520Z] SHLVL=1
14:37:36 [2019-09-16T14:37:36.520Z] TIMEOUT=120m
14:37:36 [2019-09-16T14:37:36.520Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
14:37:36 [2019-09-16T14:37:36.520Z] DOCKER_PKG=github.com/docker/docker
14:37:36 [2019-09-16T14:37:36.520Z] _=/usr/bin/env
14:37:36 [2019-09-16T14:37:36.520Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
14:38:05 [2019-09-16T14:38:05.354Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
14:38:05 [2019-09-16T14:38:05.354Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
14:38:06 [2019-09-16T14:38:06.767Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
14:38:08 [2019-09-16T14:38:08.035Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
14:38:10 [2019-09-16T14:38:10.098Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
14:38:11 [2019-09-16T14:38:11.493Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
14:38:13 [2019-09-16T14:38:13.314Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
14:38:13 [2019-09-16T14:38:13.314Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
14:38:15 [2019-09-16T14:38:15.169Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
14:38:16 [2019-09-16T14:38:16.449Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
14:38:19 [2019-09-16T14:38:19.737Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
14:38:26 [2019-09-16T14:38:26.106Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
14:38:28 [2019-09-16T14:38:28.212Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
14:38:29 [2019-09-16T14:38:29.661Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
14:38:31 [2019-09-16T14:38:31.489Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
14:38:32 [2019-09-16T14:38:32.768Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
14:38:34 [2019-09-16T14:38:34.047Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
14:38:35 [2019-09-16T14:38:35.300Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
14:38:35 [2019-09-16T14:38:35.300Z] Using test binary docker
14:38:35 [2019-09-16T14:38:35.300Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
14:38:35 [2019-09-16T14:38:35.300Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
14:38:35 [2019-09-16T14:38:35.300Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
14:38:35 [2019-09-16T14:38:35.300Z] Warning failed to create cache: (null)
14:38:35 [2019-09-16T14:38:35.300Z] .
14:38:35 [2019-09-16T14:38:35.300Z] Starting dockerd
14:38:35 [2019-09-16T14:38:35.300Z] INFO: Waiting for daemon to start...
14:38:37 [2019-09-16T14:38:37.092Z] .
14:38:37 [2019-09-16T14:38:37.092Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
14:38:37 [2019-09-16T14:38:37.460Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
14:38:37 [2019-09-16T14:38:37.460Z] Error: No such image: emptyfs
14:38:37 [2019-09-16T14:38:37.460Z] Running integration-test (iteration 1)
14:38:37 [2019-09-16T14:38:37.460Z] Running /go/src/github.com/docker/docker/integration/build flags=-test.v -test.timeout=120m  
14:38:47 [2019-09-16T14:38:47.258Z] Loaded image: buildpack-deps:jessie
14:38:47 [2019-09-16T14:38:47.258Z] Loaded image: busybox:latest
14:38:47 [2019-09-16T14:38:47.258Z] Loaded image: busybox:glibc
14:38:47 [2019-09-16T14:38:47.258Z] Loaded image: debian:jessie
14:38:47 [2019-09-16T14:38:47.258Z] Loaded image: hello-world:latest
14:38:47 [2019-09-16T14:38:47.258Z] INFO: Testing against a local daemon
14:38:47 [2019-09-16T14:38:47.258Z] === RUN   TestBuildWithSession
14:38:49 [2019-09-16T14:38:49.082Z] --- PASS: TestBuildWithSession (2.48s)
14:38:49 [2019-09-16T14:38:49.082Z] === RUN   TestBuildSquashParent
14:38:56 [2019-09-16T14:38:56.701Z] --- PASS: TestBuildSquashParent (6.47s)
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:38:56 [2019-09-16T14:38:56.701Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:38:56 [2019-09-16T14:38:56.701Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:38:56 [2019-09-16T14:38:56.701Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:38:56 [2019-09-16T14:38:56.701Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:38:58 [2019-09-16T14:38:58.528Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:38:58 [2019-09-16T14:38:58.528Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:39:00 [2019-09-16T14:39:00.628Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:39:01 [2019-09-16T14:39:01.084Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:39:02 [2019-09-16T14:39:02.889Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.01s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.63s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (2.69s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (2.39s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.53s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.13s)
14:39:02 [2019-09-16T14:39:02.889Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (2.15s)
14:39:02 [2019-09-16T14:39:02.889Z] === RUN   TestBuildMultiStageCopy
14:39:02 [2019-09-16T14:39:02.889Z] === RUN   TestBuildMultiStageCopy/copy_to_root
14:39:05 [2019-09-16T14:39:05.327Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir
14:39:05 [2019-09-16T14:39:05.694Z] === RUN   TestBuildMultiStageCopy/copy_to_newdir_nested
14:39:06 [2019-09-16T14:39:06.473Z] === RUN   TestBuildMultiStageCopy/copy_to_existingdir
14:39:06 [2019-09-16T14:39:06.837Z] === RUN   TestBuildMultiStageCopy/copy_to_newsubdir
14:39:07 [2019-09-16T14:39:07.609Z] --- PASS: TestBuildMultiStageCopy (4.41s)
14:39:07 [2019-09-16T14:39:07.609Z]     --- PASS: TestBuildMultiStageCopy/copy_to_root (2.34s)
14:39:07 [2019-09-16T14:39:07.609Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir (0.42s)
14:39:07 [2019-09-16T14:39:07.609Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newdir_nested (0.53s)
14:39:07 [2019-09-16T14:39:07.609Z]     --- PASS: TestBuildMultiStageCopy/copy_to_existingdir (0.54s)
14:39:07 [2019-09-16T14:39:07.609Z]     --- PASS: TestBuildMultiStageCopy/copy_to_newsubdir (0.58s)
14:39:07 [2019-09-16T14:39:07.609Z] === RUN   TestBuildMultiStageParentConfig
14:39:08 [2019-09-16T14:39:08.847Z] --- PASS: TestBuildMultiStageParentConfig (1.38s)
14:39:08 [2019-09-16T14:39:08.847Z] === RUN   TestBuildLabelWithTargets
14:39:11 [2019-09-16T14:39:11.519Z] --- PASS: TestBuildLabelWithTargets (2.12s)
14:39:11 [2019-09-16T14:39:11.519Z] === RUN   TestBuildWithEmptyLayers
14:39:11 [2019-09-16T14:39:11.987Z] --- PASS: TestBuildWithEmptyLayers (0.99s)
14:39:11 [2019-09-16T14:39:11.987Z] === RUN   TestBuildMultiStageOnBuild
14:39:15 [2019-09-16T14:39:15.233Z] --- PASS: TestBuildMultiStageOnBuild (2.84s)
14:39:15 [2019-09-16T14:39:15.233Z] === RUN   TestBuildUncleanTarFilenames
14:39:16 [2019-09-16T14:39:16.024Z] --- PASS: TestBuildUncleanTarFilenames (1.21s)
14:39:16 [2019-09-16T14:39:16.024Z] === RUN   TestBuildMultiStageLayerLeak
14:39:19 [2019-09-16T14:39:19.238Z] --- PASS: TestBuildMultiStageLayerLeak (3.26s)
14:39:19 [2019-09-16T14:39:19.238Z] === RUN   TestBuildWithHugeFile
14:39:53 [2019-09-16T14:39:53.588Z] --- PASS: TestBuildWithHugeFile (30.88s)
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildWithEmptyDockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:39:53 [2019-09-16T14:39:53.588Z] --- PASS: TestBuildWithEmptyDockerfile (0.04s)
14:39:53 [2019-09-16T14:39:53.588Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.18s)
14:39:53 [2019-09-16T14:39:53.588Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.18s)
14:39:53 [2019-09-16T14:39:53.588Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.13s)
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildPreserveOwnership
14:39:53 [2019-09-16T14:39:53.588Z] === RUN   TestBuildPreserveOwnership/copy_from
14:39:54 [2019-09-16T14:39:54.398Z] === RUN   TestBuildPreserveOwnership/copy_from_chowned
14:39:57 [2019-09-16T14:39:57.016Z] --- PASS: TestBuildPreserveOwnership (6.12s)
14:39:57 [2019-09-16T14:39:57.016Z]     --- PASS: TestBuildPreserveOwnership/copy_from (3.81s)
14:39:57 [2019-09-16T14:39:57.016Z]     --- PASS: TestBuildPreserveOwnership/copy_from_chowned (2.29s)
14:39:57 [2019-09-16T14:39:57.016Z] PASS
14:39:57 [2019-09-16T14:39:57.016Z] Running /go/src/github.com/docker/docker/integration/config flags=-test.v -test.timeout=120m  
14:39:57 [2019-09-16T14:39:57.016Z] INFO: Testing against a local daemon
14:39:57 [2019-09-16T14:39:57.016Z] === RUN   TestConfigList
14:40:00 [2019-09-16T14:40:00.200Z] --- PASS: TestConfigList (3.05s)
14:40:00 [2019-09-16T14:40:00.200Z]     config_test.go:30: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigList
14:40:00 [2019-09-16T14:40:00.200Z]     daemon.go:321: [d4cbff8e627d4] waiting for daemon to start
14:40:00 [2019-09-16T14:40:00.200Z]     daemon.go:339: [d4cbff8e627d4] daemon started
14:40:00 [2019-09-16T14:40:00.200Z]     daemon.go:449: [d4cbff8e627d4] Stopping daemon
14:40:00 [2019-09-16T14:40:00.200Z]     daemon.go:288: [d4cbff8e627d4] exiting daemon
14:40:00 [2019-09-16T14:40:00.200Z]     daemon.go:436: [d4cbff8e627d4] Daemon stopped
14:40:00 [2019-09-16T14:40:00.200Z] === RUN   TestConfigsCreateAndDelete
14:40:02 [2019-09-16T14:40:02.743Z] --- PASS: TestConfigsCreateAndDelete (2.83s)
14:40:02 [2019-09-16T14:40:02.743Z]     config_test.go:112: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete
14:40:02 [2019-09-16T14:40:02.743Z]     daemon.go:321: [dbb6d787570d3] waiting for daemon to start
14:40:02 [2019-09-16T14:40:02.743Z]     daemon.go:339: [dbb6d787570d3] daemon started
14:40:02 [2019-09-16T14:40:02.743Z]     daemon.go:449: [dbb6d787570d3] Stopping daemon
14:40:02 [2019-09-16T14:40:02.743Z]     daemon.go:288: [dbb6d787570d3] exiting daemon
14:40:02 [2019-09-16T14:40:02.743Z]     daemon.go:436: [dbb6d787570d3] Daemon stopped
14:40:02 [2019-09-16T14:40:02.743Z] === RUN   TestConfigsUpdate
14:40:06 [2019-09-16T14:40:06.129Z] --- PASS: TestConfigsUpdate (3.10s)
14:40:06 [2019-09-16T14:40:06.129Z]     config_test.go:140: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate
14:40:06 [2019-09-16T14:40:06.129Z]     daemon.go:321: [d08c427a56d15] waiting for daemon to start
14:40:06 [2019-09-16T14:40:06.129Z]     daemon.go:339: [d08c427a56d15] daemon started
14:40:06 [2019-09-16T14:40:06.129Z]     daemon.go:449: [d08c427a56d15] Stopping daemon
14:40:06 [2019-09-16T14:40:06.129Z]     daemon.go:288: [d08c427a56d15] exiting daemon
14:40:06 [2019-09-16T14:40:06.129Z]     daemon.go:436: [d08c427a56d15] Daemon stopped
14:40:06 [2019-09-16T14:40:06.129Z] === RUN   TestTemplatedConfig
14:40:09 [2019-09-16T14:40:09.303Z] --- PASS: TestTemplatedConfig (3.61s)
14:40:09 [2019-09-16T14:40:09.303Z]     config_test.go:192: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig
14:40:09 [2019-09-16T14:40:09.303Z]     daemon.go:321: [d8ba72a6428c8] waiting for daemon to start
14:40:09 [2019-09-16T14:40:09.303Z]     daemon.go:339: [d8ba72a6428c8] daemon started
14:40:09 [2019-09-16T14:40:09.303Z]     daemon.go:449: [d8ba72a6428c8] Stopping daemon
14:40:09 [2019-09-16T14:40:09.303Z]     daemon.go:288: [d8ba72a6428c8] exiting daemon
14:40:09 [2019-09-16T14:40:09.303Z]     daemon.go:436: [d8ba72a6428c8] Daemon stopped
14:40:09 [2019-09-16T14:40:09.303Z] === RUN   TestConfigInspect
14:40:12 [2019-09-16T14:40:12.464Z] --- PASS: TestConfigInspect (3.02s)
14:40:12 [2019-09-16T14:40:12.464Z]     config_test.go:326: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect
14:40:12 [2019-09-16T14:40:12.464Z]     daemon.go:321: [dcd3a22483278] waiting for daemon to start
14:40:12 [2019-09-16T14:40:12.464Z]     daemon.go:339: [dcd3a22483278] daemon started
14:40:12 [2019-09-16T14:40:12.464Z]     daemon.go:449: [dcd3a22483278] Stopping daemon
14:40:12 [2019-09-16T14:40:12.464Z]     daemon.go:288: [dcd3a22483278] exiting daemon
14:40:12 [2019-09-16T14:40:12.464Z]     daemon.go:436: [dcd3a22483278] Daemon stopped
14:40:12 [2019-09-16T14:40:12.464Z] === RUN   TestConfigCreateWithLabels
14:40:15 [2019-09-16T14:40:15.614Z] --- PASS: TestConfigCreateWithLabels (3.11s)
14:40:15 [2019-09-16T14:40:15.614Z]     config_test.go:350: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels
14:40:15 [2019-09-16T14:40:15.615Z]     daemon.go:321: [d6bc939339085] waiting for daemon to start
14:40:15 [2019-09-16T14:40:15.615Z]     daemon.go:339: [d6bc939339085] daemon started
14:40:15 [2019-09-16T14:40:15.615Z]     daemon.go:449: [d6bc939339085] Stopping daemon
14:40:15 [2019-09-16T14:40:15.615Z]     daemon.go:288: [d6bc939339085] exiting daemon
14:40:15 [2019-09-16T14:40:15.615Z]     daemon.go:436: [d6bc939339085] Daemon stopped
14:40:15 [2019-09-16T14:40:15.615Z] === RUN   TestConfigCreateResolve
14:40:18 [2019-09-16T14:40:18.876Z] --- PASS: TestConfigCreateResolve (2.99s)
14:40:18 [2019-09-16T14:40:18.876Z]     config_test.go:377: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:321: [d0d4ffe28c3cf] waiting for daemon to start
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:339: [d0d4ffe28c3cf] daemon started
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:449: [d0d4ffe28c3cf] Stopping daemon
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:288: [d0d4ffe28c3cf] exiting daemon
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:436: [d0d4ffe28c3cf] Daemon stopped
14:40:18 [2019-09-16T14:40:18.876Z] === RUN   TestConfigDaemonLibtrustID
14:40:18 [2019-09-16T14:40:18.876Z] --- PASS: TestConfigDaemonLibtrustID (0.55s)
14:40:18 [2019-09-16T14:40:18.876Z]     config_test.go:427: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigDaemonLibtrustID
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:321: [d29109ba8e76e] waiting for daemon to start
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:339: [d29109ba8e76e] daemon started
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:449: [d29109ba8e76e] Stopping daemon
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:288: [d29109ba8e76e] exiting daemon
14:40:18 [2019-09-16T14:40:18.876Z]     daemon.go:436: [d29109ba8e76e] Daemon stopped
14:40:18 [2019-09-16T14:40:18.876Z] PASS
14:40:18 [2019-09-16T14:40:18.876Z] Running /go/src/github.com/docker/docker/integration/container flags=-test.v -test.timeout=120m  
14:40:19 [2019-09-16T14:40:19.445Z] INFO: Testing against a local daemon
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestCheckpoint
14:40:19 [2019-09-16T14:40:19.445Z] --- SKIP: TestCheckpoint (0.00s)
14:40:19 [2019-09-16T14:40:19.445Z]     checkpoint_test.go:33: TestCheckpoint is broken; see https://github.com/moby/moby/issues/38963
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestContainerInvalidJSON
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
14:40:19 [2019-09-16T14:40:19.445Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
14:40:19 [2019-09-16T14:40:19.445Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
14:40:19 [2019-09-16T14:40:19.445Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
14:40:19 [2019-09-16T14:40:19.445Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
14:40:19 [2019-09-16T14:40:19.445Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
14:40:19 [2019-09-16T14:40:19.445Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
14:40:19 [2019-09-16T14:40:19.445Z] --- PASS: TestContainerInvalidJSON (0.01s)
14:40:19 [2019-09-16T14:40:19.445Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
14:40:19 [2019-09-16T14:40:19.445Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
14:40:19 [2019-09-16T14:40:19.445Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestCopyFromContainerPathDoesNotExist
14:40:19 [2019-09-16T14:40:19.445Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.15s)
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestCopyFromContainerPathIsNotDir
14:40:19 [2019-09-16T14:40:19.445Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.12s)
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestCopyToContainerPathDoesNotExist
14:40:19 [2019-09-16T14:40:19.445Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.10s)
14:40:19 [2019-09-16T14:40:19.445Z] === RUN   TestCopyToContainerPathIsNotDir
14:40:19 [2019-09-16T14:40:19.888Z] --- PASS: TestCopyToContainerPathIsNotDir (0.13s)
14:40:19 [2019-09-16T14:40:19.888Z] === RUN   TestCopyFromContainer
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer//
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer//bar/root
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer//bar/root/
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer/bar/quux
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer/bar/quux/
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer/bar/quux/baz
14:40:21 [2019-09-16T14:40:21.990Z] === RUN   TestCopyFromContainer/bar/filesymlink
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCopyFromContainer/bar/dirsymlink
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCopyFromContainer/bar/notarget
14:40:22 [2019-09-16T14:40:22.387Z] --- PASS: TestCopyFromContainer (2.83s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer// (0.08s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer//bar/root (0.11s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/quux (0.09s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.07s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.07s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.08s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.12s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.07s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.07s)
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:40:22 [2019-09-16T14:40:22.387Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.01s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateWithInvalidEnv
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateWithInvalidEnv/0
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateWithInvalidEnv/0
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateWithInvalidEnv/1
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateWithInvalidEnv/1
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateWithInvalidEnv/2
14:40:22 [2019-09-16T14:40:22.387Z] === PAUSE TestCreateWithInvalidEnv/2
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateWithInvalidEnv/0
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateWithInvalidEnv/2
14:40:22 [2019-09-16T14:40:22.387Z] === CONT  TestCreateWithInvalidEnv/1
14:40:22 [2019-09-16T14:40:22.387Z] --- PASS: TestCreateWithInvalidEnv (0.01s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateTmpfsMountsTarget
14:40:22 [2019-09-16T14:40:22.387Z] --- PASS: TestCreateTmpfsMountsTarget (0.06s)
14:40:22 [2019-09-16T14:40:22.387Z] === RUN   TestCreateWithCustomMaskedPaths
14:40:25 [2019-09-16T14:40:25.579Z] --- PASS: TestCreateWithCustomMaskedPaths (2.47s)
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/no_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/no_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/empty_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/empty_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/valid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/valid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/invalid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/invalid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/duplicate_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/duplicate_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/capabilities_API_v1.39
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/capabilities_API_v1.39
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/empty_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/empty_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/empty_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/empty_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/capadd_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/capadd_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/conflict_with_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/conflict_with_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCapabilities/conflict_with_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === PAUSE TestCreateWithCapabilities/conflict_with_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/no_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/conflict_with_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/conflict_with_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/capadd_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/empty_capdrop
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/empty_capadd
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/capabilities_API_v1.39
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/duplicate_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/invalid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/valid_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] === CONT  TestCreateWithCapabilities/empty_capabilities
14:40:25 [2019-09-16T14:40:25.579Z] --- PASS: TestCreateWithCapabilities (0.03s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capdrop (0.00s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/conflict_with_capadd (0.00s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/no_capabilities (0.05s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/capadd_capdrop (0.08s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/empty_capdrop (0.07s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/empty_capadd (0.06s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/capabilities_API_v1.39 (0.08s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/invalid_capabilities (0.00s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/duplicate_capabilities (0.08s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/valid_capabilities (0.07s)
14:40:25 [2019-09-16T14:40:25.579Z]     --- PASS: TestCreateWithCapabilities/empty_capabilities (0.06s)
14:40:25 [2019-09-16T14:40:25.579Z] === RUN   TestCreateWithCustomReadonlyPaths
14:40:28 [2019-09-16T14:40:28.057Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.65s)
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s
14:40:28 [2019-09-16T14:40:28.057Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0
14:40:28 [2019-09-16T14:40:28.057Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] === CONT  TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms
14:40:28 [2019-09-16T14:40:28.057Z] --- PASS: TestCreateWithInvalidHealthcheckParams (0.01s)
14:40:28 [2019-09-16T14:40:28.057Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Retries_in_Healthcheck:_less_than_0 (0.02s)
14:40:28 [2019-09-16T14:40:28.057Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_less_than_0s (0.02s)
14:40:28 [2019-09-16T14:40:28.057Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_StartPeriod_in_Healthcheck:_not_0_and_less_than_1ms (0.02s)
14:40:28 [2019-09-16T14:40:28.057Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Timeout_in_Healthcheck:_less_than_1ms (0.02s)
14:40:28 [2019-09-16T14:40:28.057Z]     --- PASS: TestCreateWithInvalidHealthcheckParams/test_invalid_Interval_in_Healthcheck:_larger_than_0s_but_less_than_1ms (0.01s)
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestContainerStartOnDaemonRestart
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestContainerStartOnDaemonRestart
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestDaemonRestartIpcMode
14:40:28 [2019-09-16T14:40:28.057Z] === PAUSE TestDaemonRestartIpcMode
14:40:28 [2019-09-16T14:40:28.057Z] === RUN   TestDiff
14:40:28 [2019-09-16T14:40:28.860Z] --- PASS: TestDiff (0.79s)
14:40:28 [2019-09-16T14:40:28.860Z] === RUN   TestExecWithCloseStdin
14:40:30 [2019-09-16T14:40:30.127Z] --- PASS: TestExecWithCloseStdin (1.03s)
14:40:30 [2019-09-16T14:40:30.127Z] === RUN   TestExec
14:40:30 [2019-09-16T14:40:30.970Z] --- PASS: TestExec (1.10s)
14:40:30 [2019-09-16T14:40:30.970Z] === RUN   TestExecUser
14:40:31 [2019-09-16T14:40:31.978Z] --- PASS: TestExecUser (1.15s)
14:40:31 [2019-09-16T14:40:31.978Z] === RUN   TestExportContainerAndImportImage
14:40:33 [2019-09-16T14:40:33.267Z] --- PASS: TestExportContainerAndImportImage (1.27s)
14:40:33 [2019-09-16T14:40:33.268Z] === RUN   TestExportContainerAfterDaemonRestart
14:40:35 [2019-09-16T14:40:35.070Z] --- PASS: TestExportContainerAfterDaemonRestart (1.51s)
14:40:35 [2019-09-16T14:40:35.070Z]     export_test.go:63: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:321: [dc4ff04c8144c] waiting for daemon to start
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:339: [dc4ff04c8144c] daemon started
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:449: [dc4ff04c8144c] Stopping daemon
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:288: [dc4ff04c8144c] exiting daemon
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:436: [dc4ff04c8144c] Daemon stopped
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:321: [dc4ff04c8144c] waiting for daemon to start
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:339: [dc4ff04c8144c] daemon started
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:449: [dc4ff04c8144c] Stopping daemon
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:288: [dc4ff04c8144c] exiting daemon
14:40:35 [2019-09-16T14:40:35.070Z]     daemon.go:436: [dc4ff04c8144c] Daemon stopped
14:40:35 [2019-09-16T14:40:35.070Z] === RUN   TestHealthCheckWorkdir
14:40:36 [2019-09-16T14:40:36.330Z] --- PASS: TestHealthCheckWorkdir (1.23s)
14:40:36 [2019-09-16T14:40:36.330Z] === RUN   TestHealthKillContainer
14:40:39 [2019-09-16T14:40:39.512Z] --- PASS: TestHealthKillContainer (3.21s)
14:40:39 [2019-09-16T14:40:39.512Z] === RUN   TestInspectCpusetInConfigPre120
14:40:40 [2019-09-16T14:40:40.291Z] --- PASS: TestInspectCpusetInConfigPre120 (0.85s)
14:40:40 [2019-09-16T14:40:40.291Z] === RUN   TestIpcModeNone
14:40:41 [2019-09-16T14:40:41.096Z] --- PASS: TestIpcModeNone (1.08s)
14:40:41 [2019-09-16T14:40:41.096Z] === RUN   TestIpcModePrivate
14:40:42 [2019-09-16T14:40:42.359Z] --- PASS: TestIpcModePrivate (1.06s)
14:40:42 [2019-09-16T14:40:42.360Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:56, shared: false, mustBeShared: false
14:40:42 [2019-09-16T14:40:42.360Z] === RUN   TestIpcModeShareable
14:40:43 [2019-09-16T14:40:43.673Z] --- PASS: TestIpcModeShareable (1.07s)
14:40:43 [2019-09-16T14:40:43.673Z]     ipcmode_linux_test.go:90: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:50, shared: true, mustBeShared: true
14:40:43 [2019-09-16T14:40:43.673Z] === RUN   TestAPIIpcModeShareableAndContainer
14:40:47 [2019-09-16T14:40:47.162Z] --- PASS: TestAPIIpcModeShareableAndContainer (3.25s)
14:40:47 [2019-09-16T14:40:47.162Z] === RUN   TestAPIIpcModeHost
14:40:47 [2019-09-16T14:40:47.530Z] --- PASS: TestAPIIpcModeHost (0.88s)
14:40:47 [2019-09-16T14:40:47.530Z] === RUN   TestDaemonIpcModeShareable
14:40:49 [2019-09-16T14:40:49.365Z] --- PASS: TestDaemonIpcModeShareable (1.92s)
14:40:49 [2019-09-16T14:40:49.365Z]     ipcmode_linux_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable
14:40:49 [2019-09-16T14:40:49.365Z]     daemon.go:321: [d45f1db4c5178] waiting for daemon to start
14:40:49 [2019-09-16T14:40:49.365Z]     daemon.go:339: [d45f1db4c5178] daemon started
14:40:49 [2019-09-16T14:40:49.365Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
14:40:49 [2019-09-16T14:40:49.365Z]     daemon.go:449: [d45f1db4c5178] Stopping daemon
14:40:49 [2019-09-16T14:40:49.365Z]     daemon.go:288: [d45f1db4c5178] exiting daemon
14:40:49 [2019-09-16T14:40:49.365Z]     daemon.go:436: [d45f1db4c5178] Daemon stopped
14:40:49 [2019-09-16T14:40:49.365Z] === RUN   TestDaemonIpcModePrivate
14:40:51 [2019-09-16T14:40:51.166Z] --- PASS: TestDaemonIpcModePrivate (1.81s)
14:40:51 [2019-09-16T14:40:51.166Z]     ipcmode_linux_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate
14:40:51 [2019-09-16T14:40:51.166Z]     daemon.go:321: [dd94ab330153e] waiting for daemon to start
14:40:51 [2019-09-16T14:40:51.166Z]     daemon.go:339: [dd94ab330153e] daemon started
14:40:51 [2019-09-16T14:40:51.166Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
14:40:51 [2019-09-16T14:40:51.166Z]     daemon.go:449: [dd94ab330153e] Stopping daemon
14:40:51 [2019-09-16T14:40:51.166Z]     daemon.go:288: [dd94ab330153e] exiting daemon
14:40:51 [2019-09-16T14:40:51.166Z]     daemon.go:436: [dd94ab330153e] Daemon stopped
14:40:51 [2019-09-16T14:40:51.166Z] === RUN   TestDaemonIpcModePrivateFromConfig
14:40:52 [2019-09-16T14:40:52.993Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.78s)
14:40:52 [2019-09-16T14:40:52.993Z]     ipcmode_linux_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig
14:40:52 [2019-09-16T14:40:52.993Z]     daemon.go:321: [d76d860d5d244] waiting for daemon to start
14:40:52 [2019-09-16T14:40:52.993Z]     daemon.go:339: [d76d860d5d244] daemon started
14:40:52 [2019-09-16T14:40:52.993Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:64, shared: false, mustBeShared: false
14:40:52 [2019-09-16T14:40:52.993Z]     daemon.go:449: [d76d860d5d244] Stopping daemon
14:40:52 [2019-09-16T14:40:52.993Z]     daemon.go:288: [d76d860d5d244] exiting daemon
14:40:52 [2019-09-16T14:40:52.993Z]     daemon.go:436: [d76d860d5d244] Daemon stopped
14:40:52 [2019-09-16T14:40:52.993Z] === RUN   TestDaemonIpcModeShareableFromConfig
14:40:54 [2019-09-16T14:40:54.810Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.81s)
14:40:54 [2019-09-16T14:40:54.810Z]     ipcmode_linux_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig
14:40:54 [2019-09-16T14:40:54.810Z]     daemon.go:321: [df2b33a193309] waiting for daemon to start
14:40:54 [2019-09-16T14:40:54.810Z]     daemon.go:339: [df2b33a193309] daemon started
14:40:54 [2019-09-16T14:40:54.810Z]     ipcmode_linux_test.go:258: [testDaemonIpcPrivateShareable] ipcdev: 0:58, shared: true, mustBeShared: true
14:40:54 [2019-09-16T14:40:54.810Z]     daemon.go:449: [df2b33a193309] Stopping daemon
14:40:54 [2019-09-16T14:40:54.810Z]     daemon.go:288: [df2b33a193309] exiting daemon
14:40:54 [2019-09-16T14:40:54.810Z]     daemon.go:436: [df2b33a193309] Daemon stopped
14:40:54 [2019-09-16T14:40:54.810Z] === RUN   TestIpcModeOlderClient
14:40:54 [2019-09-16T14:40:54.810Z] === PAUSE TestIpcModeOlderClient
14:40:54 [2019-09-16T14:40:54.810Z] === RUN   TestKillContainerInvalidSignal
14:40:56 [2019-09-16T14:40:56.179Z] --- PASS: TestKillContainerInvalidSignal (0.93s)
14:40:56 [2019-09-16T14:40:56.179Z] === RUN   TestKillContainer
14:40:56 [2019-09-16T14:40:56.179Z] === RUN   TestKillContainer/no_signal
14:40:56 [2019-09-16T14:40:56.655Z] === RUN   TestKillContainer/non_killing_signal
14:40:57 [2019-09-16T14:40:57.562Z] === RUN   TestKillContainer/killing_signal
14:40:58 [2019-09-16T14:40:58.845Z] --- PASS: TestKillContainer (2.79s)
14:40:58 [2019-09-16T14:40:58.845Z]     --- PASS: TestKillContainer/no_signal (0.93s)
14:40:58 [2019-09-16T14:40:58.845Z]     --- PASS: TestKillContainer/non_killing_signal (0.68s)
14:40:58 [2019-09-16T14:40:58.845Z]     --- PASS: TestKillContainer/killing_signal (0.82s)
14:40:58 [2019-09-16T14:40:58.845Z] === RUN   TestKillWithStopSignalAndRestartPolicies
14:40:58 [2019-09-16T14:40:58.845Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
14:40:59 [2019-09-16T14:40:59.617Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
14:41:00 [2019-09-16T14:41:00.405Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.91s)
14:41:00 [2019-09-16T14:41:00.405Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.94s)
14:41:00 [2019-09-16T14:41:00.405Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.61s)
14:41:00 [2019-09-16T14:41:00.405Z] === RUN   TestKillStoppedContainer
14:41:00 [2019-09-16T14:41:00.405Z] --- PASS: TestKillStoppedContainer (0.09s)
14:41:00 [2019-09-16T14:41:00.405Z] === RUN   TestKillStoppedContainerAPIPre120
14:41:00 [2019-09-16T14:41:00.790Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.13s)
14:41:00 [2019-09-16T14:41:00.790Z] === RUN   TestKillDifferentUserContainer
14:41:01 [2019-09-16T14:41:01.581Z] --- PASS: TestKillDifferentUserContainer (0.90s)
14:41:01 [2019-09-16T14:41:01.581Z] === RUN   TestInspectOomKilledTrue
14:41:01 [2019-09-16T14:41:01.581Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
14:41:01 [2019-09-16T14:41:01.581Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:41:01 [2019-09-16T14:41:01.581Z] === RUN   TestInspectOomKilledFalse
14:41:01 [2019-09-16T14:41:01.581Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
14:41:01 [2019-09-16T14:41:01.581Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:41:01 [2019-09-16T14:41:01.581Z] === RUN   TestLinksEtcHostsContentMatch
14:41:02 [2019-09-16T14:41:02.395Z] --- PASS: TestLinksEtcHostsContentMatch (0.71s)
14:41:02 [2019-09-16T14:41:02.395Z] === RUN   TestLinksContainerNames
14:41:04 [2019-09-16T14:41:04.210Z] --- PASS: TestLinksContainerNames (1.72s)
14:41:04 [2019-09-16T14:41:04.210Z] === RUN   TestLogsFollowTailEmpty
14:41:05 [2019-09-16T14:41:05.002Z] --- PASS: TestLogsFollowTailEmpty (1.00s)
14:41:05 [2019-09-16T14:41:05.002Z] === RUN   TestContainerNetworkMountsNoChown
14:41:05 [2019-09-16T14:41:05.798Z] --- PASS: TestContainerNetworkMountsNoChown (0.92s)
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/default
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/default
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/private
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/private
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/rprivate
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/rprivate
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/slave
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/slave
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/rslave
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/rslave
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/shared
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/shared
14:41:05 [2019-09-16T14:41:05.798Z] === RUN   TestMountDaemonRoot/rshared
14:41:05 [2019-09-16T14:41:05.798Z] === PAUSE TestMountDaemonRoot/rshared
14:41:06 [2019-09-16T14:41:06.181Z] === CONT  TestMountDaemonRoot/default
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/default/bind_root
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/default/bind_root
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/default/bind_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/default/mount_root
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/default/mount_root
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/default/mount_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === CONT  TestMountDaemonRoot/default/bind_root
14:41:06 [2019-09-16T14:41:06.181Z] === CONT  TestMountDaemonRoot/rshared
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
14:41:06 [2019-09-16T14:41:06.181Z] === RUN   TestMountDaemonRoot/rshared/bind_root
14:41:06 [2019-09-16T14:41:06.181Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rshared/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/shared
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/shared/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/shared/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/shared/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/shared/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rslave
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rslave/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rslave/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/slave
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/slave/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/slave/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/slave/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/slave/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rprivate
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/private
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/private/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/private/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/private/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/private/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/private/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === RUN   TestMountDaemonRoot/private/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/default/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/default/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/default/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rshared/mount_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rshared/bind_root
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
14:41:06 [2019-09-16T14:41:06.182Z] === CONT  TestMountDaemonRoot/shared/mount_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/shared/bind_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/slave/mount_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rslave/bind_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rslave/mount_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/slave/bind_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/private/bind_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/private/mount_subpath
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/private/mount_root
14:41:06 [2019-09-16T14:41:06.563Z] === CONT  TestMountDaemonRoot/private/bind_subpath
14:41:06 [2019-09-16T14:41:06.563Z] --- PASS: TestMountDaemonRoot (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.06s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.07s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.09s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.08s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.08s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.07s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.08s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.05s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.09s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.07s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.06s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.08s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.02s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.02s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.03s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
14:41:06 [2019-09-16T14:41:06.563Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.04s)
14:41:06 [2019-09-16T14:41:06.563Z] === RUN   TestContainerBindMountNonRecursive
14:41:09 [2019-09-16T14:41:09.395Z] --- PASS: TestContainerBindMountNonRecursive (2.27s)
14:41:09 [2019-09-16T14:41:09.395Z] === RUN   TestNetworkNat
14:41:10 [2019-09-16T14:41:10.235Z] --- PASS: TestNetworkNat (1.05s)
14:41:10 [2019-09-16T14:41:10.235Z] === RUN   TestNetworkLocalhostTCPNat
14:41:11 [2019-09-16T14:41:11.020Z] --- PASS: TestNetworkLocalhostTCPNat (0.96s)
14:41:11 [2019-09-16T14:41:11.020Z] === RUN   TestNetworkLoopbackNat
14:41:12 [2019-09-16T14:41:12.277Z] --- PASS: TestNetworkLoopbackNat (1.16s)
14:41:12 [2019-09-16T14:41:12.277Z] === RUN   TestPause
14:41:13 [2019-09-16T14:41:13.080Z] --- PASS: TestPause (1.00s)
14:41:13 [2019-09-16T14:41:13.080Z] === RUN   TestPauseFailsOnWindowsServerContainers
14:41:13 [2019-09-16T14:41:13.080Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
14:41:13 [2019-09-16T14:41:13.080Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
14:41:13 [2019-09-16T14:41:13.080Z] === RUN   TestPauseStopPausedContainer
14:41:14 [2019-09-16T14:41:14.340Z] --- PASS: TestPauseStopPausedContainer (1.01s)
14:41:14 [2019-09-16T14:41:14.340Z] === RUN   TestPsFilter
14:41:14 [2019-09-16T14:41:14.340Z] --- PASS: TestPsFilter (0.26s)
14:41:14 [2019-09-16T14:41:14.340Z] === RUN   TestRemoveContainerWithRemovedVolume
14:41:15 [2019-09-16T14:41:15.135Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.83s)
14:41:15 [2019-09-16T14:41:15.135Z] === RUN   TestRemoveContainerWithVolume
14:41:16 [2019-09-16T14:41:16.382Z] --- PASS: TestRemoveContainerWithVolume (0.85s)
14:41:16 [2019-09-16T14:41:16.382Z] === RUN   TestRemoveContainerRunning
14:41:17 [2019-09-16T14:41:17.168Z] --- PASS: TestRemoveContainerRunning (0.86s)
14:41:17 [2019-09-16T14:41:17.168Z] === RUN   TestRemoveContainerForceRemoveRunning
14:41:17 [2019-09-16T14:41:17.949Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.88s)
14:41:17 [2019-09-16T14:41:17.949Z] === RUN   TestRemoveInvalidContainer
14:41:17 [2019-09-16T14:41:17.949Z] --- PASS: TestRemoveInvalidContainer (0.01s)
14:41:17 [2019-09-16T14:41:17.949Z] === RUN   TestRenameLinkedContainer
14:41:21 [2019-09-16T14:41:21.276Z] --- PASS: TestRenameLinkedContainer (3.45s)
14:41:21 [2019-09-16T14:41:21.276Z] === RUN   TestRenameStoppedContainer
14:41:22 [2019-09-16T14:41:22.073Z] --- PASS: TestRenameStoppedContainer (0.88s)
14:41:22 [2019-09-16T14:41:22.073Z] === RUN   TestRenameRunningContainerAndReuse
14:41:23 [2019-09-16T14:41:23.879Z] --- PASS: TestRenameRunningContainerAndReuse (1.73s)
14:41:23 [2019-09-16T14:41:23.879Z] === RUN   TestRenameInvalidName
14:41:25 [2019-09-16T14:41:25.260Z] --- PASS: TestRenameInvalidName (0.95s)
14:41:25 [2019-09-16T14:41:25.260Z] === RUN   TestRenameAnonymousContainer
14:41:28 [2019-09-16T14:41:28.469Z] --- PASS: TestRenameAnonymousContainer (3.12s)
14:41:28 [2019-09-16T14:41:28.470Z] === RUN   TestRenameContainerWithSameName
14:41:29 [2019-09-16T14:41:29.033Z] --- PASS: TestRenameContainerWithSameName (0.86s)
14:41:29 [2019-09-16T14:41:29.033Z] === RUN   TestRenameContainerWithLinkedContainer
14:41:30 [2019-09-16T14:41:30.873Z] --- PASS: TestRenameContainerWithLinkedContainer (1.92s)
14:41:30 [2019-09-16T14:41:30.873Z] === RUN   TestResize
14:41:31 [2019-09-16T14:41:31.653Z] --- PASS: TestResize (0.93s)
14:41:31 [2019-09-16T14:41:31.653Z] === RUN   TestResizeWithInvalidSize
14:41:32 [2019-09-16T14:41:32.437Z] --- PASS: TestResizeWithInvalidSize (0.92s)
14:41:32 [2019-09-16T14:41:32.437Z] === RUN   TestResizeWhenContainerNotStarted
14:41:33 [2019-09-16T14:41:33.818Z] --- PASS: TestResizeWhenContainerNotStarted (0.91s)
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:41:33 [2019-09-16T14:41:33.818Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:41:35 [2019-09-16T14:41:35.762Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:41:37 [2019-09-16T14:41:37.038Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:41:38 [2019-09-16T14:41:38.857Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:41:40 [2019-09-16T14:41:40.116Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:41:40 [2019-09-16T14:41:40.914Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:41:42 [2019-09-16T14:41:42.781Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:41:43 [2019-09-16T14:41:43.167Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:41:43 [2019-09-16T14:41:43.964Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:41:44 [2019-09-16T14:41:44.756Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:41:45 [2019-09-16T14:41:45.789Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:41:47 [2019-09-16T14:41:47.953Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.04s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [ddfa006aa8770] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [ddfa006aa8770] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [ddfa006aa8770] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [ddfa006aa8770] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [ddfa006aa8770] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [ddfa006aa8770] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [ddfa006aa8770] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [ddfa006aa8770] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.44s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d58caa8acd9c7] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [d58caa8acd9c7] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d58caa8acd9c7] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [d58caa8acd9c7] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [d58caa8acd9c7] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [d58caa8acd9c7] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [d58caa8acd9c7] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [d58caa8acd9c7] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (3.02s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [df7ef193d1c8c] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [df7ef193d1c8c] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [df7ef193d1c8c] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [df7ef193d1c8c] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [df7ef193d1c8c] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [df7ef193d1c8c] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [df7ef193d1c8c] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [df7ef193d1c8c] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (3.14s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [df3c173809cf9] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [df3c173809cf9] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [df3c173809cf9] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [df3c173809cf9] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [df3c173809cf9] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [df3c173809cf9] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [df3c173809cf9] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [df3c173809cf9] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [df3c173809cf9] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [df3c173809cf9] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.32s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d127cd176228f] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [d127cd176228f] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [d127cd176228f] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [d127cd176228f] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [d127cd176228f] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d127cd176228f] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [d127cd176228f] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:449: [d127cd176228f] Stopping daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [d127cd176228f] exiting daemon
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:436: [d127cd176228f] Daemon stopped
14:41:47 [2019-09-16T14:41:47.953Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.39s)
14:41:47 [2019-09-16T14:41:47.953Z]         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
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d88f12c13d5b0] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:339: [d88f12c13d5b0] daemon started
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:321: [d88f12c13d5b0] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.953Z]         daemon.go:288: [d88f12c13d5b0] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d88f12c13d5b0] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d88f12c13d5b0] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d88f12c13d5b0] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d88f12c13d5b0] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.26s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d38b52be77aec] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d38b52be77aec] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d38b52be77aec] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d38b52be77aec] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d38b52be77aec] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d38b52be77aec] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d38b52be77aec] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d38b52be77aec] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d38b52be77aec] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d38b52be77aec] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.42s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d1fa399a7419c] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d1fa399a7419c] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d1fa399a7419c] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d1fa399a7419c] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d1fa399a7419c] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d1fa399a7419c] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d1fa399a7419c] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d1fa399a7419c] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d1fa399a7419c] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d1fa399a7419c] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.47s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d3368c0eec9e2] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d3368c0eec9e2] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d3368c0eec9e2] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d3368c0eec9e2] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d3368c0eec9e2] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d3368c0eec9e2] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d3368c0eec9e2] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d3368c0eec9e2] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.49s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d80e81c69a5e2] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d80e81c69a5e2] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d80e81c69a5e2] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d80e81c69a5e2] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d80e81c69a5e2] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d80e81c69a5e2] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d80e81c69a5e2] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d80e81c69a5e2] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d80e81c69a5e2] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d80e81c69a5e2] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.62s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d01967f2ed761] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d01967f2ed761] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d01967f2ed761] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [d01967f2ed761] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [d01967f2ed761] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [d01967f2ed761] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [d01967f2ed761] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [d01967f2ed761] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.27s)
14:41:47 [2019-09-16T14:41:47.954Z]         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
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [da2380dc86884] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [da2380dc86884] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [da2380dc86884] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [da2380dc86884] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [da2380dc86884] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:321: [da2380dc86884] waiting for daemon to start
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:339: [da2380dc86884] daemon started
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:449: [da2380dc86884] Stopping daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:288: [da2380dc86884] exiting daemon
14:41:47 [2019-09-16T14:41:47.954Z]         daemon.go:436: [da2380dc86884] Daemon stopped
14:41:47 [2019-09-16T14:41:47.954Z] === RUN   TestKernelTCPMemory
14:41:48 [2019-09-16T14:41:48.756Z] --- PASS: TestKernelTCPMemory (1.10s)
14:41:48 [2019-09-16T14:41:48.756Z] === RUN   TestNISDomainname
14:41:50 [2019-09-16T14:41:50.019Z] --- PASS: TestNISDomainname (1.16s)
14:41:50 [2019-09-16T14:41:50.019Z] === RUN   TestStats
14:41:53 [2019-09-16T14:41:53.183Z] --- PASS: TestStats (2.89s)
14:41:53 [2019-09-16T14:41:53.183Z] === RUN   TestStopContainerWithTimeout
14:41:53 [2019-09-16T14:41:53.183Z] === RUN   TestStopContainerWithTimeout/0
14:41:53 [2019-09-16T14:41:53.183Z] === PAUSE TestStopContainerWithTimeout/0
14:41:53 [2019-09-16T14:41:53.183Z] === RUN   TestStopContainerWithTimeout/1
14:41:53 [2019-09-16T14:41:53.183Z] === PAUSE TestStopContainerWithTimeout/1
14:41:53 [2019-09-16T14:41:53.183Z] === RUN   TestStopContainerWithTimeout/3
14:41:53 [2019-09-16T14:41:53.183Z] === PAUSE TestStopContainerWithTimeout/3
14:41:53 [2019-09-16T14:41:53.183Z] === RUN   TestStopContainerWithTimeout/-1
14:41:53 [2019-09-16T14:41:53.183Z] === PAUSE TestStopContainerWithTimeout/-1
14:41:53 [2019-09-16T14:41:53.183Z] === CONT  TestStopContainerWithTimeout/0
14:41:53 [2019-09-16T14:41:53.183Z] === CONT  TestStopContainerWithTimeout/-1
14:41:53 [2019-09-16T14:41:53.970Z] === CONT  TestStopContainerWithTimeout/3
14:41:55 [2019-09-16T14:41:55.751Z] === CONT  TestStopContainerWithTimeout/1
14:41:57 [2019-09-16T14:41:57.541Z] --- PASS: TestStopContainerWithTimeout (0.01s)
14:41:57 [2019-09-16T14:41:57.541Z]     --- PASS: TestStopContainerWithTimeout/0 (0.95s)
14:41:57 [2019-09-16T14:41:57.541Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.89s)
14:41:57 [2019-09-16T14:41:57.541Z]     --- PASS: TestStopContainerWithTimeout/3 (2.92s)
14:41:57 [2019-09-16T14:41:57.541Z]     --- PASS: TestStopContainerWithTimeout/1 (1.88s)
14:41:57 [2019-09-16T14:41:57.541Z] === RUN   TestDeleteDevicemapper
14:41:57 [2019-09-16T14:41:57.541Z] --- SKIP: TestDeleteDevicemapper (0.00s)
14:41:57 [2019-09-16T14:41:57.541Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
14:41:57 [2019-09-16T14:41:57.541Z] === RUN   TestStopContainerWithRestartPolicyAlways
14:42:01 [2019-09-16T14:42:01.829Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.55s)
14:42:01 [2019-09-16T14:42:01.829Z] === RUN   TestUpdateMemory
14:42:01 [2019-09-16T14:42:01.829Z] --- SKIP: TestUpdateMemory (0.00s)
14:42:01 [2019-09-16T14:42:01.829Z]     update_linux_test.go:23: !testEnv.DaemonInfo.SwapLimit
14:42:01 [2019-09-16T14:42:01.829Z] === RUN   TestUpdateCPUQuota
14:42:02 [2019-09-16T14:42:02.610Z] --- PASS: TestUpdateCPUQuota (1.53s)
14:42:02 [2019-09-16T14:42:02.610Z] === RUN   TestUpdatePidsLimit
14:42:02 [2019-09-16T14:42:02.610Z] === RUN   TestUpdatePidsLimit/update_from_none
14:42:02 [2019-09-16T14:42:02.989Z] === RUN   TestUpdatePidsLimit/no_change
14:42:03 [2019-09-16T14:42:03.792Z] === RUN   TestUpdatePidsLimit/update_lower
14:42:03 [2019-09-16T14:42:03.792Z] === RUN   TestUpdatePidsLimit/update_on_old_api_ignores_value
14:42:04 [2019-09-16T14:42:04.604Z] === RUN   TestUpdatePidsLimit/unset_limit_with_zero
14:42:04 [2019-09-16T14:42:04.973Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_one
14:42:05 [2019-09-16T14:42:05.338Z] === RUN   TestUpdatePidsLimit/unset_limit_with_minus_two
14:42:07 [2019-09-16T14:42:07.150Z] --- PASS: TestUpdatePidsLimit (4.26s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/update_from_none (0.44s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/no_change (0.43s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/update_lower (0.40s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/update_on_old_api_ignores_value (0.45s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_zero (0.47s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_one (0.43s)
14:42:07 [2019-09-16T14:42:07.150Z]     --- PASS: TestUpdatePidsLimit/unset_limit_with_minus_two (0.43s)
14:42:07 [2019-09-16T14:42:07.150Z] === RUN   TestUpdateRestartPolicy
14:42:20 [2019-09-16T14:42:20.769Z] --- PASS: TestUpdateRestartPolicy (12.79s)
14:42:20 [2019-09-16T14:42:20.769Z] === RUN   TestUpdateRestartWithAutoRemove
14:42:20 [2019-09-16T14:42:20.769Z] --- PASS: TestUpdateRestartWithAutoRemove (0.96s)
14:42:20 [2019-09-16T14:42:20.769Z] === RUN   TestWaitNonBlocked
14:42:20 [2019-09-16T14:42:20.769Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-0
14:42:20 [2019-09-16T14:42:20.769Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-0
14:42:20 [2019-09-16T14:42:20.769Z] === RUN   TestWaitNonBlocked/wait-nonblocking-exit-random
14:42:20 [2019-09-16T14:42:20.769Z] === PAUSE TestWaitNonBlocked/wait-nonblocking-exit-random
14:42:20 [2019-09-16T14:42:20.769Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-0
14:42:20 [2019-09-16T14:42:20.769Z] === CONT  TestWaitNonBlocked/wait-nonblocking-exit-random
14:42:22 [2019-09-16T14:42:22.061Z] --- PASS: TestWaitNonBlocked (0.01s)
14:42:22 [2019-09-16T14:42:22.061Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-0 (1.09s)
14:42:22 [2019-09-16T14:42:22.061Z]     --- PASS: TestWaitNonBlocked/wait-nonblocking-exit-random (1.09s)
14:42:22 [2019-09-16T14:42:22.061Z] === RUN   TestWaitBlocked
14:42:22 [2019-09-16T14:42:22.061Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-zero
14:42:22 [2019-09-16T14:42:22.061Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-zero
14:42:22 [2019-09-16T14:42:22.061Z] === RUN   TestWaitBlocked/test-wait-blocked-exit-random
14:42:22 [2019-09-16T14:42:22.061Z] === PAUSE TestWaitBlocked/test-wait-blocked-exit-random
14:42:22 [2019-09-16T14:42:22.061Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-zero
14:42:22 [2019-09-16T14:42:22.061Z] === CONT  TestWaitBlocked/test-wait-blocked-exit-random
14:42:22 [2019-09-16T14:42:22.867Z] --- PASS: TestWaitBlocked (0.01s)
14:42:22 [2019-09-16T14:42:22.867Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-zero (1.07s)
14:42:22 [2019-09-16T14:42:22.867Z]     --- PASS: TestWaitBlocked/test-wait-blocked-exit-random (1.08s)
14:42:22 [2019-09-16T14:42:22.867Z] === CONT  TestContainerStartOnDaemonRestart
14:42:22 [2019-09-16T14:42:22.867Z] === CONT  TestIpcModeOlderClient
14:42:22 [2019-09-16T14:42:22.867Z] --- PASS: TestIpcModeOlderClient (0.16s)
14:42:22 [2019-09-16T14:42:22.867Z] === CONT  TestDaemonRestartIpcMode
14:42:26 [2019-09-16T14:42:26.113Z] --- PASS: TestContainerStartOnDaemonRestart (3.33s)
14:42:26 [2019-09-16T14:42:26.113Z]     daemon_linux_test.go:35: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:321: [d57174455e62b] waiting for daemon to start
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:339: [d57174455e62b] daemon started
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:321: [d57174455e62b] waiting for daemon to start
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:288: [d57174455e62b] exiting daemon
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:339: [d57174455e62b] daemon started
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:449: [d57174455e62b] Stopping daemon
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:288: [d57174455e62b] exiting daemon
14:42:26 [2019-09-16T14:42:26.113Z]     daemon.go:436: [d57174455e62b] Daemon stopped
14:42:27 [2019-09-16T14:42:27.372Z] --- PASS: TestDaemonRestartIpcMode (4.14s)
14:42:27 [2019-09-16T14:42:27.372Z]     daemon_linux_test.go:89: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:321: [d045822cd4c41] waiting for daemon to start
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:339: [d045822cd4c41] daemon started
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:449: [d045822cd4c41] Stopping daemon
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:288: [d045822cd4c41] exiting daemon
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:436: [d045822cd4c41] Daemon stopped
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:321: [d045822cd4c41] waiting for daemon to start
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:339: [d045822cd4c41] daemon started
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:449: [d045822cd4c41] Stopping daemon
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:288: [d045822cd4c41] exiting daemon
14:42:27 [2019-09-16T14:42:27.372Z]     daemon.go:436: [d045822cd4c41] Daemon stopped
14:42:27 [2019-09-16T14:42:27.372Z] PASS
14:42:27 [2019-09-16T14:42:27.372Z] Running /go/src/github.com/docker/docker/integration/image flags=-test.v -test.timeout=120m  
14:42:27 [2019-09-16T14:42:27.372Z] INFO: Testing against a local daemon
14:42:27 [2019-09-16T14:42:27.372Z] === RUN   TestCommitInheritsEnv
14:42:28 [2019-09-16T14:42:28.166Z] --- PASS: TestCommitInheritsEnv (0.54s)
14:42:28 [2019-09-16T14:42:28.166Z] === RUN   TestImportExtremelyLargeImageWorks
14:42:28 [2019-09-16T14:42:28.166Z] === PAUSE TestImportExtremelyLargeImageWorks
14:42:28 [2019-09-16T14:42:28.166Z] === RUN   TestImagesFilterMultiReference
14:42:28 [2019-09-16T14:42:28.166Z] --- PASS: TestImagesFilterMultiReference (0.06s)
14:42:28 [2019-09-16T14:42:28.166Z] === RUN   TestRemoveImageOrphaning
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestRemoveImageOrphaning (0.55s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagUnprefixedRepoByNameOrName
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagInvalidReference
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestTagInvalidReference (0.01s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagValidPrefixedRepo
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestTagValidPrefixedRepo (0.04s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagExistedNameWithoutForce
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagOfficialNames
14:42:28 [2019-09-16T14:42:28.555Z] --- PASS: TestTagOfficialNames (0.09s)
14:42:28 [2019-09-16T14:42:28.555Z] === RUN   TestTagMatchesDigest
14:42:28 [2019-09-16T14:42:28.927Z] --- PASS: TestTagMatchesDigest (0.02s)
14:42:28 [2019-09-16T14:42:28.927Z] === CONT  TestImportExtremelyLargeImageWorks
14:44:08 [2019-09-16T14:44:08.608Z] --- PASS: TestImportExtremelyLargeImageWorks (93.20s)
14:44:08 [2019-09-16T14:44:08.608Z]     import_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestImportExtremelyLargeImageWorks
14:44:08 [2019-09-16T14:44:08.608Z]     daemon.go:321: [d5f9549379383] waiting for daemon to start
14:44:08 [2019-09-16T14:44:08.608Z]     daemon.go:339: [d5f9549379383] daemon started
14:44:08 [2019-09-16T14:44:08.608Z]     daemon.go:449: [d5f9549379383] Stopping daemon
14:44:08 [2019-09-16T14:44:08.608Z]     daemon.go:288: [d5f9549379383] exiting daemon
14:44:08 [2019-09-16T14:44:08.608Z]     daemon.go:436: [d5f9549379383] Daemon stopped
14:44:08 [2019-09-16T14:44:08.608Z] PASS
14:44:08 [2019-09-16T14:44:08.608Z] Running /go/src/github.com/docker/docker/integration/network flags=-test.v -test.timeout=120m  
14:44:08 [2019-09-16T14:44:08.608Z] INFO: Testing against a local daemon
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestNetworkCreateDelete
14:44:08 [2019-09-16T14:44:08.608Z] --- PASS: TestNetworkCreateDelete (0.21s)
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestDockerNetworkDeletePreferID
14:44:08 [2019-09-16T14:44:08.608Z] --- PASS: TestDockerNetworkDeletePreferID (0.64s)
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestInspectNetwork
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestInspectNetwork/full_network_id
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestInspectNetwork/partial_network_id
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestInspectNetwork/network_name
14:44:08 [2019-09-16T14:44:08.608Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
14:44:12 [2019-09-16T14:44:12.588Z] --- PASS: TestInspectNetwork (9.31s)
14:44:12 [2019-09-16T14:44:12.588Z]     inspect_test.go:18: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork
14:44:12 [2019-09-16T14:44:12.588Z]     daemon.go:321: [dd54772c5ef01] waiting for daemon to start
14:44:12 [2019-09-16T14:44:12.588Z]     daemon.go:339: [dd54772c5ef01] daemon started
14:44:12 [2019-09-16T14:44:12.588Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
14:44:12 [2019-09-16T14:44:12.588Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
14:44:12 [2019-09-16T14:44:12.588Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
14:44:12 [2019-09-16T14:44:12.588Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
14:44:12 [2019-09-16T14:44:12.588Z]     daemon.go:449: [dd54772c5ef01] Stopping daemon
14:44:12 [2019-09-16T14:44:12.588Z]     daemon.go:288: [dd54772c5ef01] exiting daemon
14:44:12 [2019-09-16T14:44:12.588Z]     daemon.go:436: [dd54772c5ef01] Daemon stopped
14:44:12 [2019-09-16T14:44:12.588Z] === RUN   TestRunContainerWithBridgeNone
14:44:15 [2019-09-16T14:44:15.116Z] --- PASS: TestRunContainerWithBridgeNone (2.84s)
14:44:15 [2019-09-16T14:44:15.116Z]     network_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone
14:44:15 [2019-09-16T14:44:15.116Z]     daemon.go:321: [d4ed7fb042fb5] waiting for daemon to start
14:44:15 [2019-09-16T14:44:15.116Z]     daemon.go:339: [d4ed7fb042fb5] daemon started
14:44:15 [2019-09-16T14:44:15.116Z]     daemon.go:449: [d4ed7fb042fb5] Stopping daemon
14:44:15 [2019-09-16T14:44:15.116Z]     daemon.go:288: [d4ed7fb042fb5] exiting daemon
14:44:15 [2019-09-16T14:44:15.116Z]     daemon.go:436: [d4ed7fb042fb5] Daemon stopped
14:44:15 [2019-09-16T14:44:15.116Z] === RUN   TestNetworkInvalidJSON
14:44:15 [2019-09-16T14:44:15.116Z] === RUN   TestNetworkInvalidJSON//networks/create
14:44:15 [2019-09-16T14:44:15.116Z] === PAUSE TestNetworkInvalidJSON//networks/create
14:44:15 [2019-09-16T14:44:15.116Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
14:44:15 [2019-09-16T14:44:15.116Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
14:44:15 [2019-09-16T14:44:15.116Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
14:44:15 [2019-09-16T14:44:15.116Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
14:44:15 [2019-09-16T14:44:15.116Z] === CONT  TestNetworkInvalidJSON//networks/create
14:44:15 [2019-09-16T14:44:15.116Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
14:44:15 [2019-09-16T14:44:15.116Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
14:44:15 [2019-09-16T14:44:15.116Z] --- PASS: TestNetworkInvalidJSON (0.03s)
14:44:15 [2019-09-16T14:44:15.116Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
14:44:15 [2019-09-16T14:44:15.116Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
14:44:15 [2019-09-16T14:44:15.116Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
14:44:15 [2019-09-16T14:44:15.116Z] === RUN   TestDaemonRestartWithLiveRestore
14:44:16 [2019-09-16T14:44:16.368Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
14:44:16 [2019-09-16T14:44:16.368Z]     service_test.go:32: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:321: [d7ca7ce85b08f] waiting for daemon to start
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:339: [d7ca7ce85b08f] daemon started
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:449: [d7ca7ce85b08f] Stopping daemon
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:288: [d7ca7ce85b08f] exiting daemon
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:436: [d7ca7ce85b08f] Daemon stopped
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:321: [d7ca7ce85b08f] waiting for daemon to start
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:339: [d7ca7ce85b08f] daemon started
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:449: [d7ca7ce85b08f] Stopping daemon
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:288: [d7ca7ce85b08f] exiting daemon
14:44:16 [2019-09-16T14:44:16.368Z]     daemon.go:436: [d7ca7ce85b08f] Daemon stopped
14:44:16 [2019-09-16T14:44:16.368Z] === RUN   TestDaemonDefaultNetworkPools
14:44:17 [2019-09-16T14:44:17.172Z] --- PASS: TestDaemonDefaultNetworkPools (0.85s)
14:44:17 [2019-09-16T14:44:17.172Z]     service_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools
14:44:17 [2019-09-16T14:44:17.172Z]     daemon.go:321: [d8b11c848e91b] waiting for daemon to start
14:44:17 [2019-09-16T14:44:17.172Z]     daemon.go:339: [d8b11c848e91b] daemon started
14:44:17 [2019-09-16T14:44:17.172Z]     daemon.go:449: [d8b11c848e91b] Stopping daemon
14:44:17 [2019-09-16T14:44:17.172Z]     daemon.go:288: [d8b11c848e91b] exiting daemon
14:44:17 [2019-09-16T14:44:17.172Z]     daemon.go:436: [d8b11c848e91b] Daemon stopped
14:44:17 [2019-09-16T14:44:17.172Z] === RUN   TestDaemonRestartWithExistingNetwork
14:44:18 [2019-09-16T14:44:18.441Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.20s)
14:44:18 [2019-09-16T14:44:18.441Z]     service_test.go:98: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:321: [daeb79cb24980] waiting for daemon to start
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:339: [daeb79cb24980] daemon started
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:449: [daeb79cb24980] Stopping daemon
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:288: [daeb79cb24980] exiting daemon
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:436: [daeb79cb24980] Daemon stopped
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:321: [daeb79cb24980] waiting for daemon to start
14:44:18 [2019-09-16T14:44:18.441Z]     daemon.go:339: [daeb79cb24980] daemon started
14:44:18 [2019-09-16T14:44:18.442Z]     daemon.go:449: [daeb79cb24980] Stopping daemon
14:44:18 [2019-09-16T14:44:18.442Z]     daemon.go:288: [daeb79cb24980] exiting daemon
14:44:18 [2019-09-16T14:44:18.442Z]     daemon.go:436: [daeb79cb24980] Daemon stopped
14:44:18 [2019-09-16T14:44:18.442Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
14:44:19 [2019-09-16T14:44:19.719Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.40s)
14:44:19 [2019-09-16T14:44:19.719Z]     service_test.go:131: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:321: [d7326923f51cb] waiting for daemon to start
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:339: [d7326923f51cb] daemon started
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:449: [d7326923f51cb] Stopping daemon
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:288: [d7326923f51cb] exiting daemon
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:436: [d7326923f51cb] Daemon stopped
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:321: [d7326923f51cb] waiting for daemon to start
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:339: [d7326923f51cb] daemon started
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:449: [d7326923f51cb] Stopping daemon
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:288: [d7326923f51cb] exiting daemon
14:44:19 [2019-09-16T14:44:19.719Z]     daemon.go:436: [d7326923f51cb] Daemon stopped
14:44:19 [2019-09-16T14:44:19.719Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
14:44:20 [2019-09-16T14:44:20.082Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
14:44:20 [2019-09-16T14:44:20.082Z]     service_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool
14:44:20 [2019-09-16T14:44:20.082Z]     daemon.go:321: [da2c0cfa40203] waiting for daemon to start
14:44:20 [2019-09-16T14:44:20.082Z]     daemon.go:339: [da2c0cfa40203] daemon started
14:44:20 [2019-09-16T14:44:20.082Z]     daemon.go:449: [da2c0cfa40203] Stopping daemon
14:44:20 [2019-09-16T14:44:20.082Z]     daemon.go:288: [da2c0cfa40203] exiting daemon
14:44:20 [2019-09-16T14:44:20.082Z]     daemon.go:436: [da2c0cfa40203] Daemon stopped
14:44:20 [2019-09-16T14:44:20.082Z] === RUN   TestServiceWithPredefinedNetwork
14:44:23 [2019-09-16T14:44:23.389Z] --- PASS: TestServiceWithPredefinedNetwork (3.00s)
14:44:23 [2019-09-16T14:44:23.389Z]     service_test.go:203: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork
14:44:23 [2019-09-16T14:44:23.389Z]     daemon.go:321: [d5977cac2a96e] waiting for daemon to start
14:44:23 [2019-09-16T14:44:23.389Z]     daemon.go:339: [d5977cac2a96e] daemon started
14:44:23 [2019-09-16T14:44:23.389Z]     daemon.go:449: [d5977cac2a96e] Stopping daemon
14:44:23 [2019-09-16T14:44:23.389Z]     daemon.go:288: [d5977cac2a96e] exiting daemon
14:44:23 [2019-09-16T14:44:23.389Z]     daemon.go:436: [d5977cac2a96e] Daemon stopped
14:44:23 [2019-09-16T14:44:23.389Z] === RUN   TestServiceRemoveKeepsIngressNetwork
14:44:23 [2019-09-16T14:44:23.389Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
14:44:23 [2019-09-16T14:44:23.389Z]     service_test.go:230: FLAKY_TEST
14:44:23 [2019-09-16T14:44:23.389Z] === RUN   TestServiceWithDataPathPortInit
14:44:29 [2019-09-16T14:44:29.709Z] --- PASS: TestServiceWithDataPathPortInit (5.58s)
14:44:29 [2019-09-16T14:44:29.709Z]     service_test.go:339: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:321: [dc6a3d76ef0b3] waiting for daemon to start
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:339: [dc6a3d76ef0b3] daemon started
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:449: [dc6a3d76ef0b3] Stopping daemon
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:288: [dc6a3d76ef0b3] exiting daemon
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:436: [dc6a3d76ef0b3] Daemon stopped
14:44:29 [2019-09-16T14:44:29.709Z]     service_test.go:367: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDataPathPortInit
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:321: [d15474acf5d79] waiting for daemon to start
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:339: [d15474acf5d79] daemon started
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:449: [d15474acf5d79] Stopping daemon
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:288: [d15474acf5d79] exiting daemon
14:44:29 [2019-09-16T14:44:29.709Z]     daemon.go:436: [d15474acf5d79] Daemon stopped
14:44:29 [2019-09-16T14:44:29.709Z] === RUN   TestServiceWithDefaultAddressPoolInit
14:44:34 [2019-09-16T14:44:34.773Z] --- PASS: TestServiceWithDefaultAddressPoolInit (5.23s)
14:44:34 [2019-09-16T14:44:34.773Z]     service_test.go:398: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:321: [dcb66b7631166] waiting for daemon to start
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:339: [dcb66b7631166] daemon started
14:44:34 [2019-09-16T14:44:34.773Z]     service_test.go:423: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:saanvisthiraTestServiceWithDefaultAddressPoolInit ID:eykdkknkkrfd1z1vado4vjzgm Created:2019-09-16 14:44:29.650594374 +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[]}
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:449: [dcb66b7631166] Stopping daemon
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:288: [dcb66b7631166] exiting daemon
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:436: [dcb66b7631166] Daemon stopped
14:44:34 [2019-09-16T14:44:34.773Z]     service_test.go:436: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:321: [d4fab0f681976] waiting for daemon to start
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:339: [d4fab0f681976] daemon started
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:449: [d4fab0f681976] Stopping daemon
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:288: [d4fab0f681976] exiting daemon
14:44:34 [2019-09-16T14:44:34.773Z]     daemon.go:436: [d4fab0f681976] Daemon stopped
14:44:34 [2019-09-16T14:44:34.773Z] PASS
14:44:34 [2019-09-16T14:44:34.773Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan flags=-test.v -test.timeout=120m  
14:44:34 [2019-09-16T14:44:34.773Z] INFO: Testing against a local daemon
14:44:34 [2019-09-16T14:44:34.773Z] === RUN   TestDockerNetworkIpvlanPersistance
14:44:35 [2019-09-16T14:44:35.627Z] --- PASS: TestDockerNetworkIpvlanPersistance (1.48s)
14:44:35 [2019-09-16T14:44:35.627Z]     ipvlan_test.go:29: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlanPersistance
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:321: [d181f1c883f76] waiting for daemon to start
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:339: [d181f1c883f76] daemon started
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:449: [d181f1c883f76] Stopping daemon
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:288: [d181f1c883f76] exiting daemon
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:436: [d181f1c883f76] Daemon stopped
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:321: [d181f1c883f76] waiting for daemon to start
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:339: [d181f1c883f76] daemon started
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:449: [d181f1c883f76] Stopping daemon
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:288: [d181f1c883f76] exiting daemon
14:44:35 [2019-09-16T14:44:35.627Z]     daemon.go:436: [d181f1c883f76] Daemon stopped
14:44:35 [2019-09-16T14:44:35.627Z] === RUN   TestDockerNetworkIpvlan
14:44:36 [2019-09-16T14:44:36.404Z] === RUN   TestDockerNetworkIpvlan/Subinterface
14:44:37 [2019-09-16T14:44:37.824Z] === RUN   TestDockerNetworkIpvlan/OverlapParent
14:44:38 [2019-09-16T14:44:38.654Z] === RUN   TestDockerNetworkIpvlan/L2NilParent
14:44:41 [2019-09-16T14:44:41.110Z] === RUN   TestDockerNetworkIpvlan/L2InternalMode
14:44:45 [2019-09-16T14:44:45.118Z] === RUN   TestDockerNetworkIpvlan/L3NilParent
14:45:04 [2019-09-16T14:45:04.778Z] === RUN   TestDockerNetworkIpvlan/L3InternalMode
14:45:21 [2019-09-16T14:45:21.052Z] === RUN   TestDockerNetworkIpvlan/L2MultiSubnet
14:45:40 [2019-09-16T14:45:40.728Z] === RUN   TestDockerNetworkIpvlan/L3MultiSubnet
14:46:00 [2019-09-16T14:46:00.377Z] === RUN   TestDockerNetworkIpvlan/Addressing
14:46:34 [2019-09-16T14:46:34.474Z] --- PASS: TestDockerNetworkIpvlan (117.23s)
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d592159c63934] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d592159c63934] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/Subinterface (0.12s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d592159c63934] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d592159c63934] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d592159c63934] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d28b057d5e1f0] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d28b057d5e1f0] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/OverlapParent (0.05s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d28b057d5e1f0] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d28b057d5e1f0] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d28b057d5e1f0] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d0c1dee5da6fb] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d0c1dee5da6fb] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L2NilParent (1.32s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d0c1dee5da6fb] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d0c1dee5da6fb] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d0c1dee5da6fb] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d030c7569aa11] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d030c7569aa11] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L2InternalMode (2.37s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d030c7569aa11] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d030c7569aa11] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d030c7569aa11] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d2abe74e13de0] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d2abe74e13de0] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L3NilParent (16.21s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d2abe74e13de0] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d2abe74e13de0] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d2abe74e13de0] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d0884eed8b605] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d0884eed8b605] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L3InternalMode (17.31s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d0884eed8b605] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d0884eed8b605] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d0884eed8b605] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d0f4f3d7d0579] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d0f4f3d7d0579] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L2MultiSubnet (18.17s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d0f4f3d7d0579] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d0f4f3d7d0579] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d0f4f3d7d0579] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d18003fc78e46] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d18003fc78e46] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/L3MultiSubnet (18.22s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d18003fc78e46] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d18003fc78e46] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d18003fc78e46] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [da95d7454432d] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [da95d7454432d] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     --- PASS: TestDockerNetworkIpvlan/Addressing (31.95s)
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [da95d7454432d] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [da95d7454432d] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [da95d7454432d] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z] PASS
14:46:34 [2019-09-16T14:46:34.474Z] Running /go/src/github.com/docker/docker/integration/network/macvlan flags=-test.v -test.timeout=120m  
14:46:34 [2019-09-16T14:46:34.474Z] INFO: Testing against a local daemon
14:46:34 [2019-09-16T14:46:34.474Z] === RUN   TestDockerNetworkMacvlanPersistance
14:46:34 [2019-09-16T14:46:34.474Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.42s)
14:46:34 [2019-09-16T14:46:34.474Z]     macvlan_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d3098df900812] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d3098df900812] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d3098df900812] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d3098df900812] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d3098df900812] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:321: [d3098df900812] waiting for daemon to start
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:339: [d3098df900812] daemon started
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:449: [d3098df900812] Stopping daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:288: [d3098df900812] exiting daemon
14:46:34 [2019-09-16T14:46:34.474Z]     daemon.go:436: [d3098df900812] Daemon stopped
14:46:34 [2019-09-16T14:46:34.474Z] === RUN   TestDockerNetworkMacvlan
14:46:35 [2019-09-16T14:46:35.268Z] === RUN   TestDockerNetworkMacvlan/Subinterface
14:46:36 [2019-09-16T14:46:36.547Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
14:46:37 [2019-09-16T14:46:37.351Z] === RUN   TestDockerNetworkMacvlan/NilParent
14:46:39 [2019-09-16T14:46:39.953Z] === RUN   TestDockerNetworkMacvlan/InternalMode
14:46:44 [2019-09-16T14:46:44.025Z] === RUN   TestDockerNetworkMacvlan/Addressing
14:47:00 [2019-09-16T14:47:00.295Z] --- PASS: TestDockerNetworkMacvlan (25.64s)
14:47:00 [2019-09-16T14:47:00.295Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:321: [d4a80a8dc2d31] waiting for daemon to start
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:339: [d4a80a8dc2d31] daemon started
14:47:00 [2019-09-16T14:47:00.295Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.09s)
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:449: [d4a80a8dc2d31] Stopping daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:288: [d4a80a8dc2d31] exiting daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:436: [d4a80a8dc2d31] Daemon stopped
14:47:00 [2019-09-16T14:47:00.295Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:321: [dabc6e0417572] waiting for daemon to start
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:339: [dabc6e0417572] daemon started
14:47:00 [2019-09-16T14:47:00.295Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.11s)
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:449: [dabc6e0417572] Stopping daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:288: [dabc6e0417572] exiting daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:436: [dabc6e0417572] Daemon stopped
14:47:00 [2019-09-16T14:47:00.295Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:321: [d0076ff98437a] waiting for daemon to start
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:339: [d0076ff98437a] daemon started
14:47:00 [2019-09-16T14:47:00.295Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.24s)
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:449: [d0076ff98437a] Stopping daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:288: [d0076ff98437a] exiting daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:436: [d0076ff98437a] Daemon stopped
14:47:00 [2019-09-16T14:47:00.295Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:321: [dce2a556a660c] waiting for daemon to start
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:339: [dce2a556a660c] daemon started
14:47:00 [2019-09-16T14:47:00.295Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.38s)
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:449: [dce2a556a660c] Stopping daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:288: [dce2a556a660c] exiting daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:436: [dce2a556a660c] Daemon stopped
14:47:00 [2019-09-16T14:47:00.295Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:321: [d67a63bc2aae8] waiting for daemon to start
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:339: [d67a63bc2aae8] daemon started
14:47:00 [2019-09-16T14:47:00.295Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (15.95s)
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:449: [d67a63bc2aae8] Stopping daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:288: [d67a63bc2aae8] exiting daemon
14:47:00 [2019-09-16T14:47:00.295Z]     daemon.go:436: [d67a63bc2aae8] Daemon stopped
14:47:00 [2019-09-16T14:47:00.295Z] PASS
14:47:00 [2019-09-16T14:47:00.295Z] Running /go/src/github.com/docker/docker/integration/plugin flags=-test.v -test.timeout=120m  
14:47:00 [2019-09-16T14:47:00.295Z] testing: warning: no tests to run
14:47:00 [2019-09-16T14:47:00.295Z] PASS
14:47:00 [2019-09-16T14:47:00.295Z] Running /go/src/github.com/docker/docker/integration/plugin/authz flags=-test.v -test.timeout=120m  
14:47:00 [2019-09-16T14:47:00.661Z] INFO: Testing against a local daemon
14:47:00 [2019-09-16T14:47:00.661Z] === RUN   TestAuthZPluginAllowRequest
14:47:02 [2019-09-16T14:47:02.588Z] --- PASS: TestAuthZPluginAllowRequest (1.75s)
14:47:02 [2019-09-16T14:47:02.588Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest
14:47:02 [2019-09-16T14:47:02.588Z]     daemon.go:321: [d017b2b10282c] waiting for daemon to start
14:47:02 [2019-09-16T14:47:02.588Z]     daemon.go:339: [d017b2b10282c] daemon started
14:47:02 [2019-09-16T14:47:02.588Z]     daemon.go:449: [d017b2b10282c] Stopping daemon
14:47:02 [2019-09-16T14:47:02.588Z]     daemon.go:288: [d017b2b10282c] exiting daemon
14:47:02 [2019-09-16T14:47:02.588Z]     daemon.go:436: [d017b2b10282c] Daemon stopped
14:47:02 [2019-09-16T14:47:02.588Z] === RUN   TestAuthZPluginTLS
14:47:03 [2019-09-16T14:47:03.045Z] --- PASS: TestAuthZPluginTLS (0.57s)
14:47:03 [2019-09-16T14:47:03.045Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS
14:47:03 [2019-09-16T14:47:03.045Z]     daemon.go:321: [d971d0e2ced38] waiting for daemon to start
14:47:03 [2019-09-16T14:47:03.045Z]     daemon.go:339: [d971d0e2ced38] daemon started
14:47:03 [2019-09-16T14:47:03.045Z]     daemon.go:449: [d971d0e2ced38] Stopping daemon
14:47:03 [2019-09-16T14:47:03.045Z]     daemon.go:288: [d971d0e2ced38] exiting daemon
14:47:03 [2019-09-16T14:47:03.045Z]     daemon.go:436: [d971d0e2ced38] Daemon stopped
14:47:03 [2019-09-16T14:47:03.045Z] === RUN   TestAuthZPluginDenyRequest
14:47:03 [2019-09-16T14:47:03.477Z] --- PASS: TestAuthZPluginDenyRequest (0.54s)
14:47:03 [2019-09-16T14:47:03.477Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest
14:47:03 [2019-09-16T14:47:03.477Z]     daemon.go:321: [d09ad7ae039cf] waiting for daemon to start
14:47:03 [2019-09-16T14:47:03.477Z]     daemon.go:339: [d09ad7ae039cf] daemon started
14:47:03 [2019-09-16T14:47:03.477Z]     daemon.go:449: [d09ad7ae039cf] Stopping daemon
14:47:03 [2019-09-16T14:47:03.477Z]     daemon.go:288: [d09ad7ae039cf] exiting daemon
14:47:03 [2019-09-16T14:47:03.477Z]     daemon.go:436: [d09ad7ae039cf] Daemon stopped
14:47:03 [2019-09-16T14:47:03.477Z] === RUN   TestAuthZPluginAPIDenyResponse
14:47:03 [2019-09-16T14:47:03.883Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.54s)
14:47:03 [2019-09-16T14:47:03.883Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse
14:47:03 [2019-09-16T14:47:03.883Z]     daemon.go:321: [dcebca862709e] waiting for daemon to start
14:47:03 [2019-09-16T14:47:03.883Z]     daemon.go:339: [dcebca862709e] daemon started
14:47:03 [2019-09-16T14:47:03.883Z]     daemon.go:449: [dcebca862709e] Stopping daemon
14:47:03 [2019-09-16T14:47:03.883Z]     daemon.go:288: [dcebca862709e] exiting daemon
14:47:03 [2019-09-16T14:47:03.883Z]     daemon.go:436: [dcebca862709e] Daemon stopped
14:47:03 [2019-09-16T14:47:03.883Z] === RUN   TestAuthZPluginDenyResponse
14:47:04 [2019-09-16T14:47:04.683Z] --- PASS: TestAuthZPluginDenyResponse (0.56s)
14:47:04 [2019-09-16T14:47:04.683Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse
14:47:04 [2019-09-16T14:47:04.683Z]     daemon.go:321: [ddbf48b7d3dad] waiting for daemon to start
14:47:04 [2019-09-16T14:47:04.683Z]     daemon.go:339: [ddbf48b7d3dad] daemon started
14:47:04 [2019-09-16T14:47:04.683Z]     daemon.go:449: [ddbf48b7d3dad] Stopping daemon
14:47:04 [2019-09-16T14:47:04.683Z]     daemon.go:288: [ddbf48b7d3dad] exiting daemon
14:47:04 [2019-09-16T14:47:04.683Z]     daemon.go:436: [ddbf48b7d3dad] Daemon stopped
14:47:04 [2019-09-16T14:47:04.683Z] === RUN   TestAuthZPluginAllowEventStream
14:47:06 [2019-09-16T14:47:06.474Z] --- PASS: TestAuthZPluginAllowEventStream (1.75s)
14:47:06 [2019-09-16T14:47:06.474Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream
14:47:06 [2019-09-16T14:47:06.474Z]     daemon.go:321: [d00ff5a00be62] waiting for daemon to start
14:47:06 [2019-09-16T14:47:06.474Z]     daemon.go:339: [d00ff5a00be62] daemon started
14:47:06 [2019-09-16T14:47:06.474Z]     daemon.go:449: [d00ff5a00be62] Stopping daemon
14:47:06 [2019-09-16T14:47:06.474Z]     daemon.go:288: [d00ff5a00be62] exiting daemon
14:47:06 [2019-09-16T14:47:06.474Z]     daemon.go:436: [d00ff5a00be62] Daemon stopped
14:47:06 [2019-09-16T14:47:06.474Z] === RUN   TestAuthZPluginErrorResponse
14:47:06 [2019-09-16T14:47:06.847Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
14:47:06 [2019-09-16T14:47:06.847Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse
14:47:06 [2019-09-16T14:47:06.847Z]     daemon.go:321: [de2799cc509bd] waiting for daemon to start
14:47:06 [2019-09-16T14:47:06.847Z]     daemon.go:339: [de2799cc509bd] daemon started
14:47:06 [2019-09-16T14:47:06.847Z]     daemon.go:449: [de2799cc509bd] Stopping daemon
14:47:06 [2019-09-16T14:47:06.848Z]     daemon.go:288: [de2799cc509bd] exiting daemon
14:47:06 [2019-09-16T14:47:06.848Z]     daemon.go:436: [de2799cc509bd] Daemon stopped
14:47:06 [2019-09-16T14:47:06.848Z] === RUN   TestAuthZPluginErrorRequest
14:47:07 [2019-09-16T14:47:07.226Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
14:47:07 [2019-09-16T14:47:07.226Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest
14:47:07 [2019-09-16T14:47:07.226Z]     daemon.go:321: [d4cd4e3ac21d9] waiting for daemon to start
14:47:07 [2019-09-16T14:47:07.226Z]     daemon.go:339: [d4cd4e3ac21d9] daemon started
14:47:07 [2019-09-16T14:47:07.226Z]     daemon.go:449: [d4cd4e3ac21d9] Stopping daemon
14:47:07 [2019-09-16T14:47:07.226Z]     daemon.go:288: [d4cd4e3ac21d9] exiting daemon
14:47:07 [2019-09-16T14:47:07.226Z]     daemon.go:436: [d4cd4e3ac21d9] Daemon stopped
14:47:07 [2019-09-16T14:47:07.226Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
14:47:08 [2019-09-16T14:47:08.008Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.54s)
14:47:08 [2019-09-16T14:47:08.008Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration
14:47:08 [2019-09-16T14:47:08.008Z]     daemon.go:321: [da6e209de8b48] waiting for daemon to start
14:47:08 [2019-09-16T14:47:08.008Z]     daemon.go:339: [da6e209de8b48] daemon started
14:47:08 [2019-09-16T14:47:08.008Z]     daemon.go:449: [da6e209de8b48] Stopping daemon
14:47:08 [2019-09-16T14:47:08.008Z]     daemon.go:288: [da6e209de8b48] exiting daemon
14:47:08 [2019-09-16T14:47:08.008Z]     daemon.go:436: [da6e209de8b48] Daemon stopped
14:47:08 [2019-09-16T14:47:08.008Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
14:47:10 [2019-09-16T14:47:10.440Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.20s)
14:47:10 [2019-09-16T14:47:10.440Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking
14:47:10 [2019-09-16T14:47:10.440Z]     daemon.go:321: [df6bf252ff15a] waiting for daemon to start
14:47:10 [2019-09-16T14:47:10.440Z]     daemon.go:339: [df6bf252ff15a] daemon started
14:47:10 [2019-09-16T14:47:10.440Z]     daemon.go:449: [df6bf252ff15a] Stopping daemon
14:47:10 [2019-09-16T14:47:10.440Z]     daemon.go:288: [df6bf252ff15a] exiting daemon
14:47:10 [2019-09-16T14:47:10.440Z]     daemon.go:436: [df6bf252ff15a] Daemon stopped
14:47:10 [2019-09-16T14:47:10.440Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
14:47:12 [2019-09-16T14:47:12.256Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.32s)
14:47:12 [2019-09-16T14:47:12.256Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom
14:47:12 [2019-09-16T14:47:12.256Z]     daemon.go:321: [dc530a99cc48f] waiting for daemon to start
14:47:12 [2019-09-16T14:47:12.256Z]     daemon.go:339: [dc530a99cc48f] daemon started
14:47:12 [2019-09-16T14:47:12.256Z]     daemon.go:449: [dc530a99cc48f] Stopping daemon
14:47:12 [2019-09-16T14:47:12.256Z]     daemon.go:288: [dc530a99cc48f] exiting daemon
14:47:12 [2019-09-16T14:47:12.256Z]     daemon.go:436: [dc530a99cc48f] Daemon stopped
14:47:12 [2019-09-16T14:47:12.256Z] === RUN   TestAuthZPluginHeader
14:47:13 [2019-09-16T14:47:13.534Z] --- PASS: TestAuthZPluginHeader (0.88s)
14:47:13 [2019-09-16T14:47:13.534Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader
14:47:13 [2019-09-16T14:47:13.534Z]     daemon.go:321: [d8dff3cfa7720] waiting for daemon to start
14:47:13 [2019-09-16T14:47:13.534Z]     daemon.go:339: [d8dff3cfa7720] daemon started
14:47:13 [2019-09-16T14:47:13.534Z]     daemon.go:449: [d8dff3cfa7720] Stopping daemon
14:47:13 [2019-09-16T14:47:13.534Z]     daemon.go:288: [d8dff3cfa7720] exiting daemon
14:47:13 [2019-09-16T14:47:13.534Z]     daemon.go:436: [d8dff3cfa7720] Daemon stopped
14:47:13 [2019-09-16T14:47:13.534Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
14:47:13 [2019-09-16T14:47:13.534Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
14:47:13 [2019-09-16T14:47:13.534Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:47:13 [2019-09-16T14:47:13.534Z] === RUN   TestAuthZPluginV2Disable
14:47:13 [2019-09-16T14:47:13.534Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
14:47:13 [2019-09-16T14:47:13.534Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:47:13 [2019-09-16T14:47:13.534Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
14:47:13 [2019-09-16T14:47:13.534Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
14:47:13 [2019-09-16T14:47:13.534Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:47:13 [2019-09-16T14:47:13.534Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
14:47:13 [2019-09-16T14:47:13.534Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
14:47:13 [2019-09-16T14:47:13.534Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:47:13 [2019-09-16T14:47:13.534Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
14:47:29 [2019-09-16T14:47:29.944Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.71s)
14:47:29 [2019-09-16T14:47:29.944Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:339: [dadff4c081099] daemon started
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:449: [dadff4c081099] Stopping daemon
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:288: [dadff4c081099] exiting daemon
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:436: [dadff4c081099] Daemon stopped
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: context deadline exceeded
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: read unix @->/tmp/docker-integration/dadff4c081099.sock: read: connection reset by peer
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:288: [dadff4c081099] exiting daemon
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:331: [dadff4c081099] error pinging daemon on start: Get http://dadff4c081099.sock/_ping: dial unix /tmp/docker-integration/dadff4c081099.sock: connect: connection refused
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:321: [dadff4c081099] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:339: [dadff4c081099] daemon started
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:449: [dadff4c081099] Stopping daemon
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:288: [dadff4c081099] exiting daemon
14:47:29 [2019-09-16T14:47:29.944Z]     daemon.go:436: [dadff4c081099] Daemon stopped
14:47:29 [2019-09-16T14:47:29.944Z] PASS
14:47:29 [2019-09-16T14:47:29.944Z] Running /go/src/github.com/docker/docker/integration/plugin/common flags=-test.v -test.timeout=120m  
14:47:30 [2019-09-16T14:47:30.326Z] INFO: Testing against a local daemon
14:47:30 [2019-09-16T14:47:30.326Z] === RUN   TestPluginInvalidJSON
14:47:30 [2019-09-16T14:47:30.326Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
14:47:30 [2019-09-16T14:47:30.326Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
14:47:30 [2019-09-16T14:47:30.326Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
14:47:30 [2019-09-16T14:47:30.326Z] --- PASS: TestPluginInvalidJSON (0.04s)
14:47:30 [2019-09-16T14:47:30.326Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
14:47:30 [2019-09-16T14:47:30.326Z] PASS
14:47:30 [2019-09-16T14:47:30.326Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver flags=-test.v -test.timeout=120m  
14:47:30 [2019-09-16T14:47:30.326Z] INFO: Testing against a local daemon
14:47:30 [2019-09-16T14:47:30.326Z] === RUN   TestExternalGraphDriver
14:47:30 [2019-09-16T14:47:30.712Z] === RUN   TestExternalGraphDriver/json
14:47:32 [2019-09-16T14:47:32.514Z] === RUN   TestExternalGraphDriver/spec
14:47:34 [2019-09-16T14:47:34.944Z] === RUN   TestExternalGraphDriver/pull
14:47:36 [2019-09-16T14:47:36.782Z] --- PASS: TestExternalGraphDriver (6.48s)
14:47:36 [2019-09-16T14:47:36.782Z]     external_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:321: [d48f351264797] waiting for daemon to start
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:339: [d48f351264797] daemon started
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:449: [d48f351264797] Stopping daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:288: [d48f351264797] exiting daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:436: [d48f351264797] Daemon stopped
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:321: [d48f351264797] waiting for daemon to start
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:339: [d48f351264797] daemon started
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:449: [d48f351264797] Stopping daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:288: [d48f351264797] exiting daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:436: [d48f351264797] Daemon stopped
14:47:36 [2019-09-16T14:47:36.782Z]     --- PASS: TestExternalGraphDriver/json (2.11s)
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:321: [d48f351264797] waiting for daemon to start
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:339: [d48f351264797] daemon started
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:449: [d48f351264797] Stopping daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:288: [d48f351264797] exiting daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:436: [d48f351264797] Daemon stopped
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:321: [d48f351264797] waiting for daemon to start
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:339: [d48f351264797] daemon started
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:449: [d48f351264797] Stopping daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:288: [d48f351264797] exiting daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:436: [d48f351264797] Daemon stopped
14:47:36 [2019-09-16T14:47:36.782Z]     --- PASS: TestExternalGraphDriver/spec (2.07s)
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:321: [d48f351264797] waiting for daemon to start
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:339: [d48f351264797] daemon started
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:449: [d48f351264797] Stopping daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:288: [d48f351264797] exiting daemon
14:47:36 [2019-09-16T14:47:36.782Z]     daemon.go:436: [d48f351264797] Daemon stopped
14:47:36 [2019-09-16T14:47:36.782Z]     --- PASS: TestExternalGraphDriver/pull (2.12s)
14:47:36 [2019-09-16T14:47:36.782Z] === RUN   TestGraphdriverPluginV2
14:47:36 [2019-09-16T14:47:36.782Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
14:47:36 [2019-09-16T14:47:36.782Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:47:36 [2019-09-16T14:47:36.782Z] PASS
14:47:36 [2019-09-16T14:47:36.782Z] Running /go/src/github.com/docker/docker/integration/plugin/logging flags=-test.v -test.timeout=120m  
14:47:37 [2019-09-16T14:47:37.259Z] INFO: Testing against a local daemon
14:47:37 [2019-09-16T14:47:37.260Z] === RUN   TestContinueAfterPluginCrash
14:47:37 [2019-09-16T14:47:37.260Z] === PAUSE TestContinueAfterPluginCrash
14:47:37 [2019-09-16T14:47:37.260Z] === RUN   TestDaemonStartWithLogOpt
14:47:37 [2019-09-16T14:47:37.260Z] === PAUSE TestDaemonStartWithLogOpt
14:47:37 [2019-09-16T14:47:37.260Z] === CONT  TestContinueAfterPluginCrash
14:47:37 [2019-09-16T14:47:37.260Z] === CONT  TestDaemonStartWithLogOpt
14:47:48 [2019-09-16T14:47:48.946Z] --- PASS: TestDaemonStartWithLogOpt (11.02s)
14:47:48 [2019-09-16T14:47:48.946Z]     validation_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:321: [df1772313c1fe] waiting for daemon to start
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:339: [df1772313c1fe] daemon started
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:449: [df1772313c1fe] Stopping daemon
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:288: [df1772313c1fe] exiting daemon
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:436: [df1772313c1fe] Daemon stopped
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:321: [df1772313c1fe] waiting for daemon to start
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:339: [df1772313c1fe] daemon started
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:449: [df1772313c1fe] Stopping daemon
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:288: [df1772313c1fe] exiting daemon
14:47:48 [2019-09-16T14:47:48.946Z]     daemon.go:436: [df1772313c1fe] Daemon stopped
14:47:52 [2019-09-16T14:47:52.917Z] --- PASS: TestContinueAfterPluginCrash (15.93s)
14:47:52 [2019-09-16T14:47:52.917Z]     logging_linux_test.go:22: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash
14:47:52 [2019-09-16T14:47:52.917Z]     daemon.go:321: [d288392be4568] waiting for daemon to start
14:47:52 [2019-09-16T14:47:52.917Z]     daemon.go:339: [d288392be4568] daemon started
14:47:52 [2019-09-16T14:47:52.917Z]     daemon.go:449: [d288392be4568] Stopping daemon
14:47:52 [2019-09-16T14:47:52.917Z]     daemon.go:288: [d288392be4568] exiting daemon
14:47:52 [2019-09-16T14:47:52.917Z]     daemon.go:436: [d288392be4568] Daemon stopped
14:47:52 [2019-09-16T14:47:52.917Z] PASS
14:47:52 [2019-09-16T14:47:52.917Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes flags=-test.v -test.timeout=120m  
14:47:53 [2019-09-16T14:47:53.291Z] INFO: Testing against a local daemon
14:47:53 [2019-09-16T14:47:53.291Z] === RUN   TestPluginWithDevMounts
14:47:53 [2019-09-16T14:47:53.291Z] === PAUSE TestPluginWithDevMounts
14:47:53 [2019-09-16T14:47:53.291Z] === CONT  TestPluginWithDevMounts
14:47:55 [2019-09-16T14:47:55.090Z] --- PASS: TestPluginWithDevMounts (2.04s)
14:47:55 [2019-09-16T14:47:55.090Z]     mounts_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts
14:47:55 [2019-09-16T14:47:55.090Z]     daemon.go:321: [d76b938ed9d20] waiting for daemon to start
14:47:55 [2019-09-16T14:47:55.090Z]     daemon.go:339: [d76b938ed9d20] daemon started
14:47:55 [2019-09-16T14:47:55.090Z]     daemon.go:449: [d76b938ed9d20] Stopping daemon
14:47:55 [2019-09-16T14:47:55.090Z]     daemon.go:288: [d76b938ed9d20] exiting daemon
14:47:55 [2019-09-16T14:47:55.090Z]     daemon.go:436: [d76b938ed9d20] Daemon stopped
14:47:55 [2019-09-16T14:47:55.090Z] PASS
14:47:55 [2019-09-16T14:47:55.090Z] Running /go/src/github.com/docker/docker/integration/secret flags=-test.v -test.timeout=120m  
14:47:55 [2019-09-16T14:47:55.500Z] INFO: Testing against a local daemon
14:47:55 [2019-09-16T14:47:55.500Z] === RUN   TestSecretInspect
14:47:58 [2019-09-16T14:47:58.186Z] --- PASS: TestSecretInspect (2.92s)
14:47:58 [2019-09-16T14:47:58.186Z]     secret_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect
14:47:58 [2019-09-16T14:47:58.186Z]     daemon.go:321: [dddac991c5552] waiting for daemon to start
14:47:58 [2019-09-16T14:47:58.186Z]     daemon.go:339: [dddac991c5552] daemon started
14:47:58 [2019-09-16T14:47:58.186Z]     daemon.go:449: [dddac991c5552] Stopping daemon
14:47:58 [2019-09-16T14:47:58.186Z]     daemon.go:288: [dddac991c5552] exiting daemon
14:47:58 [2019-09-16T14:47:58.186Z]     daemon.go:436: [dddac991c5552] Daemon stopped
14:47:58 [2019-09-16T14:47:58.186Z] === RUN   TestSecretList
14:48:01 [2019-09-16T14:48:01.341Z] --- PASS: TestSecretList (2.95s)
14:48:01 [2019-09-16T14:48:01.341Z]     secret_test.go:48: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretList
14:48:01 [2019-09-16T14:48:01.341Z]     daemon.go:321: [db8b1e65c9993] waiting for daemon to start
14:48:01 [2019-09-16T14:48:01.341Z]     daemon.go:339: [db8b1e65c9993] daemon started
14:48:01 [2019-09-16T14:48:01.341Z]     daemon.go:449: [db8b1e65c9993] Stopping daemon
14:48:01 [2019-09-16T14:48:01.341Z]     daemon.go:288: [db8b1e65c9993] exiting daemon
14:48:01 [2019-09-16T14:48:01.341Z]     daemon.go:436: [db8b1e65c9993] Daemon stopped
14:48:01 [2019-09-16T14:48:01.341Z] === RUN   TestSecretsCreateAndDelete
14:48:04 [2019-09-16T14:48:04.545Z] --- PASS: TestSecretsCreateAndDelete (2.92s)
14:48:04 [2019-09-16T14:48:04.545Z]     secret_test.go:125: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete
14:48:04 [2019-09-16T14:48:04.545Z]     daemon.go:321: [dd88ad45c84dc] waiting for daemon to start
14:48:04 [2019-09-16T14:48:04.545Z]     daemon.go:339: [dd88ad45c84dc] daemon started
14:48:04 [2019-09-16T14:48:04.545Z]     daemon.go:449: [dd88ad45c84dc] Stopping daemon
14:48:04 [2019-09-16T14:48:04.545Z]     daemon.go:288: [dd88ad45c84dc] exiting daemon
14:48:04 [2019-09-16T14:48:04.545Z]     daemon.go:436: [dd88ad45c84dc] Daemon stopped
14:48:04 [2019-09-16T14:48:04.545Z] === RUN   TestSecretsUpdate
14:48:06 [2019-09-16T14:48:06.964Z] --- PASS: TestSecretsUpdate (2.92s)
14:48:06 [2019-09-16T14:48:06.964Z]     secret_test.go:172: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate
14:48:06 [2019-09-16T14:48:06.964Z]     daemon.go:321: [deab8c5936b5c] waiting for daemon to start
14:48:06 [2019-09-16T14:48:06.964Z]     daemon.go:339: [deab8c5936b5c] daemon started
14:48:06 [2019-09-16T14:48:06.964Z]     daemon.go:449: [deab8c5936b5c] Stopping daemon
14:48:06 [2019-09-16T14:48:06.964Z]     daemon.go:288: [deab8c5936b5c] exiting daemon
14:48:06 [2019-09-16T14:48:06.964Z]     daemon.go:436: [deab8c5936b5c] Daemon stopped
14:48:06 [2019-09-16T14:48:06.964Z] === RUN   TestTemplatedSecret
14:48:11 [2019-09-16T14:48:11.154Z] --- PASS: TestTemplatedSecret (3.84s)
14:48:11 [2019-09-16T14:48:11.154Z]     secret_test.go:221: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret
14:48:11 [2019-09-16T14:48:11.154Z]     daemon.go:321: [d156ca6881b17] waiting for daemon to start
14:48:11 [2019-09-16T14:48:11.154Z]     daemon.go:339: [d156ca6881b17] daemon started
14:48:11 [2019-09-16T14:48:11.154Z]     daemon.go:449: [d156ca6881b17] Stopping daemon
14:48:11 [2019-09-16T14:48:11.154Z]     daemon.go:288: [d156ca6881b17] exiting daemon
14:48:11 [2019-09-16T14:48:11.154Z]     daemon.go:436: [d156ca6881b17] Daemon stopped
14:48:11 [2019-09-16T14:48:11.154Z] === RUN   TestSecretCreateResolve
14:48:14 [2019-09-16T14:48:14.357Z] --- PASS: TestSecretCreateResolve (3.05s)
14:48:14 [2019-09-16T14:48:14.357Z]     secret_test.go:342: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretCreateResolve
14:48:14 [2019-09-16T14:48:14.357Z]     daemon.go:321: [d8629feb6c02b] waiting for daemon to start
14:48:14 [2019-09-16T14:48:14.357Z]     daemon.go:339: [d8629feb6c02b] daemon started
14:48:14 [2019-09-16T14:48:14.357Z]     daemon.go:449: [d8629feb6c02b] Stopping daemon
14:48:14 [2019-09-16T14:48:14.357Z]     daemon.go:288: [d8629feb6c02b] exiting daemon
14:48:14 [2019-09-16T14:48:14.357Z]     daemon.go:436: [d8629feb6c02b] Daemon stopped
14:48:14 [2019-09-16T14:48:14.357Z] PASS
14:48:14 [2019-09-16T14:48:14.357Z] Running /go/src/github.com/docker/docker/integration/service flags=-test.v -test.timeout=120m  
14:48:14 [2019-09-16T14:48:14.357Z] INFO: Testing against a local daemon
14:48:14 [2019-09-16T14:48:14.357Z] === RUN   TestServiceCreateInit
14:48:14 [2019-09-16T14:48:14.357Z] === RUN   TestServiceCreateInit/daemonInitDisabled
14:48:19 [2019-09-16T14:48:19.489Z] === RUN   TestServiceCreateInit/daemonInitEnabled
14:48:25 [2019-09-16T14:48:25.746Z] --- PASS: TestServiceCreateInit (10.54s)
14:48:25 [2019-09-16T14:48:25.746Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (5.24s)
14:48:25 [2019-09-16T14:48:25.746Z]         create_test.go:38: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:321: [dcf4c55037cfb] waiting for daemon to start
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:339: [dcf4c55037cfb] daemon started
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:449: [dcf4c55037cfb] Stopping daemon
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:288: [dcf4c55037cfb] exiting daemon
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:436: [dcf4c55037cfb] Daemon stopped
14:48:25 [2019-09-16T14:48:25.746Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.28s)
14:48:25 [2019-09-16T14:48:25.746Z]         create_test.go:38: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:321: [db9f58b2172c3] waiting for daemon to start
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:339: [db9f58b2172c3] daemon started
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:449: [db9f58b2172c3] Stopping daemon
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:288: [db9f58b2172c3] exiting daemon
14:48:25 [2019-09-16T14:48:25.746Z]         daemon.go:436: [db9f58b2172c3] Daemon stopped
14:48:25 [2019-09-16T14:48:25.746Z] === RUN   TestCreateServiceMultipleTimes
14:48:45 [2019-09-16T14:48:45.951Z] --- PASS: TestCreateServiceMultipleTimes (18.79s)
14:48:45 [2019-09-16T14:48:45.951Z]     create_test.go:80: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes
14:48:45 [2019-09-16T14:48:45.951Z]     daemon.go:321: [d0d118f899e6f] waiting for daemon to start
14:48:45 [2019-09-16T14:48:45.951Z]     daemon.go:339: [d0d118f899e6f] daemon started
14:48:45 [2019-09-16T14:48:45.951Z]     daemon.go:449: [d0d118f899e6f] Stopping daemon
14:48:45 [2019-09-16T14:48:45.951Z]     daemon.go:288: [d0d118f899e6f] exiting daemon
14:48:45 [2019-09-16T14:48:45.951Z]     daemon.go:436: [d0d118f899e6f] Daemon stopped
14:48:45 [2019-09-16T14:48:45.951Z] === RUN   TestCreateServiceConflict
14:48:46 [2019-09-16T14:48:46.319Z] --- PASS: TestCreateServiceConflict (2.77s)
14:48:46 [2019-09-16T14:48:46.319Z]     create_test.go:129: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConflict
14:48:46 [2019-09-16T14:48:46.319Z]     daemon.go:321: [dbcf356e5d235] waiting for daemon to start
14:48:46 [2019-09-16T14:48:46.319Z]     daemon.go:339: [dbcf356e5d235] daemon started
14:48:46 [2019-09-16T14:48:46.319Z]     daemon.go:449: [dbcf356e5d235] Stopping daemon
14:48:46 [2019-09-16T14:48:46.319Z]     daemon.go:288: [dbcf356e5d235] exiting daemon
14:48:46 [2019-09-16T14:48:46.319Z]     daemon.go:436: [dbcf356e5d235] Daemon stopped
14:48:46 [2019-09-16T14:48:46.319Z] === RUN   TestCreateServiceMaxReplicas
14:48:50 [2019-09-16T14:48:50.375Z] --- PASS: TestCreateServiceMaxReplicas (3.85s)
14:48:50 [2019-09-16T14:48:50.375Z]     create_test.go:150: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMaxReplicas
14:48:50 [2019-09-16T14:48:50.375Z]     daemon.go:321: [d588911158cdc] waiting for daemon to start
14:48:50 [2019-09-16T14:48:50.375Z]     daemon.go:339: [d588911158cdc] daemon started
14:48:50 [2019-09-16T14:48:50.375Z]     daemon.go:449: [d588911158cdc] Stopping daemon
14:48:50 [2019-09-16T14:48:50.375Z]     daemon.go:288: [d588911158cdc] exiting daemon
14:48:50 [2019-09-16T14:48:50.375Z]     daemon.go:436: [d588911158cdc] Daemon stopped
14:48:50 [2019-09-16T14:48:50.375Z] === RUN   TestCreateWithDuplicateNetworkNames
14:49:06 [2019-09-16T14:49:06.893Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.57s)
14:49:06 [2019-09-16T14:49:06.893Z]     create_test.go:171: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames
14:49:06 [2019-09-16T14:49:06.893Z]     daemon.go:321: [d09f8314ca474] waiting for daemon to start
14:49:06 [2019-09-16T14:49:06.893Z]     daemon.go:339: [d09f8314ca474] daemon started
14:49:06 [2019-09-16T14:49:06.893Z]     daemon.go:449: [d09f8314ca474] Stopping daemon
14:49:06 [2019-09-16T14:49:06.893Z]     daemon.go:288: [d09f8314ca474] exiting daemon
14:49:06 [2019-09-16T14:49:06.893Z]     daemon.go:436: [d09f8314ca474] Daemon stopped
14:49:06 [2019-09-16T14:49:06.893Z] === RUN   TestCreateServiceSecretFileMode
14:49:07 [2019-09-16T14:49:07.686Z] --- PASS: TestCreateServiceSecretFileMode (2.90s)
14:49:07 [2019-09-16T14:49:07.687Z]     create_test.go:224: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode
14:49:07 [2019-09-16T14:49:07.687Z]     daemon.go:321: [dcf5d8016ff8f] waiting for daemon to start
14:49:07 [2019-09-16T14:49:07.687Z]     daemon.go:339: [dcf5d8016ff8f] daemon started
14:49:07 [2019-09-16T14:49:07.687Z]     daemon.go:449: [dcf5d8016ff8f] Stopping daemon
14:49:07 [2019-09-16T14:49:07.687Z]     daemon.go:288: [dcf5d8016ff8f] exiting daemon
14:49:07 [2019-09-16T14:49:07.687Z]     daemon.go:436: [dcf5d8016ff8f] Daemon stopped
14:49:07 [2019-09-16T14:49:07.687Z] === RUN   TestCreateServiceConfigFileMode
14:49:10 [2019-09-16T14:49:10.879Z] --- PASS: TestCreateServiceConfigFileMode (3.36s)
14:49:10 [2019-09-16T14:49:10.879Z]     create_test.go:288: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode
14:49:10 [2019-09-16T14:49:10.879Z]     daemon.go:321: [dbb3738c1378a] waiting for daemon to start
14:49:10 [2019-09-16T14:49:10.879Z]     daemon.go:339: [dbb3738c1378a] daemon started
14:49:10 [2019-09-16T14:49:10.879Z]     daemon.go:449: [dbb3738c1378a] Stopping daemon
14:49:10 [2019-09-16T14:49:10.879Z]     daemon.go:288: [dbb3738c1378a] exiting daemon
14:49:10 [2019-09-16T14:49:10.879Z]     daemon.go:436: [dbb3738c1378a] Daemon stopped
14:49:10 [2019-09-16T14:49:10.879Z] === RUN   TestCreateServiceSysctls
14:49:14 [2019-09-16T14:49:14.992Z] --- PASS: TestCreateServiceSysctls (3.89s)
14:49:14 [2019-09-16T14:49:14.992Z]     create_test.go:378: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSysctls
14:49:14 [2019-09-16T14:49:14.992Z]     daemon.go:321: [d4704b169a16e] waiting for daemon to start
14:49:14 [2019-09-16T14:49:14.992Z]     daemon.go:339: [d4704b169a16e] daemon started
14:49:14 [2019-09-16T14:49:14.992Z]     daemon.go:449: [d4704b169a16e] Stopping daemon
14:49:14 [2019-09-16T14:49:14.992Z]     daemon.go:288: [d4704b169a16e] exiting daemon
14:49:14 [2019-09-16T14:49:14.992Z]     daemon.go:436: [d4704b169a16e] Daemon stopped
14:49:14 [2019-09-16T14:49:14.992Z] === RUN   TestInspect
14:49:17 [2019-09-16T14:49:17.604Z] --- PASS: TestInspect (2.77s)
14:49:17 [2019-09-16T14:49:17.604Z]     inspect_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspect
14:49:17 [2019-09-16T14:49:17.604Z]     daemon.go:321: [d6a83a6cd3215] waiting for daemon to start
14:49:17 [2019-09-16T14:49:17.604Z]     daemon.go:339: [d6a83a6cd3215] daemon started
14:49:17 [2019-09-16T14:49:17.604Z]     daemon.go:449: [d6a83a6cd3215] Stopping daemon
14:49:17 [2019-09-16T14:49:17.604Z]     daemon.go:288: [d6a83a6cd3215] exiting daemon
14:49:17 [2019-09-16T14:49:17.604Z]     daemon.go:436: [d6a83a6cd3215] Daemon stopped
14:49:17 [2019-09-16T14:49:17.604Z] === RUN   TestDockerNetworkConnectAlias
14:49:23 [2019-09-16T14:49:23.944Z] --- PASS: TestDockerNetworkConnectAlias (6.09s)
14:49:23 [2019-09-16T14:49:23.944Z]     network_test.go:20: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias
14:49:23 [2019-09-16T14:49:23.944Z]     daemon.go:321: [dc24b7e9fef8b] waiting for daemon to start
14:49:23 [2019-09-16T14:49:23.944Z]     daemon.go:339: [dc24b7e9fef8b] daemon started
14:49:23 [2019-09-16T14:49:23.944Z]     daemon.go:449: [dc24b7e9fef8b] Stopping daemon
14:49:23 [2019-09-16T14:49:23.944Z]     daemon.go:288: [dc24b7e9fef8b] exiting daemon
14:49:23 [2019-09-16T14:49:23.944Z]     daemon.go:436: [dc24b7e9fef8b] Daemon stopped
14:49:23 [2019-09-16T14:49:23.944Z] === RUN   TestDockerNetworkReConnect
14:49:29 [2019-09-16T14:49:29.007Z] --- PASS: TestDockerNetworkReConnect (4.90s)
14:49:29 [2019-09-16T14:49:29.007Z]     network_test.go:82: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect
14:49:29 [2019-09-16T14:49:29.007Z]     daemon.go:321: [d01752adf088d] waiting for daemon to start
14:49:29 [2019-09-16T14:49:29.007Z]     daemon.go:339: [d01752adf088d] daemon started
14:49:29 [2019-09-16T14:49:29.007Z]     daemon.go:449: [d01752adf088d] Stopping daemon
14:49:29 [2019-09-16T14:49:29.007Z]     daemon.go:288: [d01752adf088d] exiting daemon
14:49:29 [2019-09-16T14:49:29.007Z]     daemon.go:436: [d01752adf088d] Daemon stopped
14:49:29 [2019-09-16T14:49:29.007Z] === RUN   TestServicePlugin
14:49:29 [2019-09-16T14:49:29.007Z] --- SKIP: TestServicePlugin (0.01s)
14:49:29 [2019-09-16T14:49:29.007Z]     plugin_test.go:26: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
14:49:29 [2019-09-16T14:49:29.007Z] === RUN   TestServiceUpdateLabel
14:49:31 [2019-09-16T14:49:31.487Z] --- PASS: TestServiceUpdateLabel (2.93s)
14:49:31 [2019-09-16T14:49:31.487Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel
14:49:31 [2019-09-16T14:49:31.487Z]     daemon.go:321: [d25f050ab08e7] waiting for daemon to start
14:49:31 [2019-09-16T14:49:31.487Z]     daemon.go:339: [d25f050ab08e7] daemon started
14:49:31 [2019-09-16T14:49:31.487Z]     daemon.go:449: [d25f050ab08e7] Stopping daemon
14:49:31 [2019-09-16T14:49:31.487Z]     daemon.go:288: [d25f050ab08e7] exiting daemon
14:49:31 [2019-09-16T14:49:31.487Z]     daemon.go:436: [d25f050ab08e7] Daemon stopped
14:49:31 [2019-09-16T14:49:31.487Z] === RUN   TestServiceUpdateSecrets
14:49:48 [2019-09-16T14:49:48.097Z] --- PASS: TestServiceUpdateSecrets (15.39s)
14:49:48 [2019-09-16T14:49:48.097Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets
14:49:48 [2019-09-16T14:49:48.097Z]     daemon.go:321: [d86ee1f440381] waiting for daemon to start
14:49:48 [2019-09-16T14:49:48.097Z]     daemon.go:339: [d86ee1f440381] daemon started
14:49:48 [2019-09-16T14:49:48.097Z]     daemon.go:449: [d86ee1f440381] Stopping daemon
14:49:48 [2019-09-16T14:49:48.097Z]     daemon.go:288: [d86ee1f440381] exiting daemon
14:49:48 [2019-09-16T14:49:48.097Z]     daemon.go:436: [d86ee1f440381] Daemon stopped
14:49:48 [2019-09-16T14:49:48.097Z] === RUN   TestServiceUpdateConfigs
14:50:04 [2019-09-16T14:50:04.388Z] --- PASS: TestServiceUpdateConfigs (15.68s)
14:50:04 [2019-09-16T14:50:04.388Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs
14:50:04 [2019-09-16T14:50:04.388Z]     daemon.go:321: [d1a477a36483d] waiting for daemon to start
14:50:04 [2019-09-16T14:50:04.388Z]     daemon.go:339: [d1a477a36483d] daemon started
14:50:04 [2019-09-16T14:50:04.388Z]     daemon.go:449: [d1a477a36483d] Stopping daemon
14:50:04 [2019-09-16T14:50:04.388Z]     daemon.go:288: [d1a477a36483d] exiting daemon
14:50:04 [2019-09-16T14:50:04.388Z]     daemon.go:436: [d1a477a36483d] Daemon stopped
14:50:04 [2019-09-16T14:50:04.388Z] === RUN   TestServiceUpdateNetwork
14:50:18 [2019-09-16T14:50:18.265Z] --- PASS: TestServiceUpdateNetwork (14.55s)
14:50:18 [2019-09-16T14:50:18.265Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork
14:50:18 [2019-09-16T14:50:18.265Z]     daemon.go:321: [d640c57a1f5ed] waiting for daemon to start
14:50:18 [2019-09-16T14:50:18.265Z]     daemon.go:339: [d640c57a1f5ed] daemon started
14:50:18 [2019-09-16T14:50:18.265Z]     daemon.go:449: [d640c57a1f5ed] Stopping daemon
14:50:18 [2019-09-16T14:50:18.265Z]     daemon.go:288: [d640c57a1f5ed] exiting daemon
14:50:18 [2019-09-16T14:50:18.265Z]     daemon.go:436: [d640c57a1f5ed] Daemon stopped
14:50:18 [2019-09-16T14:50:18.265Z] PASS
14:50:18 [2019-09-16T14:50:18.265Z] Running /go/src/github.com/docker/docker/integration/session flags=-test.v -test.timeout=120m  
14:50:18 [2019-09-16T14:50:18.265Z] INFO: Testing against a local daemon
14:50:18 [2019-09-16T14:50:18.265Z] === RUN   TestSessionCreate
14:50:18 [2019-09-16T14:50:18.265Z] --- PASS: TestSessionCreate (0.02s)
14:50:18 [2019-09-16T14:50:18.265Z] === RUN   TestSessionCreateWithBadUpgrade
14:50:18 [2019-09-16T14:50:18.265Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
14:50:18 [2019-09-16T14:50:18.265Z] PASS
14:50:18 [2019-09-16T14:50:18.265Z] Running /go/src/github.com/docker/docker/integration/system flags=-test.v -test.timeout=120m  
14:50:18 [2019-09-16T14:50:18.265Z] INFO: Testing against a local daemon
14:50:18 [2019-09-16T14:50:18.265Z] === RUN   TestCgroupDriverSystemdMemoryLimit
14:50:18 [2019-09-16T14:50:18.265Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
14:50:18 [2019-09-16T14:50:18.265Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
14:50:18 [2019-09-16T14:50:18.265Z] === RUN   TestEventsExecDie
14:50:18 [2019-09-16T14:50:18.629Z] --- PASS: TestEventsExecDie (0.98s)
14:50:18 [2019-09-16T14:50:18.629Z] === RUN   TestEventsBackwardsCompatible
14:50:18 [2019-09-16T14:50:18.629Z] --- PASS: TestEventsBackwardsCompatible (0.11s)
14:50:18 [2019-09-16T14:50:18.629Z] === RUN   TestInfoBinaryCommits
14:50:18 [2019-09-16T14:50:18.629Z] --- PASS: TestInfoBinaryCommits (0.03s)
14:50:18 [2019-09-16T14:50:18.629Z] === RUN   TestInfoAPIVersioned
14:50:19 [2019-09-16T14:50:19.009Z] --- PASS: TestInfoAPIVersioned (0.02s)
14:50:19 [2019-09-16T14:50:19.009Z] === RUN   TestInfoAPI
14:50:19 [2019-09-16T14:50:19.009Z] --- PASS: TestInfoAPI (0.03s)
14:50:19 [2019-09-16T14:50:19.009Z] === RUN   TestInfoAPIWarnings
14:50:19 [2019-09-16T14:50:19.794Z] --- PASS: TestInfoAPIWarnings (0.90s)
14:50:19 [2019-09-16T14:50:19.794Z]     info_test.go:49: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings
14:50:19 [2019-09-16T14:50:19.794Z]     daemon.go:321: [d51af3298976b] waiting for daemon to start
14:50:19 [2019-09-16T14:50:19.794Z]     daemon.go:339: [d51af3298976b] daemon started
14:50:19 [2019-09-16T14:50:19.794Z]     daemon.go:449: [d51af3298976b] Stopping daemon
14:50:19 [2019-09-16T14:50:19.794Z]     daemon.go:288: [d51af3298976b] exiting daemon
14:50:19 [2019-09-16T14:50:19.794Z]     daemon.go:436: [d51af3298976b] Daemon stopped
14:50:19 [2019-09-16T14:50:19.794Z] === RUN   TestLoginFailsWithBadCredentials
14:50:20 [2019-09-16T14:50:20.169Z] --- PASS: TestLoginFailsWithBadCredentials (0.38s)
14:50:20 [2019-09-16T14:50:20.169Z] === RUN   TestPingCacheHeaders
14:50:20 [2019-09-16T14:50:20.169Z] --- PASS: TestPingCacheHeaders (0.03s)
14:50:20 [2019-09-16T14:50:20.169Z] === RUN   TestPingGet
14:50:20 [2019-09-16T14:50:20.169Z] --- PASS: TestPingGet (0.01s)
14:50:20 [2019-09-16T14:50:20.169Z] === RUN   TestPingHead
14:50:20 [2019-09-16T14:50:20.169Z] --- PASS: TestPingHead (0.02s)
14:50:20 [2019-09-16T14:50:20.169Z] === RUN   TestVersion
14:50:20 [2019-09-16T14:50:20.169Z] --- PASS: TestVersion (0.02s)
14:50:20 [2019-09-16T14:50:20.169Z] PASS
14:50:20 [2019-09-16T14:50:20.169Z] Running /go/src/github.com/docker/docker/integration/volume flags=-test.v -test.timeout=120m  
14:50:20 [2019-09-16T14:50:20.551Z] INFO: Testing against a local daemon
14:50:20 [2019-09-16T14:50:20.551Z] === RUN   TestVolumesCreateAndList
14:50:20 [2019-09-16T14:50:20.551Z] --- PASS: TestVolumesCreateAndList (0.04s)
14:50:20 [2019-09-16T14:50:20.551Z] === RUN   TestVolumesRemove
14:50:20 [2019-09-16T14:50:20.551Z] --- PASS: TestVolumesRemove (0.10s)
14:50:20 [2019-09-16T14:50:20.551Z] === RUN   TestVolumesInspect
14:50:20 [2019-09-16T14:50:20.551Z] --- PASS: TestVolumesInspect (0.02s)
14:50:20 [2019-09-16T14:50:20.551Z] === RUN   TestVolumesInvalidJSON
14:50:20 [2019-09-16T14:50:20.551Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:50:20 [2019-09-16T14:50:20.551Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:50:20 [2019-09-16T14:50:20.551Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:50:20 [2019-09-16T14:50:20.551Z] --- PASS: TestVolumesInvalidJSON (0.01s)
14:50:20 [2019-09-16T14:50:20.551Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:50:20 [2019-09-16T14:50:20.551Z] PASS
14:50:20 [2019-09-16T14:50:20.551Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
14:50:22 [2019-09-16T14:50:22.337Z] umount: bundles/test-integration/root: mountpoint not found
14:50:22 [2019-09-16T14:50:22.337Z] Clearing AppArmor profiles cache:.
14:50:22 [2019-09-16T14:50:22.337Z] All profile caches have been cleared, but no profiles have been unloaded.
14:50:22 [2019-09-16T14:50:22.337Z] Unloading profiles will leave already running processes permanently
14:50:22 [2019-09-16T14:50:22.337Z] unconfined, which can lead to unexpected situations.
14:50:22 [2019-09-16T14:50:22.337Z] 
14:50:22 [2019-09-16T14:50:22.337Z] To set a process to complain mode, use the command line tool
14:50:22 [2019-09-16T14:50:22.337Z] 'aa-complain'. To really tear down all profiles, run the init script
14:50:22 [2019-09-16T14:50:22.337Z] with the 'teardown' option."
14:50:22 [2019-09-16T14:50:22.337Z] Removing test suite binaries
14:50:22 [2019-09-16T14:50:22.337Z]