docker / for-win

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

Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries #54

Closed cuikangyi closed 8 years ago

cuikangyi commented 8 years ago

[20:58:41.979][DockerService ][Info ] Version: 1.12.0-stable [20:58:41.987][DockerService ][Info ] Starting on: 8/23/2016 8:58:41 PM [20:58:41.995][DockerService ][Info ] Sha1: 9cd1dc28d3ac81cb5177ff9728f65200304b36f6 [20:58:42.579][BackendServer ][Info ] Started [20:58:44.013][NamedPipeServer][Info ] Version() [20:58:44.019][NamedPipeServer][Info ] Version done. [20:58:44.723][NamedPipeServer][Info ] Stop() [20:58:44.731][HyperV ][Info ] Stop [20:58:44.751][PowerShell ][Info ] Run script with parameters: -Stop True... [20:58:48.989][HyperV ][Info ] VM MobyLinuxVM is stopped [20:58:49.007][NamedPipeServer][Info ] Stop done. [20:58:49.033][NamedPipeServer][Info ] Start(Docker.Core.Settings) [20:58:49.047][HyperVGuids ][Info ] Installing GUIDs... [20:58:49.057][HyperVGuids ][Info ] GUIDs installed [20:58:49.068][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [20:58:50.680][Firewall ][Info ] Ports are opened [20:58:50.692][HyperV ][Info ] Create [20:58:50.702][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [20:58:51.162][HyperV ][Info ] Using existing Switch: DockerNAT [20:58:52.215][HyperV ][Info ] Using existing Switch IP address [20:58:53.545][HyperV ][Info ] Using existing: MobyLinuxVM [20:58:53.885][HyperV ][Info ] Setting MobyLinuxVM vm CPUs to 2 and Memory to 2048 MB [20:58:53.896][DataKit ][Info ] Starting... [20:58:53.906][PowerShell ][Info ] Run script... [20:58:53.987][DataKit ][Info ] Started [20:58:53.998][VpnKit ][Info ] Starting... [20:58:54.010][PowerShell ][Info ] Run script... [20:58:54.038][DataKit ][Info ] [20:58:54.046][DataKit ][Info ] +11649us Datakit Starting com.docker.db.exe 16bb469 ... [20:58:55.074][VpnKit ][Info ] Started [20:58:55.093][ApiProxy ][Info ] Starting... [20:58:55.105][PowerShell ][Info ] Run script... [20:58:56.013][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [20:58:56.028][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [20:58:56.034][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [20:58:56.042][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://09a8824a-e88e-4bb4-aa91-ee60054eb72a max_connections:None vsock_path: [20:58:56.049][VpnKit ][Info ] com.docker.slirp.exe: connecting to 09a8824a-e88e-4bb4-aa91-ee60054eb72a:0B95756A-9985-48AD-9470-78E060895BE7 [20:58:56.057][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://09a8824a-e88e-4bb4-aa91-ee60054eb72a [20:58:56.064][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [20:58:56.071][VpnKit ][Info ] com.docker.slirp.exe: connecting to 09a8824a-e88e-4bb4-aa91-ee60054eb72a:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [20:58:56.079][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://09a8824a-e88e-4bb4-aa91-ee60054eb72a [20:58:57.059][ApiProxy ][Info ] Started [20:58:57.073][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/exclude [20:58:57.081][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/http [20:58:57.087][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/https [20:58:57.135][ApiProxy ][Info ] docker proxy (on deprecated port): ready [20:58:57.146][ApiProxy ][Info ] dns server: ready [20:58:57.154][ApiProxy ][Info ] docker proxy: ready [20:58:57.325][DataKit ][Info ] [20:58:57.332][DataKit ][Info ] +3299821us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [20:58:59.012][Database ][Info ] Successfully removed 3 value(s) [20:58:59.028][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [20:58:59.034][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [20:58:59.042][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [20:58:59.050][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [20:58:59.057][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [20:58:59.064][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [20:58:59.074][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [20:58:59.082][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [20:58:59.088][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [20:59:00.223][DataKit ][Info ] [20:59:00.223][Database ][Info ] Successfully wrote 9 value(s) [20:59:00.231][DataKit ][Info ] +6198121us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [20:59:00.238][HyperV ][Info ] Start [20:59:00.253][PowerShell ][Info ] Run script with parameters: -Start True... [20:59:00.353][HyperV ][Info ] Starting VM MobyLinuxVM... [20:59:01.878][HyperV ][Info ] Wait for the VM to get an IP address [20:59:02.967][HyperV ][Info ] Wait for the VM to get an IP address [20:59:04.006][HyperV ][Info ] Wait for the VM to get an IP address [20:59:05.040][HyperV ][Info ] Wait for the VM to get an IP address [20:59:06.117][HyperV ][Info ] Wait for the VM to get an IP address [20:59:07.806][HyperV ][Info ] Wait for the VM to get an IP address [20:59:08.837][HyperV ][Info ] Wait for the VM to get an IP address [20:59:09.872][HyperV ][Info ] Wait for the VM to get an IP address [20:59:10.912][HyperV ][Info ] Wait for the VM to get an IP address [20:59:11.965][HyperV ][Info ] Wait for the VM to get an IP address [20:59:13.673][HyperV ][Info ] Wait for the VM to get an IP address [20:59:14.716][HyperV ][Info ] Wait for the VM to get an IP address [20:59:15.771][HyperV ][Info ] Wait for the VM to get an IP address [20:59:16.814][HyperV ][Info ] Wait for the VM to get an IP address [20:59:17.867][HyperV ][Info ] Wait for the VM to get an IP address [20:59:19.484][HyperV ][Info ] Wait for the VM to get an IP address [20:59:20.536][HyperV ][Info ] Wait for the VM to get an IP address [20:59:21.581][HyperV ][Info ] Wait for the VM to get an IP address [20:59:22.636][HyperV ][Info ] Wait for the VM to get an IP address [20:59:23.711][HyperV ][Info ] Wait for the VM to get an IP address [20:59:25.278][HyperV ][Info ] Wait for the VM to get an IP address [20:59:26.309][HyperV ][Info ] Wait for the VM to get an IP address [20:59:27.340][HyperV ][Info ] Wait for the VM to get an IP address [20:59:28.392][HyperV ][Info ] Wait for the VM to get an IP address [20:59:29.438][HyperV ][Info ] Wait for the VM to get an IP address [20:59:31.083][HyperV ][Info ] Wait for the VM to get an IP address [20:59:32.132][HyperV ][Info ] Wait for the VM to get an IP address [20:59:33.167][HyperV ][Info ] Wait for the VM to get an IP address [20:59:34.205][HyperV ][Info ] Wait for the VM to get an IP address [20:59:35.262][HyperV ][Info ] Wait for the VM to get an IP address [20:59:36.822][HyperV ][Info ] Wait for the VM to get an IP address [20:59:37.872][HyperV ][Info ] Wait for the VM to get an IP address [20:59:38.905][HyperV ][Info ] Wait for the VM to get an IP address [20:59:39.979][HyperV ][Info ] Wait for the VM to get an IP address [20:59:41.053][HyperV ][Info ] Wait for the VM to get an IP address [20:59:42.658][HyperV ][Info ] Wait for the VM to get an IP address [20:59:43.717][HyperV ][Info ] Wait for the VM to get an IP address [20:59:44.766][HyperV ][Info ] Wait for the VM to get an IP address [20:59:45.827][HyperV ][Info ] Wait for the VM to get an IP address [20:59:46.901][HyperV ][Info ] Wait for the VM to get an IP address [20:59:48.489][HyperV ][Info ] Wait for the VM to get an IP address [20:59:49.552][HyperV ][Info ] Wait for the VM to get an IP address [20:59:50.608][HyperV ][Info ] Wait for the VM to get an IP address [20:59:51.639][HyperV ][Info ] Wait for the VM to get an IP address [20:59:52.706][HyperV ][Info ] Wait for the VM to get an IP address [20:59:54.305][HyperV ][Info ] Wait for the VM to get an IP address [20:59:55.373][HyperV ][Info ] Wait for the VM to get an IP address [20:59:56.430][HyperV ][Info ] Wait for the VM to get an IP address [20:59:57.473][HyperV ][Info ] Wait for the VM to get an IP address [20:59:58.553][HyperV ][Info ] Wait for the VM to get an IP address [21:00:00.120][HyperV ][Info ] Wait for the VM to get an IP address [21:00:01.176][HyperV ][Info ] Wait for the VM to get an IP address [21:00:02.225][HyperV ][Info ] Wait for the VM to get an IP address [21:00:03.273][HyperV ][Info ] Wait for the VM to get an IP address [21:00:04.340][HyperV ][Info ] Wait for the VM to get an IP address [21:00:05.941][HyperV ][Info ] Wait for the VM to get an IP address [21:00:07.007][HyperV ][Info ] Wait for the VM to get an IP address [21:00:08.039][HyperV ][Info ] Wait for the VM to get an IP address [21:00:09.074][HyperV ][Info ] Wait for the VM to get an IP address [21:00:10.159][NamedPipeServer][Error ] Unable to execute Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries 在 System.Management.Automation.Runspaces.AsyncResult.EndInvoke() 在 System.Management.Automation.PowerShell.EndInvoke(IAsyncResult asyncResult) 在 Docker.Core.PowerShell.Run(String script, Dictionary2 parameters, Action1 lineReceived) 在 Docker.Backend.Backend.Start(Settings settings) 在 Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) 在 Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [21:00:10.203][NamedPipeServer][Info ] CheckInstallation() [21:00:10.214][HyperV ][Info ] Check Hyper-V Windows optional feature [21:00:10.225][PowerShell ][Info ] Run script... [21:00:11.644][HyperV ][Info ] Hyper-V Windows feature is enabled [21:00:11.654][NamedPipeServer][Info ] CheckInstallation done. [21:00:11.702][NamedPipeServer][Info ] CheckHyperVState() [21:00:11.714][HyperV ][Info ] Check Hyper-V State [21:00:11.725][PowerShell ][Info ] Run script with parameters: -Check True... [21:00:11.870][HyperV ][Info ] Hyper-V is running [21:00:11.880][NamedPipeServer][Info ] CheckHyperVState done.

rn commented 8 years ago

Hi @cuikangyi. Thanks for the bug report. Could you upload and provide a diagnostic ID for us to take a closer look? Thanks rolf

friism commented 8 years ago

Also see https://github.com/docker/for-win/issues/17

cuikangyi commented 8 years ago

@rneugeba Thanks for your replay. diagnostic ID 99C4A82F-9319-4FEC-84B7-788A8624E363/2016-08-24_07-00-22

and log [06:57:38.273][Program ][Info ] Version: 1.12.0-stable [06:57:38.273][Program ][Info ] Starting on: 8/24/2016 6:57:38 AM [06:57:38.289][Program ][Info ] Resources: C:\Program Files\Docker\Docker\Resources [06:57:38.289][Program ][Info ] OS: Windows 10 Pro [06:57:38.304][Program ][Info ] Edition: Professional [06:57:38.304][Program ][Info ] Id: 1607 [06:57:38.320][Program ][Info ] Build: 14393 [06:57:38.320][Program ][Info ] BuildLabName: 14393.0.amd64fre.rs1_release.160715-1616 [06:57:38.336][Program ][Info ] Sha1: 9cd1dc28d3ac81cb5177ff9728f65200304b36f6 [06:57:38.351][Program ][Info ] You can send feedback, including this log file, at https://github.com/docker/for-win/issues [06:57:39.523][TrackingStatus ][Info ] Crash report and usage statistics are enabled [06:57:39.570][Mixpanel ][Info ] Id: 99C4A82F-9319-4FEC-84B7-788A8624E363 [06:57:39.617][Mixpanel ][Info ] Usage Statistic: appLaunched [06:57:41.551][NamedPipeClient][Info ] Sending Version()... [06:57:41.691][NamedPipeClient][Info ] Received response for Version [06:57:41.703][Mixpanel ][Info ] Usage Statistic: heartbeat [06:57:13.984][BackendServer ][Info ] Started [06:57:41.612][NamedPipeServer][Info ] Version() [06:57:41.627][NamedPipeServer][Info ] Version done. [06:57:43.504][NamedPipeClient][Info ] Sending Stop()... [06:57:43.525][Updater ][Info ] Checking for updates on channel Stable... [06:57:43.532][NamedPipeServer][Info ] Stop() [06:57:43.556][HyperV ][Info ] Stop [06:57:43.619][PowerShell ][Info ] Run script with parameters: -Stop True... [06:57:44.970][Updater ][Info ] Local build 5968 is as good as the remote 5968 on channel Stable [06:57:50.741][HyperV ][Info ] VM MobyLinuxVM is stopped [06:57:50.795][NamedPipeClient][Info ] Received response for Stop [06:57:50.788][NamedPipeServer][Info ] Stop done. [06:57:50.802][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [06:57:50.821][NamedPipeServer][Info ] Start(Docker.Core.Settings) [06:57:50.828][HyperVGuids ][Info ] Installing GUIDs... [06:57:50.838][HyperVGuids ][Info ] GUIDs installed [06:57:50.919][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [06:57:53.251][Firewall ][Info ] Ports are opened [06:57:53.259][HyperV ][Info ] Create [06:57:53.267][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [06:57:53.891][HyperV ][Info ] Using existing Switch: DockerNAT [06:57:55.145][HyperV ][Info ] Using existing Switch IP address [06:57:57.300][HyperV ][Info ] Using existing: MobyLinuxVM [06:57:57.660][HyperV ][Info ] Setting MobyLinuxVM vm CPUs to 2 and Memory to 2048 MB [06:57:57.675][DataKit ][Info ] Starting... [06:57:57.691][PowerShell ][Info ] Run script... [06:57:58.003][DataKit ][Info ] Started [06:57:58.019][VpnKit ][Info ] Starting... [06:57:58.035][PowerShell ][Info ] Run script... [06:57:58.113][DataKit ][Info ] [06:57:58.113][DataKit ][Info ] +11925us Datakit Starting com.docker.db.exe 16bb469 ... [06:57:58.566][VpnKit ][Info ] Started [06:57:58.566][ApiProxy ][Info ] Starting... [06:57:58.582][PowerShell ][Info ] Run script... [06:57:59.254][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [06:57:59.254][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [06:57:59.254][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [06:57:59.269][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://15cedee8-7d59-4a48-9138-439e2190d58a max_connections:None vsock_path: [06:57:59.269][VpnKit ][Info ] com.docker.slirp.exe: connecting to 15cedee8-7d59-4a48-9138-439e2190d58a:0B95756A-9985-48AD-9470-78E060895BE7 [06:57:59.285][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://15cedee8-7d59-4a48-9138-439e2190d58a [06:57:59.285][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [06:57:59.300][VpnKit ][Info ] com.docker.slirp.exe: connecting to 15cedee8-7d59-4a48-9138-439e2190d58a:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [06:57:59.300][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://15cedee8-7d59-4a48-9138-439e2190d58a [06:58:00.457][ApiProxy ][Info ] Started [06:58:00.488][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/exclude [06:58:00.503][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/http [06:58:00.503][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/https [06:58:00.550][ApiProxy ][Info ] docker proxy (on deprecated port): ready [06:58:00.589][ApiProxy ][Info ] dns server: ready [06:58:00.600][ApiProxy ][Info ] docker proxy: ready [06:58:00.918][DataKit ][Info ] [06:58:00.925][DataKit ][Info ] +2819025us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [06:58:02.750][Database ][Info ] Successfully removed 3 value(s) [06:58:02.759][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [06:58:02.766][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [06:58:02.773][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [06:58:02.780][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [06:58:02.787][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [06:58:02.794][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [06:58:02.800][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [06:58:02.807][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [06:58:02.813][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [06:58:03.971][DataKit ][Info ] [06:58:03.973][Database ][Info ] Successfully wrote 9 value(s) [06:58:03.979][DataKit ][Info ] +5873052us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [06:58:03.987][HyperV ][Info ] Start [06:58:04.001][PowerShell ][Info ] Run script with parameters: -Start True... [06:58:04.113][HyperV ][Info ] Starting VM MobyLinuxVM... [06:58:05.857][HyperV ][Info ] Wait for the VM to get an IP address [06:58:06.949][HyperV ][Info ] Wait for the VM to get an IP address [06:58:07.999][HyperV ][Info ] Wait for the VM to get an IP address [06:58:09.038][HyperV ][Info ] Wait for the VM to get an IP address [06:58:10.103][HyperV ][Info ] Wait for the VM to get an IP address [06:58:11.734][HyperV ][Info ] Wait for the VM to get an IP address [06:58:12.770][HyperV ][Info ] Wait for the VM to get an IP address [06:58:13.812][HyperV ][Info ] Wait for the VM to get an IP address [06:58:14.852][HyperV ][Info ] Wait for the VM to get an IP address [06:58:15.905][HyperV ][Info ] Wait for the VM to get an IP address [06:58:17.719][HyperV ][Info ] Wait for the VM to get an IP address [06:58:18.753][HyperV ][Info ] Wait for the VM to get an IP address [06:58:19.786][HyperV ][Info ] Wait for the VM to get an IP address [06:58:20.820][HyperV ][Info ] Wait for the VM to get an IP address [06:58:21.870][HyperV ][Info ] Wait for the VM to get an IP address [06:58:23.679][HyperV ][Info ] Wait for the VM to get an IP address [06:58:24.725][HyperV ][Info ] Wait for the VM to get an IP address [06:58:25.769][HyperV ][Info ] Wait for the VM to get an IP address [06:58:26.822][HyperV ][Info ] Wait for the VM to get an IP address [06:58:27.873][HyperV ][Info ] Wait for the VM to get an IP address [06:58:29.460][HyperV ][Info ] Wait for the VM to get an IP address [06:58:30.494][HyperV ][Info ] Wait for the VM to get an IP address [06:58:31.531][HyperV ][Info ] Wait for the VM to get an IP address [06:58:32.566][HyperV ][Info ] Wait for the VM to get an IP address [06:58:33.629][HyperV ][Info ] Wait for the VM to get an IP address [06:58:35.327][HyperV ][Info ] Wait for the VM to get an IP address [06:58:36.360][HyperV ][Info ] Wait for the VM to get an IP address [06:58:37.396][HyperV ][Info ] Wait for the VM to get an IP address [06:58:38.432][HyperV ][Info ] Wait for the VM to get an IP address [06:58:39.483][HyperV ][Info ] Wait for the VM to get an IP address [06:58:41.138][HyperV ][Info ] Wait for the VM to get an IP address [06:58:42.197][HyperV ][Info ] Wait for the VM to get an IP address [06:58:43.238][HyperV ][Info ] Wait for the VM to get an IP address [06:58:44.278][HyperV ][Info ] Wait for the VM to get an IP address [06:58:45.357][HyperV ][Info ] Wait for the VM to get an IP address [06:58:47.087][HyperV ][Info ] Wait for the VM to get an IP address [06:58:48.126][HyperV ][Info ] Wait for the VM to get an IP address [06:58:49.171][HyperV ][Info ] Wait for the VM to get an IP address [06:58:50.210][HyperV ][Info ] Wait for the VM to get an IP address [06:58:51.282][HyperV ][Info ] Wait for the VM to get an IP address [06:58:53.064][HyperV ][Info ] Wait for the VM to get an IP address [06:58:54.121][HyperV ][Info ] Wait for the VM to get an IP address [06:58:55.158][HyperV ][Info ] Wait for the VM to get an IP address [06:58:56.202][HyperV ][Info ] Wait for the VM to get an IP address [06:58:57.258][HyperV ][Info ] Wait for the VM to get an IP address [06:58:58.998][HyperV ][Info ] Wait for the VM to get an IP address [06:59:00.061][HyperV ][Info ] Wait for the VM to get an IP address [06:59:01.111][HyperV ][Info ] Wait for the VM to get an IP address [06:59:02.167][HyperV ][Info ] Wait for the VM to get an IP address [06:59:03.226][HyperV ][Info ] Wait for the VM to get an IP address [06:59:04.931][HyperV ][Info ] Wait for the VM to get an IP address [06:59:05.989][HyperV ][Info ] Wait for the VM to get an IP address [06:59:07.045][HyperV ][Info ] Wait for the VM to get an IP address [06:59:08.087][HyperV ][Info ] Wait for the VM to get an IP address [06:59:09.146][HyperV ][Info ] Wait for the VM to get an IP address [06:59:10.854][HyperV ][Info ] Wait for the VM to get an IP address [06:59:11.890][HyperV ][Info ] Wait for the VM to get an IP address [06:59:12.921][HyperV ][Info ] Wait for the VM to get an IP address [06:59:13.958][HyperV ][Info ] Wait for the VM to get an IP address [06:59:15.095][NamedPipeServer][Error ] Unable to execute Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries 在 System.Management.Automation.Runspaces.AsyncResult.EndInvoke() 在 System.Management.Automation.PowerShell.EndInvoke(IAsyncResult asyncResult) 在 Docker.Core.PowerShell.Run(String script, Dictionary2 parameters, Action1 lineReceived) 在 Docker.Backend.Backend.Start(Settings settings) 在 Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) 在 Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [06:59:15.139][NamedPipeClient][Error ] Unable to send Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries [06:59:15.153][NamedPipeClient][Info ] Sending CheckInstallation()... [06:59:15.168][NamedPipeServer][Info ] CheckInstallation() [06:59:15.184][HyperV ][Info ] Check Hyper-V Windows optional feature [06:59:15.195][PowerShell ][Info ] Run script... [06:59:17.322][HyperV ][Info ] Hyper-V Windows feature is enabled [06:59:17.333][NamedPipeServer][Info ] CheckInstallation done. [06:59:17.363][NamedPipeClient][Info ] Received response for CheckInstallation [06:59:17.398][NamedPipeClient][Info ] Sending CheckHyperVState()... [06:59:17.416][NamedPipeServer][Info ] CheckHyperVState() [06:59:17.435][HyperV ][Info ] Check Hyper-V State [06:59:17.450][PowerShell ][Info ] Run script with parameters: -Check True... [06:59:18.343][HyperV ][Info ] Hyper-V is running [06:59:18.364][NamedPipeClient][Info ] Received response for CheckHyperVState [06:59:18.353][NamedPipeServer][Info ] CheckHyperVState done. [06:59:18.378][Notifications ][Error ] Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries [06:59:50.683][FeedbackSettings][Info ] Open logs [06:59:56.093][FeedbackSettings][Info ] Upload diagnostic [06:59:56.105][NamedPipeClient][Info ] Sending GetDebugInfo()... [06:59:56.115][NamedPipeServer][Info ] GetDebugInfo() [07:00:16.648][NamedPipeServer][Info ] GetDebugInfo done. [07:00:16.667][NamedPipeClient][Info ] Received response for GetDebugInfo [07:00:16.757][Program ][Info ] Sending Bugsnag report 3af2f647-b500-4560-829c-d11685e82718... [07:00:22.702][Program ][Info ] Bugsnag report 3af2f647-b500-4560-829c-d11685e82718 sent [07:00:22.763][NamedPipeClient][Info ] Sending DownloadVmLogs()... [07:00:22.775][NamedPipeServer][Info ] DownloadVmLogs() [07:00:22.788][PowerShell ][Info ] Run script... [07:00:25.511][FeedbackSettings][Info ] Open logs [07:00:53.091][HyperV ][Warning] Unable to download logs: 2016/08/24 07:00:53 Failed to Dial 15cedee8-7d59-4a48-9138-439e2190d58a 445ba2cb-e69b-4912-8b42-d7f494d007ea : A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.

[07:00:53.112][NamedPipeClient][Info ] Received response for DownloadVmLogs [07:00:53.104][NamedPipeServer][Info ] DownloadVmLogs done. [07:02:26.088][FeedbackSettings][Info ] Open logs

tonercart commented 8 years ago

I have the same issue.

Diagnostic loaded E29FCE66-DA9C-40C9-85CC-AD63831ADA03/2016-08-25_10-23-51

sstodd7532 commented 8 years ago

Would really like to see this get resolved. I have been getting this for a few days and have not been able to get it working after a few reinstalls. Its also on 2 different computers I use.

A diagnostic was uploaded with id: 25FF9A46-6991-4935-885B-AE50E0FB18AC/2016-08-28_13-10-19

[18:20:27.179][NamedPipeClient][Error ] Unable to send Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries [18:20:27.186][NamedPipeClient][Info ] Sending CheckInstallation()... [18:20:27.193][NamedPipeServer][Info ] CheckInstallation() [18:20:27.199][HyperV ][Info ] Check Hyper-V Windows optional feature [18:20:27.204][PowerShell ][Info ] Run script... [18:21:07.460][HyperV ][Info ] Hyper-V Windows feature is enabled [18:21:08.205][NamedPipeClient][Info ] Received response for CheckInstallation [18:21:08.169][NamedPipeServer][Info ] CheckInstallation done. [18:21:08.245][NamedPipeClient][Info ] Sending CheckHyperVState()... [18:21:08.587][NamedPipeServer][Info ] CheckHyperVState() [18:21:08.636][HyperV ][Info ] Check Hyper-V State [18:21:08.735][PowerShell ][Info ] Run script with parameters: -Check True... [18:21:09.371][HyperV ][Info ] Hyper-V is running [18:21:09.421][NamedPipeClient][Info ] Received response for CheckHyperVState [18:21:09.427][Notifications ][Error ] Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries [18:21:09.415][NamedPipeServer][Info ] CheckHyperVState done. [11:25:55.312][Mixpanel ][Info ] Usage Statistic: heartbeat [11:25:55.371][Mixpanel ][Info ] Failed to upload an event and will retry later [12:06:33.036][Notifications ][Info ] Docker is restarting... [12:06:33.118][NamedPipeClient][Info ] Sending Stop()... [12:06:33.125][NamedPipeServer][Info ] Stop() [12:06:33.130][HyperV ][Info ] Stop [12:06:33.135][PowerShell ][Info ] Run script with parameters: -Stop True... [12:06:34.196][HyperV ][Info ] Stopping VM MobyLinuxVM... [12:06:57.354][HyperV ][Info ] Kill VM MobyLinuxVM process... [12:06:58.560][HyperV ][Info ] Kill VM MobyLinuxVM process... [12:06:59.582][HyperV ][Info ] VM MobyLinuxVM is stopped [12:06:59.594][ApiProxy ][Info ] Killing existing com.docker.proxy with PID 8992 [12:06:59.603][VpnKit ][Info ] Killing existing com.docker.slirp with PID 9228 [12:06:59.612][DataKit ][Info ] Killing existing com.docker.db with PID 9976 [12:06:59.626][NamedPipeClient][Info ] Received response for Stop [12:06:59.632][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [12:06:59.618][NamedPipeServer][Info ] Stop done. [12:06:59.646][NamedPipeServer][Info ] Start(Docker.Core.Settings) [12:06:59.651][HyperVGuids ][Info ] Installing GUIDs... [12:06:59.655][HyperVGuids ][Info ] GUIDs installed [12:06:59.660][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [12:07:01.324][Firewall ][Info ] Ports are opened [12:07:01.330][HyperV ][Info ] Create [12:07:01.336][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [12:07:01.739][HyperV ][Info ] Using existing Switch: DockerNAT [12:07:02.107][HyperV ][Info ] Using existing Switch IP address [12:07:03.365][HyperV ][Info ] Using existing: MobyLinuxVM [12:07:03.681][HyperV ][Info ] Setting MobyLinuxVM vm CPUs to 2 and Memory to 2048 MB [12:07:03.690][DataKit ][Info ] Starting... [12:07:03.695][PowerShell ][Info ] Run script... [12:07:03.721][DataKit ][Info ] Started [12:07:03.732][VpnKit ][Info ] Starting... [12:07:03.737][PowerShell ][Info ] Run script... [12:07:03.751][DataKit ][Info ] [12:07:03.758][DataKit ][Info ] +6340us Datakit Starting com.docker.db.exe 16bb469 ... [12:07:03.763][VpnKit ][Info ] Started [12:07:03.771][ApiProxy ][Info ] Starting... [12:07:03.776][PowerShell ][Info ] Run script... [12:07:03.794][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [12:07:03.801][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [12:07:03.807][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [12:07:03.812][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://e2ed945c-1804-46c4-84b5-73195a72963e max_connections:None vsock_path: [12:07:03.817][VpnKit ][Info ] com.docker.slirp.exe: connecting to e2ed945c-1804-46c4-84b5-73195a72963e:0B95756A-9985-48AD-9470-78E060895BE7 [12:07:03.822][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://e2ed945c-1804-46c4-84b5-73195a72963e [12:07:03.828][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [12:07:03.833][VpnKit ][Info ] com.docker.slirp.exe: connecting to e2ed945c-1804-46c4-84b5-73195a72963e:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [12:07:03.838][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://e2ed945c-1804-46c4-84b5-73195a72963e [12:07:03.808][ApiProxy ][Info ] Started [12:07:03.847][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/exclude [12:07:03.851][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/http [12:07:03.855][Database ][Info ] Removing com.docker.driver.amd64-linux/proxy/https [12:07:03.854][ApiProxy ][Info ] docker proxy (on deprecated port): ready [12:07:03.865][ApiProxy ][Info ] dns server: ready [12:07:03.870][ApiProxy ][Info ] docker proxy: ready [12:07:04.086][DataKit ][Info ] [12:07:04.090][DataKit ][Info ] +340814us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [12:07:04.087][Database ][Info ] Successfully removed 3 value(s) [12:07:04.100][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [12:07:04.104][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [12:07:04.108][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [12:07:04.112][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [12:07:04.116][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [12:07:04.120][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [12:07:04.124][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [12:07:04.129][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [12:07:04.133][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [12:07:04.973][DataKit ][Info ] [12:07:04.978][DataKit ][Info ] +1228543us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [12:07:04.975][Database ][Info ] Successfully wrote 9 value(s) [12:07:04.988][HyperV ][Info ] Start [12:07:04.992][PowerShell ][Info ] Run script with parameters: -Start True... [12:07:05.058][HyperV ][Info ] Starting VM MobyLinuxVM... [12:07:10.678][HyperV ][Info ] Wait for the VM to get an IP address [12:07:11.697][HyperV ][Info ] Wait for the VM to get an IP address [12:07:12.716][HyperV ][Info ] Wait for the VM to get an IP address [12:07:13.734][HyperV ][Info ] Wait for the VM to get an IP address [12:07:14.754][HyperV ][Info ] Wait for the VM to get an IP address [12:07:16.080][HyperV ][Info ] Wait for the VM to get an IP address [12:07:17.122][HyperV ][Info ] Wait for the VM to get an IP address [12:07:18.167][HyperV ][Info ] Wait for the VM to get an IP address [12:07:19.186][HyperV ][Info ] Wait for the VM to get an IP address [12:07:20.207][HyperV ][Info ] Wait for the VM to get an IP address [12:07:21.526][HyperV ][Info ] Wait for the VM to get an IP address [12:07:22.544][HyperV ][Info ] Wait for the VM to get an IP address [12:07:23.563][HyperV ][Info ] Wait for the VM to get an IP address [12:07:24.588][HyperV ][Info ] Wait for the VM to get an IP address [12:07:25.605][HyperV ][Info ] Wait for the VM to get an IP address [12:07:26.940][HyperV ][Info ] Wait for the VM to get an IP address [12:07:27.959][HyperV ][Info ] Wait for the VM to get an IP address [12:07:28.976][HyperV ][Info ] Wait for the VM to get an IP address [12:07:30.022][HyperV ][Info ] Wait for the VM to get an IP address [12:07:31.042][HyperV ][Info ] Wait for the VM to get an IP address [12:07:32.410][HyperV ][Info ] Wait for the VM to get an IP address [12:07:33.427][HyperV ][Info ] Wait for the VM to get an IP address [12:07:34.448][HyperV ][Info ] Wait for the VM to get an IP address [12:07:35.464][HyperV ][Info ] Wait for the VM to get an IP address [12:07:36.481][HyperV ][Info ] Wait for the VM to get an IP address [12:07:37.816][HyperV ][Info ] Wait for the VM to get an IP address [12:07:38.832][HyperV ][Info ] Wait for the VM to get an IP address [12:07:39.869][HyperV ][Info ] Wait for the VM to get an IP address [12:07:40.888][HyperV ][Info ] Wait for the VM to get an IP address [12:07:41.907][HyperV ][Info ] Wait for the VM to get an IP address [12:07:43.256][HyperV ][Info ] Wait for the VM to get an IP address [12:07:44.274][HyperV ][Info ] Wait for the VM to get an IP address [12:07:45.292][HyperV ][Info ] Wait for the VM to get an IP address [12:07:46.310][HyperV ][Info ] Wait for the VM to get an IP address [12:07:47.328][HyperV ][Info ] Wait for the VM to get an IP address [12:07:48.649][HyperV ][Info ] Wait for the VM to get an IP address [12:07:49.666][HyperV ][Info ] Wait for the VM to get an IP address [12:07:50.684][HyperV ][Info ] Wait for the VM to get an IP address [12:07:51.702][HyperV ][Info ] Wait for the VM to get an IP address [12:07:52.719][HyperV ][Info ] Wait for the VM to get an IP address [12:07:54.025][HyperV ][Info ] Wait for the VM to get an IP address [12:07:55.043][HyperV ][Info ] Wait for the VM to get an IP address [12:07:56.058][HyperV ][Info ] Wait for the VM to get an IP address [12:07:57.085][HyperV ][Info ] Wait for the VM to get an IP address [12:07:58.109][HyperV ][Info ] Wait for the VM to get an IP address [12:07:59.413][HyperV ][Info ] Wait for the VM to get an IP address [12:08:00.431][HyperV ][Info ] Wait for the VM to get an IP address [12:08:01.449][HyperV ][Info ] Wait for the VM to get an IP address [12:08:02.466][HyperV ][Info ] Wait for the VM to get an IP address [12:08:03.484][HyperV ][Info ] Wait for the VM to get an IP address [12:08:04.812][HyperV ][Info ] Wait for the VM to get an IP address [12:08:05.828][HyperV ][Info ] Wait for the VM to get an IP address [12:08:06.845][HyperV ][Info ] Wait for the VM to get an IP address [12:08:07.862][HyperV ][Info ] Wait for the VM to get an IP address [12:08:08.881][HyperV ][Info ] Wait for the VM to get an IP address [12:08:10.202][HyperV ][Info ] Wait for the VM to get an IP address [12:08:11.222][HyperV ][Info ] Wait for the VM to get an IP address [12:08:12.242][HyperV ][Info ] Wait for the VM to get an IP address [12:08:13.264][HyperV ][Info ] Wait for the VM to get an IP address [12:08:14.285][NamedPipeServer][Error ] Unable to execute Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries at System.Management.Automation.Runspaces.AsyncResult.EndInvoke() at System.Management.Automation.PowerShell.EndInvoke(IAsyncResult asyncResult) at Docker.Core.PowerShell.Run(String script, Dictionary2 parameters, Action1 lineReceived) at Docker.Backend.Backend.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [12:08:14.292][NamedPipeClient][Error ] Unable to send Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries [12:08:14.301][Notifications ][Error ] Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries

rn commented 8 years ago

@runner7532 thanks for the report. Could you try the latest beta from https://download.docker.com/win/beta/InstallDocker.msi? It looks like in your case the Linux VM hasn't fully started and we made some omprovements in that area.

sstodd7532 commented 8 years ago

Here is the Diagnostic ID for the beta version that I just installed 6D84E753-2F42-45E0-BE49-D065DFF0E8F1/2016-08-29_22-58-26

If you want the log I will get that as well.

Irieish commented 8 years ago

Seem to be dealing w/ a similar issue, but am experiencing a Fatal error:

Unable to execute Start: Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.LinuxContainersEngine.DoStart(Settings settings) at Docker.Backend.LinuxContainersEngine.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Version: 1.12.1-beta24 + latest Windows 10 update - build 14393 (1607 - KB3176938 8/31/16).

Diagnostic ID - 6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-08-31_20-09-12

Hyper-V Virtual Ethernet Adapter keeps creating "vEthernet (DockerNAT) 2" which Network Connections shows as an "unidentified network" with "no network access".

NetworkInterfaceView shows vEthernet (DockerNAT) 2 as pointing to 10.0.75.1

Hyper-V Manager shows MobyLinuxVM as running, but the Network Adapter it's referencing is DockerNAT - which it lists as having "no communication". Not sure where the original DockerNAT vEthernet adapter is hiding, and causing the creation of vEthernet (DockerNAT) 2"

[19:47:54.364][Program ][Info ] Version: 1.12.1-beta24 [19:47:54.365][Program ][Info ] Starting on: 8/31/2016 7:47:54 PM [19:47:54.365][Program ][Info ] Resources: C:\Program Files\Docker\Docker\Resources [19:47:54.366][Program ][Info ] OS: Windows 10 Pro [19:47:54.366][Program ][Info ] Edition: Professional [19:47:54.366][Program ][Info ] Id: 1607 [19:47:54.367][Program ][Info ] Build: 14393 [19:47:54.367][Program ][Info ] BuildLabName: 14393.103.amd64fre.rs1_release_inmarket.160819-1924 [19:47:54.368][Program ][Info ] Sha1: 7e2d389a5065149cffacbc889658405e3da67b6f [19:47:54.368][Program ][Info ] You can send feedback, including this log file, at https://github.com/docker/for-win/issues [19:47:54.815][TrackingStatus ][Info ] Crash report and usage statistics are enabled [19:47:54.837][Mixpanel ][Info ] Id: 6F013C72-7104-4907-BC8B-D7F1D42EE211 [19:47:54.848][DiskEventStorer][Info ] loaded 0 pending events [19:47:54.867][Mixpanel ][Info ] Usage Statistic: appLaunched [19:47:55.058][NamedPipeClient][Info ] Sending Version()... [19:47:55.062][NamedPipeClient][Info ] Received response for Version [19:47:55.065][Mixpanel ][Info ] Usage Statistic: heartbeat [19:47:28.278][BackendServer ][Info ] Started [19:47:55.061][NamedPipeServer][Info ] Version() [19:47:55.061][NamedPipeServer][Info ] Version done. [19:47:55.328][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [19:47:55.330][NamedPipeServer][Info ] Start(Docker.Core.Settings) [19:47:55.331][Updater ][Info ] Checking for updates on channel Beta... [19:47:55.331][HyperVGuids ][Info ] Installing GUIDs... [19:47:55.338][HyperVGuids ][Info ] GUIDs installed [19:47:55.341][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [19:47:55.465][Updater ][Info ] Local build 6563 is as good as the remote 6563 on channel Beta [19:47:56.162][Firewall ][Info ] Ports are opened [19:47:56.163][HyperV ][Info ] Create [19:47:56.171][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [19:47:59.708][HyperV ][Info ] Using existing Switch: DockerNAT [19:48:00.119][HyperV ][Info ] Using existing Switch IP address [19:48:01.375][HyperV ][Info ] Using existing: MobyLinuxVM (state = Running) [19:48:01.386][DataKit ][Info ] Starting... [19:48:01.388][PowerShell ][Info ] Run script... [19:48:01.535][DataKit ][Info ] Started [19:48:01.537][VpnKit ][Info ] Starting... [19:48:01.540][PowerShell ][Info ] Run script... [19:48:01.575][DataKit ][Info ] [19:48:01.576][DataKit ][Info ] +3673us Datakit Starting com.docker.db.exe 09081b4 ... [19:48:01.838][VpnKit ][Info ] Started [19:48:01.842][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [19:48:01.842][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [19:48:01.842][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [19:48:01.843][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [19:48:01.843][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [19:48:01.843][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [19:48:01.843][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [19:48:01.843][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [19:48:01.844][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [19:48:01.870][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [19:48:01.870][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [19:48:01.871][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [19:48:01.871][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c max_connections:None vsock_path: [19:48:01.871][VpnKit ][Info ] com.docker.slirp.exe: connecting to 6f28e6f1-cb92-4c87-89df-15a3fbe5042c:0B95756A-9985-48AD-9470-78E060895BE7 [19:48:01.871][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c [19:48:01.872][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [19:48:01.872][VpnKit ][Info ] com.docker.slirp.exe: connecting to 6f28e6f1-cb92-4c87-89df-15a3fbe5042c:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [19:48:01.872][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c [19:48:03.150][DataKit ][Info ] [19:48:03.150][DataKit ][Info ] +1580133us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [19:48:03.154][Database ][Info ] Successfully wrote 9 value(s) [19:48:03.155][HyperV ][Info ] Start [19:48:03.155][PowerShell ][Info ] Run script with parameters: -Start True... [19:48:03.184][HyperV ][Info ] Starting VM MobyLinuxVM... [19:48:03.362][HyperV ][Info ] Wait for the VM to get an IP address [19:48:04.376][HyperV ][Info ] Wait for the VM to get an IP address [19:48:05.388][HyperV ][Info ] Wait for the VM to get an IP address [19:48:06.406][HyperV ][Info ] Wait for the VM to get an IP address [19:48:07.417][HyperV ][Info ] Wait for the VM to get an IP address [19:48:08.564][HyperV ][Info ] Wait for the VM to get an IP address [19:48:09.576][HyperV ][Info ] Wait for the VM to get an IP address [19:48:10.589][HyperV ][Info ] Wait for the VM to get an IP address [19:48:11.606][HyperV ][Info ] Wait for the VM to get an IP address [19:48:12.618][HyperV ][Info ] Wait for the VM to get an IP address [19:48:13.747][HyperV ][Info ] Wait for the VM to get an IP address [19:48:14.758][HyperV ][Info ] Wait for the VM to get an IP address [19:48:15.770][HyperV ][Info ] Wait for the VM to get an IP address [19:48:16.788][HyperV ][Info ] Wait for the VM to get an IP address [19:48:17.800][HyperV ][Info ] Wait for the VM to get an IP address [19:48:18.935][HyperV ][Info ] Wait for the VM to get an IP address [19:48:19.946][HyperV ][Info ] Wait for the VM to get an IP address [19:48:20.957][HyperV ][Info ] Wait for the VM to get an IP address [19:48:21.974][HyperV ][Info ] Wait for the VM to get an IP address [19:48:22.986][HyperV ][Info ] Wait for the VM to get an IP address [19:48:24.118][HyperV ][Info ] Wait for the VM to get an IP address [19:48:25.130][HyperV ][Info ] Wait for the VM to get an IP address [19:48:26.143][HyperV ][Info ] Wait for the VM to get an IP address [19:48:27.159][HyperV ][Info ] Wait for the VM to get an IP address [19:48:28.171][HyperV ][Info ] Wait for the VM to get an IP address [19:48:29.308][HyperV ][Info ] Wait for the VM to get an IP address [19:48:30.319][HyperV ][Info ] Wait for the VM to get an IP address [19:48:31.331][HyperV ][Info ] Wait for the VM to get an IP address [19:48:32.348][HyperV ][Info ] Wait for the VM to get an IP address [19:48:33.359][HyperV ][Info ] Wait for the VM to get an IP address [19:48:34.486][HyperV ][Info ] Wait for the VM to get an IP address [19:48:35.497][HyperV ][Info ] Wait for the VM to get an IP address [19:48:36.509][HyperV ][Info ] Wait for the VM to get an IP address [19:48:37.527][HyperV ][Info ] Wait for the VM to get an IP address [19:48:38.539][HyperV ][Info ] Wait for the VM to get an IP address [19:48:39.667][HyperV ][Info ] Wait for the VM to get an IP address [19:48:40.677][HyperV ][Info ] Wait for the VM to get an IP address [19:48:41.689][HyperV ][Info ] Wait for the VM to get an IP address [19:48:42.706][HyperV ][Info ] Wait for the VM to get an IP address [19:48:43.718][HyperV ][Info ] Wait for the VM to get an IP address [19:48:44.844][HyperV ][Info ] Wait for the VM to get an IP address [19:48:45.855][HyperV ][Info ] Wait for the VM to get an IP address [19:48:46.868][HyperV ][Info ] Wait for the VM to get an IP address [19:48:47.885][HyperV ][Info ] Wait for the VM to get an IP address [19:48:48.897][HyperV ][Info ] Wait for the VM to get an IP address [19:48:50.024][HyperV ][Info ] Wait for the VM to get an IP address [19:48:51.051][HyperV ][Info ] Wait for the VM to get an IP address [19:48:52.077][HyperV ][Info ] Wait for the VM to get an IP address [19:48:53.115][HyperV ][Info ] Wait for the VM to get an IP address [19:48:54.128][HyperV ][Info ] Wait for the VM to get an IP address [19:48:55.293][HyperV ][Info ] Wait for the VM to get an IP address [19:48:56.308][HyperV ][Info ] Wait for the VM to get an IP address [19:48:57.334][HyperV ][Info ] Wait for the VM to get an IP address [19:48:58.371][HyperV ][Info ] Wait for the VM to get an IP address [19:48:59.397][HyperV ][Info ] Wait for the VM to get an IP address [19:49:00.549][HyperV ][Info ] Wait for the VM to get an IP address [19:49:01.579][HyperV ][Info ] Wait for the VM to get an IP address [19:49:02.592][HyperV ][Info ] Wait for the VM to get an IP address [19:49:03.634][HyperV ][Info ] Wait for the VM to get an IP address [19:49:05.537][HyperV ][Info ] Hyper-V is running [19:49:05.537][HyperV ][Info ] Create [19:49:05.537][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [19:49:05.812][HyperV ][Info ] Using existing Switch: DockerNAT [19:49:05.938][HyperV ][Info ] Using existing Switch IP address [19:49:05.957][HyperV ][Info ] Using existing: MobyLinuxVM (state = Running) [19:49:05.957][HyperV ][Info ] Stop [19:49:05.958][PowerShell ][Info ] Run script with parameters: -Stop True... [19:49:05.998][HyperV ][Info ] Stopping VM MobyLinuxVM... [19:49:09.030][HyperV ][Info ] Turn Off VM ... [19:49:09.081][HyperV ][Info ] Kill VM MobyLinuxVM process... [19:49:10.101][HyperV ][Info ] Kill VM MobyLinuxVM process... [19:49:11.116][HyperV ][Info ] VM MobyLinuxVM killed. Waiting for state to change [19:49:11.127][HyperV ][Info ] Killed VM MobyLinuxVM is off [19:49:11.137][VpnKit ][Info ] Killing existing com.docker.slirp with PID 11064 [19:49:11.142][DataKit ][Info ] Killing existing com.docker.db with PID 11188 [19:49:11.144][HyperVGuids ][Info ] Installing GUIDs... [19:49:11.145][HyperVGuids ][Info ] GUIDs installed [19:49:11.145][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [19:49:11.872][Firewall ][Info ] Ports are opened [19:49:11.873][HyperV ][Info ] Create [19:49:11.873][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [19:49:12.088][HyperV ][Info ] Using existing Switch: DockerNAT [19:49:12.128][HyperV ][Info ] Using existing Switch IP address [19:49:12.139][HyperV ][Info ] Using existing: MobyLinuxVM (state = Off) [19:49:12.195][HyperV ][Info ] Setting MobyLinuxVM vm CPUs to 2 and Memory to 2048 MB [19:49:12.196][DataKit ][Info ] Starting... [19:49:12.197][PowerShell ][Info ] Run script... [19:49:12.286][DataKit ][Info ] Started [19:49:12.288][VpnKit ][Info ] Starting... [19:49:12.288][PowerShell ][Info ] Run script... [19:49:12.308][DataKit ][Info ] [19:49:12.309][DataKit ][Info ] +4464us Datakit Starting com.docker.db.exe 09081b4 ... [19:49:12.391][VpnKit ][Info ] Started [19:49:12.391][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [19:49:12.391][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [19:49:12.392][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [19:49:12.392][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [19:49:12.392][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [19:49:12.392][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [19:49:12.393][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [19:49:12.393][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [19:49:12.393][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [19:49:12.416][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [19:49:12.416][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [19:49:12.416][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [19:49:12.417][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c max_connections:None vsock_path: [19:49:12.417][VpnKit ][Info ] com.docker.slirp.exe: connecting to 6f28e6f1-cb92-4c87-89df-15a3fbe5042c:0B95756A-9985-48AD-9470-78E060895BE7 [19:49:12.417][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c [19:49:12.417][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [19:49:12.418][VpnKit ][Info ] com.docker.slirp.exe: connecting to 6f28e6f1-cb92-4c87-89df-15a3fbe5042c:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [19:49:12.418][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://6f28e6f1-cb92-4c87-89df-15a3fbe5042c [19:49:13.524][DataKit ][Info ] [19:49:13.524][DataKit ][Info ] +1219881us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [19:49:13.524][Database ][Info ] Successfully wrote 9 value(s) [19:49:13.526][HyperV ][Info ] Start [19:49:13.527][PowerShell ][Info ] Run script with parameters: -Start True... [19:49:13.566][HyperV ][Info ] Starting VM MobyLinuxVM... [19:49:14.009][HyperV ][Info ] Wait for the VM to get an IP address [19:49:15.026][HyperV ][Info ] Wait for the VM to get an IP address [19:49:16.039][HyperV ][Info ] Wait for the VM to get an IP address [19:49:17.066][HyperV ][Info ] Wait for the VM to get an IP address [19:49:18.091][HyperV ][Info ] Wait for the VM to get an IP address [19:49:19.348][HyperV ][Info ] Wait for the VM to get an IP address [19:49:20.365][HyperV ][Info ] Wait for the VM to get an IP address [19:49:21.377][HyperV ][Info ] Wait for the VM to get an IP address [19:49:22.388][HyperV ][Info ] Wait for the VM to get an IP address [19:49:23.404][HyperV ][Info ] Wait for the VM to get an IP address [19:49:24.609][HyperV ][Info ] Wait for the VM to get an IP address [19:49:25.626][HyperV ][Info ] Wait for the VM to get an IP address [19:49:26.638][HyperV ][Info ] Wait for the VM to get an IP address [19:49:27.651][HyperV ][Info ] Wait for the VM to get an IP address [19:49:28.663][HyperV ][Info ] Wait for the VM to get an IP address [19:49:29.876][HyperV ][Info ] Wait for the VM to get an IP address [19:49:30.900][HyperV ][Info ] Wait for the VM to get an IP address [19:49:31.913][HyperV ][Info ] Wait for the VM to get an IP address [19:49:32.935][HyperV ][Info ] Wait for the VM to get an IP address [19:49:33.948][HyperV ][Info ] Wait for the VM to get an IP address [19:49:35.156][HyperV ][Info ] Wait for the VM to get an IP address [19:49:36.180][HyperV ][Info ] Wait for the VM to get an IP address [19:49:37.207][HyperV ][Info ] Wait for the VM to get an IP address [19:49:38.230][HyperV ][Info ] Wait for the VM to get an IP address [19:49:39.256][HyperV ][Info ] Wait for the VM to get an IP address [19:49:40.490][HyperV ][Info ] Wait for the VM to get an IP address [19:49:41.526][HyperV ][Info ] Wait for the VM to get an IP address [19:49:42.552][HyperV ][Info ] Wait for the VM to get an IP address [19:49:43.577][HyperV ][Info ] Wait for the VM to get an IP address [19:49:44.597][HyperV ][Info ] Wait for the VM to get an IP address [19:49:45.812][HyperV ][Info ] Wait for the VM to get an IP address [19:49:46.829][HyperV ][Info ] Wait for the VM to get an IP address [19:49:47.856][HyperV ][Info ] Wait for the VM to get an IP address [19:49:48.881][HyperV ][Info ] Wait for the VM to get an IP address [19:49:49.906][HyperV ][Info ] Wait for the VM to get an IP address [19:49:51.118][HyperV ][Info ] Wait for the VM to get an IP address [19:49:52.138][HyperV ][Info ] Wait for the VM to get an IP address [19:49:53.165][HyperV ][Info ] Wait for the VM to get an IP address [19:49:54.190][HyperV ][Info ] Wait for the VM to get an IP address [19:49:55.201][HyperV ][Info ] Wait for the VM to get an IP address [19:49:56.407][HyperV ][Info ] Wait for the VM to get an IP address [19:49:57.448][HyperV ][Info ] Wait for the VM to get an IP address [19:49:58.474][HyperV ][Info ] Wait for the VM to get an IP address [19:49:59.485][HyperV ][Info ] Wait for the VM to get an IP address [19:50:00.501][HyperV ][Info ] Wait for the VM to get an IP address [19:50:01.728][HyperV ][Info ] Wait for the VM to get an IP address [19:50:02.763][HyperV ][Info ] Wait for the VM to get an IP address [19:50:03.788][HyperV ][Info ] Wait for the VM to get an IP address [19:50:04.814][HyperV ][Info ] Wait for the VM to get an IP address [19:50:05.834][HyperV ][Info ] Wait for the VM to get an IP address [19:50:07.063][HyperV ][Info ] Wait for the VM to get an IP address [19:50:08.104][HyperV ][Info ] Wait for the VM to get an IP address [19:50:09.130][HyperV ][Info ] Wait for the VM to get an IP address [19:50:10.152][HyperV ][Info ] Wait for the VM to get an IP address [19:50:11.176][HyperV ][Info ] Wait for the VM to get an IP address [19:50:12.405][HyperV ][Info ] Wait for the VM to get an IP address [19:50:13.442][HyperV ][Info ] Wait for the VM to get an IP address [19:50:14.455][HyperV ][Info ] Wait for the VM to get an IP address [19:50:15.479][HyperV ][Info ] Wait for the VM to get an IP address [19:50:16.497][NamedPipeServer][Error ] Unable to execute Start: Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.LinuxContainersEngine.DoStart(Settings settings) at Docker.Backend.LinuxContainersEngine.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [19:50:16.508][NamedPipeClient][Error ] Unable to send Start: Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 [19:50:16.509][Notifications ][Error ] Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 [19:50:16.518][NamedPipeClient][Info ] Sending GetDebugInfo()... [19:50:16.519][NamedPipeServer][Info ] GetDebugInfo() [19:50:28.171][NamedPipeServer][Info ] GetDebugInfo done. [19:50:28.175][NamedPipeClient][Info ] Received response for GetDebugInfo [19:50:28.186][Program ][Info ] Sending Bugsnag report aeaa6317-72cb-499b-bf15-cfb91a7095bc... [19:50:29.150][Program ][Info ] Bugsnag report aeaa6317-72cb-499b-bf15-cfb91a7095bc sent [19:50:29.166][NamedPipeClient][Info ] Sending DownloadVmLogs()... [19:50:29.167][NamedPipeServer][Info ] DownloadVmLogs() [19:50:29.168][PowerShell ][Info ] Run script... [19:50:59.256][HyperV ][Warning] Unable to download logs: 2016/08/31 19:50:59 Failed to Dial 6f28e6f1-cb92-4c87-89df-15a3fbe5042c 445ba2cb-e69b-4912-8b42-d7f494d007ea : A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.

[19:50:59.257][NamedPipeServer][Info ] DownloadVmLogs done. [19:50:59.257][NamedPipeClient][Info ] Received response for DownloadVmLogs [19:51:28.524][ErrorReportWindow][Info ] Open logs

rn commented 8 years ago

Collating the reports from #17 into this issue: This was the report from @maxday: Hi, First, thanks for your work, I've seen a great demo at DevoxxFR and I can't wait to use it :)

I'm running Docker for Windows Version: 1.12.0-beta21 on a WIN10 VM. Hyper-V is activated and Windows services are OK. The MobyLinuxVM is well created but Docker fails to start because it cannot get an IP for the VM.

The DNS server radio button configuration is set to "automatic". I've tried to reboot, reset to factory, uninstall/reinstall, I've also tried to set the a fixed DNS.

Error : Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries at Docker.Core.Pipe.NamedPipeClient.TrySend(String action, Object[] parameters) at Docker.Core.Pipe.NamedPipeClient.Send(String action, Object[] parameters) at Docker.Core.Backend.BackendClient.Start(Settings settings) at Docker.Actions.DoStart(Settings settings, Boolean showWelcomeWindow) at Docker.Core.TaskQueue.<.ctor>b__16_0()

Diagnostic id : 5C73F6A7-06A7-40B5-A2F9-9EF5214B83F2/2016-08-02_09-22-49

rn commented 8 years ago

Collating the reports from #17 into this issue: This was the report from @TaylorBarrick: I have the problem describe above and here is a log file and diagnostic ID

A diagnostic was uploaded with id: F92E5AB4-A9AA-4269-A7D6-8FEB6F6E3D34/2016-08-01_22-30-16 Windows 10.0.14393

[22:26:32.349][ApiProxy ][Info ] dns server: ready [22:26:32.353][ApiProxy ][Info ] docker proxy: ready [22:26:32.356][ApiProxy ][Info ] listen tcp 10.0.75.1:53: bind: The requested address is not valid in its context. [22:26:32.359][ApiProxy ][Info ] listen udp 10.0.75.1:53: bind: The requested address is not valid in its context. [22:26:32.363][ApiProxy ][Info ] Waiting for the port/IP to become available [22:26:32.367][ApiProxy ][Info ] Waiting for the port/IP to become available [22:26:32.551][Database ][Info ] Successfully removed 3 value(s) [22:26:32.555][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [22:26:32.553][DataKit ][Info ] [22:26:32.562][DataKit ][Info ] +524521us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [22:26:32.559][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [22:26:32.570][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [22:26:32.574][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [22:26:32.579][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [22:26:32.583][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [22:26:32.586][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [22:26:32.591][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [22:26:32.595][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [22:26:33.537][Database ][Info ] Successfully wrote 9 value(s) [22:26:33.541][HyperV ][Info ] Start [22:26:33.547][PowerShell ][Info ] Run script with parameters: -Start True... [22:26:33.537][DataKit ][Info ] [22:26:33.561][DataKit ][Info ] +1508337us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [22:26:33.631][HyperV ][Info ] Starting VM MobyLinuxVM... [22:26:34.140][HyperV ][Info ] Wait for the VM to get an IP address [22:26:35.155][HyperV ][Info ] Wait for the VM to get an IP address [22:26:36.174][HyperV ][Info ] Wait for the VM to get an IP address [22:26:37.434][HyperV ][Info ] Wait for the VM to get an IP address ... .. [22:27:37.803][NamedPipeServer][Error ] Unable to execute Start: Failed to start VM "MobyLinuxVM": The VM couldn't get an IP address after 60 tries at System.Management.Automation.Runspaces.AsyncResult.EndInvoke() at System.Management.Automation.PowerShell.EndInvoke(IAsyncResult asyncResult) at Docker.Core.PowerShell.Run(String script, Dictionary2 parameters, Action1 lineReceived) at Docker.Backend.Backend.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

rn commented 8 years ago

Collating the reports from #17 into this issue: This was the report from @kukjevov I have same problem.

It looks like problem of Windows 10 Redstone 1 update (build 14393) with combination of latest stable docker version.

I have enabled windows features like "Containers", "Hyper-V" and "Windows subsystem for linux (beta)". I have restarted computer. I tried to reinstall docker, reset to factory defaults.

Nothing helped.

And according this it looks like problem of Redstone 1. https://forums.docker.com/t/failed-to-start-vm-mobylinuxvm-the-vm-couldnt-get-an-ip-address-after-60-tries/19551/7

Have you solved this somehow ? Thank you

rn commented 8 years ago

I had a look at your logs and there seem to be a number of different issues:

As for @cuikangyi @runner7532 @Irieish @TaylorBarrick from the logs it appears like you all experience the same issue. The MobyLinuxVM boots fine, but then early during boot, it will try to contact the host via a Hyper-V technology called Hyper-V sockets but that connection never succeeds. I'm a little puzzled as to wy this is not working as I have several 14393 machines (and have tracked various insider builds over the past months) and have never seen this. Unfortunately, there is very little debugging support for this.

Could you try updating with the latest windows updates and un-install and install Beta24 again?

Irieish commented 8 years ago

Thanks rneugeba. Will post back after uninstall/reinstall of Beta24. Believe Windows is current (installed latest update released 8/31 before posting). Windows 10 Pro (Version 1607 / Build 14393.105).

Irieish commented 8 years ago

Same error after reinstall of Beta24. Diagnostic ID: 6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-01_18-05-55

Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.LinuxContainersEngine.DoStart(Settings settings) at Docker.Backend.LinuxContainersEngine.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Error log follows: [18:02:57.074][Program ][Info ] Version: 1.12.1-beta24 [18:02:57.076][Program ][Info ] Starting on: 9/1/2016 6:02:57 PM [18:02:57.076][Program ][Info ] Resources: C:\Program Files\Docker\Docker\Resources [18:02:57.077][Program ][Info ] OS: Windows 10 Pro [18:02:57.077][Program ][Info ] Edition: Professional [18:02:57.078][Program ][Info ] Id: 1607 [18:02:57.078][Program ][Info ] Build: 14393 [18:02:57.078][Program ][Info ] BuildLabName: 14393.103.amd64fre.rs1_release_inmarket.160819-1924 [18:02:57.079][Program ][Info ] Sha1: 7e2d389a5065149cffacbc889658405e3da67b6f [18:02:57.081][Program ][Info ] You can send feedback, including this log file, at https://github.com/docker/for-win/issues [18:02:57.504][TrackingStatus ][Info ] Crash report and usage statistics are enabled [18:02:57.545][Mixpanel ][Info ] Id: 6F013C72-7104-4907-BC8B-D7F1D42EE211 [18:02:57.587][DiskEventStorer][Info ] loaded 0 pending events [18:02:57.593][Mixpanel ][Info ] Usage Statistic: appLaunched [18:02:57.800][NamedPipeClient][Info ] Sending Version()... [18:02:57.807][NamedPipeClient][Info ] Received response for Version [18:02:57.810][Mixpanel ][Info ] Usage Statistic: heartbeat [18:02:53.966][BackendServer ][Info ] Started [18:02:57.805][NamedPipeServer][Info ] Version() [18:02:57.805][NamedPipeServer][Info ] Version done. [18:02:58.335][Notifications ][Info ] Docker is starting... [18:02:58.337][Updater ][Info ] Checking for updates on channel Beta... [18:02:58.352][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [18:02:58.355][NamedPipeServer][Info ] Start(Docker.Core.Settings) [18:02:58.356][HyperVGuids ][Info ] Installing GUIDs... [18:02:58.358][HyperVGuids ][Info ] GUIDs installed [18:02:58.368][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [18:02:58.478][Updater ][Info ] Local build 6563 is as good as the remote 6563 on channel Beta [18:02:59.306][Firewall ][Info ] Ports are opened [18:02:59.307][HyperV ][Info ] Create [18:02:59.313][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [18:03:02.276][HyperV ][Info ] Creating Switch: DockerNAT... [18:03:04.261][HyperV ][Info ] Switch created. [18:03:04.999][HyperV ][Info ] Set IP address on switch [18:03:06.216][HyperV ][Info ] Creating dynamic VHD: C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx [18:03:07.326][HyperV ][Info ] Creating VM MobyLinuxVM... [18:03:09.706][HyperV ][Info ] VM created. [18:03:09.712][DataKit ][Info ] Starting... [18:03:09.715][PowerShell ][Info ] Run script... [18:03:10.191][DataKit ][Info ] Started [18:03:10.195][VpnKit ][Info ] Starting... [18:03:10.200][PowerShell ][Info ] Run script... [18:03:10.233][DataKit ][Info ] [18:03:10.233][DataKit ][Info ] +9112us Datakit Starting com.docker.db.exe 09081b4 ... [18:03:10.554][VpnKit ][Info ] Started [18:03:10.560][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [18:03:10.561][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [18:03:10.561][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [18:03:10.561][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [18:03:10.561][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [18:03:10.562][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [18:03:10.562][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [18:03:10.562][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [18:03:10.562][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [18:03:10.589][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [18:03:10.590][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [18:03:10.590][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [18:03:10.590][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 max_connections:None vsock_path: [18:03:10.591][VpnKit ][Info ] com.docker.slirp.exe: connecting to 089efca5-ea10-4f65-bbed-4ef3b9e79962:0B95756A-9985-48AD-9470-78E060895BE7 [18:03:10.591][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 [18:03:10.592][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [18:03:10.592][VpnKit ][Info ] com.docker.slirp.exe: connecting to 089efca5-ea10-4f65-bbed-4ef3b9e79962:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [18:03:10.592][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 [18:03:11.536][Database ][Info ] Successfully wrote 9 value(s) [18:03:11.536][DataKit ][Info ] [18:03:11.536][DataKit ][Info ] +1314311us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [18:03:11.537][HyperV ][Info ] Start [18:03:11.537][PowerShell ][Info ] Run script with parameters: -Start True... [18:03:11.574][HyperV ][Info ] Starting VM MobyLinuxVM... [18:03:12.051][HyperV ][Info ] Wait for the VM to get an IP address [18:03:13.074][HyperV ][Info ] Wait for the VM to get an IP address [18:03:14.117][HyperV ][Info ] Wait for the VM to get an IP address [18:03:15.417][HyperV ][Info ] Wait for the VM to get an IP address [18:03:16.435][HyperV ][Info ] Wait for the VM to get an IP address [18:03:17.473][HyperV ][Info ] Wait for the VM to get an IP address [18:03:18.497][HyperV ][Info ] Wait for the VM to get an IP address [18:03:19.544][HyperV ][Info ] Wait for the VM to get an IP address [18:03:20.879][HyperV ][Info ] Wait for the VM to get an IP address [18:03:21.898][HyperV ][Info ] Wait for the VM to get an IP address [18:03:22.949][HyperV ][Info ] Wait for the VM to get an IP address [18:03:23.970][HyperV ][Info ] Wait for the VM to get an IP address [18:03:25.015][HyperV ][Info ] Wait for the VM to get an IP address [18:03:26.314][HyperV ][Info ] Wait for the VM to get an IP address [18:03:27.331][HyperV ][Info ] Wait for the VM to get an IP address [18:03:28.371][HyperV ][Info ] Wait for the VM to get an IP address [18:03:29.398][HyperV ][Info ] Wait for the VM to get an IP address [18:03:30.439][HyperV ][Info ] Wait for the VM to get an IP address [18:03:31.730][HyperV ][Info ] Wait for the VM to get an IP address [18:03:32.748][HyperV ][Info ] Wait for the VM to get an IP address [18:03:33.788][HyperV ][Info ] Wait for the VM to get an IP address [18:03:34.806][HyperV ][Info ] Wait for the VM to get an IP address [18:03:35.851][HyperV ][Info ] Wait for the VM to get an IP address [18:03:37.132][HyperV ][Info ] Wait for the VM to get an IP address [18:03:38.147][HyperV ][Info ] Wait for the VM to get an IP address [18:03:39.182][HyperV ][Info ] Wait for the VM to get an IP address [18:03:40.199][HyperV ][Info ] Wait for the VM to get an IP address [18:03:41.288][HyperV ][Info ] Wait for the VM to get an IP address [18:03:42.602][HyperV ][Info ] Wait for the VM to get an IP address [18:03:43.619][HyperV ][Info ] Wait for the VM to get an IP address [18:03:44.652][HyperV ][Info ] Wait for the VM to get an IP address [18:03:45.667][HyperV ][Info ] Wait for the VM to get an IP address [18:03:46.702][HyperV ][Info ] Wait for the VM to get an IP address [18:03:47.991][HyperV ][Info ] Wait for the VM to get an IP address [18:03:49.019][HyperV ][Info ] Wait for the VM to get an IP address [18:03:50.052][HyperV ][Info ] Wait for the VM to get an IP address [18:03:51.068][HyperV ][Info ] Wait for the VM to get an IP address [18:03:52.112][HyperV ][Info ] Wait for the VM to get an IP address [18:03:53.395][HyperV ][Info ] Wait for the VM to get an IP address [18:03:54.410][HyperV ][Info ] Wait for the VM to get an IP address [18:03:55.447][HyperV ][Info ] Wait for the VM to get an IP address [18:03:56.463][HyperV ][Info ] Wait for the VM to get an IP address [18:03:57.503][HyperV ][Info ] Wait for the VM to get an IP address [18:03:58.749][HyperV ][Info ] Wait for the VM to get an IP address [18:03:59.763][HyperV ][Info ] Wait for the VM to get an IP address [18:04:00.796][HyperV ][Info ] Wait for the VM to get an IP address [18:04:01.811][HyperV ][Info ] Wait for the VM to get an IP address [18:04:02.849][HyperV ][Info ] Wait for the VM to get an IP address [18:04:04.072][HyperV ][Info ] Wait for the VM to get an IP address [18:04:05.088][HyperV ][Info ] Wait for the VM to get an IP address [18:04:06.120][HyperV ][Info ] Wait for the VM to get an IP address [18:04:07.136][HyperV ][Info ] Wait for the VM to get an IP address [18:04:08.183][HyperV ][Info ] Wait for the VM to get an IP address [18:04:09.411][HyperV ][Info ] Wait for the VM to get an IP address [18:04:10.426][HyperV ][Info ] Wait for the VM to get an IP address [18:04:11.456][HyperV ][Info ] Wait for the VM to get an IP address [18:04:12.473][HyperV ][Info ] Wait for the VM to get an IP address [18:04:13.510][HyperV ][Info ] Wait for the VM to get an IP address [18:04:14.735][HyperV ][Info ] Wait for the VM to get an IP address [18:04:16.714][HyperV ][Info ] Hyper-V is running [18:04:16.715][HyperV ][Info ] Create [18:04:16.716][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [18:04:17.081][HyperV ][Info ] Using existing Switch: DockerNAT [18:04:17.143][HyperV ][Info ] Using existing Switch IP address [18:04:17.179][HyperV ][Info ] Using existing: MobyLinuxVM (state = Running) [18:04:17.183][HyperV ][Info ] Stop [18:04:17.183][PowerShell ][Info ] Run script with parameters: -Stop True... [18:04:17.229][HyperV ][Info ] Stopping VM MobyLinuxVM... [18:04:18.296][HyperV ][Info ] Turn Off VM ... [18:04:18.324][HyperV ][Info ] Kill VM MobyLinuxVM process... [18:04:19.346][HyperV ][Info ] Kill VM MobyLinuxVM process... [18:04:20.388][HyperV ][Info ] VM MobyLinuxVM killed. Waiting for state to change [18:04:22.399][HyperV ][Info ] Killed VM MobyLinuxVM is off [18:04:22.404][VpnKit ][Info ] Killing existing com.docker.slirp with PID 12144 [18:04:22.409][DataKit ][Info ] Killing existing com.docker.db with PID 12748 [18:04:22.411][HyperVGuids ][Info ] Installing GUIDs... [18:04:22.412][HyperVGuids ][Info ] GUIDs installed [18:04:22.412][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [18:04:23.578][Firewall ][Info ] Ports are opened [18:04:23.578][HyperV ][Info ] Create [18:04:23.579][PowerShell ][Info ] Run script with parameters: -Create True -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso... [18:04:23.868][HyperV ][Info ] Using existing Switch: DockerNAT [18:04:23.927][HyperV ][Info ] Using existing Switch IP address [18:04:23.947][HyperV ][Info ] Using existing: MobyLinuxVM (state = Off) [18:04:24.172][HyperV ][Info ] Setting MobyLinuxVM vm CPUs to 2 and Memory to 2048 MB [18:04:24.175][DataKit ][Info ] Starting... [18:04:24.175][PowerShell ][Info ] Run script... [18:04:24.304][DataKit ][Info ] Started [18:04:24.307][VpnKit ][Info ] Starting... [18:04:24.307][PowerShell ][Info ] Run script... [18:04:24.337][DataKit ][Info ] [18:04:24.337][DataKit ][Info ] +6196us Datakit Starting com.docker.db.exe 09081b4 ... [18:04:24.467][VpnKit ][Info ] Started [18:04:24.468][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [18:04:24.468][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [18:04:24.468][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [18:04:24.469][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [18:04:24.469][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/resolv.conf=nameserver 10.0.75.1 [18:04:24.469][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [18:04:24.469][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[],"debug":false} [18:04:24.470][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [18:04:24.470][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [18:04:24.498][VpnKit ][Info ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false) [18:04:24.498][VpnKit ][Info ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals [18:04:24.499][VpnKit ][Info ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version local %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.10.0 %HVSOCK_PINNED% [18:04:24.499][VpnKit ][Info ] com.docker.slirp.exe: starting port_forwarding port_control_url:hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 max_connections:None vsock_path: [18:04:24.499][VpnKit ][Info ] com.docker.slirp.exe: connecting to 089efca5-ea10-4f65-bbed-4ef3b9e79962:0B95756A-9985-48AD-9470-78E060895BE7 [18:04:24.499][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 [18:04:24.500][VpnKit ][Warning] com.docker.slirp.exe: no database: using hardcoded network configuration values [18:04:24.500][VpnKit ][Info ] com.docker.slirp.exe: connecting to 089efca5-ea10-4f65-bbed-4ef3b9e79962:30D48B34-7D27-4B0B-AAAF-BBBED334DD59 [18:04:24.500][VpnKit ][Debug ] com.docker.slirp.exe: Waiting for connections on socket hyperv-connect://089efca5-ea10-4f65-bbed-4ef3b9e79962 [18:04:25.651][Database ][Info ] Successfully wrote 9 value(s) [18:04:25.652][HyperV ][Info ] Start [18:04:25.652][PowerShell ][Info ] Run script with parameters: -Start True... [18:04:25.653][DataKit ][Info ] [18:04:25.653][DataKit ][Info ] +1322345us fs9p [ERROR] dispatcher caught Unix.Unix_error(Unix.EPIPE, "bytes_read", ""): no more requests will be handled [18:04:25.680][HyperV ][Info ] Starting VM MobyLinuxVM... [18:04:26.130][HyperV ][Info ] Wait for the VM to get an IP address [18:04:27.146][HyperV ][Info ] Wait for the VM to get an IP address [18:04:28.165][HyperV ][Info ] Wait for the VM to get an IP address [18:04:29.410][HyperV ][Info ] Wait for the VM to get an IP address [18:04:30.425][HyperV ][Info ] Wait for the VM to get an IP address [18:04:31.488][HyperV ][Info ] Wait for the VM to get an IP address [18:04:32.504][HyperV ][Info ] Wait for the VM to get an IP address [18:04:33.519][HyperV ][Info ] Wait for the VM to get an IP address [18:04:34.739][HyperV ][Info ] Wait for the VM to get an IP address [18:04:35.756][HyperV ][Info ] Wait for the VM to get an IP address [18:04:36.830][HyperV ][Info ] Wait for the VM to get an IP address [18:04:37.844][HyperV ][Info ] Wait for the VM to get an IP address [18:04:38.864][HyperV ][Info ] Wait for the VM to get an IP address [18:04:40.115][HyperV ][Info ] Wait for the VM to get an IP address [18:04:41.132][HyperV ][Info ] Wait for the VM to get an IP address [18:04:42.194][HyperV ][Info ] Wait for the VM to get an IP address [18:04:43.212][HyperV ][Info ] Wait for the VM to get an IP address [18:04:44.231][HyperV ][Info ] Wait for the VM to get an IP address [18:04:45.552][HyperV ][Info ] Wait for the VM to get an IP address [18:04:46.569][HyperV ][Info ] Wait for the VM to get an IP address [18:04:47.641][HyperV ][Info ] Wait for the VM to get an IP address [18:04:48.657][HyperV ][Info ] Wait for the VM to get an IP address [18:04:49.672][HyperV ][Info ] Wait for the VM to get an IP address [18:04:50.924][HyperV ][Info ] Wait for the VM to get an IP address [18:04:51.941][HyperV ][Info ] Wait for the VM to get an IP address [18:04:53.005][HyperV ][Info ] Wait for the VM to get an IP address [18:04:54.020][HyperV ][Info ] Wait for the VM to get an IP address [18:04:55.034][HyperV ][Info ] Wait for the VM to get an IP address [18:04:56.267][HyperV ][Info ] Wait for the VM to get an IP address [18:04:57.285][HyperV ][Info ] Wait for the VM to get an IP address [18:04:58.405][HyperV ][Info ] Wait for the VM to get an IP address [18:04:59.421][HyperV ][Info ] Wait for the VM to get an IP address [18:05:00.437][HyperV ][Info ] Wait for the VM to get an IP address [18:05:01.653][HyperV ][Info ] Wait for the VM to get an IP address [18:05:02.668][HyperV ][Info ] Wait for the VM to get an IP address [18:05:03.729][HyperV ][Info ] Wait for the VM to get an IP address [18:05:04.745][HyperV ][Info ] Wait for the VM to get an IP address [18:05:05.761][HyperV ][Info ] Wait for the VM to get an IP address [18:05:07.005][HyperV ][Info ] Wait for the VM to get an IP address [18:05:08.020][HyperV ][Info ] Wait for the VM to get an IP address [18:05:09.077][HyperV ][Info ] Wait for the VM to get an IP address [18:05:10.092][HyperV ][Info ] Wait for the VM to get an IP address [18:05:11.109][HyperV ][Info ] Wait for the VM to get an IP address [18:05:12.377][HyperV ][Info ] Wait for the VM to get an IP address [18:05:13.394][HyperV ][Info ] Wait for the VM to get an IP address [18:05:14.512][HyperV ][Info ] Wait for the VM to get an IP address [18:05:15.529][HyperV ][Info ] Wait for the VM to get an IP address [18:05:16.548][HyperV ][Info ] Wait for the VM to get an IP address [18:05:17.829][HyperV ][Info ] Wait for the VM to get an IP address [18:05:18.847][HyperV ][Info ] Wait for the VM to get an IP address [18:05:19.919][HyperV ][Info ] Wait for the VM to get an IP address [18:05:20.937][HyperV ][Info ] Wait for the VM to get an IP address [18:05:21.955][HyperV ][Info ] Wait for the VM to get an IP address [18:05:23.223][HyperV ][Info ] Wait for the VM to get an IP address [18:05:24.240][HyperV ][Info ] Wait for the VM to get an IP address [18:05:25.310][HyperV ][Info ] Wait for the VM to get an IP address [18:05:26.328][HyperV ][Info ] Wait for the VM to get an IP address [18:05:27.346][HyperV ][Info ] Wait for the VM to get an IP address [18:05:28.600][HyperV ][Info ] Wait for the VM to get an IP address [18:05:29.621][NamedPipeServer][Error ] Unable to execute Start: Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.LinuxContainersEngine.DoStart(Settings settings) at Docker.Backend.LinuxContainersEngine.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [18:05:29.637][NamedPipeClient][Error ] Unable to send Start: Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 [18:05:29.639][Notifications ][Error ] Unable to start: The VM couldn't get an IP address after 60 tries at Fatal, : line 313 at Start-MobyLinuxVM, : line 233 at , : line 322 [18:05:29.651][NamedPipeClient][Info ] Sending GetDebugInfo()... [18:05:29.652][NamedPipeServer][Info ] GetDebugInfo() [18:05:54.993][NamedPipeServer][Info ] GetDebugInfo done. [18:05:54.997][NamedPipeClient][Info ] Received response for GetDebugInfo [18:05:55.007][Program ][Info ] Sending Bugsnag report dfdc4d77-776b-48b2-8ec9-ff88635fb7a5... [18:05:55.997][Program ][Info ] Bugsnag report dfdc4d77-776b-48b2-8ec9-ff88635fb7a5 sent [18:05:56.016][NamedPipeClient][Info ] Sending DownloadVmLogs()... [18:05:56.017][NamedPipeServer][Info ] DownloadVmLogs() [18:05:56.019][PowerShell ][Info ] Run script... [18:06:26.317][HyperV ][Warning] Unable to download logs: 2016/09/01 18:06:26 Failed to Dial 089efca5-ea10-4f65-bbed-4ef3b9e79962 445ba2cb-e69b-4912-8b42-d7f494d007ea : A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond.

[18:06:26.317][NamedPipeServer][Info ] DownloadVmLogs done. [18:06:26.317][NamedPipeClient][Info ] Received response for DownloadVmLogs [18:07:16.008][ErrorReportWindow][Info ] Open logs

kukjevov commented 8 years ago

Hi.

I have reported that there is problem with Redstone 1. I have multiple Windows installations and i tried it also on Windows 10 10586 and it worked without any problem. Then i tried it in work where i also have Windows 10 14393 Redstone 1 and it also worked.

Only difference that i see now is that Redstone 1 where it is not working was upgraded from Insider Preview build and Redstone 1 where it is working was upgraded from stable 10586. I`m going to fully reinstall that one Windows to see if it helps.

@rneugeba Before i reinstall i will gather requested informations.

cuikangyi commented 8 years ago

Hi, @kukjevov For me that is the case. On my PC, it canot work on Windows 10 14393, but it can work on Windows 10 10586. And them are both fully reinstall.

tonercart commented 8 years ago

@rneugeba I managed to get working by first manually starting Docker and after that the next few re-boots were also fine. This morning however I had another failure on startup due to a different reason diagnostic is E29FCE66-DA9C-40C9-85CC-AD63831ADA03/2016-09-02_08-20-32

Again I can get going by manually starting Docker which is fine for my purposes.

FYI - Hardware is only a couple of years old - Dell laptop with i7-4510U

sstodd7532 commented 8 years ago

Unable to create: The running command stopped because the preference variable "ErrorActionPreference" or common parameter is set to Stop: Modifying the properties of the device 'Memory' failed.

The operation cannot be performed while the object is in its current state. at New-MobyLinuxVM, : line 184 at , : line 321 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.LinuxContainersEngine.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

my most recent crash report: AD4A52AE-5334-4B98-8678-7191A2331558/2016-09-02_07-51-21

After the error above, I went into task manager and stopped all tasks I found for hyper-v and docker. I then opened hyper-v manager to verify that none of the VMs were running. I then opened Docker for Windows from the start menu. Doing this I was able to get the VM to boot and get the IP successfully. It appears to work correctly but does not. I then get the following error when trying to pull down a container:

[7:49:17 AM] H:> docker pull centos/powershell Using default tag: latest Pulling repository docker.io/centos/powershell Error while pulling image: Get https://index.docker.io/v1/repositories/centos/powershell/images: dial tcp: lookup index.docker.io on 192.168.65.4:53: server misbehaving

Here is a copy of my log file, and a diagnostic was uploaded with id: AD4A52AE-5334-4B98-8678-7191A2331558/2016-09-02_08-41-59

log-2016-09-02_08-33-50.txt

As a test, I am setting my docker to not start when I login, but to allow me to start manually. The only issue that I have now is the DNS issue mentioned above.

cuikangyi commented 8 years ago

Hi, @rneugeba I have same error after reinstall of Beta24. Diagnostic ID: 0EACCFD5-7AEF-41DC-AF11-4F1C524B72F5/2016-09-03_08-56-48

kukjevov commented 8 years ago

Hi @rneugeba Here is my diagnostic ID: FB5CEB8E-709F-4A8F-8F18-DE39D01B068D/2016-09-03_07-24-39

mustikkakeitto commented 8 years ago

Hi, here is my diagnostic ID for this problem: 61006024-AE02-4DD7-84D6-8C9EE6A824AF/2016-09-07_10-13-35

Hobby-Student commented 8 years ago

[EDIT] Did several combinations of "reset to factory defaults" and restarts. It's now working again. [/EDIT]

I now have the same problem. yesterday everything was working normal... but today docker is not getting its IP. Diagnostic ID: 2908EE57-E9BE-4162-A362-8B6927FFDEF2/2016-09-07_11-14-48

Surface Pro 3 (128GB & 4GB RAM) Windows 10 Pro x64 with all updates available (no Insider)

(Have another Windows 10 Pro x64 as VM on ESXi 6 and it never worked as it never gets an IP. I know, that nested virtualization is probably not the most important thing on docker for windows... but I would use it ;) )

TaylorBarrick commented 8 years ago

I had some success for a while, but a recent reboot triggered the old behavior.
Current win build is 14915.rs_prerelease.160826-1902

Diagnostic ID: 0D363E23-6B8A-4A91-AB4F-C0283E39F2B2/2016-09-07_15-43-48

Irieish commented 8 years ago

Hi @rneugeba. Just installed beta25. Win10 Pro (1607 - build 14393.105). Slightly different error, but still not getting an IP address. Logs show everything pointing to DockerNAT, but the only adapter showing in devmgmt.msc, (including hidden) is vEthernet (DockerNAT) 2.

Get-VMSwitch reveals DockerNAT as an Internal Switch, and Hyper-V shows MobyLinuxVM using DockerNAT as the connection, but with no IP and a status of "no communication".

I was able to locate the mystery/ghosted DockerNAT ID within the debuginfo file, so could track down those entries in the registry, but wanted to roll this up first to see if there might be any better troubleshooting ideas. Thanks in advance for any help.

Below is a copy of the log file, the Diagnostic ID, and error message. log-2016-09-07_15-06-38.txt

Diagnostic ID: 6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-07_15-09-29

Unable to start: The VM couldn't get an IP address after 60 tries at , : line 332 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass7_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

st1971 commented 8 years ago

Have the same issue, clean install of Win 10 Pro 1607 build 14393.105.

The VM never starts up have left it for 60+ minutes without it responding.

Diagnostic ID: 21623F99-9384-43D1-99D9-97FD9FFA1CF3/2016-09-08_09-24-19

Get the same behaviour with the latest beta and the stable build.

dgageot commented 8 years ago

@cuikangyi @tonercart @runner7532 @Irieish A new version (Beta25) was released yesterday, could you please give it a try and tell us if you see an improvement? It might not fix the issue but at least extracts more diagnostic information. So please provide us the diag ids so that we can tackle this issue!

st1971 commented 8 years ago

Diagnostic ID: 21623F99-9384-43D1-99D9-97FD9FFA1CF3/2016-09-08_09-24-19

Was created with Beta 25

Kind Regards

Irieish commented 8 years ago

@dgageot, the Diagnostic ID above was generated after installing beta25. (6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-07_15-09-29)

GiorgioG commented 8 years ago

A diagnostic was uploaded with id: ABE399C6-8409-4EBF-ADF1-A46986F0A531/2016-09-08_16-37-37

ProblemFactory commented 8 years ago

diagnostic id: 066578FF-A665-4917-BB3C-83A7E9C2AC6B/2016-09-14_01-00-09

Irieish commented 8 years ago

Update after installing version 1.12.1-beta26 (build: 7018). Still unable to get an IP Address.

Diagnostic ID: 6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-14_14-03-31

Unable to start: The VM couldn't get an IP address after 60 tries at , : line 340 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Irieish commented 8 years ago

While I still look forward to sorting out the issue above, I noticed the taskview option to switch to Windows Containers, from which Docker was finally able to start, but generates the following error when trying to pull the nginx image. Given the IP address issue above still remains, not sure if switching to Windows containers is the best action... just wanted to share and see what was recommended.

uploaded diagnostic ID: 6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-14_15-56-48

PS C:\WINDOWS\system32> docker info Containers: 0 Running: 0 Paused: 0 Stopped: 0 Images: 0 Server Version: 1.13.0-dev Storage Driver: windowsfilter Windows: Logging Driver: json-file Plugins: Volume: local Network: nat null overlay Swarm: inactive Security Options: Kernel Version: 10.0 14393 (14393.103.amd64fre.rs1_release_inmarket.160819-1924) Operating System: Windows 10 Pro OSType: windows Architecture: x86_64 CPUs: 8 Total Memory: 15.94 GiB Name: Irieish-PC ID: F5RE:G2U7:2WDV:HQGL:343F:FQDI:JMJQ:BVA5:37LJ:RNCX:7OHX:QJLZ Docker Root Dir: C:\ProgramData\Docker Debug Mode (client): false Debug Mode (server): false Registry: https://index.docker.io/v1/ Insecure Registries: 127.0.0.0/8

PS C:\WINDOWS\system32> docker --version Docker version 1.12.1, build 23cf638, experimental PS C:\WINDOWS\system32> docker-compose --version docker-compose version 1.8.0, build d988a55 PS C:\WINDOWS\system32> docker-machine --version docker-machine.exe version 0.8.1, build 41b3b25

PS C:\WINDOWS\system32> docker run -d -p 80:80 --name webserver nginx Unable to find image 'nginx:latest' locally latest: Pulling from library/nginx

357ea8c3d80b: Extracting [==================================================>] 51.37 MB/51.37 MB 0fc04568277e: Download complete 0bed9719ddcb: Download complete C:\Program Files\Docker\Docker\Resources\bin\docker.exe: failed to register layer: re-exec error: exit status 1: output: Failed to OpenForBackup failed in Win32: open \?\C:\ProgramData\Docker\windowsfilter\016fdba92242d4ef68d105f31ffa9b69f1d69a44e1456abacfd6ede32b815b3d\usr\shar e\man\man3\Locale::gettext.3pm.gz: The filename, directory name, or volume label syntax is incorrect. (0x1f) \?\C:\ProgramData\Docker\windowsfilter\016fdba92242d4ef68d105f31ffa9b69f1d69a44e1456abacfd6ede32b815b3d\usr\share\man\man3\Locale::gettext.3pm.gz. See 'C:\Program Files\Docker\Docker\Resources\bin\docker.exe run --help'.

twsouthwick commented 8 years ago

Seeing same as original issue. Uploaded id: 10497C6E-1B27-4F0E-8743-A18C2C79AA76/2016-09-16_17-02-49

st1971 commented 8 years ago

Still seeing the same issue with beta26.

Have uploaded crash report with ID: 1FB51E6A-6A9D-4E4D-8014-2A5EE6725A3F/2016-09-17_09-18-02

maxday commented 8 years ago

hi @dgageot do you still need more info or should we remove the tag ? Thanks

ecamaj commented 8 years ago

It is not working for me too, tried both stable and beta versions.

EDAB61E7-0B34-4AF5-9D72-654DCFBA8D96/2016-09-21_18-16-31

Thank you, Eddie

alexander-mazur commented 8 years ago

The same problem for me: D5A2E073-A690-49AE-A9AD-DFF5D9FBDB32/2016-09-22_13-33-34

Thanks, Alex

ecamaj commented 8 years ago

Any news? "No one assigned"?

byhoratiss commented 8 years ago

Same problem for me: C4AEC54D-1884-4A8A-A3FC-0A3D1565E149/2016-09-24_19-45-14

:(

rn commented 8 years ago

Thanks again for all of you reporting this issue and apologies for the dealy, I was on PTO.

I went through the diagnostics to see if there is a trend, some communality etc.

First off the easy ones...

@alexander-mazur You are running windows 10 inside a VMware VM. While this may or may not work, it's a configuration we don't really support as we have no influence (nor visibility) about how the VM is configured, which version you are using etc. Nested Virtualisation is required for this to work, and it's not really a fully mature technology yet,

@tonercart your failure seems different to what others are seeing. In your case the VM doesn't start. Could you try the 1.12.1 stable update from https://download.docker.com/win/stable/InstallDocker.msi or the latest beta from https://download.docker.com/win/beta/InstallDocker.msi. I don't think we changed much in the area where you see the issue, but we improved the diags quite a bit.

All other (12+ people) seem to be on build 14393 (or newer) and seem to see the same issue. The VM starts just enough for Hyper-v manager thinking that it is running, but it seem to be stuck quite early in the boot process. VM integration services (including hearbeat, which is done in the kernel) are not up. We have not see this before...

Would one of you be available for a slightly more interactive (ie not github issue comments, but email, skype chat or similar) based debug session? Preferably in a European timezone? Thanks

ecamaj commented 8 years ago

Sure, I can help you. eduard.camaj@gmail.com -> mail/Google chat

Im free tomorrow from 15h onwards.

rn commented 8 years ago

@ryan413 reported the same issue here https://github.com/docker/for-win/issues/107 with the same build 14393 symptoms. diag ID: 9F859781-284C-44AE-9492-64E1DA42268A/2016-09-27_09-30-53

rn commented 8 years ago

quick update.

I had a screen sharing session with @ecamaj (thanks again very much for taking the time) and it appears that on his system the Linux kernel hangs half way through the boot when probing the virtual storage devices over VMBus. This is consistent with the symptoms seen by other users which are on 14393 (or above): The VM is running but there is no heartbeat from the hv_util kernel driver (which get's started a little later. @ecamaj also run this with the VM with a single vCPU which should eliminate potential locking issues in the code.

I'm looking into how to debug this further at the moment

Irieish commented 8 years ago

Thanks @rneugeba! Below is my latest diag ID after installing beta 27 (1.12.2-rc10beta27 (build: 7450) 179c18c / Win10 1607 (build: 14393.222) . Still unable to start / no IP address. Figured a fix was still in the works, but wanted to share anyway in case it helps w/ troubleshooting.

6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-09-29_16-23-01

Unable to start: The VM couldn't get an IP address after 60 tries at , : line 340 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Irieish commented 8 years ago

Just installed the latest update to beta 27 (1.12.2-rc1-beta27.1 (build 7538) a0eb77a / Win10 1607 (build: 14393.222). Still unable to start / no IP address.

6F013C72-7104-4907-BC8B-D7F1D42EE211/2016-10-01_16-18-20

Unable to start: The VM couldn't get an IP address after 60 tries at , : line 340 at Docker.Backend.HyperV.RunScript(String action, Dictionary`2 parameters) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Irieish commented 8 years ago

Here are the results if I switch to Windows containers... Docker starts, but...

PS C:\WINDOWS\system32> docker --version Docker version 1.12.2-rc1, build 45bed2c, experimental PS C:\WINDOWS\system32> docker-compose --version docker-compose version 1.8.1, build 004ddae PS C:\WINDOWS\system32> docker-machine --version docker-machine.exe version 0.8.2, build e18a919

PS C:\WINDOWS\system32> docker ps CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES

PS C:\WINDOWS\system32> docker version Client: Version: 1.12.2-rc1 API version: 1.24 Go version: go1.6.3 Git commit: 45bed2c Built: Tue Sep 27 23:38:15 2016 OS/Arch: windows/amd64 Experimental: true

Server: Version: 1.12.2-cs2-ws-beta-rc1 API version: 1.25 Go version: go1.7.1 Git commit: 62d9ff9 Built: Fri Sep 23 20:50:29 2016 OS/Arch: windows/amd64

PS C:\WINDOWS\system32> docker info Containers: 0 Running: 0 Paused: 0 Stopped: 0 Images: 1 Server Version: 1.12.2-cs2-ws-beta-rc1 Storage Driver: windowsfilter Windows: Logging Driver: json-file Plugins: Volume: local Network: nat null overlay Swarm: inactive Security Options: Kernel Version: 10.0 14393 (14393.206.amd64fre.rs1_release.160915-0644) Operating System: Windows 10 Pro OSType: windows Architecture: x86_64 CPUs: 8 Total Memory: 15.94 GiB Name: Irieish-PC ID: F5RE:G2U7:2WDV:HQGL:343F:FQDI:JMJQ:BVA5:37LJ:RNCX:7OHX:QJLZ Docker Root Dir: C:\ProgramData\Docker Debug Mode (client): false Debug Mode (server): false Registry: https://index.docker.io/v1/ Insecure Registries: 127.0.0.0/8

PS C:\WINDOWS\system32> docker run hello-world Unable to find image 'hello-world:latest' locally latest: Pulling from library/hello-world C:\Program Files\Docker\Docker\Resources\bin\docker.exe: image operating system "linux" cannot be used on this platform. See 'C:\Program Files\Docker\Docker\Resources\bin\docker.exe run --help'.

PS C:\WINDOWS\system32> docker run -d -p 80:80 --name webserver nginx Unable to find image 'nginx:latest' locally latest: Pulling from library/nginx C:\Program Files\Docker\Docker\Resources\bin\docker.exe: image operating system "linux" cannot be used on this platform. See 'C:\Program Files\Docker\Docker\Resources\bin\docker.exe run --help'.

Irieish commented 8 years ago

I also get the following error response from the Docker daemon: PS C:\WINDOWS\system32> docker run --rm -v c:/Users:/data alpine ls /data C:\Program Files\Docker\Docker\Resources\bin\docker.exe: Error response from daemon: invalid bind mount spec "c:/Users:/ data": invalid volume specification: 'c:\Users:\data'. See 'C:\Program Files\Docker\Docker\Resources\bin\docker.exe run --help'.

vpalacio commented 8 years ago

Having same problem. Diag id: EE75E116-3427-49F8-BCE0-E47C9C15B029/2016-10-01_21-17-02

Velok commented 8 years ago

Same problem for me. Diag ID: 04EAF3DD-1F41-4F49-8BA8-D56593EA1555/2016-10-02_04-00-55 Fresh native Windows 10 Pro Installation (Build 14393.222) Tried first with 1.12.1-stable and now with the newest beta. Unfortunately no luck.

rn commented 8 years ago

moving details from #121 reported by @sanori to here (closing #121 as a duplicate):

1A21DDEE-16A0-43FE-941A-B856D15B66BC/2016-10-02_15-27-20