Skip to content

Console Output

18:05:50 [2019-10-03T18:05:50.549Z] + docker run --rm -t --privileged -v /home/docker/workspace/engine_18.09/bundles:/go/src/github.com/docker/docker/bundles --name docker-pr22 -e DOCKER_EXPERIMENTAL -e DOCKER_GITCOMMIT=f50bff1e2c4d15e59e5b08dc810eecef5e5b240e -e DOCKER_GRAPHDRIVER -e TEST_SKIP_INTEGRATION_CLI -e TIMEOUT docker:f50bff1e2c4d15e59e5b08dc810eecef5e5b240e hack/make.sh dynbinary test-integration
18:05:51 [2019-10-03T18:05:51.170Z] 
18:05:51 [2019-10-03T18:05:51.170Z] Removing bundles/
18:05:51 [2019-10-03T18:05:51.170Z] 
18:05:51 [2019-10-03T18:05:51.170Z] ---> Making bundle: dynbinary (in bundles/dynbinary)
18:05:51 [2019-10-03T18:05:51.170Z] Building: bundles/dynbinary-daemon/dockerd-dev
18:05:51 [2019-10-03T18:05:51.170Z] GOOS="" GOARCH="" GOARM=""
18:07:43 [2019-10-03T18:07:43.374Z] Created binary: bundles/dynbinary-daemon/dockerd-dev
18:07:43 [2019-10-03T18:07:43.374Z] 
18:07:43 [2019-10-03T18:07:43.374Z] ---> Making bundle: test-integration (in bundles/test-integration)
18:07:43 [2019-10-03T18:07:43.658Z] PKG_CONFIG=pkg-config
18:07:43 [2019-10-03T18:07:43.658Z] GOLANG_VERSION=1.12.10
18:07:43 [2019-10-03T18:07:43.658Z] HOSTNAME=3b8bc930e546
18:07:43 [2019-10-03T18:07:43.658Z] DOCKER_EXPERIMENTAL=1
18:07:43 [2019-10-03T18:07:43.658Z] container=docker
18:07:43 [2019-10-03T18:07:43.658Z] TEST_SKIP_INTEGRATION_CLI=1
18:07:43 [2019-10-03T18:07:43.658Z] GOMETALINTER_OPTS=--deadline=2m
18:07:43 [2019-10-03T18:07:43.658Z] GOPATH=/go
18:07:43 [2019-10-03T18:07:43.658Z] PWD=/go/src/github.com/docker/docker
18:07:43 [2019-10-03T18:07:43.658Z] HOME=/root
18:07:43 [2019-10-03T18:07:43.658Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
18:07:43 [2019-10-03T18:07:43.658Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
18:07:43 [2019-10-03T18:07:43.658Z] DOCKER_GITCOMMIT=f50bff1e2c4d15e59e5b08dc810eecef5e5b240e
18:07:43 [2019-10-03T18:07:43.658Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
18:07:43 [2019-10-03T18:07:43.658Z] DOCKER_GRAPHDRIVER=overlay2
18:07:43 [2019-10-03T18:07:43.658Z] TERM=xterm
18:07:43 [2019-10-03T18:07:43.658Z] DEST=bundles/test-integration
18:07:43 [2019-10-03T18:07:43.658Z] SHLVL=1
18:07:43 [2019-10-03T18:07:43.658Z] TIMEOUT=120m
18:07:43 [2019-10-03T18:07:43.658Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
18:07:43 [2019-10-03T18:07:43.658Z] DOCKER_PKG=github.com/docker/docker
18:07:43 [2019-10-03T18:07:43.658Z] _=/usr/bin/env
18:07:43 [2019-10-03T18:07:43.658Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
18:08:40 [2019-10-03T18:08:40.599Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
18:08:40 [2019-10-03T18:08:40.599Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
18:08:40 [2019-10-03T18:08:40.599Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
18:08:42 [2019-10-03T18:08:42.838Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
18:08:44 [2019-10-03T18:08:44.878Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
18:08:47 [2019-10-03T18:08:47.597Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
18:08:49 [2019-10-03T18:08:49.654Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
18:08:49 [2019-10-03T18:08:49.940Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
18:08:54 [2019-10-03T18:08:54.376Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
18:08:55 [2019-10-03T18:08:55.891Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
18:09:01 [2019-10-03T18:09:01.446Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
18:09:14 [2019-10-03T18:09:14.055Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
18:09:17 [2019-10-03T18:09:17.578Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
18:09:19 [2019-10-03T18:09:19.619Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
18:09:24 [2019-10-03T18:09:24.033Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
18:09:25 [2019-10-03T18:09:25.516Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
18:09:28 [2019-10-03T18:09:28.220Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
18:09:30 [2019-10-03T18:09:30.254Z] ---> Making bundle: .integration-daemon-start (in bundles/test-integration)
18:09:30 [2019-10-03T18:09:30.255Z] Using test binary docker
18:09:30 [2019-10-03T18:09:30.255Z] # DOCKER_EXPERIMENTAL is set: starting daemon with experimental features enabled! 
18:09:30 [2019-10-03T18:09:30.255Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
18:09:30 [2019-10-03T18:09:30.255Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
18:09:30 [2019-10-03T18:09:30.255Z] Warning failed to create cache: (null)
18:09:30 [2019-10-03T18:09:30.255Z] .
18:09:30 [2019-10-03T18:09:30.255Z] INFO: Waiting for daemon to start...
18:09:30 [2019-10-03T18:09:30.255Z] Starting dockerd
18:09:32 [2019-10-03T18:09:32.279Z] .
18:09:32 [2019-10-03T18:09:32.279Z] ---> Making bundle: .integration-daemon-setup (in bundles/test-integration)
18:09:32 [2019-10-03T18:09:32.279Z] ---> Making bundle: .ensure-emptyfs (in bundles/test-integration)
18:09:32 [2019-10-03T18:09:32.279Z] Error: No such image: emptyfs
18:09:32 [2019-10-03T18:09:32.575Z] Running integration-test (iteration 1)
18:09:32 [2019-10-03T18:09:32.575Z] Running /go/src/github.com/docker/docker/integration/build flags=-test.v -test.timeout=120m  
18:09:47 [2019-10-03T18:09:47.915Z] Loaded image: buildpack-deps:jessie
18:09:47 [2019-10-03T18:09:47.915Z] Loaded image: busybox:latest
18:09:47 [2019-10-03T18:09:47.915Z] Loaded image: busybox:glibc
18:09:47 [2019-10-03T18:09:47.915Z] Loaded image: debian:jessie
18:09:47 [2019-10-03T18:09:47.915Z] Loaded image: hello-world:latest
18:09:47 [2019-10-03T18:09:47.915Z] INFO: Testing against a local daemon
18:09:47 [2019-10-03T18:09:47.915Z] === RUN   TestBuildWithSession
18:09:51 [2019-10-03T18:09:51.415Z] --- PASS: TestBuildWithSession (3.49s)
18:09:51 [2019-10-03T18:09:51.415Z]     build_session_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestBuildWithSession
18:09:51 [2019-10-03T18:09:51.415Z]     daemon.go:302: [dc0afca82ab9d] waiting for daemon to start
18:09:51 [2019-10-03T18:09:51.415Z]     daemon.go:334: [dc0afca82ab9d] daemon started
18:09:51 [2019-10-03T18:09:51.415Z]     daemon.go:286: [dc0afca82ab9d] exiting daemon
18:09:51 [2019-10-03T18:09:51.415Z] === RUN   TestBuildSquashParent
18:09:58 [2019-10-03T18:09:58.231Z] --- PASS: TestBuildSquashParent (6.55s)
18:09:58 [2019-10-03T18:09:58.231Z]     build_squash_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestBuildSquashParent
18:09:58 [2019-10-03T18:09:58.231Z]     daemon.go:302: [d9466c8a19992] waiting for daemon to start
18:09:58 [2019-10-03T18:09:58.231Z]     daemon.go:334: [d9466c8a19992] daemon started
18:09:58 [2019-10-03T18:09:58.231Z]     daemon.go:286: [d9466c8a19992] exiting daemon
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:09:58 [2019-10-03T18:09:58.231Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:09:58 [2019-10-03T18:09:58.231Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:09:58 [2019-10-03T18:09:58.231Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
18:09:58 [2019-10-03T18:09:58.231Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
18:09:58 [2019-10-03T18:09:58.231Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
18:09:58 [2019-10-03T18:09:58.231Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
18:10:01 [2019-10-03T18:10:01.753Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
18:10:01 [2019-10-03T18:10:01.753Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
18:10:03 [2019-10-03T18:10:03.785Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.02s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (3.31s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (3.60s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (3.74s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (3.85s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (2.09s)
18:10:03 [2019-10-03T18:10:03.786Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (1.98s)
18:10:03 [2019-10-03T18:10:03.786Z] === RUN   TestBuildMultiStageParentConfig
18:10:36 [2019-10-03T18:10:36.311Z] --- PASS: TestBuildMultiStageParentConfig (31.10s)
18:10:36 [2019-10-03T18:10:36.311Z]     build_test.go:175: [{-1 1570126204 sha256:9612b059a52615e4c5ee850ccd656bd0506de35fdf6139627355a24b02bc572d map[] sha256:1036b9254c5c39dea9ba3bb1edd77b39c12dc45f91df29eaeca3d94de0c93c2d [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126204 sha256:1bef6a2886431a90b98c6a9ab94b0f8a33084092c21c0c9a96906c1502b5e3e2 map[] sha256:a7bafb10ca6d1bf1c0c27b4b1bc359e7a0efde1b1b9cdcc1e770229e64fec05f [] [build1:latest] -1 4807485 4807485} {-1 1570126202 sha256:3243afa2c0d3eda17c7bbeb06995ff60e7f20c808642fec4a03a0863f958896e map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126202 sha256:a706784d775e39754c8fecb64033ab06f2d24734e7d4c4d022bcd2e1a1f3f974 map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126200 sha256:30c65fb8e8c0759a2fa88db3332e1db4036bba75fc15ef6835bba52cbd373cf8 map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126199 sha256:55bf1a46d30265e71ca073db9736c32e552da8f5c8037360ad4d56db9f4170dc map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126199 sha256:01d30f753b41790720e4d037aa6c7c29621099971aa59b446d4f95871ad2deee map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1570126199 sha256:4d91c0f70093ab7eefc6f86590c8e51efdb9a0470d12b3dcead36a8e783011d2 map[] sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 [<none>@<none>] [<none>:<none>] -1 4807485 4807485} {-1 1516819588 sha256:d12e8bfe0af697eb3cba07724f25d85fec150d7046b08359491939f7dcbf7d67 map[]  [] [busybox:glibc] -1 4873045 4873045} {-1 1511259801 sha256:39a904c076ffc85abeef8dbb200513e3c4c83fb085656e11b530998e58a5dab6 map[]  [] [hello-world:frozen] -1 65872 65872} {-1 1509644787 sha256:f4279da41337a9ba1488d945c0a04271f1bb9ddaf7831deefff8db201bf21381 map[]  [] [busybox:latest] -1 4807485 4807485} {-1 1509640471 sha256:ca7ff5204daea1f006dd998fbb4546c8bace764ce28594de2c7a3576ef0c4c54 map[]  [] [buildpack-deps:jessie] -1 620822854 620822854} {-1 1507585373 sha256:bbc5e06449ba698238017ac07e630080c1e5096a7ca4d4643705a58ddc4631c1 map[]  [] [debian:jessie] -1 127966408 127966408} {-1 1371157430 sha256:11f64303f0f7ffdc71f001788132bca5346831939a956e3e975c93267d89a16d map[]  [] [emptyfs:latest] -1 0 0}]
18:10:36 [2019-10-03T18:10:36.311Z] === RUN   TestBuildLabelWithTargets
18:10:36 [2019-10-03T18:10:36.311Z] --- PASS: TestBuildLabelWithTargets (1.69s)
18:10:36 [2019-10-03T18:10:36.311Z] === RUN   TestBuildWithEmptyLayers
18:10:37 [2019-10-03T18:10:37.346Z] --- PASS: TestBuildWithEmptyLayers (0.89s)
18:10:37 [2019-10-03T18:10:37.346Z] === RUN   TestBuildMultiStageOnBuild
18:10:40 [2019-10-03T18:10:40.038Z] --- PASS: TestBuildMultiStageOnBuild (2.43s)
18:10:40 [2019-10-03T18:10:40.038Z] === RUN   TestBuildUncleanTarFilenames
18:10:41 [2019-10-03T18:10:41.062Z] --- PASS: TestBuildUncleanTarFilenames (1.28s)
18:10:41 [2019-10-03T18:10:41.062Z] === RUN   TestBuildMultiStageLayerLeak
18:10:43 [2019-10-03T18:10:43.818Z] --- PASS: TestBuildMultiStageLayerLeak (2.51s)
18:10:43 [2019-10-03T18:10:43.818Z] === RUN   TestBuildWithHugeFile
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestBuildWithHugeFile (86.26s)
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestBuildWithEmptyDockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestBuildWithEmptyDockerfile (0.03s)
18:12:21 [2019-10-03T18:12:21.075Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.36s)
18:12:21 [2019-10-03T18:12:21.075Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.37s)
18:12:21 [2019-10-03T18:12:21.075Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.38s)
18:12:21 [2019-10-03T18:12:21.075Z] PASS
18:12:21 [2019-10-03T18:12:21.075Z] Running /go/src/github.com/docker/docker/integration/config flags=-test.v -test.timeout=120m  
18:12:21 [2019-10-03T18:12:21.075Z] INFO: Testing against a local daemon
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestConfigList
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestConfigList (2.30s)
18:12:21 [2019-10-03T18:12:21.075Z]     config_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigList
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:302: [db9f6ba69b0b0] waiting for daemon to start
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:334: [db9f6ba69b0b0] daemon started
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:286: [db9f6ba69b0b0] exiting daemon
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestConfigsCreateAndDelete
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestConfigsCreateAndDelete (2.30s)
18:12:21 [2019-10-03T18:12:21.075Z]     config_test.go:108: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsCreateAndDelete
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:302: [db5b548e4343b] waiting for daemon to start
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:334: [db5b548e4343b] daemon started
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:286: [db5b548e4343b] exiting daemon
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestConfigsUpdate
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestConfigsUpdate (2.24s)
18:12:21 [2019-10-03T18:12:21.075Z]     config_test.go:136: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigsUpdate
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:302: [d9b1d72bc8ea1] waiting for daemon to start
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:334: [d9b1d72bc8ea1] daemon started
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:286: [d9b1d72bc8ea1] exiting daemon
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestTemplatedConfig
18:12:21 [2019-10-03T18:12:21.075Z] --- PASS: TestTemplatedConfig (3.03s)
18:12:21 [2019-10-03T18:12:21.075Z]     config_test.go:188: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedConfig
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:302: [dfe48a933a61e] waiting for daemon to start
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:334: [dfe48a933a61e] daemon started
18:12:21 [2019-10-03T18:12:21.075Z]     daemon.go:286: [dfe48a933a61e] exiting daemon
18:12:21 [2019-10-03T18:12:21.075Z] === RUN   TestConfigInspect
18:12:22 [2019-10-03T18:12:22.603Z] --- PASS: TestConfigInspect (2.65s)
18:12:22 [2019-10-03T18:12:22.603Z]     config_test.go:330: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigInspect
18:12:22 [2019-10-03T18:12:22.603Z]     daemon.go:302: [db9d88f0f0f31] waiting for daemon to start
18:12:22 [2019-10-03T18:12:22.603Z]     daemon.go:334: [db9d88f0f0f31] daemon started
18:12:22 [2019-10-03T18:12:22.603Z]     daemon.go:286: [db9d88f0f0f31] exiting daemon
18:12:22 [2019-10-03T18:12:22.603Z] === RUN   TestConfigCreateWithLabels
18:12:25 [2019-10-03T18:12:25.326Z] --- PASS: TestConfigCreateWithLabels (2.34s)
18:12:25 [2019-10-03T18:12:25.326Z]     config_test.go:354: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateWithLabels
18:12:25 [2019-10-03T18:12:25.326Z]     daemon.go:302: [d4446e1cdfdb4] waiting for daemon to start
18:12:25 [2019-10-03T18:12:25.326Z]     daemon.go:334: [d4446e1cdfdb4] daemon started
18:12:25 [2019-10-03T18:12:25.326Z]     daemon.go:286: [d4446e1cdfdb4] exiting daemon
18:12:25 [2019-10-03T18:12:25.326Z] === RUN   TestConfigCreateResolve
18:12:27 [2019-10-03T18:12:27.365Z] --- PASS: TestConfigCreateResolve (2.40s)
18:12:27 [2019-10-03T18:12:27.365Z]     config_test.go:381: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestConfigCreateResolve
18:12:27 [2019-10-03T18:12:27.365Z]     daemon.go:302: [d8f994269cabb] waiting for daemon to start
18:12:27 [2019-10-03T18:12:27.365Z]     daemon.go:334: [d8f994269cabb] daemon started
18:12:27 [2019-10-03T18:12:27.365Z]     daemon.go:286: [d8f994269cabb] exiting daemon
18:12:27 [2019-10-03T18:12:27.365Z] PASS
18:12:27 [2019-10-03T18:12:27.365Z] Running /go/src/github.com/docker/docker/integration/container flags=-test.v -test.timeout=120m  
18:12:27 [2019-10-03T18:12:27.649Z] INFO: Testing against a local daemon
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestContainerInvalidJSON
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
18:12:27 [2019-10-03T18:12:27.650Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
18:12:27 [2019-10-03T18:12:27.650Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
18:12:27 [2019-10-03T18:12:27.650Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
18:12:27 [2019-10-03T18:12:27.650Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
18:12:27 [2019-10-03T18:12:27.650Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
18:12:27 [2019-10-03T18:12:27.650Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
18:12:27 [2019-10-03T18:12:27.650Z] --- PASS: TestContainerInvalidJSON (0.02s)
18:12:27 [2019-10-03T18:12:27.650Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
18:12:27 [2019-10-03T18:12:27.650Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
18:12:27 [2019-10-03T18:12:27.650Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestCopyFromContainerPathDoesNotExist
18:12:27 [2019-10-03T18:12:27.650Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.08s)
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestCopyFromContainerPathIsNotDir
18:12:27 [2019-10-03T18:12:27.650Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.09s)
18:12:27 [2019-10-03T18:12:27.650Z] === RUN   TestCopyToContainerPathDoesNotExist
18:12:27 [2019-10-03T18:12:27.949Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.09s)
18:12:27 [2019-10-03T18:12:27.949Z] === RUN   TestCopyToContainerPathIsNotDir
18:12:27 [2019-10-03T18:12:27.949Z] --- PASS: TestCopyToContainerPathIsNotDir (0.13s)
18:12:27 [2019-10-03T18:12:27.949Z] === RUN   TestCopyFromContainer
18:12:29 [2019-10-03T18:12:29.984Z] === RUN   TestCopyFromContainer//
18:12:29 [2019-10-03T18:12:29.984Z] === RUN   TestCopyFromContainer//bar/root
18:12:29 [2019-10-03T18:12:29.984Z] === RUN   TestCopyFromContainer//bar/root/
18:12:29 [2019-10-03T18:12:29.984Z] === RUN   TestCopyFromContainer/bar/quux
18:12:29 [2019-10-03T18:12:29.984Z] === RUN   TestCopyFromContainer/bar/quux/
18:12:30 [2019-10-03T18:12:30.272Z] === RUN   TestCopyFromContainer/bar/quux/baz
18:12:30 [2019-10-03T18:12:30.272Z] === RUN   TestCopyFromContainer/bar/filesymlink
18:12:30 [2019-10-03T18:12:30.557Z] === RUN   TestCopyFromContainer/bar/dirsymlink
18:12:30 [2019-10-03T18:12:30.557Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
18:12:30 [2019-10-03T18:12:30.557Z] === RUN   TestCopyFromContainer/bar/notarget
18:12:30 [2019-10-03T18:12:30.854Z] --- PASS: TestCopyFromContainer (2.82s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer// (0.10s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer//bar/root (0.11s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.10s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/quux (0.12s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.11s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.10s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.11s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.10s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.09s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.10s)
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
18:12:30 [2019-10-03T18:12:30.854Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.02s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateWithInvalidEnv
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateWithInvalidEnv/0
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateWithInvalidEnv/0
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateWithInvalidEnv/1
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateWithInvalidEnv/1
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateWithInvalidEnv/2
18:12:30 [2019-10-03T18:12:30.854Z] === PAUSE TestCreateWithInvalidEnv/2
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateWithInvalidEnv/0
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateWithInvalidEnv/2
18:12:30 [2019-10-03T18:12:30.854Z] === CONT  TestCreateWithInvalidEnv/1
18:12:30 [2019-10-03T18:12:30.854Z] --- PASS: TestCreateWithInvalidEnv (0.02s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateTmpfsMountsTarget
18:12:30 [2019-10-03T18:12:30.854Z] --- PASS: TestCreateTmpfsMountsTarget (0.04s)
18:12:30 [2019-10-03T18:12:30.854Z] === RUN   TestCreateWithCustomMaskedPaths
18:12:33 [2019-10-03T18:12:33.561Z] --- PASS: TestCreateWithCustomMaskedPaths (2.23s)
18:12:33 [2019-10-03T18:12:33.561Z] === RUN   TestCreateWithCustomReadonlyPaths
18:12:35 [2019-10-03T18:12:35.610Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.14s)
18:12:35 [2019-10-03T18:12:35.610Z] === RUN   TestContainerStartOnDaemonRestart
18:12:35 [2019-10-03T18:12:35.610Z] === PAUSE TestContainerStartOnDaemonRestart
18:12:35 [2019-10-03T18:12:35.610Z] === RUN   TestDaemonRestartIpcMode
18:12:35 [2019-10-03T18:12:35.610Z] === PAUSE TestDaemonRestartIpcMode
18:12:35 [2019-10-03T18:12:35.610Z] === RUN   TestDiff
18:12:35 [2019-10-03T18:12:35.919Z] --- PASS: TestDiff (0.73s)
18:12:35 [2019-10-03T18:12:35.919Z] === RUN   TestExecWithCloseStdin
18:12:36 [2019-10-03T18:12:36.949Z] --- PASS: TestExecWithCloseStdin (1.01s)
18:12:36 [2019-10-03T18:12:36.949Z] === RUN   TestExec
18:12:37 [2019-10-03T18:12:37.972Z] --- PASS: TestExec (0.93s)
18:12:37 [2019-10-03T18:12:37.972Z] === RUN   TestExecUser
18:12:38 [2019-10-03T18:12:38.991Z] --- PASS: TestExecUser (0.90s)
18:12:38 [2019-10-03T18:12:38.991Z] === RUN   TestExportContainerAndImportImage
18:12:40 [2019-10-03T18:12:40.002Z] --- PASS: TestExportContainerAndImportImage (1.07s)
18:12:40 [2019-10-03T18:12:40.002Z] === RUN   TestExportContainerAfterDaemonRestart
18:12:41 [2019-10-03T18:12:41.492Z] --- PASS: TestExportContainerAfterDaemonRestart (1.61s)
18:12:41 [2019-10-03T18:12:41.492Z]     export_test.go:63: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExportContainerAfterDaemonRestart
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:302: [d1253fa26b607] waiting for daemon to start
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:334: [d1253fa26b607] daemon started
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:286: [d1253fa26b607] exiting daemon
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:302: [d1253fa26b607] waiting for daemon to start
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:334: [d1253fa26b607] daemon started
18:12:41 [2019-10-03T18:12:41.492Z]     daemon.go:286: [d1253fa26b607] exiting daemon
18:12:41 [2019-10-03T18:12:41.492Z] === RUN   TestHealthCheckWorkdir
18:12:42 [2019-10-03T18:12:42.515Z] --- PASS: TestHealthCheckWorkdir (1.09s)
18:12:42 [2019-10-03T18:12:42.515Z] === RUN   TestHealthKillContainer
18:12:46 [2019-10-03T18:12:46.002Z] --- PASS: TestHealthKillContainer (2.88s)
18:12:46 [2019-10-03T18:12:46.002Z] === RUN   TestInspectCpusetInConfigPre120
18:12:46 [2019-10-03T18:12:46.319Z] --- PASS: TestInspectCpusetInConfigPre120 (0.84s)
18:12:46 [2019-10-03T18:12:46.319Z] === RUN   TestIpcModeNone
18:12:47 [2019-10-03T18:12:47.332Z] --- PASS: TestIpcModeNone (0.92s)
18:12:47 [2019-10-03T18:12:47.332Z] === RUN   TestIpcModePrivate
18:12:48 [2019-10-03T18:12:48.350Z] --- PASS: TestIpcModePrivate (0.99s)
18:12:48 [2019-10-03T18:12:48.350Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:55, shared: false, mustBeShared: false
18:12:48 [2019-10-03T18:12:48.350Z] === RUN   TestIpcModeShareable
18:12:49 [2019-10-03T18:12:49.364Z] --- PASS: TestIpcModeShareable (0.92s)
18:12:49 [2019-10-03T18:12:49.364Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:49, shared: true, mustBeShared: true
18:12:49 [2019-10-03T18:12:49.364Z] === RUN   TestAPIIpcModeShareableAndContainer
18:12:52 [2019-10-03T18:12:52.082Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.87s)
18:12:52 [2019-10-03T18:12:52.082Z] === RUN   TestAPIIpcModeHost
18:12:52 [2019-10-03T18:12:52.735Z] --- PASS: TestAPIIpcModeHost (0.79s)
18:12:52 [2019-10-03T18:12:52.735Z] === RUN   TestDaemonIpcModeShareable
18:12:54 [2019-10-03T18:12:54.788Z] --- PASS: TestDaemonIpcModeShareable (1.83s)
18:12:54 [2019-10-03T18:12:54.788Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareable
18:12:54 [2019-10-03T18:12:54.788Z]     daemon.go:302: [d25bed38153ec] waiting for daemon to start
18:12:54 [2019-10-03T18:12:54.788Z]     daemon.go:334: [d25bed38153ec] daemon started
18:12:54 [2019-10-03T18:12:54.788Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:57, shared: true, mustBeShared: true
18:12:54 [2019-10-03T18:12:54.788Z]     daemon.go:286: [d25bed38153ec] exiting daemon
18:12:54 [2019-10-03T18:12:54.788Z] === RUN   TestDaemonIpcModePrivate
18:12:56 [2019-10-03T18:12:56.823Z] --- PASS: TestDaemonIpcModePrivate (1.85s)
18:12:56 [2019-10-03T18:12:56.823Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivate
18:12:56 [2019-10-03T18:12:56.823Z]     daemon.go:302: [d27a277b8929c] waiting for daemon to start
18:12:56 [2019-10-03T18:12:56.823Z]     daemon.go:334: [d27a277b8929c] daemon started
18:12:56 [2019-10-03T18:12:56.823Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:63, shared: false, mustBeShared: false
18:12:56 [2019-10-03T18:12:56.823Z]     daemon.go:286: [d27a277b8929c] exiting daemon
18:12:56 [2019-10-03T18:12:56.823Z] === RUN   TestDaemonIpcModePrivateFromConfig
18:12:58 [2019-10-03T18:12:58.323Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.83s)
18:12:58 [2019-10-03T18:12:58.323Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModePrivateFromConfig
18:12:58 [2019-10-03T18:12:58.323Z]     daemon.go:302: [de3cfde520db0] waiting for daemon to start
18:12:58 [2019-10-03T18:12:58.323Z]     daemon.go:334: [de3cfde520db0] daemon started
18:12:58 [2019-10-03T18:12:58.323Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:63, shared: false, mustBeShared: false
18:12:58 [2019-10-03T18:12:58.323Z]     daemon.go:286: [de3cfde520db0] exiting daemon
18:12:58 [2019-10-03T18:12:58.323Z] === RUN   TestDaemonIpcModeShareableFromConfig
18:13:00 [2019-10-03T18:13:00.373Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.87s)
18:13:00 [2019-10-03T18:13:00.373Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonIpcModeShareableFromConfig
18:13:00 [2019-10-03T18:13:00.373Z]     daemon.go:302: [d450177f1632a] waiting for daemon to start
18:13:00 [2019-10-03T18:13:00.373Z]     daemon.go:334: [d450177f1632a] daemon started
18:13:00 [2019-10-03T18:13:00.373Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:57, shared: true, mustBeShared: true
18:13:00 [2019-10-03T18:13:00.373Z]     daemon.go:286: [d450177f1632a] exiting daemon
18:13:00 [2019-10-03T18:13:00.373Z] === RUN   TestKillContainerInvalidSignal
18:13:00 [2019-10-03T18:13:00.988Z] --- PASS: TestKillContainerInvalidSignal (0.70s)
18:13:00 [2019-10-03T18:13:00.988Z] === RUN   TestKillContainer
18:13:00 [2019-10-03T18:13:00.988Z] === RUN   TestKillContainer/no_signal
18:13:01 [2019-10-03T18:13:01.605Z] === RUN   TestKillContainer/non_killing_signal
18:13:02 [2019-10-03T18:13:02.229Z] === RUN   TestKillContainer/killing_signal
18:13:03 [2019-10-03T18:13:03.242Z] --- PASS: TestKillContainer (2.35s)
18:13:03 [2019-10-03T18:13:03.242Z]     --- PASS: TestKillContainer/no_signal (0.71s)
18:13:03 [2019-10-03T18:13:03.242Z]     --- PASS: TestKillContainer/non_killing_signal (0.48s)
18:13:03 [2019-10-03T18:13:03.242Z]     --- PASS: TestKillContainer/killing_signal (0.82s)
18:13:03 [2019-10-03T18:13:03.242Z] === RUN   TestKillWithStopSignalAndRestartPolicies
18:13:03 [2019-10-03T18:13:03.242Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
18:13:04 [2019-10-03T18:13:04.257Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
18:13:04 [2019-10-03T18:13:04.886Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.61s)
18:13:04 [2019-10-03T18:13:04.886Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.81s)
18:13:04 [2019-10-03T18:13:04.886Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.53s)
18:13:04 [2019-10-03T18:13:04.886Z] === RUN   TestKillStoppedContainer
18:13:04 [2019-10-03T18:13:04.886Z] --- PASS: TestKillStoppedContainer (0.07s)
18:13:04 [2019-10-03T18:13:04.886Z] === RUN   TestKillStoppedContainerAPIPre120
18:13:04 [2019-10-03T18:13:04.886Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.07s)
18:13:04 [2019-10-03T18:13:04.886Z] === RUN   TestKillDifferentUserContainer
18:13:05 [2019-10-03T18:13:05.916Z] --- PASS: TestKillDifferentUserContainer (0.80s)
18:13:05 [2019-10-03T18:13:05.916Z] === RUN   TestInspectOomKilledTrue
18:13:07 [2019-10-03T18:13:07.411Z] --- PASS: TestInspectOomKilledTrue (1.33s)
18:13:07 [2019-10-03T18:13:07.411Z] === RUN   TestInspectOomKilledFalse
18:13:07 [2019-10-03T18:13:07.697Z] --- PASS: TestInspectOomKilledFalse (0.70s)
18:13:07 [2019-10-03T18:13:07.697Z] === RUN   TestLinksEtcHostsContentMatch
18:13:08 [2019-10-03T18:13:08.722Z] --- PASS: TestLinksEtcHostsContentMatch (0.70s)
18:13:08 [2019-10-03T18:13:08.723Z] === RUN   TestLinksContainerNames
18:13:10 [2019-10-03T18:13:10.208Z] --- PASS: TestLinksContainerNames (1.54s)
18:13:10 [2019-10-03T18:13:10.209Z] === RUN   TestLogsFollowTailEmpty
18:13:10 [2019-10-03T18:13:10.839Z] --- PASS: TestLogsFollowTailEmpty (0.85s)
18:13:10 [2019-10-03T18:13:10.839Z] === RUN   TestContainerNetworkMountsNoChown
18:13:11 [2019-10-03T18:13:11.858Z] --- PASS: TestContainerNetworkMountsNoChown (0.81s)
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/default
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/default
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/private
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/private
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rprivate
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rprivate
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/slave
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/slave
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rslave
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rslave
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/shared
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/shared
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rshared
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rshared
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/default
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/shared
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rshared
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rslave
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/default/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/shared/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/default/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rslave/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/default/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/shared/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/default/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rslave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/default/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/shared/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rshared/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/default/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/shared/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rprivate
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/private
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/private/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/private/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/private/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/private/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/private/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/private/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/slave
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/slave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/slave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/slave/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/slave/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rshared/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rslave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rslave/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/default/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/private/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/default/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/default/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/default/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/shared/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/slave/mount_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/private/mount_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/private/bind_subpath
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/private/bind_root
18:13:11 [2019-10-03T18:13:11.858Z] === CONT  TestMountDaemonRoot/slave/bind_root
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/shared/mount_root
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/rshared/bind_root
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/rshared/mount_root
18:13:12 [2019-10-03T18:13:12.140Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
18:13:12 [2019-10-03T18:13:12.140Z] --- PASS: TestMountDaemonRoot (0.03s)
18:13:12 [2019-10-03T18:13:12.140Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.09s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.09s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.09s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.10s)
18:13:12 [2019-10-03T18:13:12.140Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.06s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.07s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.05s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
18:13:12 [2019-10-03T18:13:12.140Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.03s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.02s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.05s)
18:13:12 [2019-10-03T18:13:12.140Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.03s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.09s)
18:13:12 [2019-10-03T18:13:12.140Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.10s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.09s)
18:13:12 [2019-10-03T18:13:12.141Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.03s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.05s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.05s)
18:13:12 [2019-10-03T18:13:12.141Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.13s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.11s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.11s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.11s)
18:13:12 [2019-10-03T18:13:12.141Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.04s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.09s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.06s)
18:13:12 [2019-10-03T18:13:12.141Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.04s)
18:13:12 [2019-10-03T18:13:12.141Z] === RUN   TestNetworkNat
18:13:13 [2019-10-03T18:13:13.154Z] --- PASS: TestNetworkNat (0.81s)
18:13:13 [2019-10-03T18:13:13.154Z] === RUN   TestNetworkLocalhostTCPNat
18:13:13 [2019-10-03T18:13:13.774Z] --- PASS: TestNetworkLocalhostTCPNat (0.79s)
18:13:13 [2019-10-03T18:13:13.774Z] === RUN   TestNetworkLoopbackNat
18:13:14 [2019-10-03T18:13:14.796Z] --- PASS: TestNetworkLoopbackNat (1.04s)
18:13:14 [2019-10-03T18:13:14.796Z] === RUN   TestPause
18:13:15 [2019-10-03T18:13:15.816Z] --- PASS: TestPause (0.76s)
18:13:15 [2019-10-03T18:13:15.816Z] === RUN   TestPauseFailsOnWindowsServerContainers
18:13:15 [2019-10-03T18:13:15.816Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
18:13:15 [2019-10-03T18:13:15.816Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
18:13:15 [2019-10-03T18:13:15.816Z] === RUN   TestPauseStopPausedContainer
18:13:16 [2019-10-03T18:13:16.437Z] --- PASS: TestPauseStopPausedContainer (0.83s)
18:13:16 [2019-10-03T18:13:16.437Z] === RUN   TestPsFilter
18:13:16 [2019-10-03T18:13:16.727Z] --- PASS: TestPsFilter (0.25s)
18:13:16 [2019-10-03T18:13:16.728Z] === RUN   TestRemoveContainerWithRemovedVolume
18:13:17 [2019-10-03T18:13:17.346Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.73s)
18:13:17 [2019-10-03T18:13:17.346Z] === RUN   TestRemoveContainerWithVolume
18:13:18 [2019-10-03T18:13:18.361Z] --- PASS: TestRemoveContainerWithVolume (0.74s)
18:13:18 [2019-10-03T18:13:18.361Z] === RUN   TestRemoveContainerRunning
18:13:18 [2019-10-03T18:13:18.987Z] --- PASS: TestRemoveContainerRunning (0.78s)
18:13:18 [2019-10-03T18:13:18.987Z] === RUN   TestRemoveContainerForceRemoveRunning
18:13:19 [2019-10-03T18:13:19.607Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.76s)
18:13:19 [2019-10-03T18:13:19.607Z] === RUN   TestRemoveInvalidContainer
18:13:19 [2019-10-03T18:13:19.607Z] --- PASS: TestRemoveInvalidContainer (0.02s)
18:13:19 [2019-10-03T18:13:19.607Z] === RUN   TestRenameLinkedContainer
18:13:23 [2019-10-03T18:13:23.252Z] --- PASS: TestRenameLinkedContainer (2.91s)
18:13:23 [2019-10-03T18:13:23.252Z] === RUN   TestRenameStoppedContainer
18:13:23 [2019-10-03T18:13:23.252Z] --- PASS: TestRenameStoppedContainer (0.69s)
18:13:23 [2019-10-03T18:13:23.252Z] === RUN   TestRenameRunningContainerAndReuse
18:13:25 [2019-10-03T18:13:25.310Z] --- PASS: TestRenameRunningContainerAndReuse (1.57s)
18:13:25 [2019-10-03T18:13:25.310Z] === RUN   TestRenameInvalidName
18:13:25 [2019-10-03T18:13:25.592Z] --- PASS: TestRenameInvalidName (0.70s)
18:13:25 [2019-10-03T18:13:25.592Z] === RUN   TestRenameAnonymousContainer
18:13:28 [2019-10-03T18:13:28.297Z] --- PASS: TestRenameAnonymousContainer (2.64s)
18:13:28 [2019-10-03T18:13:28.297Z] === RUN   TestRenameContainerWithSameName
18:13:28 [2019-10-03T18:13:28.913Z] --- PASS: TestRenameContainerWithSameName (0.72s)
18:13:28 [2019-10-03T18:13:28.913Z] === RUN   TestRenameContainerWithLinkedContainer
18:13:30 [2019-10-03T18:13:30.404Z] --- PASS: TestRenameContainerWithLinkedContainer (1.36s)
18:13:30 [2019-10-03T18:13:30.404Z] === RUN   TestResize
18:13:31 [2019-10-03T18:13:31.019Z] --- PASS: TestResize (0.70s)
18:13:31 [2019-10-03T18:13:31.019Z] === RUN   TestResizeWithInvalidSize
18:13:31 [2019-10-03T18:13:31.634Z] --- PASS: TestResizeWithInvalidSize (0.70s)
18:13:31 [2019-10-03T18:13:31.634Z] === RUN   TestResizeWhenContainerNotStarted
18:13:32 [2019-10-03T18:13:32.652Z] --- PASS: TestResizeWhenContainerNotStarted (0.67s)
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
18:13:32 [2019-10-03T18:13:32.652Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
18:13:34 [2019-10-03T18:13:34.686Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
18:13:35 [2019-10-03T18:13:35.306Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
18:13:36 [2019-10-03T18:13:36.803Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
18:13:37 [2019-10-03T18:13:37.428Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
18:13:40 [2019-10-03T18:13:40.147Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
18:13:40 [2019-10-03T18:13:40.147Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
18:13:40 [2019-10-03T18:13:40.147Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
18:13:40 [2019-10-03T18:13:40.449Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
18:13:43 [2019-10-03T18:13:43.937Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
18:13:43 [2019-10-03T18:13:43.937Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.22s)
18:13:43 [2019-10-03T18:13:43.937Z]         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
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:302: [dc27ae6765bb1] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:334: [dc27ae6765bb1] daemon started
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:286: [dc27ae6765bb1] exiting daemon
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:302: [dc27ae6765bb1] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:334: [dc27ae6765bb1] daemon started
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:286: [dc27ae6765bb1] exiting daemon
18:13:43 [2019-10-03T18:13:43.937Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (2.86s)
18:13:43 [2019-10-03T18:13:43.937Z]         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
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:302: [dab4c45eb61cd] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:334: [dab4c45eb61cd] daemon started
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:286: [dab4c45eb61cd] exiting daemon
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:302: [dab4c45eb61cd] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:334: [dab4c45eb61cd] daemon started
18:13:43 [2019-10-03T18:13:43.937Z]         daemon.go:286: [dab4c45eb61cd] exiting daemon
18:13:43 [2019-10-03T18:13:43.937Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (4.17s)
18:13:43 [2019-10-03T18:13:43.937Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [dcbcc4f5b3a08] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [dcbcc4f5b3a08] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [dcbcc4f5b3a08] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [dcbcc4f5b3a08] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [dcbcc4f5b3a08] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [dcbcc4f5b3a08] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (4.98s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [dcc12c2facfe2] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [dcc12c2facfe2] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [dcc12c2facfe2] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [dcc12c2facfe2] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [dcc12c2facfe2] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [dcc12c2facfe2] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (2.28s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [ddb9f71df047d] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [ddb9f71df047d] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [ddb9f71df047d] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [ddb9f71df047d] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [ddb9f71df047d] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [ddb9f71df047d] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (4.62s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d715f5034f3b6] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d715f5034f3b6] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d715f5034f3b6] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d715f5034f3b6] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d715f5034f3b6] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d715f5034f3b6] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (3.53s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [df9fd7984341f] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [df9fd7984341f] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [df9fd7984341f] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [df9fd7984341f] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [df9fd7984341f] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [df9fd7984341f] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (5.76s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d37f8fffbdffe] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d37f8fffbdffe] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d37f8fffbdffe] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d37f8fffbdffe] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d37f8fffbdffe] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d37f8fffbdffe] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (2.12s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d445f75a1dafa] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d445f75a1dafa] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d445f75a1dafa] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d445f75a1dafa] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d445f75a1dafa] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d445f75a1dafa] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (2.09s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [da02dcb2fae5e] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [da02dcb2fae5e] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [da02dcb2fae5e] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [da02dcb2fae5e] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [da02dcb2fae5e] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [da02dcb2fae5e] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (3.23s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d1107bb827d09] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d1107bb827d09] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d1107bb827d09] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d1107bb827d09] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d1107bb827d09] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d1107bb827d09] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (3.16s)
18:13:43 [2019-10-03T18:13:43.938Z]         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
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d2f2b543ad955] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d2f2b543ad955] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:302: [d2f2b543ad955] waiting for daemon to start
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d2f2b543ad955] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:334: [d2f2b543ad955] daemon started
18:13:43 [2019-10-03T18:13:43.938Z]         daemon.go:286: [d2f2b543ad955] exiting daemon
18:13:43 [2019-10-03T18:13:43.938Z] === RUN   TestStats
18:13:46 [2019-10-03T18:13:46.180Z] --- PASS: TestStats (2.24s)
18:13:46 [2019-10-03T18:13:46.180Z] === RUN   TestStopContainerWithTimeout
18:13:46 [2019-10-03T18:13:46.180Z] === RUN   TestStopContainerWithTimeout/0
18:13:46 [2019-10-03T18:13:46.180Z] === PAUSE TestStopContainerWithTimeout/0
18:13:46 [2019-10-03T18:13:46.180Z] === RUN   TestStopContainerWithTimeout/1
18:13:46 [2019-10-03T18:13:46.180Z] === PAUSE TestStopContainerWithTimeout/1
18:13:46 [2019-10-03T18:13:46.180Z] === RUN   TestStopContainerWithTimeout/3
18:13:46 [2019-10-03T18:13:46.180Z] === PAUSE TestStopContainerWithTimeout/3
18:13:46 [2019-10-03T18:13:46.180Z] === RUN   TestStopContainerWithTimeout/-1
18:13:46 [2019-10-03T18:13:46.180Z] === PAUSE TestStopContainerWithTimeout/-1
18:13:46 [2019-10-03T18:13:46.180Z] === CONT  TestStopContainerWithTimeout/0
18:13:46 [2019-10-03T18:13:46.180Z] === CONT  TestStopContainerWithTimeout/-1
18:13:46 [2019-10-03T18:13:46.180Z] === CONT  TestStopContainerWithTimeout/1
18:13:46 [2019-10-03T18:13:46.180Z] === CONT  TestStopContainerWithTimeout/3
18:13:49 [2019-10-03T18:13:49.735Z] --- PASS: TestStopContainerWithTimeout (0.02s)
18:13:49 [2019-10-03T18:13:49.735Z]     --- PASS: TestStopContainerWithTimeout/0 (1.50s)
18:13:49 [2019-10-03T18:13:49.735Z]     --- PASS: TestStopContainerWithTimeout/1 (2.11s)
18:13:49 [2019-10-03T18:13:49.735Z]     --- PASS: TestStopContainerWithTimeout/3 (3.21s)
18:13:49 [2019-10-03T18:13:49.735Z]     --- PASS: TestStopContainerWithTimeout/-1 (3.39s)
18:13:49 [2019-10-03T18:13:49.735Z] === RUN   TestDeleteDevicemapper
18:13:49 [2019-10-03T18:13:49.735Z] --- SKIP: TestDeleteDevicemapper (0.00s)
18:13:49 [2019-10-03T18:13:49.735Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
18:13:49 [2019-10-03T18:13:49.735Z] === RUN   TestStopContainerWithRestartPolicyAlways
18:13:52 [2019-10-03T18:13:52.434Z] --- PASS: TestStopContainerWithRestartPolicyAlways (3.14s)
18:13:52 [2019-10-03T18:13:52.434Z] === RUN   TestUpdateMemory
18:13:53 [2019-10-03T18:13:53.450Z] --- PASS: TestUpdateMemory (1.09s)
18:13:53 [2019-10-03T18:13:53.450Z] === RUN   TestUpdateCPUQuota
18:13:54 [2019-10-03T18:13:54.930Z] --- PASS: TestUpdateCPUQuota (1.54s)
18:13:54 [2019-10-03T18:13:54.930Z] === RUN   TestUpdateRestartPolicy
18:14:10 [2019-10-03T18:14:10.207Z] --- PASS: TestUpdateRestartPolicy (12.69s)
18:14:10 [2019-10-03T18:14:10.207Z] === RUN   TestUpdateRestartWithAutoRemove
18:14:10 [2019-10-03T18:14:10.207Z] --- PASS: TestUpdateRestartWithAutoRemove (0.93s)
18:14:10 [2019-10-03T18:14:10.207Z] === CONT  TestDaemonRestartIpcMode
18:14:10 [2019-10-03T18:14:10.207Z] === CONT  TestContainerStartOnDaemonRestart
18:14:12 [2019-10-03T18:14:12.907Z] --- PASS: TestDaemonRestartIpcMode (4.13s)
18:14:12 [2019-10-03T18:14:12.907Z]     daemon_linux_test.go:89: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartIpcMode
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:302: [dab99068e0bb1] waiting for daemon to start
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:334: [dab99068e0bb1] daemon started
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:286: [dab99068e0bb1] exiting daemon
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:302: [dab99068e0bb1] waiting for daemon to start
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:334: [dab99068e0bb1] daemon started
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:286: [dab99068e0bb1] exiting daemon
18:14:12 [2019-10-03T18:14:12.907Z] --- PASS: TestContainerStartOnDaemonRestart (4.20s)
18:14:12 [2019-10-03T18:14:12.907Z]     daemon_linux_test.go:35: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContainerStartOnDaemonRestart
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:302: [dd8d65133bf7d] waiting for daemon to start
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:334: [dd8d65133bf7d] daemon started
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:302: [dd8d65133bf7d] waiting for daemon to start
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:286: [dd8d65133bf7d] exiting daemon
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:334: [dd8d65133bf7d] daemon started
18:14:12 [2019-10-03T18:14:12.907Z]     daemon.go:286: [dd8d65133bf7d] exiting daemon
18:14:12 [2019-10-03T18:14:12.907Z] PASS
18:14:12 [2019-10-03T18:14:12.907Z] Running /go/src/github.com/docker/docker/integration/image flags=-test.v -test.timeout=120m  
18:14:12 [2019-10-03T18:14:12.907Z] INFO: Testing against a local daemon
18:14:12 [2019-10-03T18:14:12.907Z] === RUN   TestCommitInheritsEnv
18:14:13 [2019-10-03T18:14:13.198Z] --- PASS: TestCommitInheritsEnv (0.44s)
18:14:13 [2019-10-03T18:14:13.198Z] === RUN   TestImportExtremelyLargeImageWorks
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestImportExtremelyLargeImageWorks (311.48s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestImagesFilterMultiReference
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestImagesFilterMultiReference (0.05s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestRemoveImageOrphaning
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestRemoveImageOrphaning (0.41s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagUnprefixedRepoByNameOrName
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagInvalidReference
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagInvalidReference (0.02s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagValidPrefixedRepo
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagValidPrefixedRepo (0.11s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagExistedNameWithoutForce
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagExistedNameWithoutForce (0.05s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagOfficialNames
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagOfficialNames (0.10s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestTagMatchesDigest
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestTagMatchesDigest (0.03s)
18:19:35 [2019-10-03T18:19:35.863Z] PASS
18:19:35 [2019-10-03T18:19:35.863Z] Running /go/src/github.com/docker/docker/integration/network flags=-test.v -test.timeout=120m  
18:19:35 [2019-10-03T18:19:35.863Z] INFO: Testing against a local daemon
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestNetworkCreateDelete
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestNetworkCreateDelete (0.21s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestDockerNetworkDeletePreferID
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestDockerNetworkDeletePreferID (0.60s)
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestInspectNetwork
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestInspectNetwork/full_network_id
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestInspectNetwork/partial_network_id
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestInspectNetwork/network_name
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
18:19:35 [2019-10-03T18:19:35.863Z] --- PASS: TestInspectNetwork (8.65s)
18:19:35 [2019-10-03T18:19:35.863Z]     inspect_test.go:18: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspectNetwork
18:19:35 [2019-10-03T18:19:35.863Z]     daemon.go:302: [d911dfb59e956] waiting for daemon to start
18:19:35 [2019-10-03T18:19:35.863Z]     daemon.go:334: [d911dfb59e956] daemon started
18:19:35 [2019-10-03T18:19:35.863Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
18:19:35 [2019-10-03T18:19:35.863Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
18:19:35 [2019-10-03T18:19:35.863Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
18:19:35 [2019-10-03T18:19:35.863Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
18:19:35 [2019-10-03T18:19:35.863Z]     daemon.go:286: [d911dfb59e956] exiting daemon
18:19:35 [2019-10-03T18:19:35.863Z] === RUN   TestRunContainerWithBridgeNone
18:19:37 [2019-10-03T18:19:37.896Z] --- PASS: TestRunContainerWithBridgeNone (2.73s)
18:19:37 [2019-10-03T18:19:37.896Z]     network_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestRunContainerWithBridgeNone
18:19:37 [2019-10-03T18:19:37.896Z]     daemon.go:302: [d028cdabb163c] waiting for daemon to start
18:19:37 [2019-10-03T18:19:37.896Z]     daemon.go:334: [d028cdabb163c] daemon started
18:19:37 [2019-10-03T18:19:37.896Z]     daemon.go:286: [d028cdabb163c] exiting daemon
18:19:37 [2019-10-03T18:19:37.896Z] === RUN   TestNetworkInvalidJSON
18:19:37 [2019-10-03T18:19:37.896Z] === RUN   TestNetworkInvalidJSON//networks/create
18:19:37 [2019-10-03T18:19:37.896Z] === PAUSE TestNetworkInvalidJSON//networks/create
18:19:37 [2019-10-03T18:19:37.896Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
18:19:37 [2019-10-03T18:19:37.896Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
18:19:37 [2019-10-03T18:19:37.896Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
18:19:37 [2019-10-03T18:19:37.896Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
18:19:37 [2019-10-03T18:19:37.896Z] === CONT  TestNetworkInvalidJSON//networks/create
18:19:37 [2019-10-03T18:19:37.896Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
18:19:37 [2019-10-03T18:19:37.896Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
18:19:38 [2019-10-03T18:19:38.195Z] --- PASS: TestNetworkInvalidJSON (0.02s)
18:19:38 [2019-10-03T18:19:38.195Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
18:19:38 [2019-10-03T18:19:38.195Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
18:19:38 [2019-10-03T18:19:38.195Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.01s)
18:19:38 [2019-10-03T18:19:38.195Z] === RUN   TestDaemonRestartWithLiveRestore
18:19:39 [2019-10-03T18:19:39.208Z] --- PASS: TestDaemonRestartWithLiveRestore (1.06s)
18:19:39 [2019-10-03T18:19:39.208Z]     service_test.go:32: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithLiveRestore
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:302: [d0b86603a47bc] waiting for daemon to start
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:334: [d0b86603a47bc] daemon started
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:286: [d0b86603a47bc] exiting daemon
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:302: [d0b86603a47bc] waiting for daemon to start
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:334: [d0b86603a47bc] daemon started
18:19:39 [2019-10-03T18:19:39.208Z]     daemon.go:286: [d0b86603a47bc] exiting daemon
18:19:39 [2019-10-03T18:19:39.208Z] === RUN   TestDaemonDefaultNetworkPools
18:19:39 [2019-10-03T18:19:39.832Z] --- PASS: TestDaemonDefaultNetworkPools (0.81s)
18:19:39 [2019-10-03T18:19:39.832Z]     service_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonDefaultNetworkPools
18:19:39 [2019-10-03T18:19:39.832Z]     daemon.go:302: [d24970319c4e2] waiting for daemon to start
18:19:39 [2019-10-03T18:19:39.832Z]     daemon.go:334: [d24970319c4e2] daemon started
18:19:39 [2019-10-03T18:19:39.832Z]     daemon.go:286: [d24970319c4e2] exiting daemon
18:19:39 [2019-10-03T18:19:39.832Z] === RUN   TestDaemonRestartWithExistingNetwork
18:19:41 [2019-10-03T18:19:41.312Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.20s)
18:19:41 [2019-10-03T18:19:41.312Z]     service_test.go:98: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetwork
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:302: [d7f897c9d15a4] waiting for daemon to start
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:334: [d7f897c9d15a4] daemon started
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:286: [d7f897c9d15a4] exiting daemon
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:302: [d7f897c9d15a4] waiting for daemon to start
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:334: [d7f897c9d15a4] daemon started
18:19:41 [2019-10-03T18:19:41.312Z]     daemon.go:286: [d7f897c9d15a4] exiting daemon
18:19:41 [2019-10-03T18:19:41.312Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
18:19:42 [2019-10-03T18:19:42.807Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.45s)
18:19:42 [2019-10-03T18:19:42.807Z]     service_test.go:131: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:302: [d5b1f456f9711] waiting for daemon to start
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:334: [d5b1f456f9711] daemon started
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:286: [d5b1f456f9711] exiting daemon
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:302: [d5b1f456f9711] waiting for daemon to start
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:334: [d5b1f456f9711] daemon started
18:19:42 [2019-10-03T18:19:42.807Z]     daemon.go:286: [d5b1f456f9711] exiting daemon
18:19:42 [2019-10-03T18:19:42.807Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
18:19:43 [2019-10-03T18:19:43.090Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.57s)
18:19:43 [2019-10-03T18:19:43.090Z]     service_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonWithBipAndDefaultNetworkPool
18:19:43 [2019-10-03T18:19:43.090Z]     daemon.go:302: [d3184c9a351d7] waiting for daemon to start
18:19:43 [2019-10-03T18:19:43.090Z]     daemon.go:334: [d3184c9a351d7] daemon started
18:19:43 [2019-10-03T18:19:43.090Z]     daemon.go:286: [d3184c9a351d7] exiting daemon
18:19:43 [2019-10-03T18:19:43.090Z] === RUN   TestServiceWithPredefinedNetwork
18:19:45 [2019-10-03T18:19:45.770Z] --- PASS: TestServiceWithPredefinedNetwork (2.28s)
18:19:45 [2019-10-03T18:19:45.770Z]     service_test.go:203: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithPredefinedNetwork
18:19:45 [2019-10-03T18:19:45.770Z]     daemon.go:302: [d90ccc97e9271] waiting for daemon to start
18:19:45 [2019-10-03T18:19:45.770Z]     daemon.go:334: [d90ccc97e9271] daemon started
18:19:45 [2019-10-03T18:19:45.770Z]     daemon.go:286: [d90ccc97e9271] exiting daemon
18:19:45 [2019-10-03T18:19:45.770Z] === RUN   TestServiceRemoveKeepsIngressNetwork
18:19:45 [2019-10-03T18:19:45.770Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
18:19:45 [2019-10-03T18:19:45.770Z]     service_test.go:230: FLAKY_TEST
18:19:45 [2019-10-03T18:19:45.770Z] === RUN   TestServiceWithDefaultAddressPoolInit
18:19:50 [2019-10-03T18:19:50.186Z] --- PASS: TestServiceWithDefaultAddressPoolInit (4.73s)
18:19:50 [2019-10-03T18:19:50.186Z]     service_test.go:339: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:302: [d279898bc9eec] waiting for daemon to start
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:334: [d279898bc9eec] daemon started
18:19:50 [2019-10-03T18:19:50.186Z]     service_test.go:364: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:saanvisthiraTestServiceWithDefaultAddressPoolInit ID:nz4s85lkctwi3v8lkiwqfhsvt Created:2019-10-03 18:19:46.410520187 +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[]}
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:286: [d279898bc9eec] exiting daemon
18:19:50 [2019-10-03T18:19:50.186Z]     service_test.go:377: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceWithDefaultAddressPoolInit
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:302: [d9056ea0d1911] waiting for daemon to start
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:334: [d9056ea0d1911] daemon started
18:19:50 [2019-10-03T18:19:50.186Z]     daemon.go:286: [d9056ea0d1911] exiting daemon
18:19:50 [2019-10-03T18:19:50.186Z] PASS
18:19:50 [2019-10-03T18:19:50.186Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan flags=-test.v -test.timeout=120m  
18:19:50 [2019-10-03T18:19:50.186Z] INFO: Testing against a local daemon
18:19:50 [2019-10-03T18:19:50.186Z] === RUN   TestDockerNetworkIpvlanPersistance
18:19:51 [2019-10-03T18:19:51.673Z] --- PASS: TestDockerNetworkIpvlanPersistance (1.54s)
18:19:51 [2019-10-03T18:19:51.673Z]     ipvlan_test.go:29: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlanPersistance
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:302: [d49a6d69470ca] waiting for daemon to start
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:334: [d49a6d69470ca] daemon started
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:286: [d49a6d69470ca] exiting daemon
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:302: [d49a6d69470ca] waiting for daemon to start
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:334: [d49a6d69470ca] daemon started
18:19:51 [2019-10-03T18:19:51.673Z]     daemon.go:286: [d49a6d69470ca] exiting daemon
18:19:51 [2019-10-03T18:19:51.673Z] === RUN   TestDockerNetworkIpvlan
18:19:52 [2019-10-03T18:19:52.686Z] === RUN   TestDockerNetworkIpvlan/Subinterface
18:19:53 [2019-10-03T18:19:53.731Z] === RUN   TestDockerNetworkIpvlan/OverlapParent
18:19:54 [2019-10-03T18:19:54.751Z] === RUN   TestDockerNetworkIpvlan/L2NilParent
18:19:57 [2019-10-03T18:19:57.436Z] === RUN   TestDockerNetworkIpvlan/L2InternalMode
18:20:00 [2019-10-03T18:20:00.977Z] === RUN   TestDockerNetworkIpvlan/L3NilParent
18:20:19 [2019-10-03T18:20:19.644Z] === RUN   TestDockerNetworkIpvlan/L3InternalMode
18:20:38 [2019-10-03T18:20:38.299Z] === RUN   TestDockerNetworkIpvlan/L2MultiSubnet
18:21:00 [2019-10-03T18:21:00.620Z] === RUN   TestDockerNetworkIpvlan/L3MultiSubnet
18:21:19 [2019-10-03T18:21:19.095Z] === RUN   TestDockerNetworkIpvlan/Addressing
18:21:51 [2019-10-03T18:21:51.646Z] --- PASS: TestDockerNetworkIpvlan (118.16s)
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [df2acce710d6b] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [df2acce710d6b] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/Subinterface (0.12s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [df2acce710d6b] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [dadc9246c3c41] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [dadc9246c3c41] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/OverlapParent (0.07s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [dadc9246c3c41] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d6d6c1f8d6c34] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d6d6c1f8d6c34] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L2NilParent (1.36s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d6d6c1f8d6c34] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d5bfa04767757] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d5bfa04767757] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L2InternalMode (2.31s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d5bfa04767757] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d20b5bbf1c72a] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d20b5bbf1c72a] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L3NilParent (16.34s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d20b5bbf1c72a] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d73bcf4d3e70c] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d73bcf4d3e70c] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L3InternalMode (17.38s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d73bcf4d3e70c] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d39b94e78e7bb] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d39b94e78e7bb] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L2MultiSubnet (18.39s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d39b94e78e7bb] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [ddf118064cdbc] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [ddf118064cdbc] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/L3MultiSubnet (18.44s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [ddf118064cdbc] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     ipvlan_test.go:90: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkIpvlan
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [d0e0eda21f6a2] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [d0e0eda21f6a2] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     --- PASS: TestDockerNetworkIpvlan/Addressing (32.05s)
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [d0e0eda21f6a2] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z] PASS
18:21:51 [2019-10-03T18:21:51.646Z] Running /go/src/github.com/docker/docker/integration/network/macvlan flags=-test.v -test.timeout=120m  
18:21:51 [2019-10-03T18:21:51.646Z] INFO: Testing against a local daemon
18:21:51 [2019-10-03T18:21:51.646Z] === RUN   TestDockerNetworkMacvlanPersistance
18:21:51 [2019-10-03T18:21:51.646Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.57s)
18:21:51 [2019-10-03T18:21:51.646Z]     macvlan_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlanPersistance
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [decc730b58849] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [decc730b58849] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [decc730b58849] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:302: [decc730b58849] waiting for daemon to start
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:334: [decc730b58849] daemon started
18:21:51 [2019-10-03T18:21:51.646Z]     daemon.go:286: [decc730b58849] exiting daemon
18:21:51 [2019-10-03T18:21:51.646Z] === RUN   TestDockerNetworkMacvlan
18:21:52 [2019-10-03T18:21:52.667Z] === RUN   TestDockerNetworkMacvlan/Subinterface
18:21:53 [2019-10-03T18:21:53.676Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
18:21:54 [2019-10-03T18:21:54.688Z] === RUN   TestDockerNetworkMacvlan/NilParent
18:21:57 [2019-10-03T18:21:57.381Z] === RUN   TestDockerNetworkMacvlan/InternalMode
18:22:01 [2019-10-03T18:22:01.809Z] === RUN   TestDockerNetworkMacvlan/Addressing
18:22:20 [2019-10-03T18:22:20.450Z] --- PASS: TestDockerNetworkMacvlan (25.96s)
18:22:20 [2019-10-03T18:22:20.450Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d4cea5fd1412f] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d4cea5fd1412f] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.11s)
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d4cea5fd1412f] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [dbe2167aa114f] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [dbe2167aa114f] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.08s)
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [dbe2167aa114f] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d950940ff8cfd] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d950940ff8cfd] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.35s)
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d950940ff8cfd] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d1d729c0173cf] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d1d729c0173cf] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.46s)
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d1d729c0173cf] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkMacvlan
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d2379b6693405] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d2379b6693405] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (16.11s)
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d2379b6693405] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z] PASS
18:22:20 [2019-10-03T18:22:20.450Z] Running /go/src/github.com/docker/docker/integration/plugin flags=-test.v -test.timeout=120m  
18:22:20 [2019-10-03T18:22:20.450Z] testing: warning: no tests to run
18:22:20 [2019-10-03T18:22:20.450Z] PASS
18:22:20 [2019-10-03T18:22:20.450Z] Running /go/src/github.com/docker/docker/integration/plugin/authz flags=-test.v -test.timeout=120m  
18:22:20 [2019-10-03T18:22:20.450Z] INFO: Testing against a local daemon
18:22:20 [2019-10-03T18:22:20.450Z] === RUN   TestAuthZPluginAllowRequest
18:22:20 [2019-10-03T18:22:20.450Z] --- PASS: TestAuthZPluginAllowRequest (1.77s)
18:22:20 [2019-10-03T18:22:20.450Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowRequest
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d040fa9a1abb1] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d040fa9a1abb1] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d040fa9a1abb1] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z] === RUN   TestAuthZPluginTLS
18:22:20 [2019-10-03T18:22:20.450Z] --- PASS: TestAuthZPluginTLS (0.57s)
18:22:20 [2019-10-03T18:22:20.450Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginTLS
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:302: [d131b18c99299] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:334: [d131b18c99299] daemon started
18:22:20 [2019-10-03T18:22:20.450Z]     daemon.go:286: [d131b18c99299] exiting daemon
18:22:20 [2019-10-03T18:22:20.450Z] === RUN   TestAuthZPluginDenyRequest
18:22:20 [2019-10-03T18:22:20.733Z] --- PASS: TestAuthZPluginDenyRequest (0.55s)
18:22:20 [2019-10-03T18:22:20.733Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyRequest
18:22:20 [2019-10-03T18:22:20.733Z]     daemon.go:302: [d3b828ef334a3] waiting for daemon to start
18:22:20 [2019-10-03T18:22:20.733Z]     daemon.go:334: [d3b828ef334a3] daemon started
18:22:20 [2019-10-03T18:22:20.733Z]     daemon.go:286: [d3b828ef334a3] exiting daemon
18:22:20 [2019-10-03T18:22:20.733Z] === RUN   TestAuthZPluginAPIDenyResponse
18:22:21 [2019-10-03T18:22:21.349Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.55s)
18:22:21 [2019-10-03T18:22:21.349Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAPIDenyResponse
18:22:21 [2019-10-03T18:22:21.349Z]     daemon.go:302: [db0e2f8a87f1c] waiting for daemon to start
18:22:21 [2019-10-03T18:22:21.349Z]     daemon.go:334: [db0e2f8a87f1c] daemon started
18:22:21 [2019-10-03T18:22:21.349Z]     daemon.go:286: [db0e2f8a87f1c] exiting daemon
18:22:21 [2019-10-03T18:22:21.349Z] === RUN   TestAuthZPluginDenyResponse
18:22:21 [2019-10-03T18:22:21.631Z] --- PASS: TestAuthZPluginDenyResponse (0.56s)
18:22:21 [2019-10-03T18:22:21.631Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginDenyResponse
18:22:21 [2019-10-03T18:22:21.631Z]     daemon.go:302: [d9a8c8d400979] waiting for daemon to start
18:22:21 [2019-10-03T18:22:21.631Z]     daemon.go:334: [d9a8c8d400979] daemon started
18:22:21 [2019-10-03T18:22:21.631Z]     daemon.go:286: [d9a8c8d400979] exiting daemon
18:22:21 [2019-10-03T18:22:21.631Z] === RUN   TestAuthZPluginAllowEventStream
18:22:23 [2019-10-03T18:22:23.666Z] --- PASS: TestAuthZPluginAllowEventStream (1.68s)
18:22:23 [2019-10-03T18:22:23.666Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginAllowEventStream
18:22:23 [2019-10-03T18:22:23.666Z]     daemon.go:302: [d42caf9280427] waiting for daemon to start
18:22:23 [2019-10-03T18:22:23.666Z]     daemon.go:334: [d42caf9280427] daemon started
18:22:23 [2019-10-03T18:22:23.666Z]     daemon.go:286: [d42caf9280427] exiting daemon
18:22:23 [2019-10-03T18:22:23.666Z] === RUN   TestAuthZPluginErrorResponse
18:22:23 [2019-10-03T18:22:23.950Z] --- PASS: TestAuthZPluginErrorResponse (0.55s)
18:22:23 [2019-10-03T18:22:23.950Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorResponse
18:22:23 [2019-10-03T18:22:23.950Z]     daemon.go:302: [d45eb2979e07a] waiting for daemon to start
18:22:23 [2019-10-03T18:22:23.950Z]     daemon.go:334: [d45eb2979e07a] daemon started
18:22:23 [2019-10-03T18:22:23.950Z]     daemon.go:286: [d45eb2979e07a] exiting daemon
18:22:23 [2019-10-03T18:22:23.950Z] === RUN   TestAuthZPluginErrorRequest
18:22:24 [2019-10-03T18:22:24.571Z] --- PASS: TestAuthZPluginErrorRequest (0.55s)
18:22:24 [2019-10-03T18:22:24.571Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginErrorRequest
18:22:24 [2019-10-03T18:22:24.571Z]     daemon.go:302: [d62cd88345faa] waiting for daemon to start
18:22:24 [2019-10-03T18:22:24.571Z]     daemon.go:334: [d62cd88345faa] daemon started
18:22:24 [2019-10-03T18:22:24.571Z]     daemon.go:286: [d62cd88345faa] exiting daemon
18:22:24 [2019-10-03T18:22:24.571Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
18:22:25 [2019-10-03T18:22:25.190Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.55s)
18:22:25 [2019-10-03T18:22:25.190Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureNoDuplicatePluginRegistration
18:22:25 [2019-10-03T18:22:25.190Z]     daemon.go:302: [d2569794ff583] waiting for daemon to start
18:22:25 [2019-10-03T18:22:25.190Z]     daemon.go:334: [d2569794ff583] daemon started
18:22:25 [2019-10-03T18:22:25.190Z]     daemon.go:286: [d2569794ff583] exiting daemon
18:22:25 [2019-10-03T18:22:25.190Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
18:22:27 [2019-10-03T18:22:27.226Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (2.18s)
18:22:27 [2019-10-03T18:22:27.226Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginEnsureLoadImportWorking
18:22:27 [2019-10-03T18:22:27.226Z]     daemon.go:302: [d13044daa89b3] waiting for daemon to start
18:22:27 [2019-10-03T18:22:27.226Z]     daemon.go:334: [d13044daa89b3] daemon started
18:22:27 [2019-10-03T18:22:27.226Z]     daemon.go:286: [d13044daa89b3] exiting daemon
18:22:27 [2019-10-03T18:22:27.226Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
18:22:29 [2019-10-03T18:22:29.925Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.29s)
18:22:29 [2019-10-03T18:22:29.925Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthzPluginEnsureContainerCopyToFrom
18:22:29 [2019-10-03T18:22:29.925Z]     daemon.go:302: [d9c104a2de5e8] waiting for daemon to start
18:22:29 [2019-10-03T18:22:29.925Z]     daemon.go:334: [d9c104a2de5e8] daemon started
18:22:29 [2019-10-03T18:22:29.925Z]     daemon.go:286: [d9c104a2de5e8] exiting daemon
18:22:29 [2019-10-03T18:22:29.925Z] === RUN   TestAuthZPluginHeader
18:22:30 [2019-10-03T18:22:30.544Z] --- PASS: TestAuthZPluginHeader (0.97s)
18:22:30 [2019-10-03T18:22:30.544Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginHeader
18:22:30 [2019-10-03T18:22:30.544Z]     daemon.go:302: [d39afd3590fc4] waiting for daemon to start
18:22:30 [2019-10-03T18:22:30.544Z]     daemon.go:334: [d39afd3590fc4] daemon started
18:22:30 [2019-10-03T18:22:30.544Z]     daemon.go:286: [d39afd3590fc4] exiting daemon
18:22:30 [2019-10-03T18:22:30.544Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
18:22:30 [2019-10-03T18:22:30.544Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
18:22:30 [2019-10-03T18:22:30.544Z]     authz_plugin_v2_test.go:43: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:22:30 [2019-10-03T18:22:30.544Z] === RUN   TestAuthZPluginV2Disable
18:22:30 [2019-10-03T18:22:30.544Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
18:22:30 [2019-10-03T18:22:30.544Z]     authz_plugin_v2_test.go:65: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:22:30 [2019-10-03T18:22:30.544Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
18:22:30 [2019-10-03T18:22:30.544Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
18:22:30 [2019-10-03T18:22:30.544Z]     authz_plugin_v2_test.go:91: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:22:30 [2019-10-03T18:22:30.544Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
18:22:30 [2019-10-03T18:22:30.544Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
18:22:30 [2019-10-03T18:22:30.544Z]     authz_plugin_v2_test.go:126: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:22:30 [2019-10-03T18:22:30.544Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
18:22:49 [2019-10-03T18:22:49.026Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.84s)
18:22:49 [2019-10-03T18:22:49.026Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestAuthZPluginV2NonexistentFailsDaemonStart
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:302: [ddd8856cdb91a] waiting for daemon to start
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:334: [ddd8856cdb91a] daemon started
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:286: [ddd8856cdb91a] exiting daemon
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:302: [ddd8856cdb91a] waiting for daemon to start
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:302: [ddd8856cdb91a] waiting for daemon to start
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:286: [ddd8856cdb91a] exiting daemon
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:302: [ddd8856cdb91a] waiting for daemon to start
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:334: [ddd8856cdb91a] daemon started
18:22:49 [2019-10-03T18:22:49.026Z]     daemon.go:286: [ddd8856cdb91a] exiting daemon
18:22:49 [2019-10-03T18:22:49.026Z] PASS
18:22:49 [2019-10-03T18:22:49.026Z] Running /go/src/github.com/docker/docker/integration/plugin/common flags=-test.v -test.timeout=120m  
18:22:49 [2019-10-03T18:22:49.026Z] INFO: Testing against a local daemon
18:22:49 [2019-10-03T18:22:49.026Z] === RUN   TestPluginInvalidJSON
18:22:49 [2019-10-03T18:22:49.026Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
18:22:49 [2019-10-03T18:22:49.026Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
18:22:49 [2019-10-03T18:22:49.026Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
18:22:49 [2019-10-03T18:22:49.026Z] --- PASS: TestPluginInvalidJSON (0.02s)
18:22:49 [2019-10-03T18:22:49.026Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
18:22:49 [2019-10-03T18:22:49.026Z] PASS
18:22:49 [2019-10-03T18:22:49.026Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver flags=-test.v -test.timeout=120m  
18:22:49 [2019-10-03T18:22:49.026Z] INFO: Testing against a local daemon
18:22:49 [2019-10-03T18:22:49.026Z] === RUN   TestExternalGraphDriver
18:22:49 [2019-10-03T18:22:49.026Z] === RUN   TestExternalGraphDriver/json
18:22:50 [2019-10-03T18:22:50.044Z] === RUN   TestExternalGraphDriver/spec
18:22:52 [2019-10-03T18:22:52.086Z] === RUN   TestExternalGraphDriver/pull
18:22:54 [2019-10-03T18:22:54.813Z] --- PASS: TestExternalGraphDriver (7.27s)
18:22:54 [2019-10-03T18:22:54.813Z]     external_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestExternalGraphDriver
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:302: [dc873700a0187] waiting for daemon to start
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:334: [dc873700a0187] daemon started
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:286: [dc873700a0187] exiting daemon
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:302: [dc873700a0187] waiting for daemon to start
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:334: [dc873700a0187] daemon started
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:286: [dc873700a0187] exiting daemon
18:22:54 [2019-10-03T18:22:54.813Z]     --- PASS: TestExternalGraphDriver/json (2.18s)
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:302: [dc873700a0187] waiting for daemon to start
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:334: [dc873700a0187] daemon started
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:286: [dc873700a0187] exiting daemon
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:302: [dc873700a0187] waiting for daemon to start
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:334: [dc873700a0187] daemon started
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:286: [dc873700a0187] exiting daemon
18:22:54 [2019-10-03T18:22:54.813Z]     --- PASS: TestExternalGraphDriver/spec (2.20s)
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:302: [dc873700a0187] waiting for daemon to start
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:334: [dc873700a0187] daemon started
18:22:54 [2019-10-03T18:22:54.813Z]     daemon.go:286: [dc873700a0187] exiting daemon
18:22:54 [2019-10-03T18:22:54.813Z]     --- PASS: TestExternalGraphDriver/pull (2.66s)
18:22:54 [2019-10-03T18:22:54.813Z] === RUN   TestGraphdriverPluginV2
18:22:54 [2019-10-03T18:22:54.813Z] --- SKIP: TestGraphdriverPluginV2 (0.06s)
18:22:54 [2019-10-03T18:22:54.813Z]     external_test.go:410: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:22:54 [2019-10-03T18:22:54.813Z] PASS
18:22:54 [2019-10-03T18:22:54.813Z] Running /go/src/github.com/docker/docker/integration/plugin/logging flags=-test.v -test.timeout=120m  
18:22:55 [2019-10-03T18:22:55.097Z] INFO: Testing against a local daemon
18:22:55 [2019-10-03T18:22:55.097Z] === RUN   TestContinueAfterPluginCrash
18:22:55 [2019-10-03T18:22:55.097Z] === PAUSE TestContinueAfterPluginCrash
18:22:55 [2019-10-03T18:22:55.097Z] === RUN   TestDaemonStartWithLogOpt
18:22:55 [2019-10-03T18:22:55.097Z] === PAUSE TestDaemonStartWithLogOpt
18:22:55 [2019-10-03T18:22:55.097Z] === CONT  TestContinueAfterPluginCrash
18:22:55 [2019-10-03T18:22:55.097Z] === CONT  TestDaemonStartWithLogOpt
18:23:13 [2019-10-03T18:23:13.690Z] --- PASS: TestDaemonStartWithLogOpt (16.98s)
18:23:13 [2019-10-03T18:23:13.690Z]     validation_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDaemonStartWithLogOpt
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:302: [d6e78db3731cf] waiting for daemon to start
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:334: [d6e78db3731cf] daemon started
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:286: [d6e78db3731cf] exiting daemon
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:302: [d6e78db3731cf] waiting for daemon to start
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:334: [d6e78db3731cf] daemon started
18:23:13 [2019-10-03T18:23:13.690Z]     daemon.go:286: [d6e78db3731cf] exiting daemon
18:23:17 [2019-10-03T18:23:17.140Z] --- PASS: TestContinueAfterPluginCrash (21.77s)
18:23:17 [2019-10-03T18:23:17.140Z]     logging_linux_test.go:22: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestContinueAfterPluginCrash
18:23:17 [2019-10-03T18:23:17.140Z]     daemon.go:302: [d87c8ebde3e9c] waiting for daemon to start
18:23:17 [2019-10-03T18:23:17.140Z]     daemon.go:334: [d87c8ebde3e9c] daemon started
18:23:17 [2019-10-03T18:23:17.140Z]     daemon.go:286: [d87c8ebde3e9c] exiting daemon
18:23:17 [2019-10-03T18:23:17.140Z] PASS
18:23:17 [2019-10-03T18:23:17.140Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes flags=-test.v -test.timeout=120m  
18:23:17 [2019-10-03T18:23:17.140Z] INFO: Testing against a local daemon
18:23:17 [2019-10-03T18:23:17.140Z] === RUN   TestPluginWithDevMounts
18:23:17 [2019-10-03T18:23:17.140Z] === PAUSE TestPluginWithDevMounts
18:23:17 [2019-10-03T18:23:17.140Z] === CONT  TestPluginWithDevMounts
18:23:19 [2019-10-03T18:23:19.180Z] --- PASS: TestPluginWithDevMounts (2.40s)
18:23:19 [2019-10-03T18:23:19.180Z]     mounts_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestPluginWithDevMounts
18:23:19 [2019-10-03T18:23:19.180Z]     daemon.go:302: [d8efa993d67c6] waiting for daemon to start
18:23:19 [2019-10-03T18:23:19.180Z]     daemon.go:334: [d8efa993d67c6] daemon started
18:23:19 [2019-10-03T18:23:19.180Z]     daemon.go:286: [d8efa993d67c6] exiting daemon
18:23:19 [2019-10-03T18:23:19.180Z] PASS
18:23:19 [2019-10-03T18:23:19.180Z] Running /go/src/github.com/docker/docker/integration/secret flags=-test.v -test.timeout=120m  
18:23:19 [2019-10-03T18:23:19.464Z] INFO: Testing against a local daemon
18:23:19 [2019-10-03T18:23:19.464Z] === RUN   TestSecretInspect
18:23:22 [2019-10-03T18:23:22.157Z] --- PASS: TestSecretInspect (2.41s)
18:23:22 [2019-10-03T18:23:22.157Z]     secret_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretInspect
18:23:22 [2019-10-03T18:23:22.157Z]     daemon.go:302: [dd4403bf5a993] waiting for daemon to start
18:23:22 [2019-10-03T18:23:22.157Z]     daemon.go:334: [dd4403bf5a993] daemon started
18:23:22 [2019-10-03T18:23:22.157Z]     daemon.go:286: [dd4403bf5a993] exiting daemon
18:23:22 [2019-10-03T18:23:22.157Z] === RUN   TestSecretList
18:23:24 [2019-10-03T18:23:24.856Z] --- PASS: TestSecretList (2.97s)
18:23:24 [2019-10-03T18:23:24.856Z]     secret_test.go:48: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretList
18:23:24 [2019-10-03T18:23:24.856Z]     daemon.go:302: [d6ef40c67a405] waiting for daemon to start
18:23:24 [2019-10-03T18:23:24.856Z]     daemon.go:334: [d6ef40c67a405] daemon started
18:23:24 [2019-10-03T18:23:24.856Z]     daemon.go:286: [d6ef40c67a405] exiting daemon
18:23:24 [2019-10-03T18:23:24.856Z] === RUN   TestSecretsCreateAndDelete
18:23:27 [2019-10-03T18:23:27.558Z] --- PASS: TestSecretsCreateAndDelete (2.42s)
18:23:27 [2019-10-03T18:23:27.558Z]     secret_test.go:134: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsCreateAndDelete
18:23:27 [2019-10-03T18:23:27.558Z]     daemon.go:302: [d41d9e3a4313c] waiting for daemon to start
18:23:27 [2019-10-03T18:23:27.558Z]     daemon.go:334: [d41d9e3a4313c] daemon started
18:23:27 [2019-10-03T18:23:27.558Z]     daemon.go:286: [d41d9e3a4313c] exiting daemon
18:23:27 [2019-10-03T18:23:27.558Z] === RUN   TestSecretsUpdate
18:23:29 [2019-10-03T18:23:29.595Z] --- PASS: TestSecretsUpdate (2.32s)
18:23:29 [2019-10-03T18:23:29.595Z]     secret_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestSecretsUpdate
18:23:29 [2019-10-03T18:23:29.595Z]     daemon.go:302: [df0ba49dd87cb] waiting for daemon to start
18:23:29 [2019-10-03T18:23:29.595Z]     daemon.go:334: [df0ba49dd87cb] daemon started
18:23:29 [2019-10-03T18:23:29.595Z]     daemon.go:286: [df0ba49dd87cb] exiting daemon
18:23:29 [2019-10-03T18:23:29.595Z] === RUN   TestTemplatedSecret
18:23:33 [2019-10-03T18:23:33.073Z] --- PASS: TestTemplatedSecret (3.05s)
18:23:33 [2019-10-03T18:23:33.073Z]     secret_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestTemplatedSecret
18:23:33 [2019-10-03T18:23:33.073Z]     daemon.go:302: [ddb5b43038528] waiting for daemon to start
18:23:33 [2019-10-03T18:23:33.073Z]     daemon.go:334: [ddb5b43038528] daemon started
18:23:33 [2019-10-03T18:23:33.073Z]     daemon.go:286: [ddb5b43038528] exiting daemon
18:23:33 [2019-10-03T18:23:33.073Z] PASS
18:23:33 [2019-10-03T18:23:33.073Z] Running /go/src/github.com/docker/docker/integration/service flags=-test.v -test.timeout=120m  
18:23:33 [2019-10-03T18:23:33.073Z] INFO: Testing against a local daemon
18:23:33 [2019-10-03T18:23:33.073Z] === RUN   TestServiceCreateInit
18:23:33 [2019-10-03T18:23:33.073Z] === RUN   TestServiceCreateInit/daemonInitDisabled
18:23:37 [2019-10-03T18:23:37.513Z] === RUN   TestServiceCreateInit/daemonInitEnabled
18:23:43 [2019-10-03T18:23:43.058Z] --- PASS: TestServiceCreateInit (9.61s)
18:23:43 [2019-10-03T18:23:43.058Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.82s)
18:23:43 [2019-10-03T18:23:43.058Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitDisabled
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:302: [d28586db85c05] waiting for daemon to start
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:334: [d28586db85c05] daemon started
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:286: [d28586db85c05] exiting daemon
18:23:43 [2019-10-03T18:23:43.058Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (4.75s)
18:23:43 [2019-10-03T18:23:43.058Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceCreateInit/daemonInitEnabled
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:302: [da196f4416ceb] waiting for daemon to start
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:334: [da196f4416ceb] daemon started
18:23:43 [2019-10-03T18:23:43.058Z]         daemon.go:286: [da196f4416ceb] exiting daemon
18:23:43 [2019-10-03T18:23:43.058Z] === RUN   TestCreateServiceMultipleTimes
18:24:01 [2019-10-03T18:24:01.531Z] --- PASS: TestCreateServiceMultipleTimes (17.30s)
18:24:01 [2019-10-03T18:24:01.531Z]     create_test.go:78: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceMultipleTimes
18:24:01 [2019-10-03T18:24:01.531Z]     daemon.go:302: [d367298378f19] waiting for daemon to start
18:24:01 [2019-10-03T18:24:01.531Z]     daemon.go:334: [d367298378f19] daemon started
18:24:01 [2019-10-03T18:24:01.531Z]     daemon.go:286: [d367298378f19] exiting daemon
18:24:01 [2019-10-03T18:24:01.531Z] === RUN   TestCreateWithDuplicateNetworkNames
18:24:16 [2019-10-03T18:24:16.825Z] --- PASS: TestCreateWithDuplicateNetworkNames (14.68s)
18:24:16 [2019-10-03T18:24:16.825Z]     create_test.go:127: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateWithDuplicateNetworkNames
18:24:16 [2019-10-03T18:24:16.825Z]     daemon.go:302: [d97df9325fe31] waiting for daemon to start
18:24:16 [2019-10-03T18:24:16.825Z]     daemon.go:334: [d97df9325fe31] daemon started
18:24:16 [2019-10-03T18:24:16.825Z]     daemon.go:286: [d97df9325fe31] exiting daemon
18:24:16 [2019-10-03T18:24:16.825Z] === RUN   TestCreateServiceSecretFileMode
18:24:17 [2019-10-03T18:24:17.110Z] --- PASS: TestCreateServiceSecretFileMode (2.75s)
18:24:17 [2019-10-03T18:24:17.110Z]     create_test.go:180: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceSecretFileMode
18:24:17 [2019-10-03T18:24:17.110Z]     daemon.go:302: [d93123f36f6d6] waiting for daemon to start
18:24:17 [2019-10-03T18:24:17.110Z]     daemon.go:334: [d93123f36f6d6] daemon started
18:24:17 [2019-10-03T18:24:17.110Z]     daemon.go:286: [d93123f36f6d6] exiting daemon
18:24:17 [2019-10-03T18:24:17.110Z] === RUN   TestCreateServiceConfigFileMode
18:24:19 [2019-10-03T18:24:19.803Z] --- PASS: TestCreateServiceConfigFileMode (2.68s)
18:24:19 [2019-10-03T18:24:19.803Z]     create_test.go:244: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestCreateServiceConfigFileMode
18:24:19 [2019-10-03T18:24:19.803Z]     daemon.go:302: [d16ca510d2891] waiting for daemon to start
18:24:19 [2019-10-03T18:24:19.803Z]     daemon.go:334: [d16ca510d2891] daemon started
18:24:19 [2019-10-03T18:24:19.803Z]     daemon.go:286: [d16ca510d2891] exiting daemon
18:24:19 [2019-10-03T18:24:19.803Z] === RUN   TestInspect
18:24:22 [2019-10-03T18:24:22.487Z] --- PASS: TestInspect (2.31s)
18:24:22 [2019-10-03T18:24:22.487Z]     inspect_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInspect
18:24:22 [2019-10-03T18:24:22.487Z]     daemon.go:302: [daabbd6418efd] waiting for daemon to start
18:24:22 [2019-10-03T18:24:22.487Z]     daemon.go:334: [daabbd6418efd] daemon started
18:24:22 [2019-10-03T18:24:22.487Z]     daemon.go:286: [daabbd6418efd] exiting daemon
18:24:22 [2019-10-03T18:24:22.487Z] === RUN   TestDockerNetworkConnectAlias
18:24:28 [2019-10-03T18:24:28.003Z] --- PASS: TestDockerNetworkConnectAlias (4.98s)
18:24:28 [2019-10-03T18:24:28.003Z]     network_test.go:20: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkConnectAlias
18:24:28 [2019-10-03T18:24:28.003Z]     daemon.go:302: [d1621646872be] waiting for daemon to start
18:24:28 [2019-10-03T18:24:28.003Z]     daemon.go:334: [d1621646872be] daemon started
18:24:28 [2019-10-03T18:24:28.003Z]     daemon.go:286: [d1621646872be] exiting daemon
18:24:28 [2019-10-03T18:24:28.003Z] === RUN   TestDockerNetworkReConnect
18:24:31 [2019-10-03T18:24:31.492Z] --- PASS: TestDockerNetworkReConnect (3.82s)
18:24:31 [2019-10-03T18:24:31.492Z]     network_test.go:82: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestDockerNetworkReConnect
18:24:31 [2019-10-03T18:24:31.492Z]     daemon.go:302: [da1513b616aed] waiting for daemon to start
18:24:31 [2019-10-03T18:24:31.492Z]     daemon.go:334: [da1513b616aed] daemon started
18:24:31 [2019-10-03T18:24:31.492Z]     daemon.go:286: [da1513b616aed] exiting daemon
18:24:31 [2019-10-03T18:24:31.492Z] === RUN   TestServicePlugin
18:24:31 [2019-10-03T18:24:31.492Z] --- SKIP: TestServicePlugin (0.00s)
18:24:31 [2019-10-03T18:24:31.492Z]     plugin_test.go:26: os.Getenv("DOCKER_ENGINE_GOARCH") != "amd64"
18:24:31 [2019-10-03T18:24:31.492Z] === RUN   TestServiceUpdateLabel
18:24:33 [2019-10-03T18:24:33.527Z] --- PASS: TestServiceUpdateLabel (2.35s)
18:24:33 [2019-10-03T18:24:33.527Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateLabel
18:24:33 [2019-10-03T18:24:33.527Z]     daemon.go:302: [d4946dcb29d41] waiting for daemon to start
18:24:33 [2019-10-03T18:24:33.527Z]     daemon.go:334: [d4946dcb29d41] daemon started
18:24:33 [2019-10-03T18:24:33.527Z]     daemon.go:286: [d4946dcb29d41] exiting daemon
18:24:33 [2019-10-03T18:24:33.527Z] === RUN   TestServiceUpdateSecrets
18:24:48 [2019-10-03T18:24:48.781Z] --- PASS: TestServiceUpdateSecrets (15.11s)
18:24:48 [2019-10-03T18:24:48.781Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateSecrets
18:24:48 [2019-10-03T18:24:48.781Z]     daemon.go:302: [d186baaa4f343] waiting for daemon to start
18:24:48 [2019-10-03T18:24:48.781Z]     daemon.go:334: [d186baaa4f343] daemon started
18:24:48 [2019-10-03T18:24:48.781Z]     daemon.go:286: [d186baaa4f343] exiting daemon
18:24:48 [2019-10-03T18:24:48.781Z] === RUN   TestServiceUpdateConfigs
18:25:04 [2019-10-03T18:25:04.175Z] --- PASS: TestServiceUpdateConfigs (15.00s)
18:25:04 [2019-10-03T18:25:04.175Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateConfigs
18:25:04 [2019-10-03T18:25:04.175Z]     daemon.go:302: [d098f3545ac6b] waiting for daemon to start
18:25:04 [2019-10-03T18:25:04.175Z]     daemon.go:334: [d098f3545ac6b] daemon started
18:25:04 [2019-10-03T18:25:04.175Z]     daemon.go:286: [d098f3545ac6b] exiting daemon
18:25:04 [2019-10-03T18:25:04.175Z] === RUN   TestServiceUpdateNetwork
18:25:16 [2019-10-03T18:25:16.724Z] --- PASS: TestServiceUpdateNetwork (13.10s)
18:25:16 [2019-10-03T18:25:16.724Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestServiceUpdateNetwork
18:25:16 [2019-10-03T18:25:16.724Z]     daemon.go:302: [de91ba590e0f6] waiting for daemon to start
18:25:16 [2019-10-03T18:25:16.724Z]     daemon.go:334: [de91ba590e0f6] daemon started
18:25:16 [2019-10-03T18:25:16.724Z]     daemon.go:286: [de91ba590e0f6] exiting daemon
18:25:16 [2019-10-03T18:25:16.724Z] PASS
18:25:16 [2019-10-03T18:25:16.724Z] Running /go/src/github.com/docker/docker/integration/session flags=-test.v -test.timeout=120m  
18:25:16 [2019-10-03T18:25:16.724Z] INFO: Testing against a local daemon
18:25:16 [2019-10-03T18:25:16.724Z] === RUN   TestSessionCreate
18:25:16 [2019-10-03T18:25:16.724Z] --- PASS: TestSessionCreate (0.03s)
18:25:16 [2019-10-03T18:25:16.724Z] === RUN   TestSessionCreateWithBadUpgrade
18:25:16 [2019-10-03T18:25:16.724Z] --- PASS: TestSessionCreateWithBadUpgrade (0.00s)
18:25:16 [2019-10-03T18:25:16.724Z] PASS
18:25:16 [2019-10-03T18:25:16.724Z] Running /go/src/github.com/docker/docker/integration/system flags=-test.v -test.timeout=120m  
18:25:16 [2019-10-03T18:25:16.724Z] INFO: Testing against a local daemon
18:25:16 [2019-10-03T18:25:16.724Z] === RUN   TestCgroupDriverSystemdMemoryLimit
18:25:16 [2019-10-03T18:25:16.724Z] === PAUSE TestCgroupDriverSystemdMemoryLimit
18:25:16 [2019-10-03T18:25:16.724Z] === RUN   TestEventsExecDie
18:25:17 [2019-10-03T18:25:17.735Z] --- PASS: TestEventsExecDie (0.89s)
18:25:17 [2019-10-03T18:25:17.735Z] === RUN   TestEventsBackwardsCompatible
18:25:17 [2019-10-03T18:25:17.735Z] --- PASS: TestEventsBackwardsCompatible (0.09s)
18:25:17 [2019-10-03T18:25:17.735Z] === RUN   TestInfoBinaryCommits
18:25:17 [2019-10-03T18:25:17.735Z] --- PASS: TestInfoBinaryCommits (0.04s)
18:25:17 [2019-10-03T18:25:17.735Z] === RUN   TestInfoAPIVersioned
18:25:17 [2019-10-03T18:25:17.735Z] --- PASS: TestInfoAPIVersioned (0.07s)
18:25:17 [2019-10-03T18:25:17.735Z] === RUN   TestInfoAPI
18:25:17 [2019-10-03T18:25:17.735Z] --- PASS: TestInfoAPI (0.06s)
18:25:17 [2019-10-03T18:25:17.735Z] === RUN   TestInfoAPIWarnings
18:25:18 [2019-10-03T18:25:18.745Z] --- PASS: TestInfoAPIWarnings (0.94s)
18:25:18 [2019-10-03T18:25:18.745Z]     info_test.go:49: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/TestInfoAPIWarnings
18:25:18 [2019-10-03T18:25:18.745Z]     daemon.go:302: [d1a914e9f9f3e] waiting for daemon to start
18:25:18 [2019-10-03T18:25:18.745Z]     daemon.go:334: [d1a914e9f9f3e] daemon started
18:25:18 [2019-10-03T18:25:18.745Z]     daemon.go:286: [d1a914e9f9f3e] exiting daemon
18:25:18 [2019-10-03T18:25:18.745Z] === RUN   TestLoginFailsWithBadCredentials
18:25:19 [2019-10-03T18:25:19.362Z] --- PASS: TestLoginFailsWithBadCredentials (0.62s)
18:25:19 [2019-10-03T18:25:19.362Z] === RUN   TestVersion
18:25:19 [2019-10-03T18:25:19.362Z] --- PASS: TestVersion (0.02s)
18:25:19 [2019-10-03T18:25:19.362Z] === CONT  TestCgroupDriverSystemdMemoryLimit
18:25:19 [2019-10-03T18:25:19.362Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
18:25:19 [2019-10-03T18:25:19.362Z]     cgroupdriver_systemd_test.go:35: systemd not available
18:25:19 [2019-10-03T18:25:19.362Z] PASS
18:25:19 [2019-10-03T18:25:19.362Z] Running /go/src/github.com/docker/docker/integration/volume flags=-test.v -test.timeout=120m  
18:25:19 [2019-10-03T18:25:19.362Z] INFO: Testing against a local daemon
18:25:19 [2019-10-03T18:25:19.362Z] === RUN   TestVolumesCreateAndList
18:25:19 [2019-10-03T18:25:19.644Z] --- PASS: TestVolumesCreateAndList (0.03s)
18:25:19 [2019-10-03T18:25:19.644Z] === RUN   TestVolumesRemove
18:25:19 [2019-10-03T18:25:19.644Z] --- PASS: TestVolumesRemove (0.07s)
18:25:19 [2019-10-03T18:25:19.644Z] === RUN   TestVolumesInspect
18:25:19 [2019-10-03T18:25:19.644Z] --- PASS: TestVolumesInspect (0.03s)
18:25:19 [2019-10-03T18:25:19.644Z] === RUN   TestVolumesInvalidJSON
18:25:19 [2019-10-03T18:25:19.644Z] === RUN   TestVolumesInvalidJSON//volumes/create
18:25:19 [2019-10-03T18:25:19.644Z] === PAUSE TestVolumesInvalidJSON//volumes/create
18:25:19 [2019-10-03T18:25:19.644Z] === CONT  TestVolumesInvalidJSON//volumes/create
18:25:19 [2019-10-03T18:25:19.644Z] --- PASS: TestVolumesInvalidJSON (0.02s)
18:25:19 [2019-10-03T18:25:19.644Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
18:25:19 [2019-10-03T18:25:19.644Z] PASS
18:25:19 [2019-10-03T18:25:19.644Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
18:25:21 [2019-10-03T18:25:21.117Z] umount: bundles/test-integration/root: mountpoint not found
18:25:21 [2019-10-03T18:25:21.117Z] Clearing AppArmor profiles cache:.
18:25:21 [2019-10-03T18:25:21.117Z] All profile caches have been cleared, but no profiles have been unloaded.
18:25:21 [2019-10-03T18:25:21.117Z] Unloading profiles will leave already running processes permanently
18:25:21 [2019-10-03T18:25:21.117Z] unconfined, which can lead to unexpected situations.
18:25:21 [2019-10-03T18:25:21.117Z] 
18:25:21 [2019-10-03T18:25:21.117Z] To set a process to complain mode, use the command line tool
18:25:21 [2019-10-03T18:25:21.117Z] 'aa-complain'. To really tear down all profiles, run the init script
18:25:21 [2019-10-03T18:25:21.117Z] with the 'teardown' option."
18:25:21 [2019-10-03T18:25:21.117Z] Removing test suite binaries
18:25:21 [2019-10-03T18:25:21.117Z]