docker / for-win

Bug reports for Docker Desktop for Windows
https://www.docker.com/products/docker#/windows
1.86k stars 289 forks source link

Can't switch to linux containers in Windows 10 Azure VM #411

Closed leolorenzoluis closed 7 years ago

leolorenzoluis commented 7 years ago

Expected behavior

Docker for Linux Container not working

Actual behavior

Docker for Linux Container should run

Information

Diagnostic ID: 694A9871-018A-4B14-9CFB-79E8A5846283/2017-01-22_08-41-21

Version: 1.13.0-beta38 (9805)
Channel: Stable
Sha1: 0c6d765c5482987c547f4b2b68f04167ebd3f352
Started on: 2017/01/22 08:29:31.397
Resources: C:\Program Files\Docker\Docker\Resources
OS: Windows 10 Enterprise N
Edition: EnterpriseN
Id: 1607
Build: 14393
BuildLabName: 14393.693.amd64fre.rs1_release.161220-1747
File: C:\Users\leo\AppData\Local\Docker\log.txt
CommandLine: "C:\Program Files\Docker\Docker\Docker for Windows.exe" 
You can send feedback, including this log file, at https://github.com/docker/for-win/issues
[08:29:31.522][GUI            ][Info   ] Starting...
[08:29:31.866][Tracking       ][Info   ] Crash report and usage statistics are enabled
[08:29:31.866][SegmentApi     ][Info   ] Usage statistic: appLaunched
[08:29:31.960][NamedPipeClient][Info   ] Sending Version()...
[08:29:31.975][NamedPipeClient][Info   ] Received response for Version
[08:29:31.975][SegmentApi     ][Info   ] Usage statistic: heartbeat
[08:26:30.434][BackendServer  ][Info   ] Started
[08:29:31.960][NamedPipeServer][Info   ] Version()
[08:29:31.960][NamedPipeServer][Info   ] Version done in 00:00:00.
[08:29:32.194][Updater        ][Info   ] Checking for updates on channel Stable...
[08:29:32.194][Notifications  ][Info   ] Docker is starting...
[08:29:32.210][NamedPipeClient][Info   ] Sending Start(Docker.Core.Settings)...
[08:29:32.210][NamedPipeServer][Info   ] Start(Docker.Core.Settings)
[08:29:32.225][PowerShell     ][Info   ] Run script...
[08:29:32.241][PowerShell     ][Info   ] Creating a Runspace Pool...
[08:29:32.288][Updater        ][Info   ] Local build 9805 is as good as the remote 9795 on channel Stable
[08:29:32.663][PowerShell     ][Info   ] Runspace Pool created (Min=1, Max=2)
[08:29:35.054][PowerShell     ][Info   ] Run script...
[08:29:36.288][ContainerEngineHelper][Error  ] Might have failed to kill a running dockerd process: Process with an Id of 8288 is not running.
[08:29:36.319][WindowsDockerDaemon][Info   ] Starting C:\Program Files\Docker\Docker\Resources\dockerd.exe -H npipe:////./pipe/docker_engine_windows --debug --experimental
[08:29:36.350][WindowsDockerDaemon][Info   ] Started
[08:29:36.350][ApiProxy       ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe -daemonNamedPipe=\\.\pipe\docker_engine_windows
[08:29:36.569][ApiProxy       ][Info   ] Started
[08:29:36.682][ApiProxy       ][Info   ] docker proxy (on deprecated port): ready
[08:29:36.682][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36Z" level=warning msg="Running experimental build" 
[08:29:36.682][ApiProxy       ][Info   ] docker proxy: ready
[08:29:36.682][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.682273600Z" level=debug msg="Listener created for HTTP on npipe (//./pipe/docker_engine_windows)" 
[08:29:36.685][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.685273400Z" level=info msg="Windows default isolation mode: hyperv" 
[08:29:36.685][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.685273400Z" level=debug msg="Using default logging driver json-file" 
[08:29:36.689][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.689272900Z" level=debug msg="WindowsGraphDriver InitFilter at C:\\ProgramData\\Docker\\windowsfilter" 
[08:29:36.689][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.689272900Z" level=debug msg="Using graph driver windowsfilter" 
[08:29:36.689][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.689272900Z" level=debug msg="Max Concurrent Downloads: 3" 
[08:29:36.689][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.689272900Z" level=debug msg="Max Concurrent Uploads: 5" 
[08:29:36.723][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.723274200Z" level=info msg="Graph migration to content-addressability took 0.00 seconds" 
[08:29:36.723][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.723274200Z" level=info msg="Loading containers: start." 
[08:29:36.723][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.723274200Z" level=debug msg="Option Experimental: true" 
[08:29:36.723][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.723274200Z" level=debug msg="Option DefaultDriver: nat" 
[08:29:36.723][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.723274200Z" level=debug msg="Option DefaultNetwork: nat" 
[08:29:36.782][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:29:36.782][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:29:36.832][ApiProxy       ][Info   ] i/o timeout
[08:29:36.832][ApiProxy       ][Info   ] proxy >> GET /v1.25/containers/json
[08:29:36.832][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:29:36.858][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.858167700Z" level=debug msg="Network Response : [ { \"CurrentEndpointCount\" : 0, \"ExternalInterfaceAddress\" : \"00-0D-3A-11-04-DB\", \"ID\" : \"4fa81a80-a56a-4b8b-8468-216104c65f20\", \"MacPools\" : [ { \"EndMacAddress\" : \"00-15-5D-A3-3F-FF\", \"StartMacAddress\" : \"00-15-5D-A3-30-00\" } ], \"MaxConcurrentEndpoints\" : 0, \"NATName\" : \"H4fa81a80-a56a-4b8b-8468-216104c65f20\", \"Name\" : \"nat\", \"Policies\" : [  ], \"Subnets\" : [ { \"AddressPrefix\" : \"172.25.16.0/20\", \"GatewayAddress\" : \"172.25.16.1\" } ], \"SwitchGuid\" : \"6001883e-8bd0-4a9f-aab7-6aaea1c3a372\", \"TotalEndpoints\" : 0, \"Type\" : \"nat\", \"Version\" : 4294967297 } ]" 
[08:29:36.858][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.858167700Z" level=debug msg="Launching DNS server for network%!(EXTRA string=none)" 
[08:29:36.881][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.880170200Z" level=debug msg="releasing IPv4 pools from network nat (8efa46402403dc7d0883151fb8bffbc0ad210792168a8d7ac4185432a4be5740)" 
[08:29:36.881][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.881167300Z" level=debug msg="ReleaseAddress(0.0.0.0/0, 0.0.0.0)" 
[08:29:36.881][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.881167300Z" level=debug msg="ReleasePool(0.0.0.0/0)" 
[08:29:36.883][ApiProxy       ][Info   ] i/o timeout
[08:29:36.886][DockerDaemonChecker][Error  ] Docker daemon is not running
[08:29:36.912][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.912170200Z" level=debug msg="Allocating IPv4 pools for network nat (43bac2f6a8d26ceff70343f054ce7c501addc7215cbe36b50e07bfe8ef064b41)" 
[08:29:36.912][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.912170200Z" level=debug msg="RequestPool(LocalDefault, 172.25.16.0/20, , map[], false)" 
[08:29:36.912][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.912170200Z" level=debug msg="RequestAddress(172.25.16.0/20, 172.25.16.1, map[RequestAddressType:com.docker.network.gateway])" 
[08:29:36.912][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.912170200Z" level=debug msg="Launching DNS server for network%!(EXTRA string=nat)" 
[08:29:36.917][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.917167000Z" level=debug msg="Network Response : { \"CurrentEndpointCount\" : 0, \"ExternalInterfaceAddress\" : \"00-0D-3A-11-04-DB\", \"ID\" : \"4fa81a80-a56a-4b8b-8468-216104c65f20\", \"MacPools\" : [ { \"EndMacAddress\" : \"00-15-5D-A3-3F-FF\", \"StartMacAddress\" : \"00-15-5D-A3-30-00\" } ], \"MaxConcurrentEndpoints\" : 0, \"NATName\" : \"H4fa81a80-a56a-4b8b-8468-216104c65f20\", \"Name\" : \"nat\", \"Policies\" : [  ], \"Subnets\" : [ { \"AddressPrefix\" : \"172.25.16.0/20\", \"GatewayAddress\" : \"172.25.16.1\" } ], \"SwitchGuid\" : \"6001883e-8bd0-4a9f-aab7-6aaea1c3a372\", \"TotalEndpoints\" : 0, \"Type\" : \"nat\", \"Version\" : 4294967297 }" 
[08:29:36.917][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.917167000Z" level=debug msg="Binding a resolver on network nat gateway 172.25.16.1" 
[08:29:36.917][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.917167000Z" level=debug msg="Resolver bound successfully for network nat" 
[08:29:36.947][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.947870600Z" level=info msg="Loading containers: done." 
[08:29:36.947][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.947870600Z" level=debug msg="Stackdump - waiting signal at Global\\docker-daemon-1140" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.947870600Z" level=info msg="Daemon has completed initialization" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=info msg="Docker daemon" commit=49bf474 graphdriver=windowsfilter version=1.13.0 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering routers" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering HEAD, /containers/{name:.*}/archive" 
[08:29:36.948][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering GET, /containers/json" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.948871400Z" level=debug msg="Registering GET, /containers/{name:.*}/export" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/changes" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/json" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/top" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/logs" 
[08:29:36.949][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/stats" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.949870100Z" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering GET, /exec/{id:.*}/json" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering GET, /containers/{name:.*}/archive" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering POST, /containers/create" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering POST, /containers/{name:.*}/kill" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering POST, /containers/{name:.*}/pause" 
[08:29:36.950][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.950869900Z" level=debug msg="Registering POST, /containers/{name:.*}/unpause" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/restart" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/start" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/stop" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/wait" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/resize" 
[08:29:36.951][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/attach" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.951870000Z" level=debug msg="Registering POST, /containers/{name:.*}/copy" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.952869800Z" level=debug msg="Registering POST, /containers/{name:.*}/exec" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.952869800Z" level=debug msg="Registering POST, /exec/{name:.*}/start" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.952869800Z" level=debug msg="Registering POST, /exec/{name:.*}/resize" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.952869800Z" level=debug msg="Registering POST, /containers/{name:.*}/rename" 
[08:29:36.952][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.952869800Z" level=debug msg="Registering POST, /containers/{name:.*}/update" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering POST, /containers/prune" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering PUT, /containers/{name:.*}/archive" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering DELETE, /containers/{name:.*}" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering GET, /images/json" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering GET, /images/search" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering GET, /images/get" 
[08:29:36.953][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering GET, /images/{name:.*}/get" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.953870000Z" level=debug msg="Registering GET, /images/{name:.*}/history" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering GET, /images/{name:.*}/json" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /commit" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /images/load" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /images/create" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /images/{name:.*}/push" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /images/{name:.*}/tag" 
[08:29:36.954][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.954888700Z" level=debug msg="Registering POST, /images/prune" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering DELETE, /images/{name:.*}" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering OPTIONS, /{anyroute:.*}" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering GET, /_ping" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering GET, /events" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering GET, /info" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering GET, /version" 
[08:29:36.955][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.955870000Z" level=debug msg="Registering GET, /system/df" 
[08:29:36.956][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.956875400Z" level=debug msg="Registering POST, /auth" 
[08:29:36.956][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.956875400Z" level=debug msg="Registering GET, /volumes" 
[08:29:36.956][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.956875400Z" level=debug msg="Registering GET, /volumes/{name:.*}" 
[08:29:36.956][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.956875400Z" level=debug msg="Registering POST, /volumes/create" 
[08:29:36.956][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.956875400Z" level=debug msg="Registering POST, /volumes/prune" 
[08:29:36.957][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.957871700Z" level=debug msg="Registering DELETE, /volumes/{name:.*}" 
[08:29:36.957][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.957871700Z" level=debug msg="Registering POST, /build" 
[08:29:36.957][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.957871700Z" level=debug msg="Registering POST, /swarm/init" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.957871700Z" level=debug msg="Registering POST, /swarm/join" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering POST, /swarm/leave" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering GET, /swarm" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering GET, /swarm/unlockkey" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering POST, /swarm/update" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering POST, /swarm/unlock" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.958869700Z" level=debug msg="Registering GET, /services" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.959948000Z" level=debug msg="Registering GET, /services/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.962869600Z" level=debug msg="Registering POST, /services/create" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.963869900Z" level=debug msg="Registering POST, /services/{id}/update" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.964869700Z" level=debug msg="Registering DELETE, /services/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.964869700Z" level=debug msg="Registering GET, /services/{id}/logs" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.965869900Z" level=debug msg="Registering GET, /nodes" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.966870300Z" level=debug msg="Registering GET, /nodes/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.967869700Z" level=debug msg="Registering DELETE, /nodes/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.967869700Z" level=debug msg="Registering POST, /nodes/{id}/update" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.968869700Z" level=debug msg="Registering GET, /tasks" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.969869700Z" level=debug msg="Registering GET, /tasks/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.970869600Z" level=debug msg="Registering GET, /secrets" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.970869600Z" level=debug msg="Registering POST, /secrets/create" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.971869700Z" level=debug msg="Registering DELETE, /secrets/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.971869700Z" level=debug msg="Registering GET, /secrets/{id}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.972869900Z" level=debug msg="Registering POST, /secrets/{id}/update" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.972869900Z" level=debug msg="Registering GET, /plugins" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.972869900Z" level=debug msg="Registering GET, /plugins/{name:.*}/json" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.972869900Z" level=debug msg="Registering GET, /plugins/privileges" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.973870000Z" level=debug msg="Registering DELETE, /plugins/{name:.*}" 
[08:29:36.974][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.974869800Z" level=debug msg="Registering POST, /plugins/{name:.*}/enable" 
[08:29:36.975][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.975870000Z" level=debug msg="Registering POST, /plugins/{name:.*}/disable" 
[08:29:36.975][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.975870000Z" level=debug msg="Registering POST, /plugins/pull" 
[08:29:36.975][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.975870000Z" level=debug msg="Registering POST, /plugins/{name:.*}/push" 
[08:29:36.975][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.975870000Z" level=debug msg="Registering POST, /plugins/{name:.*}/set" 
[08:29:36.975][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.975870000Z" level=debug msg="Registering POST, /plugins/create" 
[08:29:36.976][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering GET, /networks" 
[08:29:36.976][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering GET, /networks/" 
[08:29:36.976][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering GET, /networks/{id:.+}" 
[08:29:36.976][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering POST, /networks/create" 
[08:29:36.976][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering POST, /networks/{id:.*}/connect" 
[08:29:36.977][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.976870100Z" level=debug msg="Registering POST, /networks/{id:.*}/disconnect" 
[08:29:36.977][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.977870200Z" level=debug msg="Registering POST, /networks/prune" 
[08:29:36.977][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.977870200Z" level=debug msg="Registering DELETE, /networks/{id:.*}" 
[08:29:36.978][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.977870200Z" level=info msg="API listen on //./pipe/docker_engine_windows" 
[08:29:36.978][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:36.978870200Z" level=debug msg="Config reload - waiting signal at Global\\docker-daemon-config-1140" 
[08:29:37.917][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:29:37.917][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:29:37.917][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:29:37.918][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:37.918903500Z" level=debug msg="Calling GET /_ping" 
[08:29:37.919][ApiProxy       ][Info   ] proxy << GET /_ping
[08:29:37.919][ApiProxy       ][Info   ] proxy >> GET /v1.25/containers/json
[08:29:37.919][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:29:37.919][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:29:37.920][WindowsDockerDaemon][Info   ] time="2017-01-22T08:29:37.919902300Z" level=debug msg="Calling GET /v1.25/containers/json" 
[08:29:37.928][NamedPipeClient][Info   ] Received response for Start
[08:29:37.920][ApiProxy       ][Info   ] proxy << GET /v1.25/containers/json
[08:29:37.926][DockerDaemonChecker][Info   ] Docker daemon is running
[08:29:37.927][NamedPipeServer][Info   ] Start done in 00:00:05.7176361.
[08:29:37.970][Notifications  ][Info   ] Docker is running
[08:29:37.970][SegmentApi     ][Info   ] Usage statistic: installShowWelcomePopup
[08:29:37.972][SegmentApi     ][Info   ] Usage statistic: appRunning
[08:29:38.081][Actions        ][Debug  ] Start took 00:00:05.9028782
[08:31:10.962][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:31:10.963][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:10.963][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:10.963][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:10.963431400Z" level=debug msg="Calling GET /_ping" 
[08:31:10.963][ApiProxy       ][Info   ] proxy << GET /_ping
[08:31:10.964][ApiProxy       ][Info   ] proxy >> GET /v1.25/images/json
[08:31:10.964][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:10.964][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:10.964][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:10.964453300Z" level=debug msg="Calling GET /v1.25/images/json" 
[08:31:10.965][ApiProxy       ][Info   ] proxy << GET /v1.25/images/json
[08:31:12.878][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:31:12.879][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:12.879][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:12.879][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:12.879903100Z" level=debug msg="Calling GET /_ping" 
[08:31:12.880][ApiProxy       ][Info   ] proxy << GET /_ping
[08:31:12.880][ApiProxy       ][Info   ] proxy >> GET /v1.25/version
[08:31:12.880][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:12.880][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:12.880][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:12.880903800Z" level=debug msg="Calling GET /v1.25/version" 
[08:31:12.881][ApiProxy       ][Info   ] proxy << GET /v1.25/version
[08:31:14.202][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:31:14.202][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:14.202][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:14.203][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:14.203171800Z" level=debug msg="Calling GET /_ping" 
[08:31:14.203][ApiProxy       ][Info   ] proxy << GET /_ping
[08:31:14.203][ApiProxy       ][Info   ] proxy >> GET /v1.25/info
[08:31:14.203][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:14.203][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:14.204][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:14.204173400Z" level=debug msg="Calling GET /v1.25/info" 
[08:31:14.206][ApiProxy       ][Info   ] proxy << GET /v1.25/info
[08:31:43.316][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:31:43.316][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:43.316][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:43.316][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.316766300Z" level=debug msg="Calling GET /_ping" 
[08:31:43.317][ApiProxy       ][Info   ] proxy << GET /_ping
[08:31:43.320][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create [rewriteBinds]
[08:31:43.323][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create
[08:31:43.323][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:43.323][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:43.324][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.324741700Z" level=debug msg="Calling POST /v1.25/containers/create" 
[08:31:43.325][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.325741500Z" level=debug msg="form data: {\"AttachStderr\":true,\"AttachStdin\":false,\"AttachStdout\":true,\"Cmd\":null,\"Domainname\":\"\",\"Entrypoint\":null,\"Env\":[],\"HostConfig\":{\"AutoRemove\":false,\"Binds\":null,\"BlkioDeviceReadBps\":null,\"BlkioDeviceReadIOps\":null,\"BlkioDeviceWriteBps\":null,\"BlkioDeviceWriteIOps\":null,\"BlkioWeight\":0,\"BlkioWeightDevice\":null,\"CapAdd\":null,\"CapDrop\":null,\"Cgroup\":\"\",\"CgroupParent\":\"\",\"ConsoleSize\":[50,120],\"ContainerIDFile\":\"\",\"CpuCount\":0,\"CpuPercent\":0,\"CpuPeriod\":0,\"CpuQuota\":0,\"CpuRealtimePeriod\":0,\"CpuRealtimeRuntime\":0,\"CpuShares\":0,\"CpusetCpus\":\"\",\"CpusetMems\":\"\",\"Devices\":[],\"DiskQuota\":0,\"Dns\":[],\"DnsOptions\":[],\"DnsSearch\":[],\"ExtraHosts\":null,\"GroupAdd\":null,\"IOMaximumBandwidth\":0,\"IOMaximumIOps\":0,\"IpcMode\":\"\",\"Isolation\":\"\",\"KernelMemory\":0,\"Links\":null,\"LogConfig\":{\"Config\":{},\"Type\":\"\"},\"Memory\":0,\"MemoryReservation\":0,\"MemorySwap\":0,\"MemorySwappiness\":-1,\"NanoCpus\":0,\"NetworkMode\":\"default\",\"OomKillDisable\":false,\"OomScoreAdj\":0,\"PidMode\":\"\",\"PidsLimit\":0,\"PortBindings\":{},\"Privileged\":false,\"PublishAllPorts\":false,\"ReadonlyRootfs\":false,\"RestartPolicy\":{\"MaximumRetryCount\":0,\"Name\":\"no\"},\"SecurityOpt\":null,\"ShmSize\":0,\"UTSMode\":\"\",\"Ulimits\":null,\"UsernsMode\":\"\",\"VolumeDriver\":\"\",\"VolumesFrom\":null},\"Hostname\":\"\",\"Image\":\"hello-owrld\",\"Labels\":{},\"NetworkingConfig\":{\"EndpointsConfig\":{}},\"OnBuild\":null,\"OpenStdin\":false,\"StdinOnce\":false,\"Tty\":false,\"User\":\"\",\"Volumes\":{},\"WorkingDir\":\"\"}" 
[08:31:43.327][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.327741500Z" level=error msg="Handler for POST /v1.25/containers/create returned error: No such image: hello-owrld:latest" 
[08:31:43.327][ApiProxy       ][Info   ] proxy << POST /v1.25/containers/create
[08:31:43.330][ApiProxy       ][Info   ] proxy >> GET /v1.25/info
[08:31:43.330][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:43.330][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:43.330][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.330742400Z" level=debug msg="Calling GET /v1.25/info" 
[08:31:43.331][ApiProxy       ][Info   ] proxy << GET /v1.25/info
[08:31:43.403][ApiProxy       ][Info   ] proxy >> POST /v1.25/images/create?fromImage=hello-owrld&tag=latest
[08:31:43.403][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:43.403][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:43.404][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.403678300Z" level=debug msg="Calling POST /v1.25/images/create?fromImage=hello-owrld&tag=latest" 
[08:31:43.404][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.404677300Z" level=debug msg="Trying to pull hello-owrld from https://registry-1.docker.io v2" 
[08:31:43.553][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.553009800Z" level=error msg="Not continuing with pull after error: errors:\ndenied: requested access to the resource is denied\nunauthorized: authentication required\n" 
[08:31:43.553][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.553009800Z" level=info msg="Ignoring extra error returned from registry: unauthorized: authentication required" 
[08:31:43.553][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.553009800Z" level=info msg="Translating \"denied: requested access to the resource is denied\" to \"repository hello-owrld not found: does not exist or no pull access\"" 
[08:31:43.553][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:43.553009800Z" level=error msg="Handler for POST /v1.25/images/create returned error: repository hello-owrld not found: does not exist or no pull access" 
[08:31:43.553][ApiProxy       ][Info   ] proxy << POST /v1.25/images/create?fromImage=hello-owrld&tag=latest
[08:31:46.086][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:31:46.086][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:46.086][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:46.086][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.086805500Z" level=debug msg="Calling GET /_ping" 
[08:31:46.087][ApiProxy       ][Info   ] proxy << GET /_ping
[08:31:46.088][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create [rewriteBinds]
[08:31:46.088][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create
[08:31:46.088][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:46.088][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:46.088][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.088784200Z" level=debug msg="Calling POST /v1.25/containers/create" 
[08:31:46.089][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.088784200Z" level=debug msg="form data: {\"AttachStderr\":true,\"AttachStdin\":false,\"AttachStdout\":true,\"Cmd\":null,\"Domainname\":\"\",\"Entrypoint\":null,\"Env\":[],\"HostConfig\":{\"AutoRemove\":false,\"Binds\":null,\"BlkioDeviceReadBps\":null,\"BlkioDeviceReadIOps\":null,\"BlkioDeviceWriteBps\":null,\"BlkioDeviceWriteIOps\":null,\"BlkioWeight\":0,\"BlkioWeightDevice\":null,\"CapAdd\":null,\"CapDrop\":null,\"Cgroup\":\"\",\"CgroupParent\":\"\",\"ConsoleSize\":[50,120],\"ContainerIDFile\":\"\",\"CpuCount\":0,\"CpuPercent\":0,\"CpuPeriod\":0,\"CpuQuota\":0,\"CpuRealtimePeriod\":0,\"CpuRealtimeRuntime\":0,\"CpuShares\":0,\"CpusetCpus\":\"\",\"CpusetMems\":\"\",\"Devices\":[],\"DiskQuota\":0,\"Dns\":[],\"DnsOptions\":[],\"DnsSearch\":[],\"ExtraHosts\":null,\"GroupAdd\":null,\"IOMaximumBandwidth\":0,\"IOMaximumIOps\":0,\"IpcMode\":\"\",\"Isolation\":\"\",\"KernelMemory\":0,\"Links\":null,\"LogConfig\":{\"Config\":{},\"Type\":\"\"},\"Memory\":0,\"MemoryReservation\":0,\"MemorySwap\":0,\"MemorySwappiness\":-1,\"NanoCpus\":0,\"NetworkMode\":\"default\",\"OomKillDisable\":false,\"OomScoreAdj\":0,\"PidMode\":\"\",\"PidsLimit\":0,\"PortBindings\":{},\"Privileged\":false,\"PublishAllPorts\":false,\"ReadonlyRootfs\":false,\"RestartPolicy\":{\"MaximumRetryCount\":0,\"Name\":\"no\"},\"SecurityOpt\":null,\"ShmSize\":0,\"UTSMode\":\"\",\"Ulimits\":null,\"UsernsMode\":\"\",\"VolumeDriver\":\"\",\"VolumesFrom\":null},\"Hostname\":\"\",\"Image\":\"hello-world\",\"Labels\":{},\"NetworkingConfig\":{\"EndpointsConfig\":{}},\"OnBuild\":null,\"OpenStdin\":false,\"StdinOnce\":false,\"Tty\":false,\"User\":\"\",\"Volumes\":{},\"WorkingDir\":\"\"}" 
[08:31:46.089][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.089781800Z" level=error msg="Handler for POST /v1.25/containers/create returned error: No such image: hello-world:latest" 
[08:31:46.089][ApiProxy       ][Info   ] proxy << POST /v1.25/containers/create
[08:31:46.091][ApiProxy       ][Info   ] proxy >> GET /v1.25/info
[08:31:46.091][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:46.091][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:46.092][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.091782800Z" level=debug msg="Calling GET /v1.25/info" 
[08:31:46.092][ApiProxy       ][Info   ] proxy << GET /v1.25/info
[08:31:46.111][ApiProxy       ][Info   ] proxy >> POST /v1.25/images/create?fromImage=hello-world&tag=latest
[08:31:46.111][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:31:46.111][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:31:46.111][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.111783300Z" level=debug msg="Calling POST /v1.25/images/create?fromImage=hello-world&tag=latest" 
[08:31:46.111][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.111783300Z" level=debug msg="Trying to pull hello-world from https://registry-1.docker.io v2" 
[08:31:46.221][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.221520300Z" level=debug msg="Pulling ref from V2 registry: hello-world:latest" 
[08:31:46.296][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.296538900Z" level=error msg="Error trying v2 registry: image operating system \"linux\" cannot be used on this platform" 
[08:31:46.296][WindowsDockerDaemon][Info   ] time="2017-01-22T08:31:46.296538900Z" level=error msg="Attempting next endpoint for pull after error: image operating system \"linux\" cannot be used on this platform" 
[08:31:46.296][ApiProxy       ][Info   ] proxy << POST /v1.25/images/create?fromImage=hello-world&tag=latest
[08:36:15.224][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:36:15.225][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:36:15.225][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:36:15.225][WindowsDockerDaemon][Info   ] time="2017-01-22T08:36:15.225130700Z" level=debug msg="Calling GET /_ping" 
[08:36:15.225][ApiProxy       ][Info   ] proxy << GET /_ping
[08:36:15.225][ApiProxy       ][Info   ] proxy >> GET /v1.25/info
[08:36:15.225][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:36:15.225][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:36:15.226][WindowsDockerDaemon][Info   ] time="2017-01-22T08:36:15.225130700Z" level=debug msg="Calling GET /v1.25/info" 
[08:36:15.226][ApiProxy       ][Info   ] proxy << GET /v1.25/info
[08:38:12.376][ApiProxy       ][Info   ] proxy >> GET /_ping
[08:38:12.377][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:38:12.377][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:38:12.377][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.377825600Z" level=debug msg="Calling GET /_ping" 
[08:38:12.377][ApiProxy       ][Info   ] proxy << GET /_ping
[08:38:12.378][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create [rewriteBinds]
[08:38:12.378][ApiProxy       ][Info   ] proxy >> POST /v1.25/containers/create
[08:38:12.378][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:38:12.379][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:38:12.379][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.379824400Z" level=debug msg="Calling POST /v1.25/containers/create" 
[08:38:12.380][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.380824500Z" level=debug msg="form data: {\"AttachStderr\":true,\"AttachStdin\":false,\"AttachStdout\":true,\"Cmd\":null,\"Domainname\":\"\",\"Entrypoint\":null,\"Env\":[],\"HostConfig\":{\"AutoRemove\":false,\"Binds\":null,\"BlkioDeviceReadBps\":null,\"BlkioDeviceReadIOps\":null,\"BlkioDeviceWriteBps\":null,\"BlkioDeviceWriteIOps\":null,\"BlkioWeight\":0,\"BlkioWeightDevice\":null,\"CapAdd\":null,\"CapDrop\":null,\"Cgroup\":\"\",\"CgroupParent\":\"\",\"ConsoleSize\":[50,120],\"ContainerIDFile\":\"\",\"CpuCount\":0,\"CpuPercent\":0,\"CpuPeriod\":0,\"CpuQuota\":0,\"CpuRealtimePeriod\":0,\"CpuRealtimeRuntime\":0,\"CpuShares\":0,\"CpusetCpus\":\"\",\"CpusetMems\":\"\",\"Devices\":[],\"DiskQuota\":0,\"Dns\":[],\"DnsOptions\":[],\"DnsSearch\":[],\"ExtraHosts\":null,\"GroupAdd\":null,\"IOMaximumBandwidth\":0,\"IOMaximumIOps\":0,\"IpcMode\":\"\",\"Isolation\":\"\",\"KernelMemory\":0,\"Links\":null,\"LogConfig\":{\"Config\":{},\"Type\":\"\"},\"Memory\":0,\"MemoryReservation\":0,\"MemorySwap\":0,\"MemorySwappiness\":-1,\"NanoCpus\":0,\"NetworkMode\":\"default\",\"OomKillDisable\":false,\"OomScoreAdj\":0,\"PidMode\":\"\",\"PidsLimit\":0,\"PortBindings\":{},\"Privileged\":false,\"PublishAllPorts\":false,\"ReadonlyRootfs\":false,\"RestartPolicy\":{\"MaximumRetryCount\":0,\"Name\":\"no\"},\"SecurityOpt\":null,\"ShmSize\":0,\"UTSMode\":\"\",\"Ulimits\":null,\"UsernsMode\":\"\",\"VolumeDriver\":\"\",\"VolumesFrom\":null},\"Hostname\":\"\",\"Image\":\"hello-world\",\"Labels\":{},\"NetworkingConfig\":{\"EndpointsConfig\":{}},\"OnBuild\":null,\"OpenStdin\":false,\"StdinOnce\":false,\"Tty\":false,\"User\":\"\",\"Volumes\":{},\"WorkingDir\":\"\"}" 
[08:38:12.380][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.380824500Z" level=error msg="Handler for POST /v1.25/containers/create returned error: No such image: hello-world:latest" 
[08:38:12.381][ApiProxy       ][Info   ] proxy << POST /v1.25/containers/create
[08:38:12.383][ApiProxy       ][Info   ] proxy >> GET /v1.25/info
[08:38:12.383][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:38:12.383][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:38:12.383][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.383824400Z" level=debug msg="Calling GET /v1.25/info" 
[08:38:12.384][ApiProxy       ][Info   ] proxy << GET /v1.25/info
[08:38:12.402][ApiProxy       ][Info   ] proxy >> POST /v1.25/images/create?fromImage=hello-world&tag=latest
[08:38:12.402][ApiProxy       ][Info   ] Dial name pipe  \\.\pipe\docker_engine_windows
[08:38:12.402][ApiProxy       ][Info   ] Successfully dialed name pipe \\.\pipe\docker_engine_windows
[08:38:12.402][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.402828300Z" level=debug msg="Calling POST /v1.25/images/create?fromImage=hello-world&tag=latest" 
[08:38:12.402][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.402828300Z" level=debug msg="Trying to pull hello-world from https://registry-1.docker.io v2" 
[08:38:12.805][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.805099600Z" level=debug msg="Pulling ref from V2 registry: hello-world:latest" 
[08:38:12.932][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.932034100Z" level=error msg="Error trying v2 registry: image operating system \"linux\" cannot be used on this platform" 
[08:38:12.932][ApiProxy       ][Info   ] proxy << POST /v1.25/images/create?fromImage=hello-world&tag=latest
[08:38:12.932][WindowsDockerDaemon][Info   ] time="2017-01-22T08:38:12.932034100Z" level=error msg="Attempting next endpoint for pull after error: image operating system \"linux\" cannot be used on this platform" 
[08:38:45.520][SegmentApi     ][Info   ] Usage statistic: actionMenuSettings
[08:38:54.343][SegmentApi     ][Info   ] Usage statistic: actionMenuSwitchLinuxDaemon
[08:38:54.345][Notifications  ][Info   ] Docker is switching...
[08:38:54.365][SegmentApi     ][Info   ] Usage statistic: actionSettingsChanged
[08:38:54.444][NamedPipeClient][Info   ] Sending Start(Docker.Core.Settings)...
[08:38:55.446][NamedPipeServer][Info   ] Start(Docker.Core.Settings)
[08:38:55.450][PowerMode      ][Info   ] Stop
[08:38:55.451][HyperV         ][Info   ] Stop
[08:38:55.467][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[08:38:55.511][HyperV         ][Info   ] Script started at 08:38:55.507
[08:38:57.019][HyperV         ][Info   ] Module loaded at 08:38:57.019
[08:38:57.137][HyperV         ][Info   ] VM MobyLinuxVM does not exist
[08:38:57.138][HyperV         ][Debug  ] [stop] took 00:00:01.6858094 to run
[08:38:57.138][OptimizeDisk   ][Info   ] Optimize
[08:38:57.138][PowerShell     ][Info   ] Run script...
[08:38:57.151][Moby           ][Info   ] Stop
[08:38:57.152][ApiProxy       ][Info   ] Killing existing com.docker.proxy with PID 5632
[08:38:57.157][HyperVGuids    ][Info   ] Installing GUIDs...
[08:38:57.157][PowerMode      ][Info   ] Start
[08:38:57.158][HyperV         ][Info   ] Create
[08:38:57.158][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[08:38:57.159][HyperVGuids    ][Info   ] GUIDs installed
[08:38:57.179][HyperV         ][Info   ] Script started at 08:38:57.179
[08:38:57.189][HyperV         ][Info   ] Module loaded at 08:38:57.189
[08:38:57.193][Firewall       ][Info   ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe...
[08:38:57.324][HyperV         ][Info   ] Creating Switch: DockerNAT...
[08:38:58.003][Firewall       ][Info   ] Ports are opened
[08:38:58.712][HyperV         ][Info   ] Switch created.
[08:38:59.153][HyperV         ][Info   ] Set IP address on switch
[08:39:00.406][HyperV         ][Info   ] Creating VM MobyLinuxVM...
[08:39:01.135][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[08:39:01.376][HyperV         ][Info   ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx
[08:39:01.764][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[08:39:01.883][HyperV         ][Info   ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso
[08:39:02.751][HyperV         ][Info   ] VM created.
[08:39:02.751][HyperV         ][Debug  ] [create] took 00:00:05.5925161 to run
[08:39:02.752][PowerShell     ][Info   ] Run script '(Get-VM MobyLinuxVM).Id.Guid'...
[08:39:02.794][DataKit        ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.db.exe --url hyperv-connect://b49a68c9-3fb2-4c1e-b403-3f2e9c8f774b,\\.\pipe\dockerDataBase --color never
[08:39:02.831][DataKit        ][Info   ] Started
[08:39:02.834][Database       ][Info   ] Generating CA Cert Bundle
[08:39:02.855][Database       ][Info   ] CA Cert Bundle Generated
[08:39:02.864][DataKit        ][Info   ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...
[08:39:02.865][DataKit        ][Error  ] com.docker.db.exe: Failed to set up server socket listening on hyperv-connect://b49a68c9-3fb2-4c1e-b403-3f2e9c8f774b: Unix.Unix_error(Unix.ENETDOWN, "socket", "")
[08:39:02.865][DataKit        ][Info   ] com.docker.db.exe: internal error, uncaught exception:
[08:39:02.865][DataKit        ][Info   ]                    (Failure accept_forever)
[08:39:02.865][DataKit        ][Info   ]                    
[08:39:02.868][DataKit        ][Error  ] Process died
[08:39:07.839][Linux          ][Error  ] Failed to start: The operation has timed out.. Let's retry
[08:39:07.839][PowerShell     ][Info   ] Run script...
[08:39:09.709][HyperV         ][Info   ] Hyper-V is running
[08:39:09.709][PowerMode      ][Info   ] Stop
[08:39:09.709][HyperV         ][Info   ] Stop
[08:39:09.709][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[08:39:09.715][HyperV         ][Info   ] Script started at 08:39:09.715
[08:39:09.728][HyperV         ][Info   ] Module loaded at 08:39:09.728
[08:39:09.757][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[08:39:09.758][HyperV         ][Debug  ] [stop] took 00:00:00.0489962 to run
[08:39:09.758][OptimizeDisk   ][Info   ] Optimize
[08:39:09.758][PowerShell     ][Info   ] Run script...
[08:39:11.022][Moby           ][Info   ] Stop
[08:39:11.025][HyperV         ][Info   ] Destroy
[08:39:11.025][PowerShell     ][Info   ] Run script with parameters: -Destroy True -KeepVolume True...
[08:39:11.032][HyperV         ][Info   ] Script started at 08:39:11.032
[08:39:11.046][HyperV         ][Info   ] Module loaded at 08:39:11.046
[08:39:11.059][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[08:39:11.059][HyperV         ][Info   ] Destroying Switch DockerNAT...
[08:39:11.546][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[08:39:11.586][HyperV         ][Debug  ] [destroy] took 00:00:00.5616698 to run
[08:39:11.586][Firewall       ][Info   ] Closing ports...
[08:39:12.324][Firewall       ][Info   ] Ports are closed
[08:39:12.324][HyperVGuids    ][Info   ] Removing GUIDs...
[08:39:12.325][HyperVGuids    ][Info   ] GUIDs removed
[08:39:12.325][HyperV         ][Info   ] Create
[08:39:12.326][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[08:39:12.332][HyperV         ][Info   ] Script started at 08:39:12.332
[08:39:12.344][HyperV         ][Info   ] Module loaded at 08:39:12.344
[08:39:12.377][HyperV         ][Info   ] Creating Switch: DockerNAT...
[08:39:13.033][HyperV         ][Info   ] Switch created.
[08:39:13.102][HyperV         ][Info   ] Set IP address on switch
[08:39:13.112][HyperV         ][Info   ] Creating VM MobyLinuxVM...
[08:39:13.595][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[08:39:13.744][HyperV         ][Info   ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx
[08:39:14.073][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[08:39:14.186][HyperV         ][Info   ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso
[08:39:14.904][HyperV         ][Info   ] VM created.
[08:39:14.904][HyperV         ][Debug  ] [create] took 00:00:02.5786894 to run
[08:39:14.904][PowerMode      ][Info   ] Stop
[08:39:14.904][HyperV         ][Info   ] Stop
[08:39:14.904][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[08:39:14.912][HyperV         ][Info   ] Script started at 08:39:14.912
[08:39:14.922][HyperV         ][Info   ] Module loaded at 08:39:14.922
[08:39:14.941][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[08:39:14.942][HyperV         ][Debug  ] [stop] took 00:00:00.0379996 to run
[08:39:14.942][OptimizeDisk   ][Info   ] Optimize
[08:39:14.942][PowerShell     ][Info   ] Run script...
[08:39:16.170][Moby           ][Info   ] Stop
[08:39:16.177][HyperV         ][Info   ] Create
[08:39:16.177][HyperVGuids    ][Info   ] Installing GUIDs...
[08:39:16.178][PowerMode      ][Info   ] Start
[08:39:16.178][Firewall       ][Info   ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe...
[08:39:16.178][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[08:39:16.178][HyperVGuids    ][Info   ] GUIDs installed
[08:39:16.199][HyperV         ][Info   ] Script started at 08:39:16.199
[08:39:16.213][HyperV         ][Info   ] Module loaded at 08:39:16.213
[08:39:16.325][HyperV         ][Info   ] Using existing Switch: DockerNAT
[08:39:16.361][HyperV         ][Info   ] Using existing Switch IP address
[08:39:16.378][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[08:39:16.465][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[08:39:16.781][HyperV         ][Info   ] VM created.
[08:39:16.782][HyperV         ][Debug  ] [create] took 00:00:00.6049906 to run
[08:39:16.782][PowerShell     ][Info   ] Run script '(Get-VM MobyLinuxVM).Id.Guid'...
[08:39:16.801][DataKit        ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.db.exe --url hyperv-connect://935720df-c09a-4bef-a0bf-0f83bb77f7e6,\\.\pipe\dockerDataBase --color never
[08:39:16.803][DataKit        ][Info   ] Started
[08:39:16.827][DataKit        ][Info   ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...
[08:39:16.828][DataKit        ][Error  ] com.docker.db.exe: Failed to set up server socket listening on hyperv-connect://935720df-c09a-4bef-a0bf-0f83bb77f7e6: Unix.Unix_error(Unix.ENETDOWN, "socket", "")
[08:39:16.828][DataKit        ][Info   ] com.docker.db.exe: internal error, uncaught exception:
[08:39:16.828][DataKit        ][Info   ]                    (Failure accept_forever)
[08:39:16.828][DataKit        ][Info   ]                    
[08:39:16.832][Database       ][Info   ] Generating CA Cert Bundle
[08:39:16.832][DataKit        ][Error  ] Process died
[08:39:16.850][Database       ][Info   ] CA Cert Bundle Generated
[08:39:17.085][Firewall       ][Info   ] Ports are opened
[08:39:21.808][PowerMode      ][Info   ] Stop
[08:39:21.808][HyperV         ][Info   ] Stop
[08:39:21.808][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[08:39:21.814][HyperV         ][Info   ] Script started at 08:39:21.814
[08:39:21.827][HyperV         ][Info   ] Module loaded at 08:39:21.827
[08:39:21.851][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[08:39:21.851][HyperV         ][Debug  ] [stop] took 00:00:00.0425625 to run
[08:39:21.851][OptimizeDisk   ][Info   ] Optimize
[08:39:21.851][PowerShell     ][Info   ] Run script...
[08:39:23.109][Moby           ][Info   ] Stop
[08:39:23.111][HyperV         ][Info   ] Destroy
[08:39:23.112][PowerShell     ][Info   ] Run script with parameters: -Destroy True -KeepVolume True...
[08:39:23.118][HyperV         ][Info   ] Script started at 08:39:23.118
[08:39:23.130][HyperV         ][Info   ] Module loaded at 08:39:23.130
[08:39:23.143][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[08:39:23.144][HyperV         ][Info   ] Destroying Switch DockerNAT...
[08:39:23.606][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[08:39:23.643][HyperV         ][Debug  ] [destroy] took 00:00:00.5314648 to run
[08:39:23.643][Firewall       ][Info   ] Closing ports...
[08:39:24.367][Firewall       ][Info   ] Ports are closed
[08:39:24.367][HyperVGuids    ][Info   ] Removing GUIDs...
[08:39:24.367][HyperVGuids    ][Info   ] GUIDs removed
[08:39:24.372][NamedPipeClient][Error  ] Unable to send Start: The operation has timed out.
[08:39:24.369][NamedPipeServer][Error  ] Unable to execute Start: The operation has timed out.    at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings)
   at Docker.Backend.ContainerEngine.Linux.Start(Settings settings)
   at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.<Register>b__0(Object[] parameters)
   at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)
[08:39:24.376][SegmentApi     ][Info   ] Usage statistic: actionSettingsChanged
[08:39:24.382][Notifications  ][Info   ] Docker is running
[08:39:24.386][Notifications  ][Error  ] The operation has timed out.

Steps to reproduce the behavior

  1. Start docker and switch to Linux container
friism commented 7 years ago

Virtualization is required for Docker for Windows to work with Linux containers. Nested virtualization is not available in Azure VMs, so this won't work.

https://docs.docker.com/docker-for-windows/troubleshoot/#virtualization-must-be-enabled

docker-robott commented 4 years ago

Closed issues are locked after 30 days of inactivity. This helps our team focus on active issues.

If you have found a problem that seems similar to this, please open a new issue.

Send feedback to Docker Community Slack channels #docker-for-mac or #docker-for-windows. /lifecycle locked