search

docker / for-win

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

The MobyLinux VM boots slowly #488

Closed neoaisac closed 6 years ago

neoaisac commented 7 years ago

Expected behavior

Docker should start

Actual behavior

After installation, Docker for Windows tries to start. I do have a taskbar icon showing that Docker is starting until it turns red and fails.

Information

Steps to reproduce the behavior

  1. Install docker for Windows.
  2. Run docker for Windows.
  3. After a while starting, docker failes, with a red whale in the taskbar and a screen showing the following output:
Docker hv-sock proxy (vsudd) is not reachable
   en Docker.Backend.ContainerEngine.Linux.ConnectToVsud(TaskCompletionSource`1 vmId)
   en Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings)
   en Docker.Backend.ContainerEngine.Linux.Start(Settings settings)
   en Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.<Register>b__0(Object[] parameters)
   en Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

There's also a log file containing the following:

Version: 1.13.1 (10072)
Channel: Stable
Sha1: 94675c5a765e2c51fba6c10b87e0a1a4ed3dde51
Started on: 2017/02/11 18:31:04.834
Resources: C:\Program Files\Docker\Docker\Resources
OS: Windows 10 Pro
Edition: Professional
Id: 1607
Build: 14393
BuildLabName: 14393.693.amd64fre.rs1_release.161220-1747
File: C:\Users\user\AppData\Local\Docker\log.txt
CommandLine: "C:\Program Files\Docker\Docker\Docker for Windows.exe" 
You can send feedback, including this log file, at https://github.com/docker/for-win/issues
[18:31:05.419][GUI            ][Info   ] Starting...
[18:31:07.560][Tracking       ][Info   ] Crash report and usage statistics are enabled
[18:31:07.589][SegmentApi     ][Info   ] Usage statistic: appLaunched
[18:31:08.221][NamedPipeClient][Info   ] Sending Version()...
[18:31:08.317][NamedPipeClient][Info   ] Received response for Version
[18:31:08.321][SegmentApi     ][Info   ] Usage statistic: heartbeat
[18:30:59.584][BackendServer  ][Info   ] Started
[18:31:08.306][NamedPipeServer][Info   ] Version()
[18:31:08.308][NamedPipeServer][Info   ] Version done in 00:00:00.0019995.
[18:31:09.056][Updater        ][Info   ] Checking for updates on channel Stable...
[18:31:09.056][NamedPipeClient][Info   ] Sending Start(Docker.Core.Settings)...
[18:31:09.070][NamedPipeServer][Info   ] Start(Docker.Core.Settings)
[18:31:09.081][PowerMode      ][Info   ] Stop
[18:31:09.089][HyperV         ][Info   ] Stop
[18:31:09.119][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[18:31:09.270][Updater        ][Info   ] Local build 10072 is as good as the remote 10072 on channel Stable
[18:31:09.127][PowerShell     ][Info   ] Creating a Runspace Pool...
[18:31:10.082][PowerShell     ][Info   ] Runspace Pool created (Min=1, Max=2)
[18:31:10.511][HyperV         ][Info   ] Script started at 18:31:10.481
[18:31:18.611][HyperV         ][Info   ] Module loaded at 18:31:18.610
[18:31:19.492][HyperV         ][Info   ] VM MobyLinuxVM does not exist
[18:31:19.495][HyperV         ][Debug  ] [stop] took 00:00:10.4020714 to run
[18:31:19.496][OptimizeDisk   ][Info   ] Optimize
[18:31:19.499][PowerShell     ][Info   ] Run script...
[18:31:19.552][Moby           ][Info   ] Stop
[18:31:19.574][HyperVGuids    ][Info   ] Installing GUIDs...
[18:31:19.576][HyperV         ][Info   ] Create
[18:31:19.577][PowerMode      ][Info   ] Start
[18:31:19.577][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[18:31:19.580][HyperVGuids    ][Info   ] GUIDs installed
[18:31:19.592][Firewall       ][Info   ] Removing all existing rules...
[18:31:19.623][HyperV         ][Info   ] Script started at 18:31:19.621
[18:31:19.688][HyperV         ][Info   ] Module loaded at 18:31:19.688
[18:31:20.418][HyperV         ][Info   ] Creating Switch: DockerNAT...
[18:31:21.264][Firewall       ][Info   ] All existing rules are removed.
[18:31:21.268][Firewall       ][Info   ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe...
[18:31:24.807][Firewall       ][Info   ] Opening ports for SMB...
[18:31:26.703][HyperV         ][Info   ] Switch created.
[18:31:28.129][Firewall       ][Info   ] Ports are opened
[18:31:29.617][HyperV         ][Info   ] Set IP address on switch
[18:31:32.140][HyperV         ][Info   ] Creating VM MobyLinuxVM...
[18:31:36.130][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[18:31:37.311][HyperV         ][Info   ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx
[18:31:39.772][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[18:31:41.666][HyperV         ][Info   ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso
[18:31:45.475][HyperV         ][Info   ] VM created.
[18:31:45.476][HyperV         ][Debug  ] [create] took 00:00:25.8992227 to run
[18:31:45.476][PowerShell     ][Info   ] Run script '(Get-VM MobyLinuxVM).Id.Guid'...
[18:31:45.657][DataKit        ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.db.exe --url hyperv-connect://19d9e820-c56a-436e-b05e-cba6236f5859,\\.\pipe\dockerDataBase --color never
[18:31:45.665][DataKit        ][Info   ] Started
[18:31:45.678][Database       ][Info   ] Generating CA Cert Bundle
[18:31:45.826][DataKit        ][Info   ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...
[18:31:45.848][Database       ][Info   ] CA Cert Bundle Generated
[18:31:45.850][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/config=static
[18:31:45.850][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/network=hybrid
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[]}
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf=
[18:31:45.851][Database       ][Info   ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true
[18:31:45.860][DataKit        ][Error  ] com.docker.db.exe: Named-pipe connection failed on \\.\pipe\dockerDataBase: Unix.Unix_error(Unix.EPIPE, "connect", "")
[18:31:45.969][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:31:45.971][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:31:46.694][Database       ][Info   ] Successfully wrote 8 value(s)
[18:31:46.705][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/ssl/certs/ca-certificates.crt=C:\WINDOWS\TEMP\tmp138.tmp
[18:31:46.788][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:31:46.789][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:31:47.052][Database       ][Info   ] Successfully wrote value
[18:31:47.079][Moby           ][Info   ] Connecting...
[18:31:47.080][Moby           ][Error  ] Failed to read Moby's logs: Se excedió el tiempo de espera de la operación.
[18:31:47.087][HyperV         ][Info   ] Start
[18:31:47.088][PowerShell     ][Info   ] Run script with parameters: -Start True...
[18:31:47.110][PowerShell     ][Info   ] Run script '$(Find-NetRoute -RemoteIPAddress 8.8.8.8).InterfaceIndex[0]'...
[18:31:47.117][HyperV         ][Info   ] Script started at 18:31:47.116
[18:31:47.263][HyperV         ][Info   ] Module loaded at 18:31:47.262
[18:31:47.275][HyperV         ][Info   ] Starting VM MobyLinuxVM...
[18:31:48.244][HyperV         ][Debug  ] [start] took 00:00:01.1562463 to run
[18:31:49.085][Moby           ][Info   ] Connected
[18:31:49.323][Database       ][Info   ] Writing com.docker.driver.amd64-linux/slirp/dns=nameserver 192.168.0.1
search Home
[18:31:49.402][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:31:49.404][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:31:49.594][Database       ][Info   ] Successfully wrote 1 value(s)
[18:31:49.665][Moby           ][Info   ] early console in extract_kernel
[18:31:49.666][Moby           ][Info   ] input_data: 0x0000000001ec73b4
[18:31:49.666][Moby           ][Info   ] input_len: 0x000000000060b9c3
[18:31:49.666][Moby           ][Info   ] output: 0x0000000001000000
[18:31:49.666][Moby           ][Info   ] output_len: 0x00000000014c0910
[18:31:49.666][Moby           ][Info   ] kernel_total_size: 0x0000000001179000
[18:31:49.666][Moby           ][Info   ] 
[18:31:49.747][VpnKit         ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.slirp.exe --ethernet hyperv-connect://19d9e820-c56a-436e-b05e-cba6236f5859 --port hyperv-connect://19d9e820-c56a-436e-b05e-cba6236f5859 --db \\.\pipe\dockerDataBase --debug --diagnostics \\.\pipe\dockerVpnKitDiagnostics
[18:31:49.757][VpnKit         ][Info   ] Started
[18:31:49.759][Linux          ][Info   ] Trying to connect to vsud...
[18:31:49.874][VpnKit         ][Info   ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false)
[18:31:49.875][VpnKit         ][Info   ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals
[18:31:49.875][VpnKit         ][Info   ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version  %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.11.2 %HVSOCK_PINNED%
[18:31:49.875][VpnKit         ][Info   ] com.docker.slirp.exe: starting port forwarding server on port_control_url:hyperv-connect://19d9e820-c56a-436e-b05e-cba6236f5859 vsock_path:
[18:31:49.876][VpnKit         ][Info   ] com.docker.slirp.exe: connecting to 19d9e820-c56a-436e-b05e-cba6236f5859:0B95756A-9985-48AD-9470-78E060895BE7
[18:31:49.884][VpnKit         ][Info   ] com.docker.slirp.exe: connecting to 19d9e820-c56a-436e-b05e-cba6236f5859:30D48B34-7D27-4B0B-AAAF-BBBED334DD59
[18:31:49.885][VpnKit         ][Error  ] com.docker.slirp.exe: While watching /etc/resolv.conf: ENOENT
[18:31:49.886][VpnKit         ][Info   ] com.docker.slirp.exe: hosts file has bindings for nvdc.interoute.com
[18:31:52.283][Moby           ][Info   ] Decompressing Linux... Parsing ELF... done.
[18:31:52.285][Moby           ][Info   ] Booting the kernel.
[18:31:52.335][Moby           ][Info   ] Linux version 4.9.8-moby (root@1d811a9194c4) (gcc version 5.3.0 (Alpine 5.3.0) ) #1 SMP Wed Feb 8 09:56:43 UTC 2017
[18:31:52.366][Moby           ][Info   ] Command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate rootdelay=300 noautodetect
[18:31:52.366][Moby           ][Info   ] 
[18:31:52.387][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[18:31:52.408][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[18:31:52.450][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[18:31:52.467][Moby           ][Info   ] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[18:31:52.497][Moby           ][Info   ] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[18:31:52.497][Moby           ][Info   ] x86/fpu: Using 'eager' FPU context switches.
[18:31:52.498][Moby           ][Info   ] e820: BIOS-provided physical RAM map:
[18:31:52.510][Moby           ][Info   ] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[18:31:52.548][Moby           ][Info   ] BIOS-e820: [mem 0x0000000000100000-0x000000007eeedfff] usable
[18:31:52.574][Moby           ][Info   ] BIOS-e820: [mem 0x000000007eeee000-0x000000007eef1fff] ACPI data
[18:31:52.606][Moby           ][Info   ] BIOS-e820: [mem 0x000000007eef2000-0x000000007ef1afff] reserved
[18:31:52.621][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ef1b000-0x000000007ff9afff] usable
[18:31:52.636][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ff9b000-0x000000007fff2fff] reserved
[18:31:52.658][Moby           ][Info   ] BIOS-e820: [mem 0x000000007fff3000-0x000000007fffafff] ACPI data
[18:31:52.677][Moby           ][Info   ] BIOS-e820: [mem 0x000000007fffb000-0x000000007fffefff] ACPI NVS
[18:31:52.694][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ffff000-0x000000007fffffff] usable
[18:31:52.704][Moby           ][Info   ] bootconsole [earlyser0] enabled
[18:31:52.715][Moby           ][Info   ] NX (Execute Disable) protection: active
[18:31:52.729][Moby           ][Info   ] efi: EFI v2.31 by EDK II
[18:31:52.818][Moby           ][Info   ] efi:  ACPI=0x7fffa000  ACPI 2.0=0x7fffa014  SMBIOS=0x7fff2000  PROP=0x439b3d8  MEMATTR=0x7f51ed18 
[18:31:52.834][Moby           ][Info   ] SMBIOS 2.4 present.
[18:31:52.850][Moby           ][Info   ] Hypervisor detected: Microsoft HyperV
[18:31:52.880][Moby           ][Info   ] HyperV: features 0x2e7f, hints 0x2c2c
[18:31:52.901][Moby           ][Info   ] HyperV: LAPIC Timer Frequency: 0x1e8480
[18:31:52.925][Moby           ][Info   ] clocksource: hyperv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[18:31:52.950][Moby           ][Info   ] tsc: Marking TSC unstable due to running on Hyper-V
[18:31:52.976][Moby           ][Info   ] e820: last_pfn = 0x80000 max_arch_pfn = 0x400000000
[18:31:53.003][Moby           ][Info   ] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
[18:31:53.029][Moby           ][Info   ] Using GB pages for direct mapping
[18:31:53.041][Moby           ][Info   ] RAMDISK: [mem 0x77f05000-0x7b3e6fff]
[18:31:53.073][Moby           ][Info   ] ACPI: Early table checksum verification disabled
[18:31:53.153][Moby           ][Info   ] ACPI: RSDP 0x000000007FFFA014 000024 (v02 VRTUAL)
[18:31:53.210][Moby           ][Info   ] ACPI: XSDT 0x000000007FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.241][Moby           ][Info   ] ACPI: FACP 0x000000007FFF7000 0000F4 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.315][Moby           ][Info   ] ACPI: DSDT 0x000000007EEEF000 00256F (v02 MSFTVM DSDT01   00000001 MSFT 04000000)
[18:31:53.372][Moby           ][Info   ] ACPI: FACS 0x000000007FFFE000 000040
[18:31:53.456][Moby           ][Info   ] ACPI: APIC 0x000000007FFF8000 0007D2 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.498][Moby           ][Info   ] ACPI: OEM0 0x000000007FFF6000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.545][Moby           ][Info   ] ACPI: WAET 0x000000007FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.586][Moby           ][Info   ] ACPI: OEM1 0x000000007FFF4000 00009E (v02 MSFTVM UARTS    00000001 MSFT 04000000)
[18:31:53.622][Moby           ][Info   ] ACPI: OEM2 0x000000007FFF3000 0002E2 (v02 MSFTVM VTPM2    00000001 MSFT 04000000)
[18:31:53.661][Moby           ][Info   ] ACPI: SRAT 0x000000007EEEE000 000190 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:31:53.772][Moby           ][Info   ] Zone ranges:
[18:31:53.799][Moby           ][Info   ]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[18:31:53.840][Moby           ][Info   ]   DMA32    [mem 0x0000000001000000-0x000000007fffffff]
[18:31:53.872][Moby           ][Info   ]   Normal   empty
[18:31:53.888][Moby           ][Info   ] Movable zone start for each node
[18:31:53.906][Moby           ][Info   ] Early memory node ranges
[18:31:53.926][Moby           ][Info   ]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[18:31:53.930][Moby           ][Info   ]   node   0: [mem 0x0000000000100000-0x000000007eeedfff]
[18:31:53.954][Moby           ][Info   ]   node   0: [mem 0x000000007ef1b000-0x000000007ff9afff]
[18:31:53.971][Moby           ][Info   ]   node   0: [mem 0x000000007ffff000-0x000000007fffffff]
[18:31:54.003][Moby           ][Info   ] Initmem setup node 0 [mem 0x0000000000001000-0x000000007fffffff]
[18:31:54.078][Moby           ][Info   ] ACPI: PM-Timer IO Port: 0x408
[18:31:54.094][Moby           ][Info   ] ------------[ cut here ]------------
[18:31:54.125][Moby           ][Info   ] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/apic/apic.c:2065 __generic_processor_info+0x14d/0x258
[18:31:54.196][Moby           ][Info   ] Only 127 processors supported.Processor 128/0x80 and the rest are ignored.
[18:31:54.211][Moby           ][Info   ] Modules linked in:
[18:31:54.234][Moby           ][Info   ] CPU: 0 PID: 0 Comm: swapper Not tainted 4.9.8-moby #1
[18:31:54.341][Moby           ][Info   ] Hardware name: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v1.0 11/26/2012
[18:31:54.551][Moby           ][Info   ]  0000000000000000 ffffffff8141a4a5 ffffffff81e03d68 0000000000000000
[18:31:54.678][Moby           ][Info   ]  ffffffff810ddb53 0000000000000080 ffffffff81e03dc8 0000000000000000
[18:31:54.803][Moby           ][Info   ]  0000000000000014 0000000000000000 ffffffff81bc3173 ffffffff810ddbc6
[18:31:54.832][Moby           ][Info   ] Call Trace:
[18:31:54.849][Moby           ][Info   ]  [<ffffffff8141a4a5>] ? dump_stack+0x5a/0x6f
[18:31:54.883][Moby           ][Info   ]  [<ffffffff810ddb53>] ? __warn+0xd2/0xeb
[18:31:54.904][Moby           ][Info   ]  [<ffffffff810ddbc6>] ? warn_slowpath_fmt+0x5a/0x76
[18:31:54.935][Moby           ][Info   ]  [<ffffffff81fa564b>] ? __early_ioremap+0x13d/0x1bd
[18:31:54.958][Moby           ][Info   ]  [<ffffffff81041244>] ? native_flush_tlb_single+0x5/0x9
[18:31:54.987][Moby           ][Info   ]  [<ffffffff81038d14>] ? __generic_processor_info+0x14d/0x258
[18:31:55.003][Moby           ][Info   ]  [<ffffffff810351f5>] ? acpi_register_lapic+0x42/0x71
[18:31:55.027][Moby           ][Info   ]  [<ffffffff81f8c388>] ? acpi_parse_lapic+0x3e/0x43
[18:31:55.050][Moby           ][Info   ]  [<ffffffff81fb5a5a>] ? acpi_parse_entries_array+0xf4/0x152
[18:31:55.073][Moby           ][Info   ]  [<ffffffff81fb5c1b>] ? acpi_table_parse_entries_array+0xbb/0xee
[18:31:55.081][Moby           ][Info   ]  [<ffffffff81f8cd6e>] ? acpi_boot_init+0xee/0x44c
[18:31:55.104][Moby           ][Info   ]  [<ffffffff81043176>] ? pmd_val+0x7/0x8
[18:31:55.153][Moby           ][Info   ]  [<ffffffff810431ef>] ? pmd_page_vaddr+0x9/0x36
[18:31:55.189][Moby           ][Info   ]  [<ffffffff81f8c34a>] ? acpi_parse_x2apic_nmi+0x3c/0x3c
[18:31:55.235][Moby           ][Info   ]  [<ffffffff81f8c7b2>] ? dmi_ignore_irq0_timer_override+0x26/0x26
[18:31:55.272][Moby           ][Info   ]  [<ffffffff81f86549>] ? setup_arch+0x8c8/0x967
[18:31:55.306][Moby           ][Info   ]  [<ffffffff81f7bb80>] ? start_kernel+0xa9/0x440
[18:31:55.325][Moby           ][Info   ]  [<ffffffff81f7b120>] ? early_idt_handler_array+0x120/0x120
[18:31:55.336][Moby           ][Info   ]  [<ffffffff81f7b407>] ? x86_64_start_kernel+0x13f/0x161
[18:31:55.369][Moby           ][Info   ] ---[ end trace 4e33597f3ba6d817 ]---
[18:31:55.407][Moby           ][Info   ] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[18:31:55.513][Moby           ][Info   ] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23
[18:31:55.533][Moby           ][Info   ] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[18:31:55.561][Moby           ][Info   ] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[18:31:55.578][Moby           ][Info   ] Using ACPI (MADT) for SMP configuration information
[18:31:55.597][Moby           ][Info   ] smpboot: 240 Processors exceeds NR_CPUS limit of 128
[18:31:55.618][Moby           ][Info   ] smpboot: Allowing 128 CPUs, 126 hotplug CPUs
[18:31:55.637][Moby           ][Info   ] e820: [mem 0x80000000-0xffffffff] available for PCI devices
[18:31:55.656][Moby           ][Info   ] Booting paravirtualized kernel on bare hardware
[18:31:55.682][Moby           ][Info   ] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[18:31:55.714][Moby           ][Info   ] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:128 nr_node_ids:1
[18:31:55.784][Moby           ][Info   ] percpu: Embedded 35 pages/cpu @ffff880075e00000 s105112 r8192 d30056 u262144
[18:31:55.806][Moby           ][Info   ] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 515799
[18:31:55.825][Moby           ][Info   ] Kernel command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate rootdelay=300 noautodetect
[18:31:55.826][Moby           ][Info   ] 
[18:31:55.852][Moby           ][Info   ] log_buf_len individual max cpu contribution: 4096 bytes
[18:31:55.874][Moby           ][Info   ] log_buf_len total cpu_extra contributions: 520192 bytes
[18:31:55.898][Moby           ][Info   ] log_buf_len min size: 131072 bytes
[18:31:55.915][Moby           ][Info   ] log_buf_len: 1048576 bytes
[18:31:55.923][Moby           ][Info   ] early log buf free: 120604(92%)
[18:31:55.950][Moby           ][Info   ] PID hash table entries: 4096 (order: 3, 32768 bytes)
[18:31:55.973][Moby           ][Info   ] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[18:31:56.033][Moby           ][Info   ] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[18:31:56.191][Moby           ][Info   ] Memory: 1952056K/2096184K available (8467K kernel code, 1407K rwdata, 2848K rodata, 1380K init, 584K bss, 144128K reserved, 0K cma-reserved)
[18:31:56.323][Moby           ][Info   ] Hierarchical RCU implementation.
[18:31:56.353][Moby           ][Info   ]    Build-time adjustment of leaf fanout to 64.
[18:31:56.375][Moby           ][Info   ] Using NULL legacy PIC
[18:31:56.407][Moby           ][Info   ] NR_IRQS:8448 nr_irqs:1448 0
[18:31:56.485][Moby           ][Info   ] Console: colour dummy device 80x25
[18:31:56.560][Moby           ][Info   ] console [ttyS0] enabled
[18:31:56.577][Moby           ][Info   ] console [ttyS0] enabled
[18:31:56.609][Moby           ][Info   ] bootconsole [earlyser0] disabled
[18:31:56.623][Moby           ][Info   ] bootconsole [earlyser0] disabled
[18:31:57.085][Moby           ][Info   ] tsc: Fast TSC calibration failed
[18:31:57.122][Moby           ][Info   ] tsc: Unable to calibrate against PIT
[18:31:57.190][Moby           ][Info   ] tsc: using PMTIMER reference calibration
[18:31:57.253][Moby           ][Info   ] tsc: Detected 1972.311 MHz processor
[18:31:57.353][Moby           ][Info   ] Calibrating delay loop (skipped), value calculated using timer frequency.. 3944.62 BogoMIPS (lpj=19723110)
[18:31:57.377][Moby           ][Info   ] pid_max: default: 131072 minimum: 1024
[18:31:57.427][Moby           ][Info   ] ACPI: Core revision 20160831
[18:31:57.525][Moby           ][Info   ] ACPI: 1 ACPI AML tables successfully acquired and loaded
[18:31:57.556][Moby           ][Info   ] Security Framework initialized
[18:31:57.585][Moby           ][Info   ] Yama: becoming mindful.
[18:31:57.641][Moby           ][Info   ] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
[18:31:57.745][Moby           ][Info   ] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
[18:31:57.809][Moby           ][Info   ] CPU: Physical Processor ID: 0
[18:31:57.840][Moby           ][Info   ] CPU: Processor Core ID: 0
[18:31:57.855][Moby           ][Info   ] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 4
[18:31:57.884][Moby           ][Info   ] Last level dTLB entries: 4KB 512, 2MB 256, 4MB 128, 1GB 0
[18:31:57.916][Moby           ][Info   ] Freeing SMP alternatives memory: 24K (ffffffff820ba000 - ffffffff820c0000)
[18:31:57.965][Moby           ][Info   ] ftrace: allocating 37494 entries in 147 pages
[18:31:58.922][Moby           ][Info   ] smpboot: Max logical packages: 120
[18:31:59.766][Moby           ][Info   ] Switched APIC routing to physical flat.
[18:32:02.259][Moby           ][Info   ] smpboot: CPU0: AMD A8-6410 APU with AMD Radeon R5 Graphics (family: 0x16, model: 0x30, stepping: 0x1)
[18:32:03.756][Moby           ][Info   ] Performance Events: PMU not available due to virtualization, using software events only.
[18:32:04.555][Moby           ][Info   ] NMI watchdog: disabled (cpu0): hardware events not enabled
[18:32:05.040][Moby           ][Info   ] NMI watchdog: Shutting down hard lockup detector on all cpus
[18:32:05.272][Moby           ][Info   ] x86: Booting SMP configuration:
[18:32:06.462][Moby           ][Info   ] .... node  #0, CPUs:          #1calibrate_delay_direct() dropping max bogoMips estimate 3 = 20089199
[18:32:07.485][Moby           ][Info   ] calibrate_delay_direct() failed to get a good estimate for loops_per_jiffy.
[18:32:08.533][Moby           ][Info   ] Probably due to long platform interrupts. Consider using "lpj=" boot option.
[18:32:08.883][Moby           ][Info   ] x86: Booted up 1 node, 2 CPUs
[18:32:09.576][Moby           ][Info   ] smpboot: Total of 2 processors activated (6135.16 BogoMIPS)
[18:32:09.855][Moby           ][Info   ] devtmpfs: initialized
[18:32:10.134][Moby           ][Info   ] x86/mm: Memory block size: 128MB
[18:32:11.067][Moby           ][Info   ] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[18:32:11.317][Moby           ][Info   ] NET: Registered protocol family 16
[18:32:11.714][Moby           ][Info   ] cpuidle: using governor ladder
[18:32:11.976][Moby           ][Info   ] cpuidle: using governor menu
[18:32:12.367][Moby           ][Info   ] ACPI: bus type PCI registered
[18:32:12.913][Moby           ][Info   ] PCI: Fatal: No config space access function found
[18:32:13.576][Moby           ][Info   ] HugeTLB registered 1 GB page size, pre-allocated 0 pages
[18:32:14.167][Moby           ][Info   ] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[18:32:14.481][Moby           ][Info   ] ACPI: Added _OSI(Module Device)
[18:32:14.780][Moby           ][Info   ] ACPI: Added _OSI(Processor Device)
[18:32:15.170][Moby           ][Info   ] ACPI: Added _OSI(3.0 _SCP Extensions)
[18:32:15.519][Moby           ][Info   ] ACPI: Added _OSI(Processor Aggregator Device)
[18:32:16.176][Moby           ][Info   ] ACPI: Executed 1 blocks of module-level executable AML code
[18:32:16.826][Moby           ][Info   ] ACPI: Dynamic OEM Table Load:
[18:32:17.206][Moby           ][Info   ] ACPI: Interpreter enabled
[18:32:17.418][Moby           ][Info   ] ACPI: (supports S0 S5)
[18:32:17.805][Moby           ][Info   ] ACPI: Using IOAPIC for interrupt routing
[18:32:18.758][Moby           ][Info   ] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[18:32:19.168][Moby           ][Info   ] ACPI: Enabled 1 GPEs in block 00 to 0F
[18:32:19.332][Moby           ][Info   ] SCSI subsystem initialized
[18:32:19.759][Moby           ][Info   ] pps_core: LinuxPPS API ver. 1 registered
[18:32:20.306][Moby           ][Info   ] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[18:32:20.603][Moby           ][Info   ] PTP clock support registered
[18:32:20.928][Moby           ][Info   ] Registered efivars operations
[18:32:21.088][Moby           ][Info   ] wmi: Mapper loaded
[18:32:21.856][Moby           ][Info   ] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[18:32:22.457][Moby           ][Info   ] hv_vmbus: Hyper-V Host Build:14393-10.0-0-0.576; Vmbus version:4.0
[18:32:22.786][Moby           ][Info   ] PCI: Using ACPI for IRQ routing
[18:32:23.106][Moby           ][Info   ] PCI: System does not support PCI
[18:32:23.321][Moby           ][Info   ] NetLabel: Initializing
[18:32:23.591][Moby           ][Info   ] NetLabel:  domain hash size = 128
[18:32:23.936][Moby           ][Info   ] NetLabel:  protocols = UNLABELED CIPSOv4
[18:32:24.336][Moby           ][Info   ] NetLabel:  unlabeled traffic allowed by default
[18:32:25.236][Moby           ][Info   ] clocksource: Switched to clocksource hyperv_clocksource_tsc_page
[18:32:25.420][Moby           ][Info   ] FS-Cache: Loaded
[18:32:25.571][Moby           ][Info   ] CacheFiles: Loaded
[18:32:25.814][Moby           ][Info   ] pnp: PnP ACPI init
[18:32:26.178][Moby           ][Info   ] pnp: PnP ACPI: found 3 devices
[18:32:26.737][Moby           ][Info   ] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[18:32:27.001][Moby           ][Info   ] NET: Registered protocol family 2
[18:32:27.479][Moby           ][Info   ] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[18:32:27.892][Moby           ][Info   ] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
[18:32:28.353][Moby           ][Info   ] TCP: Hash tables configured (established 16384 bind 16384)
[18:32:28.768][Moby           ][Info   ] UDP hash table entries: 1024 (order: 3, 32768 bytes)
[18:32:29.204][Moby           ][Info   ] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes)
[18:32:29.519][Moby           ][Info   ] NET: Registered protocol family 1
[18:32:29.996][Moby           ][Info   ] RPC: Registered named UNIX socket transport module.
[18:32:30.402][Moby           ][Info   ] RPC: Registered udp transport module.
[18:32:30.697][Moby           ][Info   ] RPC: Registered tcp transport module.
[18:32:30.922][Moby           ][Info   ] random: fast init done
[18:32:31.470][Moby           ][Info   ] RPC: Registered tcp NFSv4.1 backchannel transport module.
[18:32:31.689][Moby           ][Info   ] Unpacking initramfs...
[18:32:36.474][Moby           ][Info   ] Freeing initrd memory: 54152K (ffff880077f05000 - ffff88007b3e7000)
[18:32:37.202][Moby           ][Info   ] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x38dc035ef11, max_idle_ns: 881590643443 ns
[18:32:37.672][Moby           ][Info   ] AVX2 or AES-NI instructions are not detected.
[18:32:37.955][Moby           ][Info   ] AVX2 instructions are not detected.
[18:32:38.429][Moby           ][Info   ] futex hash table entries: 32768 (order: 9, 2097152 bytes)
[18:32:38.812][Moby           ][Info   ] audit: initializing netlink subsys (disabled)
[18:32:39.268][Moby           ][Info   ] audit: type=2000 audit(1486837935.390:1): initialized
[18:32:39.639][Moby           ][Info   ] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[18:32:39.928][Moby           ][Info   ] FS-Cache: Netfs 'nfs' registered for caching
[18:32:40.246][Moby           ][Info   ] NFS: Registering the id_resolver key type
[18:32:40.528][Moby           ][Info   ] Key type id_resolver registered
[18:32:40.821][Moby           ][Info   ] Key type id_legacy registered
[18:32:41.443][Moby           ][Info   ] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[18:32:41.862][Moby           ][Info   ] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[18:32:42.204][Moby           ][Info   ] FS-Cache: Netfs 'cifs' registered for caching
[18:32:42.570][Moby           ][Info   ] ntfs: driver 2.1.32 [Flags: R/O].
[18:32:42.824][Moby           ][Info   ] fuse init (API version 7.26)
[18:32:43.288][Moby           ][Info   ] 9p: Installing v9fs 9p2000 file system support
[18:32:43.668][Moby           ][Info   ] FS-Cache: Netfs '9p' registered for caching
[18:32:43.879][Moby           ][Info   ] aufs 4.9-20170206
[18:32:44.165][Moby           ][Info   ] NET: Registered protocol family 38
[18:32:44.403][Moby           ][Info   ] Key type asymmetric registered
[18:32:44.670][Moby           ][Info   ] Asymmetric key parser 'x509' registered
[18:32:45.204][Moby           ][Info   ] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[18:32:45.418][Moby           ][Info   ] io scheduler noop registered
[18:32:45.832][Moby           ][Info   ] io scheduler deadline registered (default)
[18:32:46.071][Moby           ][Info   ] io scheduler cfq registered
[18:32:46.465][Moby           ][Info   ] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[18:32:46.931][Moby           ][Info   ] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[18:32:47.373][Moby           ][Info   ] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[18:32:47.621][Moby           ][Info   ] hv_vmbus: registering driver hyperv_fb
[18:32:47.844][Moby           ][Info   ] GHES: HEST is not enabled!
[18:32:48.355][Moby           ][Info   ] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[18:32:50.022][Linux          ][Error  ] Failed to start: Docker hv-sock proxy (vsudd) is not reachable. Let's retry
[18:32:50.028][PowerShell     ][Info   ] Run script...
[18:32:50.305][Moby           ][Info   ] 00:01: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[18:32:54.138][Moby           ][Info   ] 00:02: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[18:32:54.780][Moby           ][Info   ] Initializing Nozomi driver 2.1d
[18:32:55.269][Moby           ][Info   ] Non-volatile memory driver v1.3
[18:32:56.484][Moby           ][Info   ] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[18:32:56.966][Moby           ][Info   ] loop: module loaded
[18:32:57.504][Moby           ][Info   ] nbd: registered device at major 43
[18:32:58.009][Moby           ][Info   ] VMware PVSCSI driver - version 1.0.7.0-k
[18:32:58.599][Moby           ][Info   ] hv_vmbus: registering driver hv_storvsc
[18:32:58.978][Moby           ][Info   ] scsi host0: storvsc_host_t
[18:32:59.816][HyperV         ][Info   ] Hyper-V is running
[18:32:59.817][PowerMode      ][Info   ] Stop
[18:32:59.819][HyperV         ][Info   ] Stop
[18:32:59.820][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[18:32:59.856][HyperV         ][Info   ] Script started at 18:32:59.856
[18:33:00.202][Moby           ][Info   ] scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[18:33:01.204][HyperV         ][Info   ] Module loaded at 18:33:01.204
[18:33:01.495][HyperV         ][Info   ] Stopping VM MobyLinuxVM...
[18:33:01.645][Moby           ][Info   ] scsi 0:0:0:1: CD-ROM            Msft     Virtual DVD-ROM  1.0  PQ: 0 ANSI: 0
[18:33:03.255][Moby           ][Info   ] sd 0:0:0:0: [sda] 125829120 512-byte logical blocks: (64.4 GB/60.0 GiB)
[18:33:04.109][Moby           ][Info   ] sr 0:0:0:1: [sr0] scsi3-mmc drive: 0x/0x caddy
[18:33:04.899][Moby           ][Info   ] cdrom: Uniform CD-ROM driver Revision: 3.20
[18:33:05.713][Moby           ][Info   ] sd 0:0:0:0: Attached scsi generic sg0 type 0
[18:33:05.866][Moby           ][Info   ] sr 0
[18:33:05.870][Moby           ][Error  ] Failed to read Moby's logs: Se excedió el tiempo de espera de la operación.
[18:33:06.279][HyperV         ][Info   ] Turn Off VM ...
[18:33:06.374][HyperV         ][Info   ] VM MobyLinuxVM killed. Waiting for state to change
[18:33:07.433][HyperV         ][Info   ] Killed VM MobyLinuxVM is off
[18:33:07.438][HyperV         ][Info   ] Destroying Switch DockerNAT...
[18:33:10.824][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[18:33:11.120][HyperV         ][Debug  ] [stop] took 00:00:11.3005421 to run
[18:33:11.120][OptimizeDisk   ][Info   ] Optimize
[18:33:11.120][PowerShell     ][Info   ] Run script...
[18:33:11.158][Moby           ][Info   ] Stop
[18:33:11.172][VpnKit         ][Info   ] Killing existing com.docker.slirp with PID 352
[18:33:11.188][DataKit        ][Info   ] Killing existing com.docker.db with PID 4508
[18:33:11.215][HyperV         ][Info   ] Destroy
[18:33:11.216][PowerShell     ][Info   ] Run script with parameters: -Destroy True -KeepVolume True...
[18:33:11.255][HyperV         ][Info   ] Script started at 18:33:11.254
[18:33:11.312][HyperV         ][Info   ] Module loaded at 18:33:11.312
[18:33:11.356][HyperV         ][Info   ] VM MobyLinuxVM does not exist
[18:33:11.367][HyperV         ][Info   ] Destroying Switch DockerNAT...
[18:33:11.440][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[18:33:11.481][HyperV         ][Debug  ] [destroy] took 00:00:00.2655403 to run
[18:33:11.483][Firewall       ][Info   ] Closing ports...
[18:33:11.483][Firewall       ][Info   ] Removing all existing rules...
[18:33:12.845][Firewall       ][Info   ] Removing DockerProxy...
[18:33:14.361][Firewall       ][Info   ] Removed DockerProxy.
[18:33:15.619][Firewall       ][Info   ] Removing DockerSmbMount...
[18:33:16.989][Firewall       ][Info   ] Removed DockerSmbMount.
[18:33:18.266][Firewall       ][Info   ] All existing rules are removed.
[18:33:18.266][Firewall       ][Info   ] Ports are closed
[18:33:18.268][HyperVGuids    ][Info   ] Removing GUIDs...
[18:33:18.279][HyperVGuids    ][Info   ] GUIDs removed
[18:33:18.280][HyperV         ][Info   ] Create
[18:33:18.281][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[18:33:18.330][HyperV         ][Info   ] Script started at 18:33:18.329
[18:33:18.379][HyperV         ][Info   ] Module loaded at 18:33:18.378
[18:33:18.599][HyperV         ][Info   ] Creating Switch: DockerNAT...
[18:33:22.587][HyperV         ][Info   ] Switch created.
[18:33:23.356][HyperV         ][Info   ] Set IP address on switch
[18:33:23.466][HyperV         ][Info   ] Creating VM MobyLinuxVM...
[18:33:25.762][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[18:33:26.827][HyperV         ][Info   ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx
[18:33:28.421][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[18:33:29.685][HyperV         ][Info   ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso
[18:33:32.727][HyperV         ][Info   ] VM created.
[18:33:32.727][HyperV         ][Debug  ] [create] took 00:00:14.4461758 to run
[18:33:32.727][PowerMode      ][Info   ] Stop
[18:33:32.727][HyperV         ][Info   ] Stop
[18:33:32.728][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[18:33:32.779][HyperV         ][Info   ] Script started at 18:33:32.779
[18:33:32.833][HyperV         ][Info   ] Module loaded at 18:33:32.832
[18:33:32.940][HyperV         ][Info   ] VM MobyLinuxVM is stopped
[18:33:32.941][HyperV         ][Debug  ] [stop] took 00:00:00.2137081 to run
[18:33:32.941][OptimizeDisk   ][Info   ] Optimize
[18:33:32.941][PowerShell     ][Info   ] Run script...
[18:33:35.626][Moby           ][Info   ] Stop
[18:33:35.650][HyperVGuids    ][Info   ] Installing GUIDs...
[18:33:35.650][HyperV         ][Info   ] Create
[18:33:35.651][PowerMode      ][Info   ] Start
[18:33:35.651][PowerShell     ][Info   ] Run script with parameters: -Create True -VhdPathOverride  -SwitchSubnetAddress 10.0.75.0 -SwitchSubnetMaskSize 24 -CPUs 2 -Memory 2048 -IsoFile C:\Program Files\Docker\Docker\Resources\mobylinux.iso...
[18:33:35.651][Firewall       ][Info   ] Removing all existing rules...
[18:33:35.652][HyperVGuids    ][Info   ] GUIDs installed
[18:33:35.698][HyperV         ][Info   ] Script started at 18:33:35.697
[18:33:35.782][HyperV         ][Info   ] Module loaded at 18:33:35.782
[18:33:37.520][Firewall       ][Info   ] All existing rules are removed.
[18:33:37.521][Firewall       ][Info   ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe...
[18:33:37.681][HyperV         ][Info   ] Using existing Switch: DockerNAT
[18:33:38.363][HyperV         ][Info   ] Using existing Switch IP address
[18:33:38.650][HyperV         ][Info   ] Setting CPUs to 2 and Memory to 2048 MB
[18:33:40.827][HyperV         ][Info   ] Connect Internal Switch DockerNAT
[18:33:41.518][Firewall       ][Info   ] Opening ports for SMB...
[18:33:42.980][HyperV         ][Info   ] VM created.
[18:33:42.981][HyperV         ][Debug  ] [create] took 00:00:07.3297845 to run
[18:33:42.981][PowerShell     ][Info   ] Run script '(Get-VM MobyLinuxVM).Id.Guid'...
[18:33:43.134][DataKit        ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.db.exe --url hyperv-connect://3e4af7d2-750f-4a67-a7c9-0c1ade7b998b,\\.\pipe\dockerDataBase --color never
[18:33:43.145][DataKit        ][Info   ] Started
[18:33:43.148][Database       ][Info   ] Generating CA Cert Bundle
[18:33:43.282][Database       ][Info   ] CA Cert Bundle Generated
[18:33:43.300][DataKit        ][Info   ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...
[18:33:43.312][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/config=static
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/network=hybrid
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[]}
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf=
[18:33:43.313][Database       ][Info   ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true
[18:33:43.331][DataKit        ][Error  ] com.docker.db.exe: Named-pipe connection failed on \\.\pipe\dockerDataBase: Unix.Unix_error(Unix.EPIPE, "connect", "")
[18:33:43.458][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:33:43.482][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:33:45.343][Database       ][Info   ] Successfully wrote 8 value(s)
[18:33:45.344][Database       ][Info   ] Writing com.docker.driver.amd64-linux/etc/ssl/certs/ca-certificates.crt=C:\WINDOWS\TEMP\tmpCC16.tmp
[18:33:45.466][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:33:45.474][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:33:45.577][Firewall       ][Info   ] Ports are opened
[18:33:45.914][Database       ][Info   ] Successfully wrote value
[18:33:45.915][Moby           ][Info   ] Connecting...
[18:33:45.915][Moby           ][Error  ] Failed to read Moby's logs: Se excedió el tiempo de espera de la operación.
[18:33:45.916][HyperV         ][Info   ] Start
[18:33:45.916][PowerShell     ][Info   ] Run script '$(Find-NetRoute -RemoteIPAddress 8.8.8.8).InterfaceIndex[0]'...
[18:33:45.916][PowerShell     ][Info   ] Run script with parameters: -Start True...
[18:33:45.977][HyperV         ][Info   ] Script started at 18:33:45.976
[18:33:46.043][HyperV         ][Info   ] Module loaded at 18:33:46.043
[18:33:46.050][HyperV         ][Info   ] Starting VM MobyLinuxVM...
[18:33:46.220][Database       ][Info   ] Writing com.docker.driver.amd64-linux/slirp/dns=nameserver 192.168.0.1
search Home
[18:33:46.347][DataKit        ][Info   ] com.docker.db.exe: accepted a new connection on \\.\pipe\dockerDataBase
[18:33:46.362][DataKit        ][Info   ] com.docker.db.exe: Using protocol TwoThousand msize 16384
[18:33:46.951][Database       ][Info   ] Successfully wrote 1 value(s)
[18:33:47.153][VpnKit         ][Info   ] Starting C:\Program Files\Docker\Docker\Resources\com.docker.slirp.exe --ethernet hyperv-connect://3e4af7d2-750f-4a67-a7c9-0c1ade7b998b --port hyperv-connect://3e4af7d2-750f-4a67-a7c9-0c1ade7b998b --db \\.\pipe\dockerDataBase --debug --diagnostics \\.\pipe\dockerVpnKitDiagnostics
[18:33:47.157][VpnKit         ][Info   ] Started
[18:33:47.265][VpnKit         ][Info   ] com.docker.slirp.exe: Logging to stdout (stdout:true DEBUG:false)
[18:33:47.266][VpnKit         ][Info   ] com.docker.slirp.exe: Setting handler to ignore all SIGPIPE signals
[18:33:47.266][VpnKit         ][Info   ] com.docker.slirp.exe: vpnkit version %VERSION% with hostnet version  %HOSTNET_PINNED% uwt version 0.0.3 hvsock version 0.11.2 %HVSOCK_PINNED%
[18:33:47.266][VpnKit         ][Info   ] com.docker.slirp.exe: starting port forwarding server on port_control_url:hyperv-connect://3e4af7d2-750f-4a67-a7c9-0c1ade7b998b vsock_path:
[18:33:47.266][VpnKit         ][Info   ] com.docker.slirp.exe: connecting to 3e4af7d2-750f-4a67-a7c9-0c1ade7b998b:0B95756A-9985-48AD-9470-78E060895BE7
[18:33:47.282][VpnKit         ][Info   ] com.docker.slirp.exe: connecting to 3e4af7d2-750f-4a67-a7c9-0c1ade7b998b:30D48B34-7D27-4B0B-AAAF-BBBED334DD59
[18:33:47.282][VpnKit         ][Error  ] com.docker.slirp.exe: While watching /etc/resolv.conf: ENOENT
[18:33:47.284][VpnKit         ][Info   ] com.docker.slirp.exe: hosts file has bindings for nvdc.interoute.com
[18:33:47.388][HyperV         ][Debug  ] [start] took 00:00:01.4720813 to run
[18:33:47.388][Linux          ][Info   ] Trying to connect to vsud...
[18:33:47.919][Moby           ][Info   ] Connected
[18:33:48.961][Moby           ][Info   ] early console in extract_kernel
[18:33:48.966][Moby           ][Info   ] input_data: 0x0000000001ec73b4
[18:33:48.966][Moby           ][Info   ] input_len: 0x000000000060b9c3
[18:33:48.976][Moby           ][Info   ] output: 0x0000000001000000
[18:33:48.978][Moby           ][Info   ] output_len: 0x00000000014c0910
[18:33:48.979][Moby           ][Info   ] kernel_total_size: 0x0000000001179000
[18:33:48.979][Moby           ][Info   ] 
[18:33:52.576][Moby           ][Info   ] Decompressing Linux... Parsing ELF... done.
[18:33:52.580][Moby           ][Info   ] Booting the kernel.
[18:33:52.650][Moby           ][Info   ] Linux version 4.9.8-moby (root@1d811a9194c4) (gcc version 5.3.0 (Alpine 5.3.0) ) #1 SMP Wed Feb 8 09:56:43 UTC 2017
[18:33:52.677][Moby           ][Info   ] Command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate rootdelay=300 noautodetect
[18:33:52.677][Moby           ][Info   ] 
[18:33:52.699][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[18:33:52.718][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[18:33:52.724][Moby           ][Info   ] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[18:33:52.737][Moby           ][Info   ] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[18:33:52.759][Moby           ][Info   ] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[18:33:52.772][Moby           ][Info   ] x86/fpu: Using 'eager' FPU context switches.
[18:33:52.781][Moby           ][Info   ] e820: BIOS-provided physical RAM map:
[18:33:52.792][Moby           ][Info   ] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[18:33:52.811][Moby           ][Info   ] BIOS-e820: [mem 0x0000000000100000-0x000000007eeedfff] usable
[18:33:52.827][Moby           ][Info   ] BIOS-e820: [mem 0x000000007eeee000-0x000000007eef1fff] ACPI data
[18:33:52.842][Moby           ][Info   ] BIOS-e820: [mem 0x000000007eef2000-0x000000007ef1afff] reserved
[18:33:52.864][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ef1b000-0x000000007ff9afff] usable
[18:33:52.875][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ff9b000-0x000000007fff2fff] reserved
[18:33:52.888][Moby           ][Info   ] BIOS-e820: [mem 0x000000007fff3000-0x000000007fffafff] ACPI data
[18:33:52.904][Moby           ][Info   ] BIOS-e820: [mem 0x000000007fffb000-0x000000007fffefff] ACPI NVS
[18:33:52.915][Moby           ][Info   ] BIOS-e820: [mem 0x000000007ffff000-0x000000007fffffff] usable
[18:33:52.930][Moby           ][Info   ] bootconsole [earlyser0] enabled
[18:33:52.948][Moby           ][Info   ] NX (Execute Disable) protection: active
[18:33:52.966][Moby           ][Info   ] efi: EFI v2.31 by EDK II
[18:33:53.000][Moby           ][Info   ] efi:  ACPI=0x7fffa000  ACPI 2.0=0x7fffa014  SMBIOS=0x7fff2000  PROP=0x439b3d8  MEMATTR=0x7f51cd18 
[18:33:53.019][Moby           ][Info   ] SMBIOS 2.4 present.
[18:33:53.048][Moby           ][Info   ] Hypervisor detected: Microsoft HyperV
[18:33:53.083][Moby           ][Info   ] HyperV: features 0x2e7f, hints 0x2c2c
[18:33:53.101][Moby           ][Info   ] HyperV: LAPIC Timer Frequency: 0x1e8480
[18:33:53.113][Moby           ][Info   ] clocksource: hyperv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[18:33:53.125][Moby           ][Info   ] tsc: Marking TSC unstable due to running on Hyper-V
[18:33:53.133][Moby           ][Info   ] e820: last_pfn = 0x80000 max_arch_pfn = 0x400000000
[18:33:53.144][Moby           ][Info   ] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
[18:33:53.159][Moby           ][Info   ] Using GB pages for direct mapping
[18:33:53.171][Moby           ][Info   ] RAMDISK: [mem 0x77f05000-0x7b3e6fff]
[18:33:53.186][Moby           ][Info   ] ACPI: Early table checksum verification disabled
[18:33:53.225][Moby           ][Info   ] ACPI: RSDP 0x000000007FFFA014 000024 (v02 VRTUAL)
[18:33:53.274][Moby           ][Info   ] ACPI: XSDT 0x000000007FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.298][Moby           ][Info   ] ACPI: FACP 0x000000007FFF7000 0000F4 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.321][Moby           ][Info   ] ACPI: DSDT 0x000000007EEEF000 00256F (v02 MSFTVM DSDT01   00000001 MSFT 04000000)
[18:33:53.346][Moby           ][Info   ] ACPI: FACS 0x000000007FFFE000 000040
[18:33:53.364][Moby           ][Info   ] ACPI: APIC 0x000000007FFF8000 0007D2 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.399][Moby           ][Info   ] ACPI: OEM0 0x000000007FFF6000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.436][Moby           ][Info   ] ACPI: WAET 0x000000007FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.461][Moby           ][Info   ] ACPI: OEM1 0x000000007FFF4000 00009E (v02 MSFTVM UARTS    00000001 MSFT 04000000)
[18:33:53.482][Moby           ][Info   ] ACPI: OEM2 0x000000007FFF3000 0002E2 (v02 MSFTVM VTPM2    00000001 MSFT 04000000)
[18:33:53.510][Moby           ][Info   ] ACPI: SRAT 0x000000007EEEE000 000190 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[18:33:53.624][Moby           ][Info   ] Zone ranges:
[18:33:53.670][Moby           ][Info   ]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[18:33:53.697][Moby           ][Info   ]   DMA32    [mem 0x0000000001000000-0x000000007fffffff]
[18:33:53.767][Moby           ][Info   ]   Normal   empty
[18:33:53.778][Moby           ][Info   ] Movable zone start for each node
[18:33:53.789][Moby           ][Info   ] Early memory node ranges
[18:33:53.806][Moby           ][Info   ]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[18:33:53.821][Moby           ][Info   ]   node   0: [mem 0x0000000000100000-0x000000007eeedfff]
[18:33:53.830][Moby           ][Info   ]   node   0: [mem 0x000000007ef1b000-0x000000007ff9afff]
[18:33:53.838][Moby           ][Info   ]   node   0: [mem 0x000000007ffff000-0x000000007fffffff]
[18:33:53.858][Moby           ][Info   ] Initmem setup node 0 [mem 0x0000000000001000-0x000000007fffffff]
[18:33:53.898][Moby           ][Info   ] ACPI: PM-Timer IO Port: 0x408
[18:33:53.918][Moby           ][Info   ] ------------[ cut here ]------------
[18:33:53.935][Moby           ][Info   ] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/apic/apic.c:2065 __generic_processor_info+0x14d/0x258
[18:33:53.946][Moby           ][Info   ] Only 127 processors supported.Processor 128/0x80 and the rest are ignored.
[18:33:53.967][Moby           ][Info   ] Modules linked in:
[18:33:53.977][Moby           ][Info   ] CPU: 0 PID: 0 Comm: swapper Not tainted 4.9.8-moby #1
[18:33:53.999][Moby           ][Info   ] Hardware name: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v1.0 11/26/2012
[18:33:54.079][Moby           ][Info   ]  0000000000000000 ffffffff8141a4a5 ffffffff81e03d68 0000000000000000
[18:33:54.138][Moby           ][Info   ]  ffffffff810ddb53 0000000000000080 ffffffff81e03dc8 0000000000000000
[18:33:54.186][Moby           ][Info   ]  0000000000000014 0000000000000000 ffffffff81bc3173 ffffffff810ddbc6
[18:33:54.195][Moby           ][Info   ] Call Trace:
[18:33:54.205][Moby           ][Info   ]  [<ffffffff8141a4a5>] ? dump_stack+0x5a/0x6f
[18:33:54.217][Moby           ][Info   ]  [<ffffffff810ddb53>] ? __warn+0xd2/0xeb
[18:33:54.228][Moby           ][Info   ]  [<ffffffff810ddbc6>] ? warn_slowpath_fmt+0x5a/0x76
[18:33:54.245][Moby           ][Info   ]  [<ffffffff81fa564b>] ? __early_ioremap+0x13d/0x1bd
[18:33:54.261][Moby           ][Info   ]  [<ffffffff81041244>] ? native_flush_tlb_single+0x5/0x9
[18:33:54.278][Moby           ][Info   ]  [<ffffffff81038d14>] ? __generic_processor_info+0x14d/0x258
[18:33:54.284][Moby           ][Info   ]  [<ffffffff810351f5>] ? acpi_register_lapic+0x42/0x71
[18:33:54.300][Moby           ][Info   ]  [<ffffffff81f8c388>] ? acpi_parse_lapic+0x3e/0x43
[18:33:54.314][Moby           ][Info   ]  [<ffffffff81fb5a5a>] ? acpi_parse_entries_array+0xf4/0x152
[18:33:54.331][Moby           ][Info   ]  [<ffffffff81fb5c1b>] ? acpi_table_parse_entries_array+0xbb/0xee
[18:33:54.344][Moby           ][Info   ]  [<ffffffff81f8cd6e>] ? acpi_boot_init+0xee/0x44c
[18:33:54.357][Moby           ][Info   ]  [<ffffffff81043176>] ? pmd_val+0x7/0x8
[18:33:54.374][Moby           ][Info   ]  [<ffffffff810431ef>] ? pmd_page_vaddr+0x9/0x36
[18:33:54.393][Moby           ][Info   ]  [<ffffffff81f8c34a>] ? acpi_parse_x2apic_nmi+0x3c/0x3c
[18:33:54.401][Moby           ][Info   ]  [<ffffffff81f8c7b2>] ? dmi_ignore_irq0_timer_override+0x26/0x26
[18:33:54.425][Moby           ][Info   ]  [<ffffffff81f86549>] ? setup_arch+0x8c8/0x967
[18:33:54.440][Moby           ][Info   ]  [<ffffffff81f7bb80>] ? start_kernel+0xa9/0x440
[18:33:54.460][Moby           ][Info   ]  [<ffffffff81f7b120>] ? early_idt_handler_array+0x120/0x120
[18:33:54.475][Moby           ][Info   ]  [<ffffffff81f7b407>] ? x86_64_start_kernel+0x13f/0x161
[18:33:54.488][Moby           ][Info   ] ---[ end trace 739704b63fca10d2 ]---
[18:33:54.496][Moby           ][Info   ] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[18:33:54.521][Moby           ][Info   ] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23
[18:33:54.533][Moby           ][Info   ] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[18:33:54.549][Moby           ][Info   ] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[18:33:54.560][Moby           ][Info   ] Using ACPI (MADT) for SMP configuration information
[18:33:54.581][Moby           ][Info   ] smpboot: 240 Processors exceeds NR_CPUS limit of 128
[18:33:54.596][Moby           ][Info   ] smpboot: Allowing 128 CPUs, 126 hotplug CPUs
[18:33:54.617][Moby           ][Info   ] e820: [mem 0x80000000-0xffffffff] available for PCI devices
[18:33:54.648][Moby           ][Info   ] Booting paravirtualized kernel on bare hardware
[18:33:54.665][Moby           ][Info   ] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[18:33:54.682][Moby           ][Info   ] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:128 nr_node_ids:1
[18:33:54.751][Moby           ][Info   ] percpu: Embedded 35 pages/cpu @ffff880075e00000 s105112 r8192 d30056 u262144
[18:33:54.769][Moby           ][Info   ] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 515799
[18:33:54.798][Moby           ][Info   ] Kernel command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate rootdelay=300 noautodetect
[18:33:54.799][Moby           ][Info   ] 
[18:33:54.832][Moby           ][Info   ] log_buf_len individual max cpu contribution: 4096 bytes
[18:33:54.863][Moby           ][Info   ] log_buf_len total cpu_extra contributions: 520192 bytes
[18:33:54.882][Moby           ][Info   ] log_buf_len min size: 131072 bytes
[18:33:54.900][Moby           ][Info   ] log_buf_len: 1048576 bytes
[18:33:54.910][Moby           ][Info   ] early log buf free: 120604(92%)
[18:33:54.937][Moby           ][Info   ] PID hash table entries: 4096 (order: 3, 32768 bytes)
[18:33:54.952][Moby           ][Info   ] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[18:33:54.972][Moby           ][Info   ] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[18:33:55.048][Moby           ][Info   ] Memory: 1952024K/2096184K available (8467K kernel code, 1407K rwdata, 2848K rodata, 1380K init, 584K bss, 144160K reserved, 0K cma-reserved)
[18:33:55.075][Moby           ][Info   ] Hierarchical RCU implementation.
[18:33:55.083][Moby           ][Info   ]    Build-time adjustment of leaf fanout to 64.
[18:33:55.110][Moby           ][Info   ] Using NULL legacy PIC
[18:33:55.124][Moby           ][Info   ] NR_IRQS:8448 nr_irqs:1448 0
[18:33:55.147][Moby           ][Info   ] Console: colour dummy device 80x25
[18:33:55.179][Moby           ][Info   ] console [ttyS0] enabled
[18:33:55.190][Moby           ][Info   ] console [ttyS0] enabled
[18:33:55.200][Moby           ][Info   ] bootconsole [earlyser0] disabled
[18:33:55.211][Moby           ][Info   ] bootconsole [earlyser0] disabled
[18:33:55.528][Moby           ][Info   ] tsc: Fast TSC calibration failed
[18:33:55.541][Moby           ][Info   ] tsc: Unable to calibrate against PIT
[18:33:55.566][Moby           ][Info   ] tsc: using PMTIMER reference calibration
[18:33:55.595][Moby           ][Info   ] tsc: Detected 2014.244 MHz processor
[18:33:55.638][Moby           ][Info   ] Calibrating delay loop (skipped), value calculated using timer frequency.. 4028.48 BogoMIPS (lpj=20142440)
[18:33:55.666][Moby           ][Info   ] pid_max: default: 131072 minimum: 1024
[18:33:55.679][Moby           ][Info   ] ACPI: Core revision 20160831
[18:33:55.739][Moby           ][Info   ] ACPI: 1 ACPI AML tables successfully acquired and loaded
[18:33:55.765][Moby           ][Info   ] Security Framework initialized
[18:33:55.786][Moby           ][Info   ] Yama: becoming mindful.
[18:33:55.816][Moby           ][Info   ] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
[18:33:55.838][Moby           ][Info   ] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
[18:33:55.871][Moby           ][Info   ] CPU: Physical Processor ID: 0
[18:33:55.894][Moby           ][Info   ] CPU: Processor Core ID: 0
[18:33:55.924][Moby           ][Info   ] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 4
[18:33:55.976][Moby           ][Info   ] Last level dTLB entries: 4KB 512, 2MB 256, 4MB 128, 1GB 0
[18:33:56.027][Moby           ][Info   ] Freeing SMP alternatives memory: 24K (ffffffff820ba000 - ffffffff820c0000)
[18:33:56.065][Moby           ][Info   ] ftrace: allocating 37494 entries in 147 pages
[18:33:57.019][Moby           ][Info   ] smpboot: Max logical packages: 120
[18:33:57.679][Moby           ][Info   ] Switched APIC routing to physical flat.
[18:33:59.662][Moby           ][Info   ] smpboot: CPU0: AMD A8-6410 APU with AMD Radeon R5 Graphics (family: 0x16, model: 0x30, stepping: 0x1)
[18:34:01.249][Moby           ][Info   ] Performance Events: PMU not available due to virtualization, using software events only.
[18:34:02.282][Moby           ][Info   ] NMI watchdog: disabled (cpu0): hardware events not enabled
[18:34:03.400][Moby           ][Info   ] NMI watchdog: Shutting down hard lockup detector on all cpus
[18:34:03.987][Moby           ][Info   ] x86: Booting SMP configuration:
[18:34:06.346][Moby           ][Info   ] .... node  #0, CPUs:          #1calibrate_delay_direct() dropping max bogoMips estimate 0 = 17502259
[18:34:07.394][Moby           ][Info   ] calibrate_delay_direct() failed to get a good estimate for loops_per_jiffy.
[18:34:08.326][Moby           ][Info   ] Probably due to long platform interrupts. Consider using "lpj=" boot option.
[18:34:08.713][Moby           ][Info   ] x86: Booted up 1 node, 2 CPUs
[18:34:09.181][Moby           ][Info   ] smpboot: Total of 2 processors activated (6042.08 BogoMIPS)
[18:34:09.429][Moby           ][Info   ] devtmpfs: initialized
[18:34:09.764][Moby           ][Info   ] x86/mm: Memory block size: 128MB
[18:34:10.560][Moby           ][Info   ] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[18:34:10.876][Moby           ][Info   ] NET: Registered protocol family 16
[18:34:11.195][Moby           ][Info   ] cpuidle: using governor ladder
[18:34:11.480][Moby           ][Info   ] cpuidle: using governor menu
[18:34:11.776][Moby           ][Info   ] ACPI: bus type PCI registered
[18:34:12.196][Moby           ][Info   ] PCI: Fatal: No config space access function found
[18:34:12.728][Moby           ][Info   ] HugeTLB registered 1 GB page size, pre-allocated 0 pages
[18:34:13.169][Moby           ][Info   ] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[18:34:13.450][Moby           ][Info   ] ACPI: Added _OSI(Module Device)
[18:34:13.781][Moby           ][Info   ] ACPI: Added _OSI(Processor Device)
[18:34:14.087][Moby           ][Info   ] ACPI: Added _OSI(3.0 _SCP Extensions)
[18:34:14.427][Moby           ][Info   ] ACPI: Added _OSI(Processor Aggregator Device)
[18:34:15.082][Moby           ][Info   ] ACPI: Executed 1 blocks of module-level executable AML code
[18:34:15.317][Moby           ][Info   ] ACPI: Dynamic OEM Table Load:
[18:34:15.485][Moby           ][Info   ] ACPI: Interpreter enabled
[18:34:15.710][Moby           ][Info   ] ACPI: (supports S0 S5)
[18:34:16.056][Moby           ][Info   ] ACPI: Using IOAPIC for interrupt routing
[18:34:16.616][Moby           ][Info   ] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[18:34:17.045][Moby           ][Info   ] ACPI: Enabled 1 GPEs in block 00 to 0F
[18:34:17.338][Moby           ][Info   ] SCSI subsystem initialized
[18:34:17.683][Moby           ][Info   ] pps_core: LinuxPPS API ver. 1 registered
[18:34:18.409][Moby           ][Info   ] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[18:34:18.661][Moby           ][Info   ] PTP clock support registered
[18:34:18.925][Moby           ][Info   ] Registered efivars operations
[18:34:19.122][Moby           ][Info   ] wmi: Mapper loaded
[18:34:19.933][Moby           ][Info   ] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[18:34:20.346][Moby           ][Info   ] hv_vmbus: Hyper-V Host Build:14393-10.0-0-0.576; Vmbus version:4.0
[18:34:20.606][Moby           ][Info   ] PCI: Using ACPI for IRQ routing
[18:34:20.944][Moby           ][Info   ] PCI: System does not support PCI
[18:34:21.248][Moby           ][Info   ] NetLabel: Initializing
[18:34:22.049][Moby           ][Info   ] NetLabel:  domain hash size = 128
[18:34:22.439][Moby           ][Info   ] NetLabel:  protocols = UNLABELED CIPSOv4
[18:34:22.859][Moby           ][Info   ] NetLabel:  unlabeled traffic allowed by default
[18:34:23.475][Moby           ][Info   ] clocksource: Switched to clocksource hyperv_clocksource_tsc_page
[18:34:23.737][Moby           ][Info   ] FS-Cache: Loaded
[18:34:23.884][Moby           ][Info   ] CacheFiles: Loaded
[18:34:24.026][Moby           ][Info   ] pnp: PnP ACPI init
[18:34:24.279][Moby           ][Info   ] pnp: PnP ACPI: found 3 devices
[18:34:25.126][Moby           ][Info   ] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[18:34:25.347][Moby           ][Info   ] random: fast init done
[18:34:25.681][Moby           ][Info   ] NET: Registered protocol family 2
[18:34:26.220][Moby           ][Info   ] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[18:34:26.756][Moby           ][Info   ] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
[18:34:27.351][Moby           ][Info   ] TCP: Hash tables configured (established 16384 bind 16384)
[18:34:27.826][Moby           ][Info   ] UDP hash table entries: 1024 (order: 3, 32768 bytes)
[18:34:28.294][Moby           ][Info   ] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes)
[18:34:28.573][Moby           ][Info   ] NET: Registered protocol family 1
[18:34:29.104][Moby           ][Info   ] RPC: Registered named UNIX socket transport module.
[18:34:29.406][Moby           ][Info   ] RPC: Registered udp transport module.
[18:34:29.697][Moby           ][Info   ] RPC: Registered tcp transport module.
[18:34:30.323][Moby           ][Info   ] RPC: Registered tcp NFSv4.1 backchannel transport module.
[18:34:30.503][Moby           ][Info   ] Unpacking initramfs...
[18:34:35.096][Moby           ][Info   ] Freeing initrd memory: 54152K (ffff880077f05000 - ffff88007b3e7000)
[18:34:35.874][Moby           ][Info   ] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1d08bdfb9a1, max_idle_ns: 440795263195 ns
[18:34:36.259][Moby           ][Info   ] AVX2 or AES-NI instructions are not detected.
[18:34:36.591][Moby           ][Info   ] AVX2 instructions are not detected.
[18:34:37.148][Moby           ][Info   ] futex hash table entries: 32768 (order: 9, 2097152 bytes)
[18:34:37.562][Moby           ][Info   ] audit: initializing netlink subsys (disabled)
[18:34:38.027][Moby           ][Info   ] audit: type=2000 audit(1486838054.650:1): initialized
[18:34:38.512][Moby           ][Info   ] workingset: timestamp_bits=46 max_order=19 bucket_order=0
[18:34:38.790][Moby           ][Info   ] FS-Cache: Netfs 'nfs' registered for caching
[18:34:39.208][Moby           ][Info   ] NFS: Registering the id_resolver key type
[18:34:39.492][Moby           ][Info   ] Key type id_resolver registered
[18:34:39.706][Moby           ][Info   ] Key type id_legacy registered
[18:34:40.315][Moby           ][Info   ] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[18:34:40.676][Moby           ][Info   ] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[18:34:41.012][Moby           ][Info   ] FS-Cache: Netfs 'cifs' registered for caching
[18:34:41.364][Moby           ][Info   ] ntfs: driver 2.1.32 [Flags: R/O].
[18:34:41.675][Moby           ][Info   ] fuse init (API version 7.26)
[18:34:42.075][Moby           ][Info   ] 9p: Installing v9fs 9p2000 file system support
[18:34:42.518][Moby           ][Info   ] FS-Cache: Netfs '9p' registered for caching
[18:34:42.711][Moby           ][Info   ] aufs 4.9-20170206
[18:34:42.952][Moby           ][Info   ] NET: Registered protocol family 38
[18:34:43.258][Moby           ][Info   ] Key type asymmetric registered
[18:34:43.617][Moby           ][Info   ] Asymmetric key parser 'x509' registered
[18:34:44.174][Moby           ][Info   ] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[18:34:44.397][Moby           ][Info   ] io scheduler noop registered
[18:34:44.818][Moby           ][Info   ] io scheduler deadline registered (default)
[18:34:45.088][Moby           ][Info   ] io scheduler cfq registered
[18:34:45.495][Moby           ][Info   ] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[18:34:46.095][Moby           ][Info   ] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[18:34:46.535][Moby           ][Info   ] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[18:34:46.887][Moby           ][Info   ] hv_vmbus: registering driver hyperv_fb
[18:34:47.176][Moby           ][Info   ] GHES: HEST is not enabled!
[18:34:47.546][PowerMode      ][Info   ] Stop
[18:34:47.548][HyperV         ][Info   ] Stop
[18:34:47.550][PowerShell     ][Info   ] Run script with parameters: -Stop True...
[18:34:47.600][HyperV         ][Info   ] Script started at 18:34:47.600
[18:34:47.683][HyperV         ][Info   ] Module loaded at 18:34:47.677
[18:34:47.979][HyperV         ][Info   ] Stopping VM MobyLinuxVM...
[18:34:48.389][Moby           ][Info   ] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[18:34:52.270][Moby           ][Info   ] 00:01: ttyS0 at I/O 0x3f8 (irq = 4
[18:34:52.271][Moby           ][Error  ] Failed to read Moby's logs: Se excedió el tiempo de espera de la operación.
[18:34:52.627][HyperV         ][Info   ] Turn Off VM ...
[18:34:52.689][HyperV         ][Info   ] VM MobyLinuxVM killed. Waiting for state to change
[18:34:53.739][HyperV         ][Info   ] Killed VM MobyLinuxVM is off
[18:34:53.743][HyperV         ][Info   ] Destroying Switch DockerNAT...
[18:34:57.025][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[18:34:57.387][HyperV         ][Debug  ] [stop] took 00:00:09.8387518 to run
[18:34:57.387][OptimizeDisk   ][Info   ] Optimize
[18:34:57.387][PowerShell     ][Info   ] Run script...
[18:34:57.439][Moby           ][Info   ] Stop
[18:34:57.452][VpnKit         ][Info   ] Killing existing com.docker.slirp with PID 9220
[18:34:57.469][DataKit        ][Info   ] Killing existing com.docker.db with PID 9232
[18:34:57.480][HyperV         ][Info   ] Destroy
[18:34:57.481][PowerShell     ][Info   ] Run script with parameters: -Destroy True -KeepVolume True...
[18:34:57.518][HyperV         ][Info   ] Script started at 18:34:57.518
[18:34:57.582][HyperV         ][Info   ] Module loaded at 18:34:57.581
[18:34:57.624][HyperV         ][Info   ] VM MobyLinuxVM does not exist
[18:34:57.627][HyperV         ][Info   ] Destroying Switch DockerNAT...
[18:34:57.713][HyperV         ][Info   ] Removing VM MobyLinuxVM...
[18:34:57.754][HyperV         ][Debug  ] [destroy] took 00:00:00.2735399 to run
[18:34:57.754][Firewall       ][Info   ] Closing ports...
[18:34:57.754][Firewall       ][Info   ] Removing all existing rules...
[18:34:59.285][Firewall       ][Info   ] Removing DockerProxy...
[18:35:00.849][Firewall       ][Info   ] Removed DockerProxy.
[18:35:02.330][Firewall       ][Info   ] Removing DockerSmbMount...
[18:35:03.791][Firewall       ][Info   ] Removed DockerSmbMount.
[18:35:05.143][Firewall       ][Info   ] All existing rules are removed.
[18:35:05.168][NamedPipeClient][Error  ] Unable to send Start: Docker hv-sock proxy (vsudd) is not reachable
[18:35:05.174][Notifications  ][Error  ] Docker hv-sock proxy (vsudd) is not reachable
[18:35:05.144][Firewall       ][Info   ] Ports are closed
[18:35:05.144][HyperVGuids    ][Info   ] Removing GUIDs...
[18:35:05.147][HyperVGuids    ][Info   ] GUIDs removed
[18:35:05.153][NamedPipeServer][Error  ] Unable to execute Start: Docker hv-sock proxy (vsudd) is not reachable    en Docker.Backend.ContainerEngine.Linux.ConnectToVsud(TaskCompletionSource`1 vmId)
   en Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings)
   en Docker.Backend.ContainerEngine.Linux.Start(Settings settings)
   en Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.<Register>b__0(Object[] parameters)
   en Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)
