Skipping 1,841 KB.. Full Log

14:32:08 [2019-09-16T14:32:08.262Z] + echo Creating powerpc-integration-bundles.tar.gz
14:32:08 [2019-09-16T14:32:08.262Z] Creating powerpc-integration-bundles.tar.gz
14:32:08 [2019-09-16T14:32:08.262Z] + find bundles -path */root/*overlay2 -prune -o -type f ( -name *.log+  -o -name *.prof ) -printxargs
14:32:08 [2019-09-16T14:32:08.262Z]  tar -czf powerpc-integration-bundles.tar.gz
[Pipeline] archiveArtifacts
14:32:08 [2019-09-16T14:32:08.306Z] Archiving artifacts
14:32:08 [2019-09-16T14:32:08.631Z] Uploaded 1 artifact(s) to https://corp-us-east-1-jenkins-k8s-maste-jenkinsartifacts-1lzm7adht5e1j.s3.amazonaws.com/public/engine/PR-359/1/artifacts/
[Pipeline] sh
14:32:08 [2019-09-16T14:32:08.999Z] + make clean
14:32:09 [2019-09-16T14:32:09.617Z] docker volume rm -f docker-dev-cache
14:32:09 [2019-09-16T14:32:09.617Z] docker-dev-cache
[Pipeline] deleteDir
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // node
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
14:32:18 [2019-09-16T14:32:18.460Z] --- PASS: TestServiceUpdateSecrets (15.41s)
14:32:18 [2019-09-16T14:32:18.460Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateSecrets
14:32:18 [2019-09-16T14:32:18.460Z]     daemon.go:302: [dd15f59944fc6] waiting for daemon to start
14:32:18 [2019-09-16T14:32:18.460Z]     daemon.go:334: [dd15f59944fc6] daemon started
14:32:18 [2019-09-16T14:32:18.460Z]     daemon.go:286: [dd15f59944fc6] exiting daemon
14:32:18 [2019-09-16T14:32:18.460Z] === RUN   TestServiceUpdateConfigs
14:32:33 [2019-09-16T14:32:33.306Z] --- PASS: TestServiceUpdateConfigs (15.50s)
14:32:33 [2019-09-16T14:32:33.306Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateConfigs
14:32:33 [2019-09-16T14:32:33.306Z]     daemon.go:302: [d097a0c39b848] waiting for daemon to start
14:32:33 [2019-09-16T14:32:33.306Z]     daemon.go:334: [d097a0c39b848] daemon started
14:32:33 [2019-09-16T14:32:33.306Z]     daemon.go:286: [d097a0c39b848] exiting daemon
14:32:33 [2019-09-16T14:32:33.306Z] === RUN   TestServiceUpdateNetwork
14:32:48 [2019-09-16T14:32:48.157Z] --- PASS: TestServiceUpdateNetwork (15.29s)
14:32:48 [2019-09-16T14:32:48.157Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateNetwork
14:32:48 [2019-09-16T14:32:48.157Z]     daemon.go:302: [de9e3a6add5d9] waiting for daemon to start
14:32:48 [2019-09-16T14:32:48.157Z]     daemon.go:334: [de9e3a6add5d9] daemon started
14:32:48 [2019-09-16T14:32:48.157Z]     daemon.go:286: [de9e3a6add5d9] exiting daemon
14:32:48 [2019-09-16T14:32:48.157Z] === RUN   TestServiceUpdateLabel
14:32:49 [2019-09-16T14:32:49.526Z] --- PASS: TestServiceUpdateLabel (3.03s)
14:32:49 [2019-09-16T14:32:49.526Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateLabel
14:32:49 [2019-09-16T14:32:49.526Z]     daemon.go:302: [d8c032661f564] waiting for daemon to start
14:32:49 [2019-09-16T14:32:49.526Z]     daemon.go:334: [d8c032661f564] daemon started
14:32:49 [2019-09-16T14:32:49.526Z]     daemon.go:286: [d8c032661f564] exiting daemon
14:32:49 [2019-09-16T14:32:49.526Z] === RUN   TestServiceUpdateSecrets
14:33:07 [2019-09-16T14:33:07.589Z] --- PASS: TestServiceUpdateSecrets (15.49s)
14:33:07 [2019-09-16T14:33:07.589Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateSecrets
14:33:07 [2019-09-16T14:33:07.589Z]     daemon.go:302: [df102ab2e8ff5] waiting for daemon to start
14:33:07 [2019-09-16T14:33:07.589Z]     daemon.go:334: [df102ab2e8ff5] daemon started
14:33:07 [2019-09-16T14:33:07.589Z]     daemon.go:286: [df102ab2e8ff5] exiting daemon
14:33:07 [2019-09-16T14:33:07.589Z] === RUN   TestServiceUpdateConfigs
14:33:22 [2019-09-16T14:33:22.438Z] --- PASS: TestServiceUpdateConfigs (15.46s)
14:33:22 [2019-09-16T14:33:22.438Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateConfigs
14:33:22 [2019-09-16T14:33:22.438Z]     daemon.go:302: [d51545633087e] waiting for daemon to start
14:33:22 [2019-09-16T14:33:22.438Z]     daemon.go:334: [d51545633087e] daemon started
14:33:22 [2019-09-16T14:33:22.438Z]     daemon.go:286: [d51545633087e] exiting daemon
14:33:22 [2019-09-16T14:33:22.438Z] === RUN   TestServiceUpdateNetwork
14:33:37 [2019-09-16T14:33:37.286Z] --- PASS: TestServiceUpdateNetwork (15.69s)
14:33:37 [2019-09-16T14:33:37.286Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateNetwork
14:33:37 [2019-09-16T14:33:37.286Z]     daemon.go:302: [d6aea106005b3] waiting for daemon to start
14:33:37 [2019-09-16T14:33:37.286Z]     daemon.go:334: [d6aea106005b3] daemon started
14:33:37 [2019-09-16T14:33:37.286Z]     daemon.go:286: [d6aea106005b3] exiting daemon
14:33:37 [2019-09-16T14:33:37.286Z] === RUN   TestServiceUpdateLabel
14:33:39 [2019-09-16T14:33:39.180Z] --- PASS: TestServiceUpdateLabel (3.03s)
14:33:39 [2019-09-16T14:33:39.180Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateLabel
14:33:39 [2019-09-16T14:33:39.180Z]     daemon.go:302: [db70b588546c9] waiting for daemon to start
14:33:39 [2019-09-16T14:33:39.180Z]     daemon.go:334: [db70b588546c9] daemon started
14:33:39 [2019-09-16T14:33:39.180Z]     daemon.go:286: [db70b588546c9] exiting daemon
14:33:39 [2019-09-16T14:33:39.180Z] === RUN   TestServiceUpdateSecrets
14:33:57 [2019-09-16T14:33:57.234Z] --- PASS: TestServiceUpdateSecrets (15.43s)
14:33:57 [2019-09-16T14:33:57.234Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateSecrets
14:33:57 [2019-09-16T14:33:57.234Z]     daemon.go:302: [d9cd2b0352c37] waiting for daemon to start
14:33:57 [2019-09-16T14:33:57.234Z]     daemon.go:334: [d9cd2b0352c37] daemon started
14:33:57 [2019-09-16T14:33:57.234Z]     daemon.go:286: [d9cd2b0352c37] exiting daemon
14:33:57 [2019-09-16T14:33:57.234Z] === RUN   TestServiceUpdateConfigs
14:34:12 [2019-09-16T14:34:12.094Z] --- PASS: TestServiceUpdateConfigs (15.42s)
14:34:12 [2019-09-16T14:34:12.094Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateConfigs
14:34:12 [2019-09-16T14:34:12.094Z]     daemon.go:302: [d7727117f7c10] waiting for daemon to start
14:34:12 [2019-09-16T14:34:12.094Z]     daemon.go:334: [d7727117f7c10] daemon started
14:34:12 [2019-09-16T14:34:12.094Z]     daemon.go:286: [d7727117f7c10] exiting daemon
14:34:12 [2019-09-16T14:34:12.094Z] === RUN   TestServiceUpdateNetwork
14:34:26 [2019-09-16T14:34:26.943Z] --- PASS: TestServiceUpdateNetwork (15.40s)
14:34:26 [2019-09-16T14:34:26.943Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateNetwork
14:34:26 [2019-09-16T14:34:26.943Z]     daemon.go:302: [d89ad6e714c5b] waiting for daemon to start
14:34:26 [2019-09-16T14:34:26.943Z]     daemon.go:334: [d89ad6e714c5b] daemon started
14:34:26 [2019-09-16T14:34:26.943Z]     daemon.go:286: [d89ad6e714c5b] exiting daemon
14:34:26 [2019-09-16T14:34:26.943Z] === RUN   TestServiceUpdateLabel
14:34:28 [2019-09-16T14:34:28.313Z] --- PASS: TestServiceUpdateLabel (3.06s)
14:34:28 [2019-09-16T14:34:28.313Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateLabel
14:34:28 [2019-09-16T14:34:28.313Z]     daemon.go:302: [d1703276d7f92] waiting for daemon to start
14:34:28 [2019-09-16T14:34:28.313Z]     daemon.go:334: [d1703276d7f92] daemon started
14:34:28 [2019-09-16T14:34:28.313Z]     daemon.go:286: [d1703276d7f92] exiting daemon
14:34:28 [2019-09-16T14:34:28.313Z] === RUN   TestServiceUpdateSecrets
14:34:46 [2019-09-16T14:34:46.563Z] --- PASS: TestServiceUpdateSecrets (15.38s)
14:34:46 [2019-09-16T14:34:46.563Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateSecrets
14:34:46 [2019-09-16T14:34:46.563Z]     daemon.go:302: [d5e7715b40c23] waiting for daemon to start
14:34:46 [2019-09-16T14:34:46.563Z]     daemon.go:334: [d5e7715b40c23] daemon started
14:34:46 [2019-09-16T14:34:46.563Z]     daemon.go:286: [d5e7715b40c23] exiting daemon
14:34:46 [2019-09-16T14:34:46.563Z] === RUN   TestServiceUpdateConfigs
14:35:01 [2019-09-16T14:35:01.412Z] --- PASS: TestServiceUpdateConfigs (15.29s)
14:35:01 [2019-09-16T14:35:01.412Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateConfigs
14:35:01 [2019-09-16T14:35:01.412Z]     daemon.go:302: [d986d80b50261] waiting for daemon to start
14:35:01 [2019-09-16T14:35:01.412Z]     daemon.go:334: [d986d80b50261] daemon started
14:35:01 [2019-09-16T14:35:01.412Z]     daemon.go:286: [d986d80b50261] exiting daemon
14:35:01 [2019-09-16T14:35:01.412Z] === RUN   TestServiceUpdateNetwork
14:35:16 [2019-09-16T14:35:16.262Z] --- PASS: TestServiceUpdateNetwork (15.15s)
14:35:16 [2019-09-16T14:35:16.262Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateNetwork
14:35:16 [2019-09-16T14:35:16.262Z]     daemon.go:302: [d48d9aba3e99e] waiting for daemon to start
14:35:16 [2019-09-16T14:35:16.262Z]     daemon.go:334: [d48d9aba3e99e] daemon started
14:35:16 [2019-09-16T14:35:16.262Z]     daemon.go:286: [d48d9aba3e99e] exiting daemon
14:35:16 [2019-09-16T14:35:16.262Z] === RUN   TestServiceUpdateLabel
14:35:17 [2019-09-16T14:35:17.192Z] --- PASS: TestServiceUpdateLabel (3.07s)
14:35:17 [2019-09-16T14:35:17.192Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateLabel
14:35:17 [2019-09-16T14:35:17.192Z]     daemon.go:302: [d37633a653cdc] waiting for daemon to start
14:35:17 [2019-09-16T14:35:17.192Z]     daemon.go:334: [d37633a653cdc] daemon started
14:35:17 [2019-09-16T14:35:17.192Z]     daemon.go:286: [d37633a653cdc] exiting daemon
14:35:17 [2019-09-16T14:35:17.192Z] === RUN   TestServiceUpdateSecrets
14:35:35 [2019-09-16T14:35:35.250Z] --- PASS: TestServiceUpdateSecrets (15.47s)
14:35:35 [2019-09-16T14:35:35.250Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateSecrets
14:35:35 [2019-09-16T14:35:35.250Z]     daemon.go:302: [d28b4f4dad8ab] waiting for daemon to start
14:35:35 [2019-09-16T14:35:35.250Z]     daemon.go:334: [d28b4f4dad8ab] daemon started
14:35:35 [2019-09-16T14:35:35.250Z]     daemon.go:286: [d28b4f4dad8ab] exiting daemon
14:35:35 [2019-09-16T14:35:35.250Z] === RUN   TestServiceUpdateConfigs
14:35:50 [2019-09-16T14:35:50.096Z] --- PASS: TestServiceUpdateConfigs (15.63s)
14:35:50 [2019-09-16T14:35:50.096Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateConfigs
14:35:50 [2019-09-16T14:35:50.096Z]     daemon.go:302: [dcaba929dfffb] waiting for daemon to start
14:35:50 [2019-09-16T14:35:50.096Z]     daemon.go:334: [dcaba929dfffb] daemon started
14:35:50 [2019-09-16T14:35:50.096Z]     daemon.go:286: [dcaba929dfffb] exiting daemon
14:35:50 [2019-09-16T14:35:50.096Z] === RUN   TestServiceUpdateNetwork
14:36:04 [2019-09-16T14:36:04.948Z] --- PASS: TestServiceUpdateNetwork (15.19s)
14:36:04 [2019-09-16T14:36:04.948Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/TestServiceUpdateNetwork
14:36:04 [2019-09-16T14:36:04.948Z]     daemon.go:302: [d28cc8300b784] waiting for daemon to start
14:36:04 [2019-09-16T14:36:04.948Z]     daemon.go:334: [d28cc8300b784] daemon started
14:36:04 [2019-09-16T14:36:04.948Z]     daemon.go:286: [d28cc8300b784] exiting daemon
14:36:04 [2019-09-16T14:36:04.948Z] PASS
14:36:04 [2019-09-16T14:36:04.949Z] Running /go/src/github.com/docker/docker/integration/session flags=-test.v -test.timeout=375000m -test.count 5 -test.run TestBuildWithHugeFile|TestBuildWithEmptyDockerfile|TestContainerInvalidJSON|TestCopyFromContainer|TestDaemonRestartIpcMode|TestExecWithCloseStdin|TestExecUser|TestHealthKillContainer|TestAPIIpcModeHost|testDaemonIpcPrivateShareable|TestDaemonIpcModeShareable|TestDaemonIpcModePrivate|testDaemonIpcFromConfig|TestDaemonIpcModePrivateFromConfig|TestDaemonIpcModeShareableFromConfig|TestStopContainerWithTimeout|TestDeleteDevicemapper|TestStopContainerWithTimeout|TestImagesFilterMultiReference|createAmbiguousNetworks|TestNetworkInvalidJSON|TestMain|setupTest|TestPluginInvalidJSON|TestServiceUpdateLabel|TestServiceUpdateSecrets|TestServiceUpdateConfigs|TestServiceUpdateNetwork|getService|TestVolumesInvalidJSON 
14:36:04 [2019-09-16T14:36:04.949Z] INFO: Testing against a local daemon
14:36:04 [2019-09-16T14:36:04.949Z] testing: warning: no tests to run
14:36:04 [2019-09-16T14:36:04.949Z] PASS
14:36:04 [2019-09-16T14:36:04.949Z] Running /go/src/github.com/docker/docker/integration/system flags=-test.v -test.timeout=375000m -test.count 5 -test.run TestBuildWithHugeFile|TestBuildWithEmptyDockerfile|TestContainerInvalidJSON|TestCopyFromContainer|TestDaemonRestartIpcMode|TestExecWithCloseStdin|TestExecUser|TestHealthKillContainer|TestAPIIpcModeHost|testDaemonIpcPrivateShareable|TestDaemonIpcModeShareable|TestDaemonIpcModePrivate|testDaemonIpcFromConfig|TestDaemonIpcModePrivateFromConfig|TestDaemonIpcModeShareableFromConfig|TestStopContainerWithTimeout|TestDeleteDevicemapper|TestStopContainerWithTimeout|TestImagesFilterMultiReference|createAmbiguousNetworks|TestNetworkInvalidJSON|TestMain|setupTest|TestPluginInvalidJSON|TestServiceUpdateLabel|TestServiceUpdateSecrets|TestServiceUpdateConfigs|TestServiceUpdateNetwork|getService|TestVolumesInvalidJSON 
14:36:04 [2019-09-16T14:36:04.949Z] INFO: Testing against a local daemon
14:36:04 [2019-09-16T14:36:04.949Z] testing: warning: no tests to run
14:36:04 [2019-09-16T14:36:04.949Z] PASS
14:36:04 [2019-09-16T14:36:04.949Z] Running /go/src/github.com/docker/docker/integration/volume flags=-test.v -test.timeout=375000m -test.count 5 -test.run TestBuildWithHugeFile|TestBuildWithEmptyDockerfile|TestContainerInvalidJSON|TestCopyFromContainer|TestDaemonRestartIpcMode|TestExecWithCloseStdin|TestExecUser|TestHealthKillContainer|TestAPIIpcModeHost|testDaemonIpcPrivateShareable|TestDaemonIpcModeShareable|TestDaemonIpcModePrivate|testDaemonIpcFromConfig|TestDaemonIpcModePrivateFromConfig|TestDaemonIpcModeShareableFromConfig|TestStopContainerWithTimeout|TestDeleteDevicemapper|TestStopContainerWithTimeout|TestImagesFilterMultiReference|createAmbiguousNetworks|TestNetworkInvalidJSON|TestMain|setupTest|TestPluginInvalidJSON|TestServiceUpdateLabel|TestServiceUpdateSecrets|TestServiceUpdateConfigs|TestServiceUpdateNetwork|getService|TestVolumesInvalidJSON 
14:36:04 [2019-09-16T14:36:04.949Z] INFO: Testing against a local daemon
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] --- PASS: TestVolumesInvalidJSON (0.05s)
14:36:04 [2019-09-16T14:36:04.949Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] --- PASS: TestVolumesInvalidJSON (0.05s)
14:36:04 [2019-09-16T14:36:04.949Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] --- PASS: TestVolumesInvalidJSON (0.04s)
14:36:04 [2019-09-16T14:36:04.949Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] --- PASS: TestVolumesInvalidJSON (0.05s)
14:36:04 [2019-09-16T14:36:04.949Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON
14:36:04 [2019-09-16T14:36:04.949Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:36:04 [2019-09-16T14:36:04.949Z] --- PASS: TestVolumesInvalidJSON (0.04s)
14:36:04 [2019-09-16T14:36:04.949Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:36:04 [2019-09-16T14:36:04.949Z] PASS
14:36:04 [2019-09-16T14:36:04.949Z] ---> Making bundle: .integration-daemon-stop (in /go/src/github.com/docker/docker/bundles/test-integration-flaky/1)
14:36:09 [2019-09-16T14:36:09.125Z] umount: /go/src/github.com/docker/docker/bundles/test-integration-flaky/1/root: mountpoint not found
14:36:09 [2019-09-16T14:36:09.125Z] Clearing AppArmor profiles cache:.
14:36:09 [2019-09-16T14:36:09.125Z] All profile caches have been cleared, but no profiles have been unloaded.
14:36:09 [2019-09-16T14:36:09.125Z] Unloading profiles will leave already running processes permanently
14:36:09 [2019-09-16T14:36:09.125Z] unconfined, which can lead to unexpected situations.
14:36:09 [2019-09-16T14:36:09.125Z] 
14:36:09 [2019-09-16T14:36:09.125Z] To set a process to complain mode, use the command line tool
14:36:09 [2019-09-16T14:36:09.125Z] 'aa-complain'. To really tear down all profiles, run the init script
14:36:09 [2019-09-16T14:36:09.125Z] with the 'teardown' option."
14:36:09 [2019-09-16T14:36:09.125Z] Removing test suite binaries
14:36:09 [2019-09-16T14:36:09.125Z] 
14:36:09 [2019-09-16T14:36:09.125Z] ---> Making bundle: test-integration (in bundles/test-integration)
14:36:10 [2019-09-16T14:36:10.054Z] PKG_CONFIG=pkg-config
14:36:10 [2019-09-16T14:36:10.054Z] GOLANG_VERSION=1.11.13
14:36:10 [2019-09-16T14:36:10.054Z] HOSTNAME=75e4f0f68e63
14:36:10 [2019-09-16T14:36:10.054Z] KEEPBUNDLE=1
14:36:10 [2019-09-16T14:36:10.054Z] DOCKER_INTEGRATION_DAEMON_DEST=/go/src/github.com/docker/docker/bundles/test-integration/1
14:36:10 [2019-09-16T14:36:10.054Z] container=docker
14:36:10 [2019-09-16T14:36:10.054Z] TEST_SKIP_INTEGRATION_CLI=1
14:36:10 [2019-09-16T14:36:10.054Z] GOMETALINTER_OPTS=--deadline=2m
14:36:10 [2019-09-16T14:36:10.054Z] GOPATH=/go
14:36:10 [2019-09-16T14:36:10.054Z] PWD=/go/src/github.com/docker/docker
14:36:10 [2019-09-16T14:36:10.054Z] HOME=/root
14:36:10 [2019-09-16T14:36:10.054Z] SCRIPTDIR=/go/src/github.com/docker/docker/hack
14:36:10 [2019-09-16T14:36:10.054Z] MAKEDIR=/go/src/github.com/docker/docker/hack/make
14:36:10 [2019-09-16T14:36:10.054Z] DOCKER_GITCOMMIT=e081431e03c5dca4cbcba7db8735325677adefd0
14:36:10 [2019-09-16T14:36:10.054Z] DOCKER_BUILDTAGS=apparmor seccomp selinux journald
14:36:10 [2019-09-16T14:36:10.054Z] DOCKER_GRAPHDRIVER=overlay2
14:36:10 [2019-09-16T14:36:10.054Z] TEST_INTEGRATION_DEST=1
14:36:10 [2019-09-16T14:36:10.054Z] TERM=xterm
14:36:10 [2019-09-16T14:36:10.054Z] DEST=/go/src/github.com/docker/docker/bundles/test-integration/1
14:36:10 [2019-09-16T14:36:10.054Z] SHLVL=1
14:36:10 [2019-09-16T14:36:10.054Z] TIMEOUT=120m
14:36:10 [2019-09-16T14:36:10.054Z] PATH=/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
14:36:10 [2019-09-16T14:36:10.054Z] DOCKER_PKG=github.com/docker/docker
14:36:10 [2019-09-16T14:36:10.054Z] _=/usr/bin/env
14:36:10 [2019-09-16T14:36:10.054Z] Building test suite binary /go/src/github.com/docker/docker/integration/build/test.main
14:36:12 [2019-09-16T14:36:12.576Z] Building test suite binary /go/src/github.com/docker/docker/integration/config/test.main
14:36:13 [2019-09-16T14:36:13.141Z] Building test suite binary /go/src/github.com/docker/docker/integration/container/test.main
14:36:14 [2019-09-16T14:36:14.512Z] Building test suite binary /go/src/github.com/docker/docker/integration/image/test.main
14:36:15 [2019-09-16T14:36:15.444Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/test.main
14:36:16 [2019-09-16T14:36:16.374Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/ipvlan/test.main
14:36:17 [2019-09-16T14:36:17.305Z] Building test suite binary /go/src/github.com/docker/docker/integration/network/macvlan/test.main
14:36:17 [2019-09-16T14:36:17.870Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/test.main
14:36:18 [2019-09-16T14:36:18.129Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/authz/test.main
14:36:19 [2019-09-16T14:36:19.498Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/common/test.main
14:36:20 [2019-09-16T14:36:20.429Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/graphdriver/test.main
14:36:21 [2019-09-16T14:36:21.799Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/logging/test.main
14:36:23 [2019-09-16T14:36:23.170Z] Building test suite binary /go/src/github.com/docker/docker/integration/plugin/volumes/test.main
14:36:24 [2019-09-16T14:36:24.541Z] Building test suite binary /go/src/github.com/docker/docker/integration/secret/test.main
14:36:25 [2019-09-16T14:36:25.473Z] Building test suite binary /go/src/github.com/docker/docker/integration/service/test.main
14:36:26 [2019-09-16T14:36:26.864Z] Building test suite binary /go/src/github.com/docker/docker/integration/session/test.main
14:36:27 [2019-09-16T14:36:27.797Z] Building test suite binary /go/src/github.com/docker/docker/integration/system/test.main
14:36:28 [2019-09-16T14:36:28.728Z] Building test suite binary /go/src/github.com/docker/docker/integration/volume/test.main
14:36:29 [2019-09-16T14:36:29.660Z] ---> Making bundle: .integration-daemon-start (in /go/src/github.com/docker/docker/bundles/test-integration/1)
14:36:29 [2019-09-16T14:36:29.660Z] Using test binary docker
14:36:29 [2019-09-16T14:36:29.660Z] /etc/init.d/apparmor: 130: /etc/init.d/apparmor: systemd-detect-virt: not found
14:36:29 [2019-09-16T14:36:29.660Z] Starting AppArmor profiles:Warning from stdin (line 1): /sbin/apparmor_parser: cannot use or update cache, disable, or force-complain via stdin
14:36:29 [2019-09-16T14:36:29.660Z] Warning failed to create cache: (null)
14:36:29 [2019-09-16T14:36:29.660Z] .
14:36:29 [2019-09-16T14:36:29.660Z] INFO: Waiting for daemon to start...
14:36:29 [2019-09-16T14:36:29.660Z] Starting dockerd
14:36:32 [2019-09-16T14:36:32.180Z] .
14:36:32 [2019-09-16T14:36:32.180Z] ---> Making bundle: .integration-daemon-setup (in /go/src/github.com/docker/docker/bundles/test-integration/1)
14:36:32 [2019-09-16T14:36:32.180Z] ---> Making bundle: .ensure-emptyfs (in /go/src/github.com/docker/docker/bundles/test-integration/1)
14:36:32 [2019-09-16T14:36:32.180Z] Running integration-test (iteration 1)
14:36:32 [2019-09-16T14:36:32.180Z] Running /go/src/github.com/docker/docker/integration/build flags=-test.v -test.timeout=120m  
14:36:32 [2019-09-16T14:36:32.180Z] INFO: Testing against a local daemon
14:36:32 [2019-09-16T14:36:32.180Z] === RUN   TestBuildWithSession
14:36:35 [2019-09-16T14:36:35.455Z] --- PASS: TestBuildWithSession (3.11s)
14:36:35 [2019-09-16T14:36:35.455Z]     build_session_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestBuildWithSession
14:36:35 [2019-09-16T14:36:35.455Z]     daemon.go:302: [d6c6973c6c95c] waiting for daemon to start
14:36:35 [2019-09-16T14:36:35.455Z]     daemon.go:334: [d6c6973c6c95c] daemon started
14:36:35 [2019-09-16T14:36:35.455Z]     daemon.go:286: [d6c6973c6c95c] exiting daemon
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildSquashParent
14:36:35 [2019-09-16T14:36:35.455Z] --- SKIP: TestBuildSquashParent (0.00s)
14:36:35 [2019-09-16T14:36:35.455Z]     build_squash_test.go:23: !testEnv.DaemonInfo.ExperimentalBuild
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:36:35 [2019-09-16T14:36:35.455Z] === RUN   TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:36:35 [2019-09-16T14:36:35.455Z] === PAUSE TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:36:35 [2019-09-16T14:36:35.455Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal
14:36:35 [2019-09-16T14:36:35.455Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove
14:36:37 [2019-09-16T14:36:37.350Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal
14:36:37 [2019-09-16T14:36:37.350Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove
14:36:39 [2019-09-16T14:36:39.246Z] === CONT  TestBuildWithRemoveAndForceRemove/successful_build_with_remove
14:36:39 [2019-09-16T14:36:39.246Z] === CONT  TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove
14:36:41 [2019-09-16T14:36:41.140Z] --- PASS: TestBuildWithRemoveAndForceRemove (0.05s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove (2.02s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_no_removal (2.13s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_no_removal (1.86s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove_and_force_remove (1.95s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/successful_build_with_remove (1.90s)
14:36:41 [2019-09-16T14:36:41.140Z]     --- PASS: TestBuildWithRemoveAndForceRemove/failed_build_with_remove_and_force_remove (1.89s)
14:36:41 [2019-09-16T14:36:41.140Z] === RUN   TestBuildMultiStageParentConfig
14:37:13 [2019-09-16T14:37:13.176Z] --- PASS: TestBuildMultiStageParentConfig (31.11s)
14:37:13 [2019-09-16T14:37:13.176Z]     build_test.go:175: [{-1 1568644602 sha256:f3c6774f598e62d2b8c6050da192c45d885d6fa14281fb413766a34c2a63796d map[] sha256:bd6f8d9d2c8b8e4888177b7e45601d8f664fc879729668c2c97d2a2e071e1c15 [] [build1:latest] -1 1129289 1129289} {-1 1568644601 sha256:ef85515b3bfd8ae8ec08ad839115dce66ab3fcfd95fac2484342abd5cea814d1 map[] sha256:c4459d28378890b1e6ce702917fe292c8d51f78ba45565054a0cec2fbeac1454 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644600 sha256:cc01dd33254c826d11de17b323af1ea30ddd253ea1b7d67b9ad510b9c69f41d9 map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644599 sha256:fbb0c89c58b2b332dae94ee7137e41453f7a3fbf82d8a28d78dec369ed9b591e map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644598 sha256:abdc4846739d90b1e232dfda77dd3b3961aabe11f1d13050f64703866a7ca7b0 map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644598 sha256:d513d792c63219232b2b763875cb3b103dc68c671095588a9ee88b94a742ef49 map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644596 sha256:c3c3adfb765698b5dbf3669021aba3f15dd90de224590aa3590c93b080446132 map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1568644596 sha256:b89ffc7284e0fb9c72e6ef574514e9665f095dc35086ee665737ef2cf6baee8a map[] sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 [<none>@<none>] [<none>:<none>] -1 1129289 1129289} {-1 1516768215 sha256:2bbf44aed9f866d88c0e7d006d4ffe8d53186a12ffd6dca5e1baa59ba3024b85 map[]  [] [busybox:glibc] -1 4403845 4403845} {-1 1511223798 sha256:f2a91732366c0332ccd7afd2a5c4ff2b9af81f549370f7a19acd460f87686bc7 map[]  [] [hello-world:frozen] -1 1848 1848} {-1 1509809246 sha256:cb92533ca5cc26b3e36c11b6007fb838a8d2ea73a24faf738084c57ce193b944 map[]  [] [buildpack-deps:jessie] -1 614744077 614744077} {-1 1509772896 sha256:25fc9eb3417fa06d0d7fc83706b1ef5855dd1a8767fc29476b49e4edf8230867 map[]  [] [debian:jessie] -1 123410006 123410006} {-1 1509748757 sha256:6ad733544a6317992a6fac4eb19fe1df577d4dec7529efec28a5bd0edad0fd30 map[]  [] [busybox:latest] -1 1129289 1129289} {-1 1371157430 sha256:11f64303f0f7ffdc71f001788132bca5346831939a956e3e975c93267d89a16d map[]  [] [emptyfs:latest] -1 0 0}]
14:37:13 [2019-09-16T14:37:13.176Z] === RUN   TestBuildLabelWithTargets
14:37:13 [2019-09-16T14:37:13.739Z] --- PASS: TestBuildLabelWithTargets (1.66s)
14:37:13 [2019-09-16T14:37:13.739Z] === RUN   TestBuildWithEmptyLayers
14:37:14 [2019-09-16T14:37:14.672Z] --- PASS: TestBuildWithEmptyLayers (0.69s)
14:37:14 [2019-09-16T14:37:14.672Z] === RUN   TestBuildMultiStageOnBuild
14:37:17 [2019-09-16T14:37:17.205Z] --- PASS: TestBuildMultiStageOnBuild (2.59s)
14:37:17 [2019-09-16T14:37:17.205Z] === RUN   TestBuildUncleanTarFilenames
14:37:18 [2019-09-16T14:37:18.135Z] --- PASS: TestBuildUncleanTarFilenames (0.95s)
14:37:18 [2019-09-16T14:37:18.135Z] === RUN   TestBuildMultiStageLayerLeak
14:37:20 [2019-09-16T14:37:20.656Z] --- PASS: TestBuildMultiStageLayerLeak (2.65s)
14:37:20 [2019-09-16T14:37:20.656Z] === RUN   TestBuildWithHugeFile
14:38:16 [2019-09-16T14:38:16.853Z] --- PASS: TestBuildWithHugeFile (53.83s)
14:38:16 [2019-09-16T14:38:16.853Z] === RUN   TestBuildWithEmptyDockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === RUN   TestBuildWithEmptyDockerfile/empty-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === PAUSE TestBuildWithEmptyDockerfile/empty-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === RUN   TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === PAUSE TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === RUN   TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === PAUSE TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === CONT  TestBuildWithEmptyDockerfile/empty-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === CONT  TestBuildWithEmptyDockerfile/comment-only-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] === CONT  TestBuildWithEmptyDockerfile/empty-lines-dockerfile
14:38:16 [2019-09-16T14:38:16.853Z] --- PASS: TestBuildWithEmptyDockerfile (0.06s)
14:38:16 [2019-09-16T14:38:16.853Z]     --- PASS: TestBuildWithEmptyDockerfile/comment-only-dockerfile (0.27s)
14:38:16 [2019-09-16T14:38:16.853Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-dockerfile (0.27s)
14:38:16 [2019-09-16T14:38:16.853Z]     --- PASS: TestBuildWithEmptyDockerfile/empty-lines-dockerfile (0.08s)
14:38:16 [2019-09-16T14:38:16.853Z] PASS
14:38:16 [2019-09-16T14:38:16.853Z] Running /go/src/github.com/docker/docker/integration/config flags=-test.v -test.timeout=120m  
14:38:16 [2019-09-16T14:38:16.853Z] INFO: Testing against a local daemon
14:38:16 [2019-09-16T14:38:16.853Z] === RUN   TestConfigList
14:38:18 [2019-09-16T14:38:18.220Z] --- PASS: TestConfigList (3.01s)
14:38:18 [2019-09-16T14:38:18.220Z]     config_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigList
14:38:18 [2019-09-16T14:38:18.220Z]     daemon.go:302: [d530bdbde10bc] waiting for daemon to start
14:38:18 [2019-09-16T14:38:18.220Z]     daemon.go:334: [d530bdbde10bc] daemon started
14:38:18 [2019-09-16T14:38:18.220Z]     daemon.go:286: [d530bdbde10bc] exiting daemon
14:38:18 [2019-09-16T14:38:18.220Z] === RUN   TestConfigsCreateAndDelete
14:38:21 [2019-09-16T14:38:21.493Z] --- PASS: TestConfigsCreateAndDelete (2.97s)
14:38:21 [2019-09-16T14:38:21.493Z]     config_test.go:108: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigsCreateAndDelete
14:38:21 [2019-09-16T14:38:21.493Z]     daemon.go:302: [d726e2819982e] waiting for daemon to start
14:38:21 [2019-09-16T14:38:21.493Z]     daemon.go:334: [d726e2819982e] daemon started
14:38:21 [2019-09-16T14:38:21.493Z]     daemon.go:286: [d726e2819982e] exiting daemon
14:38:21 [2019-09-16T14:38:21.493Z] === RUN   TestConfigsUpdate
14:38:24 [2019-09-16T14:38:24.049Z] --- PASS: TestConfigsUpdate (3.04s)
14:38:24 [2019-09-16T14:38:24.049Z]     config_test.go:136: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigsUpdate
14:38:24 [2019-09-16T14:38:24.049Z]     daemon.go:302: [d0f27a1126829] waiting for daemon to start
14:38:24 [2019-09-16T14:38:24.049Z]     daemon.go:334: [d0f27a1126829] daemon started
14:38:24 [2019-09-16T14:38:24.049Z]     daemon.go:286: [d0f27a1126829] exiting daemon
14:38:24 [2019-09-16T14:38:24.049Z] === RUN   TestTemplatedConfig
14:38:27 [2019-09-16T14:38:27.326Z] --- PASS: TestTemplatedConfig (3.31s)
14:38:27 [2019-09-16T14:38:27.326Z]     config_test.go:188: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestTemplatedConfig
14:38:27 [2019-09-16T14:38:27.326Z]     daemon.go:302: [d201a6c0fa85d] waiting for daemon to start
14:38:27 [2019-09-16T14:38:27.326Z]     daemon.go:334: [d201a6c0fa85d] daemon started
14:38:27 [2019-09-16T14:38:27.326Z]     daemon.go:286: [d201a6c0fa85d] exiting daemon
14:38:27 [2019-09-16T14:38:27.326Z] === RUN   TestConfigInspect
14:38:30 [2019-09-16T14:38:30.599Z] --- PASS: TestConfigInspect (2.91s)
14:38:30 [2019-09-16T14:38:30.599Z]     config_test.go:330: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigInspect
14:38:30 [2019-09-16T14:38:30.599Z]     daemon.go:302: [dc9a35f9a3fb8] waiting for daemon to start
14:38:30 [2019-09-16T14:38:30.599Z]     daemon.go:334: [dc9a35f9a3fb8] daemon started
14:38:30 [2019-09-16T14:38:30.599Z]     daemon.go:286: [dc9a35f9a3fb8] exiting daemon
14:38:30 [2019-09-16T14:38:30.599Z] === RUN   TestConfigCreateWithLabels
14:38:33 [2019-09-16T14:38:33.871Z] --- PASS: TestConfigCreateWithLabels (3.01s)
14:38:33 [2019-09-16T14:38:33.871Z]     config_test.go:354: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigCreateWithLabels
14:38:33 [2019-09-16T14:38:33.871Z]     daemon.go:302: [db2ab9972cdfa] waiting for daemon to start
14:38:33 [2019-09-16T14:38:33.871Z]     daemon.go:334: [db2ab9972cdfa] daemon started
14:38:33 [2019-09-16T14:38:33.871Z]     daemon.go:286: [db2ab9972cdfa] exiting daemon
14:38:33 [2019-09-16T14:38:33.871Z] === RUN   TestConfigCreateResolve
14:38:36 [2019-09-16T14:38:36.391Z] --- PASS: TestConfigCreateResolve (3.07s)
14:38:36 [2019-09-16T14:38:36.391Z]     config_test.go:381: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestConfigCreateResolve
14:38:36 [2019-09-16T14:38:36.391Z]     daemon.go:302: [dcbf960526404] waiting for daemon to start
14:38:36 [2019-09-16T14:38:36.391Z]     daemon.go:334: [dcbf960526404] daemon started
14:38:36 [2019-09-16T14:38:36.391Z]     daemon.go:286: [dcbf960526404] exiting daemon
14:38:36 [2019-09-16T14:38:36.391Z] PASS
14:38:36 [2019-09-16T14:38:36.391Z] Running /go/src/github.com/docker/docker/integration/container flags=-test.v -test.timeout=120m  
14:38:36 [2019-09-16T14:38:36.648Z] INFO: Testing against a local daemon
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestContainerInvalidJSON
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestContainerInvalidJSON//containers/foobar/copy
14:38:36 [2019-09-16T14:38:36.648Z] === PAUSE TestContainerInvalidJSON//containers/foobar/copy
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestContainerInvalidJSON//containers/foobar/exec
14:38:36 [2019-09-16T14:38:36.648Z] === PAUSE TestContainerInvalidJSON//containers/foobar/exec
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestContainerInvalidJSON//exec/foobar/start
14:38:36 [2019-09-16T14:38:36.648Z] === PAUSE TestContainerInvalidJSON//exec/foobar/start
14:38:36 [2019-09-16T14:38:36.648Z] === CONT  TestContainerInvalidJSON//containers/foobar/copy
14:38:36 [2019-09-16T14:38:36.648Z] === CONT  TestContainerInvalidJSON//exec/foobar/start
14:38:36 [2019-09-16T14:38:36.648Z] === CONT  TestContainerInvalidJSON//containers/foobar/exec
14:38:36 [2019-09-16T14:38:36.648Z] --- PASS: TestContainerInvalidJSON (0.06s)
14:38:36 [2019-09-16T14:38:36.648Z]     --- PASS: TestContainerInvalidJSON//exec/foobar/start (0.00s)
14:38:36 [2019-09-16T14:38:36.648Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/copy (0.00s)
14:38:36 [2019-09-16T14:38:36.648Z]     --- PASS: TestContainerInvalidJSON//containers/foobar/exec (0.00s)
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestCopyFromContainerPathDoesNotExist
14:38:36 [2019-09-16T14:38:36.648Z] --- PASS: TestCopyFromContainerPathDoesNotExist (0.15s)
14:38:36 [2019-09-16T14:38:36.648Z] === RUN   TestCopyFromContainerPathIsNotDir
14:38:36 [2019-09-16T14:38:36.905Z] --- PASS: TestCopyFromContainerPathIsNotDir (0.15s)
14:38:36 [2019-09-16T14:38:36.905Z] === RUN   TestCopyToContainerPathDoesNotExist
14:38:36 [2019-09-16T14:38:36.905Z] --- PASS: TestCopyToContainerPathDoesNotExist (0.13s)
14:38:36 [2019-09-16T14:38:36.905Z] === RUN   TestCopyToContainerPathIsNotDir
14:38:37 [2019-09-16T14:38:37.163Z] --- PASS: TestCopyToContainerPathIsNotDir (0.14s)
14:38:37 [2019-09-16T14:38:37.163Z] === RUN   TestCopyFromContainer
14:38:39 [2019-09-16T14:38:39.059Z] === RUN   TestCopyFromContainer//
14:38:39 [2019-09-16T14:38:39.059Z] === RUN   TestCopyFromContainer//bar/root
14:38:39 [2019-09-16T14:38:39.059Z] === RUN   TestCopyFromContainer//bar/root/
14:38:39 [2019-09-16T14:38:39.059Z] === RUN   TestCopyFromContainer/bar/quux
14:38:39 [2019-09-16T14:38:39.059Z] === RUN   TestCopyFromContainer/bar/quux/
14:38:39 [2019-09-16T14:38:39.316Z] === RUN   TestCopyFromContainer/bar/quux/baz
14:38:39 [2019-09-16T14:38:39.316Z] === RUN   TestCopyFromContainer/bar/filesymlink
14:38:39 [2019-09-16T14:38:39.316Z] === RUN   TestCopyFromContainer/bar/dirsymlink
14:38:39 [2019-09-16T14:38:39.316Z] === RUN   TestCopyFromContainer/bar/dirsymlink/
14:38:39 [2019-09-16T14:38:39.573Z] === RUN   TestCopyFromContainer/bar/notarget
14:38:39 [2019-09-16T14:38:39.573Z] --- PASS: TestCopyFromContainer (2.43s)
14:38:39 [2019-09-16T14:38:39.573Z]     --- PASS: TestCopyFromContainer// (0.06s)
14:38:39 [2019-09-16T14:38:39.573Z]     --- PASS: TestCopyFromContainer//bar/root (0.10s)
14:38:39 [2019-09-16T14:38:39.573Z]     --- PASS: TestCopyFromContainer//bar/root/ (0.06s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/quux (0.08s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/quux/ (0.07s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/quux/baz (0.07s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/filesymlink (0.07s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink (0.07s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/dirsymlink/ (0.08s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCopyFromContainer/bar/notarget (0.07s)
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateFailsWhenIdentifierDoesNotExist/digest
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateFailsWhenIdentifierDoesNotExist/digest
14:38:39 [2019-09-16T14:38:39.574Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag
14:38:39 [2019-09-16T14:38:39.574Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/digest
14:38:39 [2019-09-16T14:38:39.574Z] === CONT  TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag
14:38:39 [2019-09-16T14:38:39.574Z] --- PASS: TestCreateFailsWhenIdentifierDoesNotExist (0.05s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_and_tag (0.00s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/digest (0.01s)
14:38:39 [2019-09-16T14:38:39.574Z]     --- PASS: TestCreateFailsWhenIdentifierDoesNotExist/image_no_tag (0.00s)
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateWithInvalidEnv
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateWithInvalidEnv/0
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateWithInvalidEnv/0
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateWithInvalidEnv/1
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateWithInvalidEnv/1
14:38:39 [2019-09-16T14:38:39.574Z] === RUN   TestCreateWithInvalidEnv/2
14:38:39 [2019-09-16T14:38:39.574Z] === PAUSE TestCreateWithInvalidEnv/2
14:38:39 [2019-09-16T14:38:39.830Z] === CONT  TestCreateWithInvalidEnv/0
14:38:39 [2019-09-16T14:38:39.830Z] === CONT  TestCreateWithInvalidEnv/2
14:38:39 [2019-09-16T14:38:39.830Z] === CONT  TestCreateWithInvalidEnv/1
14:38:39 [2019-09-16T14:38:39.830Z] --- PASS: TestCreateWithInvalidEnv (0.05s)
14:38:39 [2019-09-16T14:38:39.830Z]     --- PASS: TestCreateWithInvalidEnv/0 (0.00s)
14:38:39 [2019-09-16T14:38:39.830Z]     --- PASS: TestCreateWithInvalidEnv/2 (0.00s)
14:38:39 [2019-09-16T14:38:39.830Z]     --- PASS: TestCreateWithInvalidEnv/1 (0.00s)
14:38:39 [2019-09-16T14:38:39.830Z] === RUN   TestCreateTmpfsMountsTarget
14:38:39 [2019-09-16T14:38:39.830Z] --- PASS: TestCreateTmpfsMountsTarget (0.08s)
14:38:39 [2019-09-16T14:38:39.830Z] === RUN   TestCreateWithCustomMaskedPaths
14:38:42 [2019-09-16T14:38:42.352Z] --- PASS: TestCreateWithCustomMaskedPaths (2.35s)
14:38:42 [2019-09-16T14:38:42.352Z] === RUN   TestCreateWithCustomReadonlyPaths
14:38:44 [2019-09-16T14:38:44.874Z] --- PASS: TestCreateWithCustomReadonlyPaths (2.45s)
14:38:44 [2019-09-16T14:38:44.874Z] === RUN   TestContainerStartOnDaemonRestart
14:38:44 [2019-09-16T14:38:44.874Z] === PAUSE TestContainerStartOnDaemonRestart
14:38:44 [2019-09-16T14:38:44.874Z] === RUN   TestDaemonRestartIpcMode
14:38:44 [2019-09-16T14:38:44.874Z] === PAUSE TestDaemonRestartIpcMode
14:38:44 [2019-09-16T14:38:44.874Z] === RUN   TestDiff
14:38:45 [2019-09-16T14:38:45.438Z] --- PASS: TestDiff (0.84s)
14:38:45 [2019-09-16T14:38:45.438Z] === RUN   TestExecWithCloseStdin
14:38:46 [2019-09-16T14:38:46.370Z] --- PASS: TestExecWithCloseStdin (0.98s)
14:38:46 [2019-09-16T14:38:46.370Z] === RUN   TestExec
14:38:47 [2019-09-16T14:38:47.301Z] --- PASS: TestExec (1.00s)
14:38:47 [2019-09-16T14:38:47.301Z] === RUN   TestExecUser
14:38:48 [2019-09-16T14:38:48.670Z] --- PASS: TestExecUser (0.97s)
14:38:48 [2019-09-16T14:38:48.670Z] === RUN   TestExportContainerAndImportImage
14:38:49 [2019-09-16T14:38:49.600Z] --- PASS: TestExportContainerAndImportImage (1.05s)
14:38:49 [2019-09-16T14:38:49.600Z] === RUN   TestExportContainerAfterDaemonRestart
14:38:50 [2019-09-16T14:38:50.971Z] --- PASS: TestExportContainerAfterDaemonRestart (1.39s)
14:38:50 [2019-09-16T14:38:50.971Z]     export_test.go:63: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestExportContainerAfterDaemonRestart
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:302: [d9a27c909caf5] waiting for daemon to start
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:334: [d9a27c909caf5] daemon started
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:286: [d9a27c909caf5] exiting daemon
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:302: [d9a27c909caf5] waiting for daemon to start
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:334: [d9a27c909caf5] daemon started
14:38:50 [2019-09-16T14:38:50.971Z]     daemon.go:286: [d9a27c909caf5] exiting daemon
14:38:50 [2019-09-16T14:38:50.971Z] === RUN   TestHealthCheckWorkdir
14:38:51 [2019-09-16T14:38:51.904Z] --- PASS: TestHealthCheckWorkdir (1.18s)
14:38:51 [2019-09-16T14:38:51.904Z] === RUN   TestHealthKillContainer
14:38:55 [2019-09-16T14:38:55.175Z] --- PASS: TestHealthKillContainer (2.99s)
14:38:55 [2019-09-16T14:38:55.175Z] === RUN   TestInspectCpusetInConfigPre120
14:38:55 [2019-09-16T14:38:55.738Z] --- PASS: TestInspectCpusetInConfigPre120 (0.87s)
14:38:55 [2019-09-16T14:38:55.738Z] === RUN   TestIpcModeNone
14:38:57 [2019-09-16T14:38:57.108Z] --- PASS: TestIpcModeNone (0.96s)
14:38:57 [2019-09-16T14:38:57.109Z] === RUN   TestIpcModePrivate
14:38:58 [2019-09-16T14:38:58.040Z] --- PASS: TestIpcModePrivate (0.98s)
14:38:58 [2019-09-16T14:38:58.040Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: private, ipcdev: 0:94, shared: false, mustBeShared: false
14:38:58 [2019-09-16T14:38:58.040Z] === RUN   TestIpcModeShareable
14:38:58 [2019-09-16T14:38:58.971Z] --- PASS: TestIpcModeShareable (0.97s)
14:38:58 [2019-09-16T14:38:58.971Z]     ipcmode_linux_test.go:87: [testIpcPrivateShareable] ipcmode: shareable, ipcdev: 0:88, shared: true, mustBeShared: true
14:38:58 [2019-09-16T14:38:58.971Z] === RUN   TestAPIIpcModeShareableAndContainer
14:39:02 [2019-09-16T14:39:02.244Z] --- PASS: TestAPIIpcModeShareableAndContainer (2.87s)
14:39:02 [2019-09-16T14:39:02.244Z] === RUN   TestAPIIpcModeHost
14:39:02 [2019-09-16T14:39:02.501Z] --- PASS: TestAPIIpcModeHost (0.82s)
14:39:02 [2019-09-16T14:39:02.501Z] === RUN   TestDaemonIpcModeShareable
14:39:04 [2019-09-16T14:39:04.395Z] --- PASS: TestDaemonIpcModeShareable (1.72s)
14:39:04 [2019-09-16T14:39:04.395Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonIpcModeShareable
14:39:04 [2019-09-16T14:39:04.395Z]     daemon.go:302: [ddc6e5e9ce3f7] waiting for daemon to start
14:39:04 [2019-09-16T14:39:04.395Z]     daemon.go:334: [ddc6e5e9ce3f7] daemon started
14:39:04 [2019-09-16T14:39:04.395Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:99, shared: true, mustBeShared: true
14:39:04 [2019-09-16T14:39:04.395Z]     daemon.go:286: [ddc6e5e9ce3f7] exiting daemon
14:39:04 [2019-09-16T14:39:04.395Z] === RUN   TestDaemonIpcModePrivate
14:39:05 [2019-09-16T14:39:05.764Z] --- PASS: TestDaemonIpcModePrivate (1.68s)
14:39:05 [2019-09-16T14:39:05.764Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonIpcModePrivate
14:39:05 [2019-09-16T14:39:05.764Z]     daemon.go:302: [d0d25197b5552] waiting for daemon to start
14:39:05 [2019-09-16T14:39:05.764Z]     daemon.go:334: [d0d25197b5552] daemon started
14:39:05 [2019-09-16T14:39:05.764Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:105, shared: false, mustBeShared: false
14:39:05 [2019-09-16T14:39:05.764Z]     daemon.go:286: [d0d25197b5552] exiting daemon
14:39:05 [2019-09-16T14:39:05.764Z] === RUN   TestDaemonIpcModePrivateFromConfig
14:39:07 [2019-09-16T14:39:07.656Z] --- PASS: TestDaemonIpcModePrivateFromConfig (1.73s)
14:39:07 [2019-09-16T14:39:07.656Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonIpcModePrivateFromConfig
14:39:07 [2019-09-16T14:39:07.656Z]     daemon.go:302: [d5ba28d8199d8] waiting for daemon to start
14:39:07 [2019-09-16T14:39:07.656Z]     daemon.go:334: [d5ba28d8199d8] daemon started
14:39:07 [2019-09-16T14:39:07.656Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:105, shared: false, mustBeShared: false
14:39:07 [2019-09-16T14:39:07.656Z]     daemon.go:286: [d5ba28d8199d8] exiting daemon
14:39:07 [2019-09-16T14:39:07.656Z] === RUN   TestDaemonIpcModeShareableFromConfig
14:39:09 [2019-09-16T14:39:09.549Z] --- PASS: TestDaemonIpcModeShareableFromConfig (1.70s)
14:39:09 [2019-09-16T14:39:09.549Z]     ipcmode_linux_test.go:227: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonIpcModeShareableFromConfig
14:39:09 [2019-09-16T14:39:09.549Z]     daemon.go:302: [d50f3ddb2abc3] waiting for daemon to start
14:39:09 [2019-09-16T14:39:09.549Z]     daemon.go:334: [d50f3ddb2abc3] daemon started
14:39:09 [2019-09-16T14:39:09.549Z]     ipcmode_linux_test.go:255: [testDaemonIpcPrivateShareable] ipcdev: 0:99, shared: true, mustBeShared: true
14:39:09 [2019-09-16T14:39:09.549Z]     daemon.go:286: [d50f3ddb2abc3] exiting daemon
14:39:09 [2019-09-16T14:39:09.549Z] === RUN   TestKillContainerInvalidSignal
14:39:10 [2019-09-16T14:39:10.112Z] --- PASS: TestKillContainerInvalidSignal (0.90s)
14:39:10 [2019-09-16T14:39:10.112Z] === RUN   TestKillContainer
14:39:10 [2019-09-16T14:39:10.112Z] === RUN   TestKillContainer/no_signal
14:39:11 [2019-09-16T14:39:11.041Z] === RUN   TestKillContainer/non_killing_signal
14:39:11 [2019-09-16T14:39:11.605Z] === RUN   TestKillContainer/killing_signal
14:39:12 [2019-09-16T14:39:12.974Z] --- PASS: TestKillContainer (2.55s)
14:39:12 [2019-09-16T14:39:12.974Z]     --- PASS: TestKillContainer/no_signal (0.83s)
14:39:12 [2019-09-16T14:39:12.974Z]     --- PASS: TestKillContainer/non_killing_signal (0.58s)
14:39:12 [2019-09-16T14:39:12.974Z]     --- PASS: TestKillContainer/killing_signal (0.84s)
14:39:12 [2019-09-16T14:39:12.974Z] === RUN   TestKillWithStopSignalAndRestartPolicies
14:39:12 [2019-09-16T14:39:12.974Z] === RUN   TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy
14:39:13 [2019-09-16T14:39:13.538Z] === RUN   TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy
14:39:14 [2019-09-16T14:39:14.468Z] --- PASS: TestKillWithStopSignalAndRestartPolicies (1.66s)
14:39:14 [2019-09-16T14:39:14.468Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/same-signal-disables-restart-policy (0.82s)
14:39:14 [2019-09-16T14:39:14.468Z]     --- PASS: TestKillWithStopSignalAndRestartPolicies/different-signal-keep-restart-policy (0.58s)
14:39:14 [2019-09-16T14:39:14.468Z] === RUN   TestKillStoppedContainer
14:39:14 [2019-09-16T14:39:14.468Z] --- PASS: TestKillStoppedContainer (0.12s)
14:39:14 [2019-09-16T14:39:14.468Z] === RUN   TestKillStoppedContainerAPIPre120
14:39:14 [2019-09-16T14:39:14.734Z] --- PASS: TestKillStoppedContainerAPIPre120 (0.13s)
14:39:14 [2019-09-16T14:39:14.734Z] === RUN   TestKillDifferentUserContainer
14:39:15 [2019-09-16T14:39:15.665Z] --- PASS: TestKillDifferentUserContainer (0.89s)
14:39:15 [2019-09-16T14:39:15.665Z] === RUN   TestInspectOomKilledTrue
14:39:15 [2019-09-16T14:39:15.665Z] --- SKIP: TestInspectOomKilledTrue (0.00s)
14:39:15 [2019-09-16T14:39:15.665Z]     kill_test.go:151: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:39:15 [2019-09-16T14:39:15.665Z] === RUN   TestInspectOomKilledFalse
14:39:15 [2019-09-16T14:39:15.665Z] --- SKIP: TestInspectOomKilledFalse (0.00s)
14:39:15 [2019-09-16T14:39:15.665Z]     kill_test.go:169: testEnv.DaemonInfo.OSType == "windows" || !testEnv.DaemonInfo.MemoryLimit || !testEnv.DaemonInfo.SwapLimit
14:39:15 [2019-09-16T14:39:15.665Z] === RUN   TestLinksEtcHostsContentMatch
14:39:16 [2019-09-16T14:39:16.227Z] --- PASS: TestLinksEtcHostsContentMatch (0.58s)
14:39:16 [2019-09-16T14:39:16.227Z] === RUN   TestLinksContainerNames
14:39:18 [2019-09-16T14:39:18.121Z] --- PASS: TestLinksContainerNames (1.71s)
14:39:18 [2019-09-16T14:39:18.121Z] === RUN   TestLogsFollowTailEmpty
14:39:18 [2019-09-16T14:39:18.685Z] --- PASS: TestLogsFollowTailEmpty (0.89s)
14:39:18 [2019-09-16T14:39:18.685Z] === RUN   TestContainerNetworkMountsNoChown
14:39:19 [2019-09-16T14:39:19.617Z] --- PASS: TestContainerNetworkMountsNoChown (0.85s)
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/default
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/default
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/private
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/private
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rprivate
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rprivate
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/slave
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/slave
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rslave
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rslave
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/shared
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/shared
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rshared
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rshared
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/default
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/default/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/default/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/default/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/default/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/default/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/default/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/rslave
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/default/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/default/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rslave/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rslave/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rslave/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rslave/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rslave/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rslave/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rslave/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rslave/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/rshared
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rshared/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rshared/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rshared/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rshared/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rshared/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rshared/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rshared/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rshared/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/shared
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/shared/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/shared/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/shared/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/shared/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/shared/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/shared/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/shared/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/shared/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/rprivate
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rprivate/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rprivate/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rprivate/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rprivate/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rprivate/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rprivate/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/rprivate/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/rprivate/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/slave
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/slave/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/slave/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/slave/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/slave/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/slave/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/slave/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/slave/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/slave/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/private
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/private/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/private/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/private/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/private/bind_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/private/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/private/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === RUN   TestMountDaemonRoot/private/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === PAUSE TestMountDaemonRoot/private/mount_subpath
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/default/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/rslave/bind_root
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/default/mount_root
14:39:19 [2019-09-16T14:39:19.617Z] === CONT  TestMountDaemonRoot/default/bind_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rslave/mount_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rslave/mount_root
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rslave/bind_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/default/mount_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rshared/bind_root
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/shared/bind_root
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rprivate/bind_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rshared/mount_subpath
14:39:19 [2019-09-16T14:39:19.874Z] === CONT  TestMountDaemonRoot/rshared/mount_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/rshared/bind_subpath
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/slave/bind_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/shared/mount_subpath
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/shared/mount_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/shared/bind_subpath
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/private/bind_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/rprivate/bind_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/rprivate/mount_subpath
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/rprivate/mount_root
14:39:20 [2019-09-16T14:39:20.131Z] === CONT  TestMountDaemonRoot/slave/mount_subpath
14:39:20 [2019-09-16T14:39:20.388Z] === CONT  TestMountDaemonRoot/slave/mount_root
14:39:20 [2019-09-16T14:39:20.388Z] === CONT  TestMountDaemonRoot/slave/bind_subpath
14:39:20 [2019-09-16T14:39:20.388Z] === CONT  TestMountDaemonRoot/private/mount_subpath
14:39:20 [2019-09-16T14:39:20.388Z] === CONT  TestMountDaemonRoot/private/mount_root
14:39:20 [2019-09-16T14:39:20.388Z] === CONT  TestMountDaemonRoot/private/bind_subpath
14:39:20 [2019-09-16T14:39:20.388Z] --- PASS: TestMountDaemonRoot (0.05s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/rslave (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rslave/bind_root (0.08s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rslave/mount_subpath (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rslave/mount_root (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rslave/bind_subpath (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/default (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/default/bind_root (0.09s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/default/mount_root (0.08s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/default/bind_subpath (0.08s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/default/mount_subpath (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/rshared (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rshared/bind_root (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rshared/mount_subpath (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rshared/mount_root (0.07s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rshared/bind_subpath (0.06s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/shared (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/shared/bind_root (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/shared/mount_subpath (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/shared/mount_root (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/shared/bind_subpath (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/rprivate (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_subpath (0.03s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rprivate/bind_root (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_subpath (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/rprivate/mount_root (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/slave (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/slave/bind_root (0.03s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/slave/mount_subpath (0.05s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/slave/bind_subpath (0.03s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/slave/mount_root (0.05s)
14:39:20 [2019-09-16T14:39:20.388Z]     --- PASS: TestMountDaemonRoot/private (0.00s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/private/bind_root (0.05s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/private/mount_subpath (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/private/mount_root (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z]         --- PASS: TestMountDaemonRoot/private/bind_subpath (0.04s)
14:39:20 [2019-09-16T14:39:20.388Z] === RUN   TestNetworkNat
14:39:21 [2019-09-16T14:39:21.319Z] --- PASS: TestNetworkNat (0.88s)
14:39:21 [2019-09-16T14:39:21.319Z] === RUN   TestNetworkLocalhostTCPNat
14:39:22 [2019-09-16T14:39:22.253Z] --- PASS: TestNetworkLocalhostTCPNat (0.89s)
14:39:22 [2019-09-16T14:39:22.253Z] === RUN   TestNetworkLoopbackNat
14:39:23 [2019-09-16T14:39:23.182Z] --- PASS: TestNetworkLoopbackNat (1.09s)
14:39:23 [2019-09-16T14:39:23.182Z] === RUN   TestPause
14:39:24 [2019-09-16T14:39:24.112Z] --- PASS: TestPause (0.95s)
14:39:24 [2019-09-16T14:39:24.112Z] === RUN   TestPauseFailsOnWindowsServerContainers
14:39:24 [2019-09-16T14:39:24.112Z] --- SKIP: TestPauseFailsOnWindowsServerContainers (0.00s)
14:39:24 [2019-09-16T14:39:24.112Z]     pause_test.go:54: testEnv.DaemonInfo.OSType != "windows" || testEnv.DaemonInfo.Isolation != "process"
14:39:24 [2019-09-16T14:39:24.112Z] === RUN   TestPauseStopPausedContainer
14:39:25 [2019-09-16T14:39:25.041Z] --- PASS: TestPauseStopPausedContainer (0.89s)
14:39:25 [2019-09-16T14:39:25.041Z] === RUN   TestPsFilter
14:39:25 [2019-09-16T14:39:25.299Z] --- PASS: TestPsFilter (0.26s)
14:39:25 [2019-09-16T14:39:25.299Z] === RUN   TestRemoveContainerWithRemovedVolume
14:39:26 [2019-09-16T14:39:26.228Z] --- PASS: TestRemoveContainerWithRemovedVolume (0.89s)
14:39:26 [2019-09-16T14:39:26.228Z] === RUN   TestRemoveContainerWithVolume
14:39:27 [2019-09-16T14:39:27.160Z] --- PASS: TestRemoveContainerWithVolume (0.88s)
14:39:27 [2019-09-16T14:39:27.160Z] === RUN   TestRemoveContainerRunning
14:39:28 [2019-09-16T14:39:28.091Z] --- PASS: TestRemoveContainerRunning (0.88s)
14:39:28 [2019-09-16T14:39:28.091Z] === RUN   TestRemoveContainerForceRemoveRunning
14:39:29 [2019-09-16T14:39:29.019Z] --- PASS: TestRemoveContainerForceRemoveRunning (0.87s)
14:39:29 [2019-09-16T14:39:29.019Z] === RUN   TestRemoveInvalidContainer
14:39:29 [2019-09-16T14:39:29.019Z] --- PASS: TestRemoveInvalidContainer (0.05s)
14:39:29 [2019-09-16T14:39:29.019Z] === RUN   TestRenameLinkedContainer
14:39:32 [2019-09-16T14:39:32.292Z] --- PASS: TestRenameLinkedContainer (3.32s)
14:39:32 [2019-09-16T14:39:32.292Z] === RUN   TestRenameStoppedContainer
14:39:33 [2019-09-16T14:39:33.222Z] --- PASS: TestRenameStoppedContainer (0.86s)
14:39:33 [2019-09-16T14:39:33.222Z] === RUN   TestRenameRunningContainerAndReuse
14:39:35 [2019-09-16T14:39:35.115Z] --- PASS: TestRenameRunningContainerAndReuse (1.71s)
14:39:35 [2019-09-16T14:39:35.115Z] === RUN   TestRenameInvalidName
14:39:35 [2019-09-16T14:39:35.679Z] --- PASS: TestRenameInvalidName (0.86s)
14:39:35 [2019-09-16T14:39:35.679Z] === RUN   TestRenameAnonymousContainer
14:39:39 [2019-09-16T14:39:39.865Z] --- PASS: TestRenameAnonymousContainer (3.56s)
14:39:39 [2019-09-16T14:39:39.865Z] === RUN   TestRenameContainerWithSameName
14:39:40 [2019-09-16T14:39:40.122Z] --- PASS: TestRenameContainerWithSameName (0.89s)
14:39:40 [2019-09-16T14:39:40.122Z] === RUN   TestRenameContainerWithLinkedContainer
14:39:42 [2019-09-16T14:39:42.016Z] --- PASS: TestRenameContainerWithLinkedContainer (1.77s)
14:39:42 [2019-09-16T14:39:42.016Z] === RUN   TestResize
14:39:42 [2019-09-16T14:39:42.946Z] --- PASS: TestResize (0.88s)
14:39:42 [2019-09-16T14:39:42.946Z] === RUN   TestResizeWithInvalidSize
14:39:43 [2019-09-16T14:39:43.878Z] --- PASS: TestResizeWithInvalidSize (0.89s)
14:39:43 [2019-09-16T14:39:43.878Z] === RUN   TestResizeWhenContainerNotStarted
14:39:44 [2019-09-16T14:39:44.443Z] --- PASS: TestResizeWhenContainerNotStarted (0.84s)
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === RUN   TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === PAUSE TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:39:44 [2019-09-16T14:39:44.443Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:39:46 [2019-09-16T14:39:46.340Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:39:46 [2019-09-16T14:39:46.597Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:39:47 [2019-09-16T14:39:47.527Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:39:47 [2019-09-16T14:39:47.784Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:39:48 [2019-09-16T14:39:48.716Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:39:50 [2019-09-16T14:39:50.090Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:39:51 [2019-09-16T14:39:51.021Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:39:52 [2019-09-16T14:39:52.916Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:39:53 [2019-09-16T14:39:53.847Z] === CONT  TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:39:54 [2019-09-16T14:39:54.779Z] === CONT  TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z] --- PASS: TestDaemonRestartKillContainers (0.00s)
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon (1.49s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [dfe86b44b48e9] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [dfe86b44b48e9] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [dfe86b44b48e9] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [dfe86b44b48e9] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [dfe86b44b48e9] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [dfe86b44b48e9] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon (2.05s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [db5769c952570] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [db5769c952570] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [db5769c952570] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [db5769c952570] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [db5769c952570] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [db5769c952570] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon (1.44s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_created_should_not_be_restarted/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d036fdf297082] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d036fdf297082] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d036fdf297082] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d036fdf297082] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d036fdf297082] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d036fdf297082] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon (1.35s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d9d2ef00fc991] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d9d2ef00fc991] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d9d2ef00fc991] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d9d2ef00fc991] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d9d2ef00fc991] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d9d2ef00fc991] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon (1.38s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_created_should_not_be_restarted/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d540fbf50c61c] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d540fbf50c61c] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d540fbf50c61c] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d540fbf50c61c] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d540fbf50c61c] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d540fbf50c61c] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon (2.12s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d8a4a75fc5e03] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d8a4a75fc5e03] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d8a4a75fc5e03] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d8a4a75fc5e03] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d8a4a75fc5e03] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d8a4a75fc5e03] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon (2.14s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_with_restart=always/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d3f1c545cda03] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d3f1c545cda03] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d3f1c545cda03] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d3f1c545cda03] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d3f1c545cda03] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d3f1c545cda03] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon (2.79s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d1aaa0c600851] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d1aaa0c600851] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d1aaa0c600851] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d1aaa0c600851] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d1aaa0c600851] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d1aaa0c600851] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon (2.96s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_with_restart=always/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d81dedf40255e] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d81dedf40255e] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d81dedf40255e] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d81dedf40255e] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d81dedf40255e] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d81dedf40255e] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon (2.05s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d33fb02605573] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d33fb02605573] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d33fb02605573] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d33fb02605573] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d33fb02605573] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d33fb02605573] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon (2.23s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=true/container_without_restart_policy/kill-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d00fc2918b3f4] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d00fc2918b3f4] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [d00fc2918b3f4] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d00fc2918b3f4] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [d00fc2918b3f4] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [d00fc2918b3f4] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]     --- PASS: TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon (2.14s)
14:39:57 [2019-09-16T14:39:57.302Z]         restart_test.go:67: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartKillContainers/live-restore=false/container_without_restart_policy/stop-daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [dc56288b44d5e] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [dc56288b44d5e] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [dc56288b44d5e] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:302: [dc56288b44d5e] waiting for daemon to start
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:334: [dc56288b44d5e] daemon started
14:39:57 [2019-09-16T14:39:57.302Z]         daemon.go:286: [dc56288b44d5e] exiting daemon
14:39:57 [2019-09-16T14:39:57.302Z] === RUN   TestStats
14:39:59 [2019-09-16T14:39:59.195Z] --- PASS: TestStats (2.16s)
14:39:59 [2019-09-16T14:39:59.195Z] === RUN   TestStopContainerWithTimeout
14:39:59 [2019-09-16T14:39:59.195Z] === RUN   TestStopContainerWithTimeout/0
14:39:59 [2019-09-16T14:39:59.195Z] === PAUSE TestStopContainerWithTimeout/0
14:39:59 [2019-09-16T14:39:59.195Z] === RUN   TestStopContainerWithTimeout/1
14:39:59 [2019-09-16T14:39:59.195Z] === PAUSE TestStopContainerWithTimeout/1
14:39:59 [2019-09-16T14:39:59.195Z] === RUN   TestStopContainerWithTimeout/3
14:39:59 [2019-09-16T14:39:59.195Z] === PAUSE TestStopContainerWithTimeout/3
14:39:59 [2019-09-16T14:39:59.195Z] === RUN   TestStopContainerWithTimeout/-1
14:39:59 [2019-09-16T14:39:59.195Z] === PAUSE TestStopContainerWithTimeout/-1
14:39:59 [2019-09-16T14:39:59.195Z] === CONT  TestStopContainerWithTimeout/0
14:39:59 [2019-09-16T14:39:59.195Z] === CONT  TestStopContainerWithTimeout/3
14:40:00 [2019-09-16T14:40:00.564Z] === CONT  TestStopContainerWithTimeout/-1
14:40:02 [2019-09-16T14:40:02.483Z] === CONT  TestStopContainerWithTimeout/1
14:40:03 [2019-09-16T14:40:03.850Z] --- PASS: TestStopContainerWithTimeout (0.05s)
14:40:03 [2019-09-16T14:40:03.850Z]     --- PASS: TestStopContainerWithTimeout/0 (1.08s)
14:40:03 [2019-09-16T14:40:03.850Z]     --- PASS: TestStopContainerWithTimeout/3 (2.94s)
14:40:03 [2019-09-16T14:40:03.850Z]     --- PASS: TestStopContainerWithTimeout/-1 (2.80s)
14:40:03 [2019-09-16T14:40:03.850Z]     --- PASS: TestStopContainerWithTimeout/1 (1.81s)
14:40:03 [2019-09-16T14:40:03.850Z] === RUN   TestDeleteDevicemapper
14:40:03 [2019-09-16T14:40:03.850Z] --- SKIP: TestDeleteDevicemapper (0.00s)
14:40:03 [2019-09-16T14:40:03.850Z]     stop_linux_test.go:74: testEnv.DaemonInfo.Driver != "devicemapper"
14:40:03 [2019-09-16T14:40:03.850Z] === RUN   TestStopContainerWithRestartPolicyAlways
14:40:06 [2019-09-16T14:40:06.372Z] --- PASS: TestStopContainerWithRestartPolicyAlways (2.06s)
14:40:06 [2019-09-16T14:40:06.372Z] === RUN   TestUpdateMemory
14:40:06 [2019-09-16T14:40:06.372Z] --- SKIP: TestUpdateMemory (0.00s)
14:40:06 [2019-09-16T14:40:06.372Z]     update_linux_test.go:21: !testEnv.DaemonInfo.SwapLimit
14:40:06 [2019-09-16T14:40:06.372Z] === RUN   TestUpdateCPUQuota
14:40:07 [2019-09-16T14:40:07.741Z] --- PASS: TestUpdateCPUQuota (1.61s)
14:40:07 [2019-09-16T14:40:07.741Z] === RUN   TestUpdateRestartPolicy
14:40:22 [2019-09-16T14:40:22.590Z] --- PASS: TestUpdateRestartPolicy (13.06s)
14:40:22 [2019-09-16T14:40:22.590Z] === RUN   TestUpdateRestartWithAutoRemove
14:40:22 [2019-09-16T14:40:22.590Z] --- PASS: TestUpdateRestartWithAutoRemove (0.86s)
14:40:22 [2019-09-16T14:40:22.590Z] === CONT  TestContainerStartOnDaemonRestart
14:40:22 [2019-09-16T14:40:22.590Z] === CONT  TestDaemonRestartIpcMode
14:40:25 [2019-09-16T14:40:25.112Z] --- PASS: TestContainerStartOnDaemonRestart (3.49s)
14:40:25 [2019-09-16T14:40:25.112Z]     daemon_linux_test.go:35: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestContainerStartOnDaemonRestart
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:302: [d8439fe928ba9] waiting for daemon to start
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:334: [d8439fe928ba9] daemon started
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:302: [d8439fe928ba9] waiting for daemon to start
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:286: [d8439fe928ba9] exiting daemon
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:334: [d8439fe928ba9] daemon started
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:286: [d8439fe928ba9] exiting daemon
14:40:25 [2019-09-16T14:40:25.112Z] --- PASS: TestDaemonRestartIpcMode (3.57s)
14:40:25 [2019-09-16T14:40:25.112Z]     daemon_linux_test.go:89: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartIpcMode
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:302: [dc05d25118ffd] waiting for daemon to start
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:334: [dc05d25118ffd] daemon started
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:286: [dc05d25118ffd] exiting daemon
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:302: [dc05d25118ffd] waiting for daemon to start
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:334: [dc05d25118ffd] daemon started
14:40:25 [2019-09-16T14:40:25.112Z]     daemon.go:286: [dc05d25118ffd] exiting daemon
14:40:25 [2019-09-16T14:40:25.112Z] PASS
14:40:25 [2019-09-16T14:40:25.112Z] Running /go/src/github.com/docker/docker/integration/image flags=-test.v -test.timeout=120m  
14:40:25 [2019-09-16T14:40:25.112Z] INFO: Testing against a local daemon
14:40:25 [2019-09-16T14:40:25.112Z] === RUN   TestCommitInheritsEnv
14:40:25 [2019-09-16T14:40:25.676Z] --- PASS: TestCommitInheritsEnv (0.47s)
14:40:25 [2019-09-16T14:40:25.676Z] === RUN   TestImportExtremelyLargeImageWorks
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestImportExtremelyLargeImageWorks (105.62s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestImagesFilterMultiReference
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestImagesFilterMultiReference (0.07s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestRemoveImageOrphaning
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestRemoveImageOrphaning (0.45s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagUnprefixedRepoByNameOrName
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.06s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagInvalidReference
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagInvalidReference (0.05s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagValidPrefixedRepo
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagValidPrefixedRepo (0.08s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagExistedNameWithoutForce
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagExistedNameWithoutForce (0.06s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagOfficialNames
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagOfficialNames (0.09s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestTagMatchesDigest
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestTagMatchesDigest (0.05s)
14:42:17 [2019-09-16T14:42:17.099Z] PASS
14:42:17 [2019-09-16T14:42:17.099Z] Running /go/src/github.com/docker/docker/integration/network flags=-test.v -test.timeout=120m  
14:42:17 [2019-09-16T14:42:17.099Z] INFO: Testing against a local daemon
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestNetworkCreateDelete
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestNetworkCreateDelete (0.14s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestDockerNetworkDeletePreferID
14:42:17 [2019-09-16T14:42:17.099Z] --- PASS: TestDockerNetworkDeletePreferID (0.32s)
14:42:17 [2019-09-16T14:42:17.099Z] === RUN   TestInspectNetwork
14:42:18 [2019-09-16T14:42:18.991Z] === RUN   TestInspectNetwork/full_network_id
14:42:18 [2019-09-16T14:42:18.991Z] === RUN   TestInspectNetwork/partial_network_id
14:42:18 [2019-09-16T14:42:18.991Z] === RUN   TestInspectNetwork/network_name
14:42:18 [2019-09-16T14:42:18.991Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
14:42:23 [2019-09-16T14:42:23.161Z] --- PASS: TestInspectNetwork (10.49s)
14:42:23 [2019-09-16T14:42:23.161Z]     inspect_test.go:18: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestInspectNetwork
14:42:23 [2019-09-16T14:42:23.161Z]     daemon.go:302: [d9eec1fa36704] waiting for daemon to start
14:42:23 [2019-09-16T14:42:23.161Z]     daemon.go:334: [d9eec1fa36704] daemon started
14:42:23 [2019-09-16T14:42:23.161Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
14:42:23 [2019-09-16T14:42:23.161Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
14:42:23 [2019-09-16T14:42:23.161Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
14:42:23 [2019-09-16T14:42:23.161Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
14:42:23 [2019-09-16T14:42:23.161Z]     daemon.go:286: [d9eec1fa36704] exiting daemon
14:42:23 [2019-09-16T14:42:23.161Z] === RUN   TestRunContainerWithBridgeNone
14:42:26 [2019-09-16T14:42:26.432Z] --- PASS: TestRunContainerWithBridgeNone (2.61s)
14:42:26 [2019-09-16T14:42:26.432Z]     network_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestRunContainerWithBridgeNone
14:42:26 [2019-09-16T14:42:26.432Z]     daemon.go:302: [d77cc112a3e34] waiting for daemon to start
14:42:26 [2019-09-16T14:42:26.432Z]     daemon.go:334: [d77cc112a3e34] daemon started
14:42:26 [2019-09-16T14:42:26.432Z]     daemon.go:286: [d77cc112a3e34] exiting daemon
14:42:26 [2019-09-16T14:42:26.432Z] === RUN   TestNetworkInvalidJSON
14:42:26 [2019-09-16T14:42:26.432Z] === RUN   TestNetworkInvalidJSON//networks/create
14:42:26 [2019-09-16T14:42:26.432Z] === PAUSE TestNetworkInvalidJSON//networks/create
14:42:26 [2019-09-16T14:42:26.432Z] === RUN   TestNetworkInvalidJSON//networks/bridge/connect
14:42:26 [2019-09-16T14:42:26.432Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/connect
14:42:26 [2019-09-16T14:42:26.432Z] === RUN   TestNetworkInvalidJSON//networks/bridge/disconnect
14:42:26 [2019-09-16T14:42:26.432Z] === PAUSE TestNetworkInvalidJSON//networks/bridge/disconnect
14:42:26 [2019-09-16T14:42:26.432Z] === CONT  TestNetworkInvalidJSON//networks/create
14:42:26 [2019-09-16T14:42:26.432Z] === CONT  TestNetworkInvalidJSON//networks/bridge/disconnect
14:42:26 [2019-09-16T14:42:26.432Z] === CONT  TestNetworkInvalidJSON//networks/bridge/connect
14:42:26 [2019-09-16T14:42:26.432Z] --- PASS: TestNetworkInvalidJSON (0.05s)
14:42:26 [2019-09-16T14:42:26.432Z]     --- PASS: TestNetworkInvalidJSON//networks/create (0.00s)
14:42:26 [2019-09-16T14:42:26.432Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/disconnect (0.00s)
14:42:26 [2019-09-16T14:42:26.432Z]     --- PASS: TestNetworkInvalidJSON//networks/bridge/connect (0.00s)
14:42:26 [2019-09-16T14:42:26.432Z] === RUN   TestDaemonRestartWithLiveRestore
14:42:26 [2019-09-16T14:42:26.994Z] --- PASS: TestDaemonRestartWithLiveRestore (1.05s)
14:42:26 [2019-09-16T14:42:26.994Z]     service_test.go:32: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartWithLiveRestore
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:302: [d751fda850629] waiting for daemon to start
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:334: [d751fda850629] daemon started
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:286: [d751fda850629] exiting daemon
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:302: [d751fda850629] waiting for daemon to start
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:334: [d751fda850629] daemon started
14:42:26 [2019-09-16T14:42:26.994Z]     daemon.go:286: [d751fda850629] exiting daemon
14:42:26 [2019-09-16T14:42:26.994Z] === RUN   TestDaemonDefaultNetworkPools
14:42:27 [2019-09-16T14:42:27.557Z] --- PASS: TestDaemonDefaultNetworkPools (0.71s)
14:42:27 [2019-09-16T14:42:27.557Z]     service_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonDefaultNetworkPools
14:42:27 [2019-09-16T14:42:27.557Z]     daemon.go:302: [d8fc58be6123f] waiting for daemon to start
14:42:27 [2019-09-16T14:42:27.557Z]     daemon.go:334: [d8fc58be6123f] daemon started
14:42:27 [2019-09-16T14:42:27.557Z]     daemon.go:286: [d8fc58be6123f] exiting daemon
14:42:27 [2019-09-16T14:42:27.557Z] === RUN   TestDaemonRestartWithExistingNetwork
14:42:28 [2019-09-16T14:42:28.927Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.13s)
14:42:28 [2019-09-16T14:42:28.927Z]     service_test.go:98: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartWithExistingNetwork
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:302: [d88f801c6bf79] waiting for daemon to start
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:334: [d88f801c6bf79] daemon started
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:286: [d88f801c6bf79] exiting daemon
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:302: [d88f801c6bf79] waiting for daemon to start
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:334: [d88f801c6bf79] daemon started
14:42:28 [2019-09-16T14:42:28.927Z]     daemon.go:286: [d88f801c6bf79] exiting daemon
14:42:28 [2019-09-16T14:42:28.927Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
14:42:30 [2019-09-16T14:42:30.297Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.20s)
14:42:30 [2019-09-16T14:42:30.297Z]     service_test.go:131: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:302: [d7bca3abb767a] waiting for daemon to start
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:334: [d7bca3abb767a] daemon started
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:286: [d7bca3abb767a] exiting daemon
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:302: [d7bca3abb767a] waiting for daemon to start
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:334: [d7bca3abb767a] daemon started
14:42:30 [2019-09-16T14:42:30.297Z]     daemon.go:286: [d7bca3abb767a] exiting daemon
14:42:30 [2019-09-16T14:42:30.297Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
14:42:30 [2019-09-16T14:42:30.553Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.57s)
14:42:30 [2019-09-16T14:42:30.553Z]     service_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonWithBipAndDefaultNetworkPool
14:42:30 [2019-09-16T14:42:30.553Z]     daemon.go:302: [de269469ec517] waiting for daemon to start
14:42:30 [2019-09-16T14:42:30.553Z]     daemon.go:334: [de269469ec517] daemon started
14:42:30 [2019-09-16T14:42:30.553Z]     daemon.go:286: [de269469ec517] exiting daemon
14:42:30 [2019-09-16T14:42:30.553Z] === RUN   TestServiceWithPredefinedNetwork
14:42:33 [2019-09-16T14:42:33.826Z] --- PASS: TestServiceWithPredefinedNetwork (3.05s)
14:42:33 [2019-09-16T14:42:33.826Z]     service_test.go:203: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceWithPredefinedNetwork
14:42:33 [2019-09-16T14:42:33.826Z]     daemon.go:302: [d2e867c08e0c2] waiting for daemon to start
14:42:33 [2019-09-16T14:42:33.826Z]     daemon.go:334: [d2e867c08e0c2] daemon started
14:42:33 [2019-09-16T14:42:33.826Z]     daemon.go:286: [d2e867c08e0c2] exiting daemon
14:42:33 [2019-09-16T14:42:33.826Z] === RUN   TestServiceRemoveKeepsIngressNetwork
14:42:48 [2019-09-16T14:42:48.681Z] --- PASS: TestServiceRemoveKeepsIngressNetwork (13.38s)
14:42:48 [2019-09-16T14:42:48.681Z]     service_test.go:232: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceRemoveKeepsIngressNetwork
14:42:48 [2019-09-16T14:42:48.681Z]     daemon.go:302: [dea8205021727] waiting for daemon to start
14:42:48 [2019-09-16T14:42:48.681Z]     daemon.go:334: [dea8205021727] daemon started
14:42:48 [2019-09-16T14:42:48.681Z]     daemon.go:286: [dea8205021727] exiting daemon
14:42:48 [2019-09-16T14:42:48.681Z] === RUN   TestServiceWithDefaultAddressPoolInit
14:42:52 [2019-09-16T14:42:52.855Z] --- PASS: TestServiceWithDefaultAddressPoolInit (5.94s)
14:42:52 [2019-09-16T14:42:52.855Z]     service_test.go:337: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceWithDefaultAddressPoolInit
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:302: [da4c632aca0b7] waiting for daemon to start
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:334: [da4c632aca0b7] daemon started
14:42:52 [2019-09-16T14:42:52.855Z]     service_test.go:362: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:saanvisthiraTestServiceWithDefaultAddressPoolInit ID:3mosfsabrp521ai7d7rx90o7y Created:2019-09-16 14:42:48.477069552 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.0.0/24 IPRange: Gateway:20.20.0.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[] Services:map[]}
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:286: [da4c632aca0b7] exiting daemon
14:42:52 [2019-09-16T14:42:52.855Z]     service_test.go:375: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceWithDefaultAddressPoolInit
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:302: [dddbb9e051d69] waiting for daemon to start
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:334: [dddbb9e051d69] daemon started
14:42:52 [2019-09-16T14:42:52.855Z]     daemon.go:286: [dddbb9e051d69] exiting daemon
14:42:52 [2019-09-16T14:42:52.855Z] PASS
14:42:52 [2019-09-16T14:42:52.855Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan flags=-test.v -test.timeout=120m  
14:42:53 [2019-09-16T14:42:53.112Z] INFO: Testing against a local daemon
14:42:53 [2019-09-16T14:42:53.112Z] === RUN   TestDockerNetworkIpvlanPersistance
14:42:54 [2019-09-16T14:42:54.481Z] --- PASS: TestDockerNetworkIpvlanPersistance (1.34s)
14:42:54 [2019-09-16T14:42:54.481Z]     ipvlan_test.go:26: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlanPersistance
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:302: [de4187d488225] waiting for daemon to start
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:334: [de4187d488225] daemon started
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:286: [de4187d488225] exiting daemon
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:302: [de4187d488225] waiting for daemon to start
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:334: [de4187d488225] daemon started
14:42:54 [2019-09-16T14:42:54.481Z]     daemon.go:286: [de4187d488225] exiting daemon
14:42:54 [2019-09-16T14:42:54.481Z] === RUN   TestDockerNetworkIpvlan
14:42:55 [2019-09-16T14:42:55.044Z] === RUN   TestDockerNetworkIpvlan/Subinterface
14:42:55 [2019-09-16T14:42:55.974Z] === RUN   TestDockerNetworkIpvlan/OverlapParent
14:42:56 [2019-09-16T14:42:56.905Z] === RUN   TestDockerNetworkIpvlan/L2NilParent
14:43:00 [2019-09-16T14:43:00.177Z] === RUN   TestDockerNetworkIpvlan/L2InternalMode
14:43:04 [2019-09-16T14:43:04.351Z] === RUN   TestDockerNetworkIpvlan/L3NilParent
14:43:22 [2019-09-16T14:43:22.406Z] === RUN   TestDockerNetworkIpvlan/L3InternalMode
14:43:44 [2019-09-16T14:43:44.303Z] === RUN   TestDockerNetworkIpvlan/L2MultiSubnet
14:44:02 [2019-09-16T14:44:02.357Z] === RUN   TestDockerNetworkIpvlan/L3MultiSubnet
14:44:24 [2019-09-16T14:44:24.254Z] === RUN   TestDockerNetworkIpvlan/Addressing
14:44:56 [2019-09-16T14:44:56.297Z] --- PASS: TestDockerNetworkIpvlan (120.58s)
14:44:56 [2019-09-16T14:44:56.297Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.297Z]     daemon.go:302: [d2e60c7c46d9a] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.297Z]     daemon.go:334: [d2e60c7c46d9a] daemon started
14:44:56 [2019-09-16T14:44:56.297Z]     --- PASS: TestDockerNetworkIpvlan/Subinterface (0.08s)
14:44:56 [2019-09-16T14:44:56.297Z]     daemon.go:286: [d2e60c7c46d9a] exiting daemon
14:44:56 [2019-09-16T14:44:56.297Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.297Z]     daemon.go:302: [dfb64713145a6] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.297Z]     daemon.go:334: [dfb64713145a6] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/OverlapParent (0.06s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [dfb64713145a6] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d411d8d0e075b] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d411d8d0e075b] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L2NilParent (1.90s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d411d8d0e075b] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d601df9dcb4a5] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d601df9dcb4a5] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L2InternalMode (2.89s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d601df9dcb4a5] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [df748b3bdce94] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [df748b3bdce94] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L3NilParent (16.97s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [df748b3bdce94] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [ddf6cb3da22bf] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [ddf6cb3da22bf] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L3InternalMode (17.94s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [ddf6cb3da22bf] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d0aa208751485] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d0aa208751485] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L2MultiSubnet (19.41s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d0aa208751485] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [dfc92fd1c3c74] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [dfc92fd1c3c74] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/L3MultiSubnet (19.42s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [dfc92fd1c3c74] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     ipvlan_test.go:87: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkIpvlan
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d154884a7f3d7] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d154884a7f3d7] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     --- PASS: TestDockerNetworkIpvlan/Addressing (32.46s)
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d154884a7f3d7] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z] PASS
14:44:56 [2019-09-16T14:44:56.298Z] Running /go/src/github.com/docker/docker/integration/network/macvlan flags=-test.v -test.timeout=120m  
14:44:56 [2019-09-16T14:44:56.298Z] INFO: Testing against a local daemon
14:44:56 [2019-09-16T14:44:56.298Z] === RUN   TestDockerNetworkMacvlanPersistance
14:44:56 [2019-09-16T14:44:56.298Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.34s)
14:44:56 [2019-09-16T14:44:56.298Z]     macvlan_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlanPersistance
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d05cada21586d] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d05cada21586d] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d05cada21586d] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:302: [d05cada21586d] waiting for daemon to start
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:334: [d05cada21586d] daemon started
14:44:56 [2019-09-16T14:44:56.298Z]     daemon.go:286: [d05cada21586d] exiting daemon
14:44:56 [2019-09-16T14:44:56.298Z] === RUN   TestDockerNetworkMacvlan
14:44:57 [2019-09-16T14:44:57.228Z] === RUN   TestDockerNetworkMacvlan/Subinterface
14:44:57 [2019-09-16T14:44:57.791Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
14:44:58 [2019-09-16T14:44:58.721Z] === RUN   TestDockerNetworkMacvlan/NilParent
14:45:01 [2019-09-16T14:45:01.994Z] === RUN   TestDockerNetworkMacvlan/InternalMode
14:45:06 [2019-09-16T14:45:06.166Z] === RUN   TestDockerNetworkMacvlan/Addressing
14:45:24 [2019-09-16T14:45:24.217Z] --- PASS: TestDockerNetworkMacvlan (26.00s)
14:45:24 [2019-09-16T14:45:24.217Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlan
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [d14231156c1cd] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [d14231156c1cd] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.07s)
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [d14231156c1cd] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlan
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [d442a78f0a6bb] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [d442a78f0a6bb] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.08s)
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [d442a78f0a6bb] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlan
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [dfbd10a95d444] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [dfbd10a95d444] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.91s)
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [dfbd10a95d444] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlan
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [d1aafa58c65b1] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [d1aafa58c65b1] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (2.99s)
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [d1aafa58c65b1] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z]     macvlan_test.go:69: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkMacvlan
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [de41ae88b09bc] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [de41ae88b09bc] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (16.24s)
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [de41ae88b09bc] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z] PASS
14:45:24 [2019-09-16T14:45:24.217Z] Running /go/src/github.com/docker/docker/integration/plugin flags=-test.v -test.timeout=120m  
14:45:24 [2019-09-16T14:45:24.217Z] testing: warning: no tests to run
14:45:24 [2019-09-16T14:45:24.217Z] PASS
14:45:24 [2019-09-16T14:45:24.217Z] Running /go/src/github.com/docker/docker/integration/plugin/authz flags=-test.v -test.timeout=120m  
14:45:24 [2019-09-16T14:45:24.217Z] INFO: Testing against a local daemon
14:45:24 [2019-09-16T14:45:24.217Z] === RUN   TestAuthZPluginAllowRequest
14:45:24 [2019-09-16T14:45:24.217Z] --- PASS: TestAuthZPluginAllowRequest (1.64s)
14:45:24 [2019-09-16T14:45:24.217Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginAllowRequest
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:302: [d74b003a6cd4f] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:334: [d74b003a6cd4f] daemon started
14:45:24 [2019-09-16T14:45:24.217Z]     daemon.go:286: [d74b003a6cd4f] exiting daemon
14:45:24 [2019-09-16T14:45:24.217Z] === RUN   TestAuthZPluginTLS
14:45:24 [2019-09-16T14:45:24.781Z] --- PASS: TestAuthZPluginTLS (0.59s)
14:45:24 [2019-09-16T14:45:24.781Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginTLS
14:45:24 [2019-09-16T14:45:24.781Z]     daemon.go:302: [d21351d340656] waiting for daemon to start
14:45:24 [2019-09-16T14:45:24.781Z]     daemon.go:334: [d21351d340656] daemon started
14:45:24 [2019-09-16T14:45:24.781Z]     daemon.go:286: [d21351d340656] exiting daemon
14:45:24 [2019-09-16T14:45:24.781Z] === RUN   TestAuthZPluginDenyRequest
14:45:25 [2019-09-16T14:45:25.343Z] --- PASS: TestAuthZPluginDenyRequest (0.58s)
14:45:25 [2019-09-16T14:45:25.343Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginDenyRequest
14:45:25 [2019-09-16T14:45:25.343Z]     daemon.go:302: [d233284cbd2d7] waiting for daemon to start
14:45:25 [2019-09-16T14:45:25.343Z]     daemon.go:334: [d233284cbd2d7] daemon started
14:45:25 [2019-09-16T14:45:25.343Z]     daemon.go:286: [d233284cbd2d7] exiting daemon
14:45:25 [2019-09-16T14:45:25.343Z] === RUN   TestAuthZPluginAPIDenyResponse
14:45:25 [2019-09-16T14:45:25.910Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.58s)
14:45:25 [2019-09-16T14:45:25.910Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginAPIDenyResponse
14:45:25 [2019-09-16T14:45:25.910Z]     daemon.go:302: [d811356d47488] waiting for daemon to start
14:45:25 [2019-09-16T14:45:25.910Z]     daemon.go:334: [d811356d47488] daemon started
14:45:25 [2019-09-16T14:45:25.910Z]     daemon.go:286: [d811356d47488] exiting daemon
14:45:25 [2019-09-16T14:45:25.910Z] === RUN   TestAuthZPluginDenyResponse
14:45:26 [2019-09-16T14:45:26.473Z] --- PASS: TestAuthZPluginDenyResponse (0.63s)
14:45:26 [2019-09-16T14:45:26.473Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginDenyResponse
14:45:26 [2019-09-16T14:45:26.473Z]     daemon.go:302: [d1fc9d9b72f1d] waiting for daemon to start
14:45:26 [2019-09-16T14:45:26.473Z]     daemon.go:334: [d1fc9d9b72f1d] daemon started
14:45:26 [2019-09-16T14:45:26.473Z]     daemon.go:286: [d1fc9d9b72f1d] exiting daemon
14:45:26 [2019-09-16T14:45:26.473Z] === RUN   TestAuthZPluginAllowEventStream
14:45:28 [2019-09-16T14:45:28.372Z] --- PASS: TestAuthZPluginAllowEventStream (1.66s)
14:45:28 [2019-09-16T14:45:28.372Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginAllowEventStream
14:45:28 [2019-09-16T14:45:28.372Z]     daemon.go:302: [da1d64f20d8a9] waiting for daemon to start
14:45:28 [2019-09-16T14:45:28.372Z]     daemon.go:334: [da1d64f20d8a9] daemon started
14:45:28 [2019-09-16T14:45:28.372Z]     daemon.go:286: [da1d64f20d8a9] exiting daemon
14:45:28 [2019-09-16T14:45:28.372Z] === RUN   TestAuthZPluginErrorResponse
14:45:28 [2019-09-16T14:45:28.628Z] --- PASS: TestAuthZPluginErrorResponse (0.59s)
14:45:28 [2019-09-16T14:45:28.628Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginErrorResponse
14:45:28 [2019-09-16T14:45:28.628Z]     daemon.go:302: [db5d45681fd42] waiting for daemon to start
14:45:28 [2019-09-16T14:45:28.628Z]     daemon.go:334: [db5d45681fd42] daemon started
14:45:28 [2019-09-16T14:45:28.628Z]     daemon.go:286: [db5d45681fd42] exiting daemon
14:45:28 [2019-09-16T14:45:28.628Z] === RUN   TestAuthZPluginErrorRequest
14:45:29 [2019-09-16T14:45:29.192Z] --- PASS: TestAuthZPluginErrorRequest (0.58s)
14:45:29 [2019-09-16T14:45:29.192Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginErrorRequest
14:45:29 [2019-09-16T14:45:29.192Z]     daemon.go:302: [d0b195b1e200c] waiting for daemon to start
14:45:29 [2019-09-16T14:45:29.192Z]     daemon.go:334: [d0b195b1e200c] daemon started
14:45:29 [2019-09-16T14:45:29.192Z]     daemon.go:286: [d0b195b1e200c] exiting daemon
14:45:29 [2019-09-16T14:45:29.192Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
14:45:29 [2019-09-16T14:45:29.756Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.57s)
14:45:29 [2019-09-16T14:45:29.756Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginEnsureNoDuplicatePluginRegistration
14:45:29 [2019-09-16T14:45:29.756Z]     daemon.go:302: [d1b058a6fb636] waiting for daemon to start
14:45:29 [2019-09-16T14:45:29.756Z]     daemon.go:334: [d1b058a6fb636] daemon started
14:45:29 [2019-09-16T14:45:29.756Z]     daemon.go:286: [d1b058a6fb636] exiting daemon
14:45:29 [2019-09-16T14:45:29.756Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
14:45:32 [2019-09-16T14:45:32.278Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.93s)
14:45:32 [2019-09-16T14:45:32.278Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginEnsureLoadImportWorking
14:45:32 [2019-09-16T14:45:32.278Z]     daemon.go:302: [df41b22758ed8] waiting for daemon to start
14:45:32 [2019-09-16T14:45:32.278Z]     daemon.go:334: [df41b22758ed8] daemon started
14:45:32 [2019-09-16T14:45:32.278Z]     daemon.go:286: [df41b22758ed8] exiting daemon
14:45:32 [2019-09-16T14:45:32.278Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
14:45:34 [2019-09-16T14:45:34.172Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (2.03s)
14:45:34 [2019-09-16T14:45:34.172Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthzPluginEnsureContainerCopyToFrom
14:45:34 [2019-09-16T14:45:34.172Z]     daemon.go:302: [dca6ad0202901] waiting for daemon to start
14:45:34 [2019-09-16T14:45:34.172Z]     daemon.go:334: [dca6ad0202901] daemon started
14:45:34 [2019-09-16T14:45:34.172Z]     daemon.go:286: [dca6ad0202901] exiting daemon
14:45:34 [2019-09-16T14:45:34.172Z] === RUN   TestAuthZPluginHeader
14:45:34 [2019-09-16T14:45:34.736Z] --- PASS: TestAuthZPluginHeader (0.80s)
14:45:34 [2019-09-16T14:45:34.736Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginHeader
14:45:34 [2019-09-16T14:45:34.736Z]     daemon.go:302: [d66487935093f] waiting for daemon to start
14:45:34 [2019-09-16T14:45:34.736Z]     daemon.go:334: [d66487935093f] daemon started
14:45:34 [2019-09-16T14:45:34.736Z]     daemon.go:286: [d66487935093f] exiting daemon
14:45:34 [2019-09-16T14:45:34.736Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
14:45:39 [2019-09-16T14:45:39.987Z] --- PASS: TestAuthZPluginV2AllowNonVolumeRequest (4.87s)
14:45:39 [2019-09-16T14:45:39.987Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginV2AllowNonVolumeRequest
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:302: [d674ac7708fa9] waiting for daemon to start
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:334: [d674ac7708fa9] daemon started
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:286: [d674ac7708fa9] exiting daemon
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:302: [d674ac7708fa9] waiting for daemon to start
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:334: [d674ac7708fa9] daemon started
14:45:39 [2019-09-16T14:45:39.987Z]     daemon.go:286: [d674ac7708fa9] exiting daemon
14:45:39 [2019-09-16T14:45:39.987Z] === RUN   TestAuthZPluginV2Disable
14:45:43 [2019-09-16T14:45:43.262Z] --- PASS: TestAuthZPluginV2Disable (3.25s)
14:45:43 [2019-09-16T14:45:43.262Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginV2Disable
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:302: [d0562c2db0762] waiting for daemon to start
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:334: [d0562c2db0762] daemon started
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:286: [d0562c2db0762] exiting daemon
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:302: [d0562c2db0762] waiting for daemon to start
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:334: [d0562c2db0762] daemon started
14:45:43 [2019-09-16T14:45:43.262Z]     daemon.go:286: [d0562c2db0762] exiting daemon
14:45:43 [2019-09-16T14:45:43.262Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
14:45:46 [2019-09-16T14:45:46.535Z] --- PASS: TestAuthZPluginV2RejectVolumeRequests (3.41s)
14:45:46 [2019-09-16T14:45:46.535Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginV2RejectVolumeRequests
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:302: [db836e1925417] waiting for daemon to start
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:334: [db836e1925417] daemon started
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:286: [db836e1925417] exiting daemon
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:302: [db836e1925417] waiting for daemon to start
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:334: [db836e1925417] daemon started
14:45:46 [2019-09-16T14:45:46.535Z]     daemon.go:286: [db836e1925417] exiting daemon
14:45:46 [2019-09-16T14:45:46.535Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
14:45:58 [2019-09-16T14:45:58.715Z] --- PASS: TestAuthZPluginV2BadManifestFailsDaemonStart (11.38s)
14:45:58 [2019-09-16T14:45:58.715Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginV2BadManifestFailsDaemonStart
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:302: [d260269cb0e9b] waiting for daemon to start
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:334: [d260269cb0e9b] daemon started
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:286: [d260269cb0e9b] exiting daemon
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:302: [d260269cb0e9b] waiting for daemon to start
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:302: [d260269cb0e9b] waiting for daemon to start
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:286: [d260269cb0e9b] exiting daemon
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:302: [d260269cb0e9b] waiting for daemon to start
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:302: [d260269cb0e9b] waiting for daemon to start
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:334: [d260269cb0e9b] daemon started
14:45:58 [2019-09-16T14:45:58.715Z]     daemon.go:286: [d260269cb0e9b] exiting daemon
14:45:58 [2019-09-16T14:45:58.715Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
14:46:16 [2019-09-16T14:46:16.765Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.42s)
14:46:16 [2019-09-16T14:46:16.765Z]     main_test.go:54: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestAuthZPluginV2NonexistentFailsDaemonStart
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:302: [ded054a5bdaba] waiting for daemon to start
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:334: [ded054a5bdaba] daemon started
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:286: [ded054a5bdaba] exiting daemon
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:302: [ded054a5bdaba] waiting for daemon to start
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:302: [ded054a5bdaba] waiting for daemon to start
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:286: [ded054a5bdaba] exiting daemon
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:302: [ded054a5bdaba] waiting for daemon to start
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:334: [ded054a5bdaba] daemon started
14:46:16 [2019-09-16T14:46:16.765Z]     daemon.go:286: [ded054a5bdaba] exiting daemon
14:46:16 [2019-09-16T14:46:16.765Z] PASS
14:46:16 [2019-09-16T14:46:16.765Z] Running /go/src/github.com/docker/docker/integration/plugin/common flags=-test.v -test.timeout=120m  
14:46:16 [2019-09-16T14:46:16.765Z] INFO: Testing against a local daemon
14:46:16 [2019-09-16T14:46:16.765Z] === RUN   TestPluginInvalidJSON
14:46:16 [2019-09-16T14:46:16.765Z] === RUN   TestPluginInvalidJSON//plugins/foobar/set
14:46:16 [2019-09-16T14:46:16.765Z] === PAUSE TestPluginInvalidJSON//plugins/foobar/set
14:46:16 [2019-09-16T14:46:16.765Z] === CONT  TestPluginInvalidJSON//plugins/foobar/set
14:46:16 [2019-09-16T14:46:16.765Z] --- PASS: TestPluginInvalidJSON (0.05s)
14:46:16 [2019-09-16T14:46:16.765Z]     --- PASS: TestPluginInvalidJSON//plugins/foobar/set (0.00s)
14:46:16 [2019-09-16T14:46:16.765Z] PASS
14:46:16 [2019-09-16T14:46:16.765Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver flags=-test.v -test.timeout=120m  
14:46:16 [2019-09-16T14:46:16.765Z] INFO: Testing against a local daemon
14:46:16 [2019-09-16T14:46:16.765Z] === RUN   TestExternalGraphDriver
14:46:16 [2019-09-16T14:46:16.765Z] === RUN   TestExternalGraphDriver/json
14:46:16 [2019-09-16T14:46:16.765Z] === RUN   TestExternalGraphDriver/spec
14:46:18 [2019-09-16T14:46:18.658Z] === RUN   TestExternalGraphDriver/pull
14:46:20 [2019-09-16T14:46:20.027Z] --- PASS: TestExternalGraphDriver (5.95s)
14:46:20 [2019-09-16T14:46:20.027Z]     external_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestExternalGraphDriver
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:302: [dccd830a166ab] waiting for daemon to start
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:334: [dccd830a166ab] daemon started
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:286: [dccd830a166ab] exiting daemon
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:302: [dccd830a166ab] waiting for daemon to start
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:334: [dccd830a166ab] daemon started
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:286: [dccd830a166ab] exiting daemon
14:46:20 [2019-09-16T14:46:20.027Z]     --- PASS: TestExternalGraphDriver/json (2.04s)
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:302: [dccd830a166ab] waiting for daemon to start
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:334: [dccd830a166ab] daemon started
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:286: [dccd830a166ab] exiting daemon
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:302: [dccd830a166ab] waiting for daemon to start
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:334: [dccd830a166ab] daemon started
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:286: [dccd830a166ab] exiting daemon
14:46:20 [2019-09-16T14:46:20.027Z]     --- PASS: TestExternalGraphDriver/spec (2.05s)
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:302: [dccd830a166ab] waiting for daemon to start
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:334: [dccd830a166ab] daemon started
14:46:20 [2019-09-16T14:46:20.027Z]     daemon.go:286: [dccd830a166ab] exiting daemon
14:46:20 [2019-09-16T14:46:20.027Z]     --- PASS: TestExternalGraphDriver/pull (1.75s)
14:46:20 [2019-09-16T14:46:20.027Z] === RUN   TestGraphdriverPluginV2
14:46:25 [2019-09-16T14:46:25.317Z] --- PASS: TestGraphdriverPluginV2 (4.68s)
14:46:25 [2019-09-16T14:46:25.317Z]     external_test.go:413: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestGraphdriverPluginV2
14:46:25 [2019-09-16T14:46:25.317Z]     daemon.go:302: [d07fdfa68a100] waiting for daemon to start
14:46:25 [2019-09-16T14:46:25.317Z]     daemon.go:334: [d07fdfa68a100] daemon started
14:46:25 [2019-09-16T14:46:25.318Z]     daemon.go:286: [d07fdfa68a100] exiting daemon
14:46:25 [2019-09-16T14:46:25.318Z]     daemon.go:302: [d07fdfa68a100] waiting for daemon to start
14:46:25 [2019-09-16T14:46:25.318Z]     daemon.go:334: [d07fdfa68a100] daemon started
14:46:25 [2019-09-16T14:46:25.318Z]     daemon.go:286: [d07fdfa68a100] exiting daemon
14:46:25 [2019-09-16T14:46:25.318Z] PASS
14:46:25 [2019-09-16T14:46:25.318Z] Running /go/src/github.com/docker/docker/integration/plugin/logging flags=-test.v -test.timeout=120m  
14:46:25 [2019-09-16T14:46:25.318Z] INFO: Testing against a local daemon
14:46:25 [2019-09-16T14:46:25.318Z] === RUN   TestContinueAfterPluginCrash
14:46:25 [2019-09-16T14:46:25.318Z] === PAUSE TestContinueAfterPluginCrash
14:46:25 [2019-09-16T14:46:25.318Z] === RUN   TestDaemonStartWithLogOpt
14:46:25 [2019-09-16T14:46:25.318Z] === PAUSE TestDaemonStartWithLogOpt
14:46:25 [2019-09-16T14:46:25.318Z] === CONT  TestContinueAfterPluginCrash
14:46:25 [2019-09-16T14:46:25.318Z] === CONT  TestDaemonStartWithLogOpt
14:46:35 [2019-09-16T14:46:35.272Z] --- PASS: TestDaemonStartWithLogOpt (9.97s)
14:46:35 [2019-09-16T14:46:35.272Z]     validation_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDaemonStartWithLogOpt
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:302: [d21b7298d451b] waiting for daemon to start
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:334: [d21b7298d451b] daemon started
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:286: [d21b7298d451b] exiting daemon
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:302: [d21b7298d451b] waiting for daemon to start
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:334: [d21b7298d451b] daemon started
14:46:35 [2019-09-16T14:46:35.272Z]     daemon.go:286: [d21b7298d451b] exiting daemon
14:46:40 [2019-09-16T14:46:40.521Z] --- PASS: TestContinueAfterPluginCrash (15.09s)
14:46:40 [2019-09-16T14:46:40.521Z]     logging_linux_test.go:22: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestContinueAfterPluginCrash
14:46:40 [2019-09-16T14:46:40.521Z]     daemon.go:302: [de432853da7c1] waiting for daemon to start
14:46:40 [2019-09-16T14:46:40.521Z]     daemon.go:334: [de432853da7c1] daemon started
14:46:40 [2019-09-16T14:46:40.521Z]     daemon.go:286: [de432853da7c1] exiting daemon
14:46:40 [2019-09-16T14:46:40.521Z] PASS
14:46:40 [2019-09-16T14:46:40.521Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes flags=-test.v -test.timeout=120m  
14:46:40 [2019-09-16T14:46:40.521Z] INFO: Testing against a local daemon
14:46:40 [2019-09-16T14:46:40.521Z] === RUN   TestPluginWithDevMounts
14:46:40 [2019-09-16T14:46:40.521Z] === PAUSE TestPluginWithDevMounts
14:46:40 [2019-09-16T14:46:40.521Z] === CONT  TestPluginWithDevMounts
14:46:41 [2019-09-16T14:46:41.889Z] --- PASS: TestPluginWithDevMounts (1.77s)
14:46:41 [2019-09-16T14:46:41.889Z]     mounts_test.go:23: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestPluginWithDevMounts
14:46:41 [2019-09-16T14:46:41.889Z]     daemon.go:302: [d44f9ae5c18e3] waiting for daemon to start
14:46:41 [2019-09-16T14:46:41.889Z]     daemon.go:334: [d44f9ae5c18e3] daemon started
14:46:41 [2019-09-16T14:46:41.889Z]     daemon.go:286: [d44f9ae5c18e3] exiting daemon
14:46:41 [2019-09-16T14:46:41.889Z] PASS
14:46:41 [2019-09-16T14:46:41.889Z] Running /go/src/github.com/docker/docker/integration/secret flags=-test.v -test.timeout=120m  
14:46:41 [2019-09-16T14:46:41.889Z] INFO: Testing against a local daemon
14:46:41 [2019-09-16T14:46:41.889Z] === RUN   TestSecretInspect
14:46:45 [2019-09-16T14:46:45.161Z] --- PASS: TestSecretInspect (3.05s)
14:46:45 [2019-09-16T14:46:45.161Z]     secret_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestSecretInspect
14:46:45 [2019-09-16T14:46:45.161Z]     daemon.go:302: [df968c03841ce] waiting for daemon to start
14:46:45 [2019-09-16T14:46:45.161Z]     daemon.go:334: [df968c03841ce] daemon started
14:46:45 [2019-09-16T14:46:45.161Z]     daemon.go:286: [df968c03841ce] exiting daemon
14:46:45 [2019-09-16T14:46:45.161Z] === RUN   TestSecretList
14:46:48 [2019-09-16T14:46:48.435Z] --- PASS: TestSecretList (3.05s)
14:46:48 [2019-09-16T14:46:48.435Z]     secret_test.go:48: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestSecretList
14:46:48 [2019-09-16T14:46:48.435Z]     daemon.go:302: [d99baf0303123] waiting for daemon to start
14:46:48 [2019-09-16T14:46:48.435Z]     daemon.go:334: [d99baf0303123] daemon started
14:46:48 [2019-09-16T14:46:48.435Z]     daemon.go:286: [d99baf0303123] exiting daemon
14:46:48 [2019-09-16T14:46:48.435Z] === RUN   TestSecretsCreateAndDelete
14:46:50 [2019-09-16T14:46:50.957Z] --- PASS: TestSecretsCreateAndDelete (2.93s)
14:46:50 [2019-09-16T14:46:50.957Z]     secret_test.go:134: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestSecretsCreateAndDelete
14:46:50 [2019-09-16T14:46:50.957Z]     daemon.go:302: [d04069dc260a0] waiting for daemon to start
14:46:50 [2019-09-16T14:46:50.957Z]     daemon.go:334: [d04069dc260a0] daemon started
14:46:50 [2019-09-16T14:46:50.957Z]     daemon.go:286: [d04069dc260a0] exiting daemon
14:46:50 [2019-09-16T14:46:50.957Z] === RUN   TestSecretsUpdate
14:46:54 [2019-09-16T14:46:54.228Z] --- PASS: TestSecretsUpdate (3.03s)
14:46:54 [2019-09-16T14:46:54.228Z]     secret_test.go:181: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestSecretsUpdate
14:46:54 [2019-09-16T14:46:54.228Z]     daemon.go:302: [d23fc6e6351be] waiting for daemon to start
14:46:54 [2019-09-16T14:46:54.228Z]     daemon.go:334: [d23fc6e6351be] daemon started
14:46:54 [2019-09-16T14:46:54.228Z]     daemon.go:286: [d23fc6e6351be] exiting daemon
14:46:54 [2019-09-16T14:46:54.228Z] === RUN   TestTemplatedSecret
14:46:57 [2019-09-16T14:46:57.499Z] --- PASS: TestTemplatedSecret (3.24s)
14:46:57 [2019-09-16T14:46:57.499Z]     secret_test.go:230: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestTemplatedSecret
14:46:57 [2019-09-16T14:46:57.499Z]     daemon.go:302: [d3d3eaa037fd6] waiting for daemon to start
14:46:57 [2019-09-16T14:46:57.499Z]     daemon.go:334: [d3d3eaa037fd6] daemon started
14:46:57 [2019-09-16T14:46:57.499Z]     daemon.go:286: [d3d3eaa037fd6] exiting daemon
14:46:57 [2019-09-16T14:46:57.499Z] PASS
14:46:57 [2019-09-16T14:46:57.499Z] Running /go/src/github.com/docker/docker/integration/service flags=-test.v -test.timeout=120m  
14:46:57 [2019-09-16T14:46:57.499Z] INFO: Testing against a local daemon
14:46:57 [2019-09-16T14:46:57.499Z] === RUN   TestServiceCreateInit
14:46:57 [2019-09-16T14:46:57.499Z] === RUN   TestServiceCreateInit/daemonInitDisabled
14:47:02 [2019-09-16T14:47:02.751Z] === RUN   TestServiceCreateInit/daemonInitEnabled
14:47:08 [2019-09-16T14:47:08.004Z] --- PASS: TestServiceCreateInit (10.08s)
14:47:08 [2019-09-16T14:47:08.004Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (4.83s)
14:47:08 [2019-09-16T14:47:08.004Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceCreateInit/daemonInitDisabled
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:302: [d64c2535aa202] waiting for daemon to start
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:334: [d64c2535aa202] daemon started
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:286: [d64c2535aa202] exiting daemon
14:47:08 [2019-09-16T14:47:08.004Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (5.18s)
14:47:08 [2019-09-16T14:47:08.004Z]         create_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceCreateInit/daemonInitEnabled
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:302: [d17ddcc2b5ddf] waiting for daemon to start
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:334: [d17ddcc2b5ddf] daemon started
14:47:08 [2019-09-16T14:47:08.004Z]         daemon.go:286: [d17ddcc2b5ddf] exiting daemon
14:47:08 [2019-09-16T14:47:08.004Z] === RUN   TestCreateServiceMultipleTimes
14:47:29 [2019-09-16T14:47:29.919Z] --- PASS: TestCreateServiceMultipleTimes (21.22s)
14:47:29 [2019-09-16T14:47:29.919Z]     create_test.go:78: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestCreateServiceMultipleTimes
14:47:29 [2019-09-16T14:47:29.920Z]     daemon.go:302: [d5a56ebade012] waiting for daemon to start
14:47:29 [2019-09-16T14:47:29.920Z]     daemon.go:334: [d5a56ebade012] daemon started
14:47:29 [2019-09-16T14:47:29.920Z]     daemon.go:286: [d5a56ebade012] exiting daemon
14:47:29 [2019-09-16T14:47:29.920Z] === RUN   TestCreateWithDuplicateNetworkNames
14:47:44 [2019-09-16T14:47:44.771Z] --- PASS: TestCreateWithDuplicateNetworkNames (15.42s)
14:47:44 [2019-09-16T14:47:44.771Z]     create_test.go:127: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestCreateWithDuplicateNetworkNames
14:47:44 [2019-09-16T14:47:44.771Z]     daemon.go:302: [dedae4af36ab9] waiting for daemon to start
14:47:44 [2019-09-16T14:47:44.771Z]     daemon.go:334: [dedae4af36ab9] daemon started
14:47:44 [2019-09-16T14:47:44.771Z]     daemon.go:286: [dedae4af36ab9] exiting daemon
14:47:44 [2019-09-16T14:47:44.771Z] === RUN   TestCreateServiceSecretFileMode
14:47:47 [2019-09-16T14:47:47.292Z] --- PASS: TestCreateServiceSecretFileMode (3.07s)
14:47:47 [2019-09-16T14:47:47.292Z]     create_test.go:180: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestCreateServiceSecretFileMode
14:47:47 [2019-09-16T14:47:47.292Z]     daemon.go:302: [d541a1359b8bd] waiting for daemon to start
14:47:47 [2019-09-16T14:47:47.292Z]     daemon.go:334: [d541a1359b8bd] daemon started
14:47:47 [2019-09-16T14:47:47.292Z]     daemon.go:286: [d541a1359b8bd] exiting daemon
14:47:47 [2019-09-16T14:47:47.292Z] === RUN   TestCreateServiceConfigFileMode
14:47:50 [2019-09-16T14:47:50.564Z] --- PASS: TestCreateServiceConfigFileMode (3.13s)
14:47:50 [2019-09-16T14:47:50.564Z]     create_test.go:244: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestCreateServiceConfigFileMode
14:47:50 [2019-09-16T14:47:50.564Z]     daemon.go:302: [dcb87754a9e26] waiting for daemon to start
14:47:50 [2019-09-16T14:47:50.564Z]     daemon.go:334: [dcb87754a9e26] daemon started
14:47:50 [2019-09-16T14:47:50.564Z]     daemon.go:286: [dcb87754a9e26] exiting daemon
14:47:50 [2019-09-16T14:47:50.564Z] === RUN   TestInspect
14:47:53 [2019-09-16T14:47:53.836Z] --- PASS: TestInspect (3.01s)
14:47:53 [2019-09-16T14:47:53.836Z]     inspect_test.go:25: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestInspect
14:47:53 [2019-09-16T14:47:53.837Z]     daemon.go:302: [dac65d727d19b] waiting for daemon to start
14:47:53 [2019-09-16T14:47:53.837Z]     daemon.go:334: [dac65d727d19b] daemon started
14:47:53 [2019-09-16T14:47:53.837Z]     daemon.go:286: [dac65d727d19b] exiting daemon
14:47:53 [2019-09-16T14:47:53.837Z] === RUN   TestDockerNetworkConnectAlias
14:48:00 [2019-09-16T14:48:00.381Z] --- PASS: TestDockerNetworkConnectAlias (7.10s)
14:48:00 [2019-09-16T14:48:00.381Z]     network_test.go:20: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestDockerNetworkConnectAlias
14:48:00 [2019-09-16T14:48:00.381Z]     daemon.go:302: [dc1bb749a1730] waiting for daemon to start
14:48:00 [2019-09-16T14:48:00.381Z]     daemon.go:334: [dc1bb749a1730] daemon started
14:48:00 [2019-09-16T14:48:00.381Z]     daemon.go:286: [dc1bb749a1730] exiting daemon
14:48:00 [2019-09-16T14:48:00.381Z] === RUN   TestServicePlugin
14:48:39 [2019-09-16T14:48:39.060Z] --- PASS: TestServicePlugin (33.98s)
14:48:39 [2019-09-16T14:48:39.060Z]     plugin_test.go:36: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServicePlugin
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:302: [d40886c1299d9] waiting for daemon to start
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:334: [d40886c1299d9] daemon started
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:286: [d40886c1299d9] exiting daemon
14:48:39 [2019-09-16T14:48:39.060Z]     plugin_test.go:57: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServicePlugin
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:302: [d1b0109027f47] waiting for daemon to start
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:334: [d1b0109027f47] daemon started
14:48:39 [2019-09-16T14:48:39.060Z]     plugin_test.go:59: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServicePlugin
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:302: [d91e608ddffc0] waiting for daemon to start
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:334: [d91e608ddffc0] daemon started
14:48:39 [2019-09-16T14:48:39.060Z]     plugin_test.go:62: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServicePlugin
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:302: [dc3bc8f55f79e] waiting for daemon to start
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:334: [dc3bc8f55f79e] daemon started
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:286: [dc3bc8f55f79e] exiting daemon
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:286: [d91e608ddffc0] exiting daemon
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:286: [d1b0109027f47] exiting daemon
14:48:39 [2019-09-16T14:48:39.060Z] === RUN   TestServiceUpdateLabel
14:48:39 [2019-09-16T14:48:39.060Z] --- PASS: TestServiceUpdateLabel (3.03s)
14:48:39 [2019-09-16T14:48:39.060Z]     update_test.go:21: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceUpdateLabel
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:302: [dc7ce2df7cc64] waiting for daemon to start
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:334: [dc7ce2df7cc64] daemon started
14:48:39 [2019-09-16T14:48:39.060Z]     daemon.go:286: [dc7ce2df7cc64] exiting daemon
14:48:39 [2019-09-16T14:48:39.060Z] === RUN   TestServiceUpdateSecrets
14:48:53 [2019-09-16T14:48:53.912Z] --- PASS: TestServiceUpdateSecrets (15.53s)
14:48:53 [2019-09-16T14:48:53.912Z]     update_test.go:77: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceUpdateSecrets
14:48:53 [2019-09-16T14:48:53.912Z]     daemon.go:302: [d65cb7134099a] waiting for daemon to start
14:48:53 [2019-09-16T14:48:53.912Z]     daemon.go:334: [d65cb7134099a] daemon started
14:48:53 [2019-09-16T14:48:53.912Z]     daemon.go:286: [d65cb7134099a] exiting daemon
14:48:53 [2019-09-16T14:48:53.912Z] === RUN   TestServiceUpdateConfigs
14:49:08 [2019-09-16T14:49:08.760Z] --- PASS: TestServiceUpdateConfigs (15.54s)
14:49:08 [2019-09-16T14:49:08.760Z]     update_test.go:139: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceUpdateConfigs
14:49:08 [2019-09-16T14:49:08.760Z]     daemon.go:302: [d0a25da9654e4] waiting for daemon to start
14:49:08 [2019-09-16T14:49:08.760Z]     daemon.go:334: [d0a25da9654e4] daemon started
14:49:08 [2019-09-16T14:49:08.760Z]     daemon.go:286: [d0a25da9654e4] exiting daemon
14:49:08 [2019-09-16T14:49:08.760Z] === RUN   TestServiceUpdateNetwork
14:49:23 [2019-09-16T14:49:23.623Z] --- PASS: TestServiceUpdateNetwork (15.30s)
14:49:23 [2019-09-16T14:49:23.623Z]     update_test.go:201: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestServiceUpdateNetwork
14:49:23 [2019-09-16T14:49:23.623Z]     daemon.go:302: [d7c3bb12811dd] waiting for daemon to start
14:49:23 [2019-09-16T14:49:23.623Z]     daemon.go:334: [d7c3bb12811dd] daemon started
14:49:23 [2019-09-16T14:49:23.623Z]     daemon.go:286: [d7c3bb12811dd] exiting daemon
14:49:23 [2019-09-16T14:49:23.623Z] PASS
14:49:23 [2019-09-16T14:49:23.623Z] Running /go/src/github.com/docker/docker/integration/session flags=-test.v -test.timeout=120m  
14:49:23 [2019-09-16T14:49:23.879Z] INFO: Testing against a local daemon
14:49:23 [2019-09-16T14:49:23.879Z] === RUN   TestSessionCreate
14:49:23 [2019-09-16T14:49:23.879Z] --- SKIP: TestSessionCreate (0.00s)
14:49:23 [2019-09-16T14:49:23.879Z]     session_test.go:14: !testEnv.DaemonInfo.ExperimentalBuild
14:49:23 [2019-09-16T14:49:23.879Z] === RUN   TestSessionCreateWithBadUpgrade
14:49:23 [2019-09-16T14:49:23.879Z] --- SKIP: TestSessionCreateWithBadUpgrade (0.00s)
14:49:23 [2019-09-16T14:49:23.879Z]     session_test.go:31: !testEnv.DaemonInfo.ExperimentalBuild
14:49:23 [2019-09-16T14:49:23.879Z] PASS
14:49:23 [2019-09-16T14:49:23.879Z] Running /go/src/github.com/docker/docker/integration/system flags=-test.v -test.timeout=120m  
14:49:23 [2019-09-16T14:49:23.879Z] INFO: Testing against a local daemon
14:49:23 [2019-09-16T14:49:23.879Z] === RUN   TestCgroupDriverSystemdMemoryLimit
14:49:23 [2019-09-16T14:49:23.879Z] === PAUSE TestCgroupDriverSystemdMemoryLimit
14:49:23 [2019-09-16T14:49:23.879Z] === RUN   TestEventsExecDie
14:49:24 [2019-09-16T14:49:24.816Z] --- PASS: TestEventsExecDie (0.96s)
14:49:24 [2019-09-16T14:49:24.816Z] === RUN   TestEventsBackwardsCompatible
14:49:25 [2019-09-16T14:49:25.073Z] --- PASS: TestEventsBackwardsCompatible (0.12s)
14:49:25 [2019-09-16T14:49:25.073Z] === RUN   TestInfoBinaryCommits
14:49:25 [2019-09-16T14:49:25.073Z] --- PASS: TestInfoBinaryCommits (0.06s)
14:49:25 [2019-09-16T14:49:25.073Z] === RUN   TestInfoAPIVersioned
14:49:25 [2019-09-16T14:49:25.073Z] --- PASS: TestInfoAPIVersioned (0.01s)
14:49:25 [2019-09-16T14:49:25.073Z] === RUN   TestInfoAPI
14:49:25 [2019-09-16T14:49:25.073Z] --- PASS: TestInfoAPI (0.06s)
14:49:25 [2019-09-16T14:49:25.073Z] === RUN   TestInfoAPIWarnings
14:49:26 [2019-09-16T14:49:26.002Z] --- PASS: TestInfoAPIWarnings (0.77s)
14:49:26 [2019-09-16T14:49:26.002Z]     info_test.go:49: Creating a new daemon at: /go/src/github.com/docker/docker/bundles/test-integration/1/TestInfoAPIWarnings
14:49:26 [2019-09-16T14:49:26.002Z]     daemon.go:302: [dc2f95f31b22e] waiting for daemon to start
14:49:26 [2019-09-16T14:49:26.002Z]     daemon.go:334: [dc2f95f31b22e] daemon started
14:49:26 [2019-09-16T14:49:26.002Z]     daemon.go:286: [dc2f95f31b22e] exiting daemon
14:49:26 [2019-09-16T14:49:26.002Z] === RUN   TestLoginFailsWithBadCredentials
14:49:26 [2019-09-16T14:49:26.259Z] --- PASS: TestLoginFailsWithBadCredentials (0.31s)
14:49:26 [2019-09-16T14:49:26.259Z] === RUN   TestVersion
14:49:26 [2019-09-16T14:49:26.259Z] --- PASS: TestVersion (0.05s)
14:49:26 [2019-09-16T14:49:26.259Z] === CONT  TestCgroupDriverSystemdMemoryLimit
14:49:26 [2019-09-16T14:49:26.259Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
14:49:26 [2019-09-16T14:49:26.259Z]     cgroupdriver_systemd_test.go:35: systemd not available
14:49:26 [2019-09-16T14:49:26.259Z] PASS
14:49:26 [2019-09-16T14:49:26.259Z] Running /go/src/github.com/docker/docker/integration/volume flags=-test.v -test.timeout=120m  
14:49:26 [2019-09-16T14:49:26.259Z] INFO: Testing against a local daemon
14:49:26 [2019-09-16T14:49:26.259Z] === RUN   TestVolumesCreateAndList
14:49:26 [2019-09-16T14:49:26.259Z] --- PASS: TestVolumesCreateAndList (0.05s)
14:49:26 [2019-09-16T14:49:26.259Z] === RUN   TestVolumesRemove
14:49:26 [2019-09-16T14:49:26.516Z] --- PASS: TestVolumesRemove (0.12s)
14:49:26 [2019-09-16T14:49:26.516Z] === RUN   TestVolumesInspect
14:49:26 [2019-09-16T14:49:26.516Z] --- PASS: TestVolumesInspect (0.06s)
14:49:26 [2019-09-16T14:49:26.516Z] === RUN   TestVolumesInvalidJSON
14:49:26 [2019-09-16T14:49:26.516Z] === RUN   TestVolumesInvalidJSON//volumes/create
14:49:26 [2019-09-16T14:49:26.516Z] === PAUSE TestVolumesInvalidJSON//volumes/create
14:49:26 [2019-09-16T14:49:26.516Z] === CONT  TestVolumesInvalidJSON//volumes/create
14:49:26 [2019-09-16T14:49:26.516Z] --- PASS: TestVolumesInvalidJSON (0.05s)
14:49:26 [2019-09-16T14:49:26.516Z]     --- PASS: TestVolumesInvalidJSON//volumes/create (0.00s)
14:49:26 [2019-09-16T14:49:26.516Z] PASS
14:49:26 [2019-09-16T14:49:26.516Z] ---> Making bundle: .integration-daemon-stop (in /go/src/github.com/docker/docker/bundles/test-integration/1)
14:49:27 [2019-09-16T14:49:27.883Z] umount: /go/src/github.com/docker/docker/bundles/test-integration/1/root: mountpoint not found
14:49:27 [2019-09-16T14:49:27.883Z] Clearing AppArmor profiles cache:.
14:49:27 [2019-09-16T14:49:27.883Z] All profile caches have been cleared, but no profiles have been unloaded.
14:49:27 [2019-09-16T14:49:27.883Z] Unloading profiles will leave already running processes permanently
14:49:27 [2019-09-16T14:49:27.884Z] unconfined, which can lead to unexpected situations.
14:49:27 [2019-09-16T14:49:27.884Z] 
14:49:27 [2019-09-16T14:49:27.884Z] To set a process to complain mode, use the command line tool
14:49:27 [2019-09-16T14:49:27.884Z] 'aa-complain'. To really tear down all profiles, run the init script
14:49:27 [2019-09-16T14:49:27.884Z] with the 'teardown' option."
14:49:27 [2019-09-16T14:49:27.884Z] Removing test suite binaries
14:49:27 [2019-09-16T14:49:27.884Z] 
14:49:30 [2019-09-16T14:49:30.404Z] Remaining pids to kill: []
[Pipeline] }
[Pipeline] // stage
Post stage
[Pipeline] sh
14:49:30 [2019-09-16T14:49:30.990Z] + echo Ensuring container killed.
14:49:30 [2019-09-16T14:49:30.990Z] Ensuring container killed.
14:49:30 [2019-09-16T14:49:30.990Z] + docker rm -vf docker-pr1
14:49:31 [2019-09-16T14:49:31.247Z] Error: No such container: docker-pr1
14:49:31 [2019-09-16T14:49:31.247Z] + true
[Pipeline] sh
14:49:31 [2019-09-16T14:49:31.530Z] + echo Chowning /workspace to jenkins user
14:49:31 [2019-09-16T14:49:31.530Z] Chowning /workspace to jenkins user
14:49:31 [2019-09-16T14:49:31.530Z] + id -u
14:49:31 [2019-09-16T14:49:31.530Z] + id -g
14:49:31 [2019-09-16T14:49:31.530Z] + docker run --rm -v /home/ubuntu/workspace/engine_PR-359:/workspace busybox chown -R 1000:1000 /workspace
[Pipeline] sh
14:49:43 [2019-09-16T14:49:43.992Z] + echo Creating janky-bundles.tar.gz
14:49:43 [2019-09-16T14:49:43.992Z] Creating janky-bundles.tar.gz
14:49:43 [2019-09-16T14:49:43.992Z] + find bundles -path */root/*overlay2 -prune -o -type f ( -name *.log -o -name *.prof ) -print
14:49:43 [2019-09-16T14:49:43.992Z] + xargs tar -czf janky-bundles.tar.gz
[Pipeline] archiveArtifacts
14:49:45 [2019-09-16T14:49:45.896Z] Archiving artifacts
14:49:46 [2019-09-16T14:49:46.566Z] Uploaded 1 artifact(s) to https://corp-us-east-1-jenkins-k8s-maste-jenkinsartifacts-1lzm7adht5e1j.s3.amazonaws.com/public/engine/PR-359/1/artifacts/
[Pipeline] sh
14:49:46 [2019-09-16T14:49:46.851Z] + make clean
14:49:47 [2019-09-16T14:49:47.107Z] docker volume rm -f docker-dev-cache
14:49:47 [2019-09-16T14:49:47.107Z] docker-dev-cache
[Pipeline] deleteDir
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // node
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // parallel
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // timestamps
[Pipeline] }
[Pipeline] // timeout
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] End of Pipeline

GitHub has been notified of this commit’s build result

Finished: SUCCESS