[18:35:43.849][ErrorReportWindow][Info   ] Open logs
brooksa321 commented 7 years ago

+1 Same issue

jazmatician commented 7 years ago

+1 very nearly the same issue [23:18:26.910][NamedPipeServer][Error ] Unable to execute Start: The operation has timed out. at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass8_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

rn commented 7 years ago

@brooksa321 @jazmatician could you please file a separate issue with a diagnostics ID. The error message can have several different cause and seperate issues will allow us to triage these separately.

rn commented 7 years ago

@neoaisac The main issue is that on your system the Linux VM is booting quite slowly. Normally the system VM boots in around 10s. On your system even the kernel boot takes more than 60s We have a timeout value of 60s (which is quite conservative) and this is exceeded on your system.

Is there other load on the system? How old is the system?

neoaisac commented 7 years ago

The system is 1yo.

On 13 Feb 2017 2:50 pm, "Rolf Neugebauer" notifications@github.com wrote:

@neoaisac https://github.com/neoaisac The main issue is that on your system the Linux VM is booting quite slowly. Normally the system VM boots in around 10s. On your system even the kernel boot takes more than 60s We have a timeout value of 60s (which is quite conservative) and this is exceeded on your system.

Is there other load on the system? How old is the system?

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/docker/for-win/issues/488#issuecomment-279412819, or mute the thread https://github.com/notifications/unsubscribe-auth/AHc7Th548eKkRtBRCNyhWrrk9gox3OCVks5rcG2sgaJpZM4L-cYv .

rn commented 6 years ago

closing old issue

docker-robott commented 4 years ago

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

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

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