docker / for-win

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

Docker hv-sock proxy (vsudd) is not reachable #1013

Closed samarkumar1 closed 6 years ago

samarkumar1 commented 7 years ago

Expected behavior

Docker should run as linux container when start from window 10 machine

Actual behavior

getting below error Docker hv-sock proxy (vsudd) is not reachable at Docker.Backend.ContainerEngine.Linux.ConnectToVsud(TaskCompletionSource`1 vmId) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass9_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters)

Information

Details log as below: Version: 17.06.0-ce-win19 (12801) Channel: stable Sha1: c98c1c25e05a39ca8ef5394baa1d68f92f8e5008 Started on: 2017/08/17 13:54:02.492 Resources: C:\Program Files\Docker\Docker\Resources OS: Windows 10 Enterprise 2016 LTSB Edition: EnterpriseS Id: 1607 Build: 14393 BuildLabName: 14393.1480.amd64fre.rs1_release.170706-2004 File: C:\Users\g73kuma\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 [13:54:12.559][GUI ][Info ] Starting... [13:54:31.287][Tracking ][Info ] Crash report and usage statistics are enabled [13:54:31.290][SegmentApi ][Info ] Usage statistic: appLaunched [13:54:31.511][NamedPipeClient][Info ] Sending Version()... [13:54:31.540][SegmentApi ][Error ] Failed to track event appLaunched: An error occurred while sending the request. [13:54:31.686][NamedPipeClient][Info ] Received response for Version [13:54:31.691][SegmentApi ][Info ] Usage statistic: heartbeat [13:54:31.711][SegmentApi ][Error ] Failed to track event heartbeat: An error occurred while sending the request. [13:51:13.594][BackendServer ][Info ] Started [13:54:31.629][NamedPipeServer][Info ] Version() [13:54:31.650][NamedPipeServer][Info ] Version done in 00:00:00.0010005. [13:54:33.035][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [13:54:33.046][Updater ][Info ] Checking for updates on channel stable... [13:54:33.095][NamedPipeServer][Info ] Start(Docker.Core.Settings) [13:54:33.146][PowerShell ][Info ] Run script... [13:54:33.164][UpdateFeedDownloader][Error ] The remote server returned an error: (407) Proxy Authentication Required. [13:54:33.164][Updater ][Info ] No update available [13:54:33.148][PowerShell ][Info ] Creating a Runspace Pool... [13:54:41.856][PowerShell ][Info ] Runspace Pool created (Min=1, Max=2) [13:55:23.474][PowerShell ][Info ] Run script... [13:55:29.422][ContainerEngineHelper][Error ] Might have failed to kill a running dockerd process: Process with an Id of 14648 is not running. [13:55:30.029][WindowsDockerDaemon][Info ] Starting C:\Program Files\Docker\Docker\Resources\dockerd.exe -H npipe:////./pipe/docker_engine_windows -G "ENT\g73kuma" [13:55:32.806][WindowsDockerDaemon][Info ] Started [13:55:33.501][WindowsDockerDaemon][Warning] time="2017-08-17T13:55:33-07:00" msg="Running experimental build" [13:55:33.574][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:33.574777200-07:00" msg="Listener created for HTTP on npipe (//./pipe/docker_engine_windows)" [13:55:36.395][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:36.395779100-07:00" msg="Windows default isolation mode: hyperv" [13:55:36.395][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.395779100-07:00" msg="Using default logging driver json-file" [13:55:36.463][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.463777400-07:00" msg="Stackdump - waiting signal at Global\docker-daemon-9360" [13:55:36.515][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.515780600-07:00" msg="WindowsGraphDriver InitFilter at C:\ProgramData\Docker\windowsfilter" [13:55:36.516][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.515780600-07:00" msg="Using graph driver windowsfilter" [13:55:36.531][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.531778700-07:00" msg="Max Concurrent Downloads: 3" [13:55:36.531][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:36.531778700-07:00" msg="Max Concurrent Uploads: 5" [13:55:37.200][ApiProxy ][Info ] docker proxy (on deprecated port): ready [13:55:37.206][ApiProxy ][Info ] docker proxy: ready [13:55:37.332][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:37.332782000-07:00" msg="Graph migration to content-addressability took 0.00 seconds" [13:55:37.332][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:37.332782000-07:00" msg="Loading containers: start." [13:55:37.333][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:37.333777900-07:00" msg="Option Experimental: true" [13:55:37.333][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:37.333777900-07:00" msg="Option DefaultDriver: nat" [13:55:37.333][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:37.333777900-07:00" msg="Option DefaultNetwork: nat" [13:55:37.356][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:37.356778500-07:00" msg="Restoring existing overlay networks from HNS into docker" [13:55:37.356][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:37.356778500-07:00" msg="[GET]=>[/networks/] Request : " [13:55:43.137][ApiProxy ][Info ] proxy >> GET /_ping [13:55:43.137][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:43.188][ApiProxy ][Info ] i/o timeout [13:55:43.189][ApiProxy ][Info ] proxy >> GET /v1.30/containers/json [13:55:43.189][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:43.239][ApiProxy ][Info ] i/o timeout [13:55:43.246][DockerDaemonChecker][Error ] Docker daemon is not running [13:55:44.407][ApiProxy ][Info ] proxy >> GET /_ping [13:55:44.407][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:44.457][ApiProxy ][Info ] i/o timeout [13:55:44.457][ApiProxy ][Info ] proxy >> GET /v1.30/containers/json [13:55:44.457][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:44.507][ApiProxy ][Info ] i/o timeout [13:55:44.513][DockerDaemonChecker][Error ] Docker daemon is not running [13:55:45.673][ApiProxy ][Info ] proxy >> GET /_ping [13:55:45.673][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:45.689][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:45.689781400-07:00" msg="Network Response : [ { \"CurrentEndpointCount\" : 0, \"ExternalInterfaceAddress\" : \"64-51-06-A2-92-70\", \"ExternalInterfaceIndex\" : 26, \"ID\" : \"402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"MacPools\" : [ { \"EndMacAddress\" : \"00-15-5D-85-1F-FF\", \"StartMacAddress\" : \"00-15-5D-85-10-00\" } ], \"MaxConcurrentEndpoints\" : 0, \"NATName\" : \"H402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"Name\" : \"nat\", \"Policies\" : [ ], \"Subnets\" : [ { \"AddressPrefix\" : \"172.23.240.0/20\", \"GatewayAddress\" : \"172.23.240.1\" } ], \"SwitchGuid\" : \"51e0d22d-3ed8-41c7-acbc-b7087d1b14f0\", \"TotalEndpoints\" : 0, \"Type\" : \"nat\", \"Version\" : 4294967297 } ]" [13:55:45.724][ApiProxy ][Info ] i/o timeout [13:55:45.724][ApiProxy ][Info ] proxy >> GET /v1.30/containers/json [13:55:45.724][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:45.776][ApiProxy ][Info ] i/o timeout [13:55:45.791][DockerDaemonChecker][Error ] Docker daemon is not running [13:55:45.927][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:45.927783300-07:00" msg="Network (db77944) restored" [13:55:46.187][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.187783800-07:00" msg="[GET]=>[/networks/] Request : " [13:55:46.246][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.246781500-07:00" msg="Network Response : [ { \"CurrentEndpointCount\" : 0, \"ExternalInterfaceAddress\" : \"64-51-06-A2-92-70\", \"ExternalInterfaceIndex\" : 26, \"ID\" : \"402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"MacPools\" : [ { \"EndMacAddress\" : \"00-15-5D-85-1F-FF\", \"StartMacAddress\" : \"00-15-5D-85-10-00\" } ], \"MaxConcurrentEndpoints\" : 0, \"NATName\" : \"H402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"Name\" : \"nat\", \"Policies\" : [ ], \"Subnets\" : [ { \"AddressPrefix\" : \"172.23.240.0/20\", \"GatewayAddress\" : \"172.23.240.1\" } ], \"SwitchGuid\" : \"51e0d22d-3ed8-41c7-acbc-b7087d1b14f0\", \"TotalEndpoints\" : 0, \"Type\" : \"nat\", \"Version\" : 4294967297 } ]" [13:55:46.296][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.296781800-07:00" msg="Launching DNS server for network%!(EXTRA string=none)" [13:55:46.690][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.689781800-07:00" msg="releasing IPv4 pools from network nat (db779448be047928f6eec88943f2e4c31977ef35347d8d96e380eacc86ae35ac)" [13:55:46.690][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.690781900-07:00" msg="ReleaseAddress(172.23.240.0/20, 172.23.240.1)" [13:55:46.690][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.690781900-07:00" msg="ReleasePool(172.23.240.0/20)" [13:55:46.834][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:46.833782100-07:00" msg="cleanupServiceBindings for db779448be047928f6eec88943f2e4c31977ef35347d8d96e380eacc86ae35ac" [13:55:46.951][ApiProxy ][Info ] proxy >> GET /_ping [13:55:46.952][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:47.003][ApiProxy ][Info ] i/o timeout [13:55:47.004][ApiProxy ][Info ] proxy >> GET /v1.30/containers/json [13:55:47.004][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:47.055][ApiProxy ][Info ] i/o timeout [13:55:47.061][DockerDaemonChecker][Error ] Docker daemon is not running [13:55:47.143][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.143783600-07:00" msg="Allocating IPv4 pools for network nat (f8278b4f4601b49ae85b0ca7d01efed430febef1d5b0312ca0fc84ecaf378e33)" [13:55:47.144][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.143783600-07:00" msg="RequestPool(LocalDefault, 172.23.240.0/20, , map[], false)" [13:55:47.144][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.144783000-07:00" msg="RequestAddress(172.23.240.0/20, 172.23.240.1, map[RequestAddressType:com.docker.network.gateway])" [13:55:47.404][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.404783500-07:00" msg="Launching DNS server for network%!(EXTRA string=nat)" [13:55:47.404][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.404783500-07:00" msg="[GET]=>[/networks/402b98a5-63ce-4bb9-b3ae-8979f9610c5c] Request : " [13:55:47.417][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.417782300-07:00" msg="Network Response : { \"CurrentEndpointCount\" : 0, \"ExternalInterfaceAddress\" : \"64-51-06-A2-92-70\", \"ExternalInterfaceIndex\" : 26, \"ID\" : \"402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"MacPools\" : [ { \"EndMacAddress\" : \"00-15-5D-85-1F-FF\", \"StartMacAddress\" : \"00-15-5D-85-10-00\" } ], \"MaxConcurrentEndpoints\" : 0, \"NATName\" : \"H402b98a5-63ce-4bb9-b3ae-8979f9610c5c\", \"Name\" : \"nat\", \"Policies\" : [ ], \"Subnets\" : [ { \"AddressPrefix\" : \"172.23.240.0/20\", \"GatewayAddress\" : \"172.23.240.1\" } ], \"SwitchGuid\" : \"51e0d22d-3ed8-41c7-acbc-b7087d1b14f0\", \"TotalEndpoints\" : 0, \"Type\" : \"nat\", \"Version\" : 4294967297 }" [13:55:47.417][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.417782300-07:00" msg="Binding a resolver on network nat gateway 172.23.240.1" [13:55:47.420][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.420781600-07:00" msg="Resolver bound successfully for network nat" [13:55:47.915][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:47.915781200-07:00" msg="Loading containers: done." [13:55:47.965][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:47.965785300-07:00" msg="Daemon has completed initialization" [13:55:47.965][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:47.965785300-07:00" msg="Docker daemon" commit=02c1d87 graphdriver=windowsfilter version=17.06.0-ce [13:55:47.966][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.966782800-07:00" msg="Registering routers" [13:55:47.966][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.966782800-07:00" msg="Registering GET, /containers/{name:.}/checkpoints" [13:55:47.966][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.966782800-07:00" msg="Registering POST, /containers/{name:.}/checkpoints" [13:55:47.966][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.966782800-07:00" msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}" [13:55:47.967][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.966782800-07:00" msg="Registering HEAD, /containers/{name:.}/archive" [13:55:47.967][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.967781800-07:00" msg="Registering GET, /containers/json" [13:55:47.967][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.967781800-07:00" msg="Registering GET, /containers/{name:.}/export" [13:55:47.967][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.967781800-07:00" msg="Registering GET, /containers/{name:.}/changes" [13:55:47.967][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.967781800-07:00" msg="Registering GET, /containers/{name:.}/json" [13:55:47.968][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.968780800-07:00" msg="Registering GET, /containers/{name:.}/top" [13:55:47.968][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.968780800-07:00" msg="Registering GET, /containers/{name:.}/logs" [13:55:47.968][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.968780800-07:00" msg="Registering GET, /containers/{name:.}/stats" [13:55:47.968][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.968780800-07:00" msg="Registering GET, /containers/{name:.}/attach/ws" [13:55:47.968][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.968780800-07:00" msg="Registering GET, /exec/{id:.}/json" [13:55:47.969][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.969780900-07:00" msg="Registering GET, /containers/{name:.}/archive" [13:55:47.969][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.969780900-07:00" msg="Registering POST, /containers/create" [13:55:47.969][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.969780900-07:00" msg="Registering POST, /containers/{name:.}/kill" [13:55:47.969][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.969780900-07:00" msg="Registering POST, /containers/{name:.}/pause" [13:55:47.969][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.969780900-07:00" msg="Registering POST, /containers/{name:.}/unpause" [13:55:47.971][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.970780700-07:00" msg="Registering POST, /containers/{name:.}/restart" [13:55:47.971][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.971781600-07:00" msg="Registering POST, /containers/{name:.}/start" [13:55:47.971][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.971781600-07:00" msg="Registering POST, /containers/{name:.}/stop" [13:55:47.972][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.972782100-07:00" msg="Registering POST, /containers/{name:.}/wait" [13:55:47.972][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.972782100-07:00" msg="Registering POST, /containers/{name:.}/resize" [13:55:47.972][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.972782100-07:00" msg="Registering POST, /containers/{name:.}/attach" [13:55:47.973][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.973781500-07:00" msg="Registering POST, /containers/{name:.}/copy" [13:55:47.973][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.973781500-07:00" msg="Registering POST, /containers/{name:.}/exec" [13:55:47.974][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.973781500-07:00" msg="Registering POST, /exec/{name:.}/start" [13:55:47.974][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.974781200-07:00" msg="Registering POST, /exec/{name:.}/resize" [13:55:47.975][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.975781400-07:00" msg="Registering POST, /containers/{name:.}/rename" [13:55:47.975][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.975781400-07:00" msg="Registering POST, /containers/{name:.}/update" [13:55:47.976][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering POST, /containers/prune" [13:55:47.976][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering PUT, /containers/{name:.}/archive" [13:55:47.976][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering DELETE, /containers/{name:.}" [13:55:47.976][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering GET, /images/json" [13:55:47.976][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering GET, /images/search" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.976781500-07:00" msg="Registering GET, /images/get" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering GET, /images/{name:.}/get" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering GET, /images/{name:.}/history" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering GET, /images/{name:.}/json" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering POST, /commit" [13:55:47.977][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering POST, /images/load" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.977781300-07:00" msg="Registering POST, /images/create" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering POST, /images/{name:.}/push" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering POST, /images/{name:.}/tag" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering POST, /images/prune" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering DELETE, /images/{name:.}" [13:55:47.978][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering OPTIONS, /{anyroute:.}" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.978781400-07:00" msg="Registering GET, /_ping" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /events" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /info" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /version" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /system/df" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering POST, /auth" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /volumes" [13:55:47.979][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering GET, /volumes/{name:.}" [13:55:47.980][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.979780800-07:00" msg="Registering POST, /volumes/create" [13:55:47.980][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.980781300-07:00" msg="Registering POST, /volumes/prune" [13:55:47.980][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.980781300-07:00" msg="Registering DELETE, /volumes/{name:.}" [13:55:47.980][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.980781300-07:00" msg="Registering POST, /build" [13:55:47.980][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.980781300-07:00" msg="Registering POST, /swarm/init" [13:55:47.981][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering POST, /swarm/join" [13:55:47.981][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering POST, /swarm/leave" [13:55:47.981][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering GET, /swarm" [13:55:47.981][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering GET, /swarm/unlockkey" [13:55:47.981][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering POST, /swarm/update" [13:55:47.982][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.981784900-07:00" msg="Registering POST, /swarm/unlock" [13:55:47.982][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.982785800-07:00" msg="Registering GET, /services" [13:55:47.982][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.982785800-07:00" msg="Registering GET, /services/{id}" [13:55:47.982][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.982785800-07:00" msg="Registering POST, /services/create" [13:55:47.983][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.983791300-07:00" msg="Registering POST, /services/{id}/update" [13:55:47.983][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.983791300-07:00" msg="Registering DELETE, /services/{id}" [13:55:47.983][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.983791300-07:00" msg="Registering GET, /services/{id}/logs" [13:55:47.983][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.983791300-07:00" msg="Registering GET, /nodes" [13:55:47.984][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.984783800-07:00" msg="Registering GET, /nodes/{id}" [13:55:47.984][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.984783800-07:00" msg="Registering DELETE, /nodes/{id}" [13:55:47.984][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.984783800-07:00" msg="Registering POST, /nodes/{id}/update" [13:55:47.985][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.984783800-07:00" msg="Registering GET, /tasks" [13:55:47.985][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.985784000-07:00" msg="Registering GET, /tasks/{id}" [13:55:47.985][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.985784000-07:00" msg="Registering GET, /tasks/{id}/logs" [13:55:47.985][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.985784000-07:00" msg="Registering GET, /secrets" [13:55:47.985][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.985784000-07:00" msg="Registering POST, /secrets/create" [13:55:47.986][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.986782200-07:00" msg="Registering DELETE, /secrets/{id}" [13:55:47.986][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.986782200-07:00" msg="Registering GET, /secrets/{id}" [13:55:47.986][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.986782200-07:00" msg="Registering POST, /secrets/{id}/update" [13:55:47.986][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.986782200-07:00" msg="Registering GET, /configs" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.986782200-07:00" msg="Registering POST, /configs/create" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.987782000-07:00" msg="Registering DELETE, /configs/{id}" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.987782000-07:00" msg="Registering GET, /configs/{id}" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.987782000-07:00" msg="Registering POST, /configs/{id}/update" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.987782000-07:00" msg="Registering GET, /plugins" [13:55:47.987][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.987782000-07:00" msg="Registering GET, /plugins/{name:.}/json" [13:55:47.988][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.988781700-07:00" msg="Registering GET, /plugins/privileges" [13:55:47.988][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.988781700-07:00" msg="Registering DELETE, /plugins/{name:.}" [13:55:47.988][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.988781700-07:00" msg="Registering POST, /plugins/{name:.}/enable" [13:55:47.988][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.988781700-07:00" msg="Registering POST, /plugins/{name:.}/disable" [13:55:47.988][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.988781700-07:00" msg="Registering POST, /plugins/pull" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.989782200-07:00" msg="Registering POST, /plugins/{name:.}/push" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.989782200-07:00" msg="Registering POST, /plugins/{name:.}/upgrade" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.989782200-07:00" msg="Registering POST, /plugins/{name:.}/set" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.989782200-07:00" msg="Registering POST, /plugins/create" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.990781600-07:00" msg="Registering GET, /distribution/{name:.}/json" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.990781600-07:00" msg="Registering GET, /networks" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.990781600-07:00" msg="Registering GET, /networks/" [13:55:47.990][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.990781600-07:00" msg="Registering GET, /networks/{id:.+}" [13:55:47.991][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.991781400-07:00" msg="Registering POST, /networks/create" [13:55:47.991][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.991781400-07:00" msg="Registering POST, /networks/{id:.}/connect" [13:55:47.991][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.991781400-07:00" msg="Registering POST, /networks/{id:.}/disconnect" [13:55:47.991][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.991781400-07:00" msg="Registering POST, /networks/prune" [13:55:47.991][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.991781400-07:00" msg="Registering DELETE, /networks/{id:.*}" [13:55:47.992][WindowsDockerDaemon][Info ] time="2017-08-17T13:55:47.992781100-07:00" msg="API listen on //./pipe/docker_engine_windows" [13:55:47.992][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:47.992781100-07:00" msg="Config reload - waiting signal at Global\docker-daemon-config-9360" [13:55:48.235][ApiProxy ][Info ] proxy >> GET /_ping [13:55:48.235][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:48.246][ApiProxy ][Info ] Successfully dialed name pipe \.\pipe\docker_engine_windows [13:55:48.249][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:48.249782300-07:00" msg="Calling GET /_ping" [13:55:48.254][ApiProxy ][Info ] proxy << GET /_ping [13:55:48.254][ApiProxy ][Info ] proxy >> GET /v1.30/containers/json [13:55:48.254][ApiProxy ][Info ] Dial name pipe \.\pipe\docker_engine_windows [13:55:48.265][ApiProxy ][Info ] Successfully dialed name pipe \.\pipe\docker_engine_windows [13:55:48.265][WindowsDockerDaemon][Debug ] time="2017-08-17T13:55:48.265782300-07:00" msg="Calling GET /v1.30/containers/json" [13:55:48.267][ApiProxy ][Info ] proxy << GET /v1.30/containers/json [13:55:48.275][DockerDaemonChecker][Info ] Docker daemon is running [13:55:48.276][NamedPipeServer][Info ] Start done in 00:01:15.1811862. [13:55:48.279][NamedPipeClient][Info ] Received response for Start [13:55:48.472][Actions ][Debug ] Start took 00:01:15.4541870 [13:55:48.473][Notifications ][Info ] Docker is running [13:55:48.473][SegmentApi ][Info ] Usage statistic: appRunning [13:55:48.562][SegmentApi ][Error ] Failed to track event appRunning: An error occurred while sending the request. [14:02:35.503][SegmentApi ][Info ] Usage statistic: actionMenuSwitchLinuxDaemon [14:02:35.508][Notifications ][Info ] Docker is switching... [14:02:35.564][SegmentApi ][Error ] Failed to track event actionMenuSwitchLinuxDaemon: An error occurred while sending the request. [14:02:35.593][SegmentApi ][Info ] Usage statistic: actionSettingsChanged [14:02:35.595][NamedPipeClient][Info ] Sending Start(Docker.Core.Settings)... [14:02:35.621][SegmentApi ][Error ] Failed to track event actionSettingsChanged: An error occurred while sending the request. [14:02:35.618][NamedPipeServer][Info ] Start(Docker.Core.Settings) [14:02:35.624][PowerMode ][Info ] Stop [14:02:35.625][HyperV ][Info ] Stop [14:02:35.638][PowerShell ][Info ] Run script with parameters: -Stop True... [14:02:35.723][HyperV ][Info ] Script started at 14:02:35.716 [14:02:40.264][HyperV ][Info ] Module loaded at 14:02:40.264 [14:02:40.717][HyperV ][Info ] VM MobyLinuxVM does not exist [14:02:40.718][HyperV ][Debug ] [stop] took 00:00:05.0904282 to run [14:02:40.718][OptimizeDisk ][Info ] Optimize [14:02:40.718][PowerShell ][Info ] Run script... [14:02:40.739][Moby ][Info ] Stop [14:02:40.746][ApiProxy ][Info ] Killing existing com.docker.proxy with PID 13236 [14:02:40.801][PowerMode ][Info ] Start [14:02:40.802][HyperVGuids ][Info ] Installing GUIDs... [14:02:40.807][HyperVGuids ][Info ] GUIDs installed [14:02:40.809][Firewall ][Info ] Removing all existing rules... [14:02:40.810][HyperV ][Info ] Create [14:02:40.811][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... [14:02:40.827][HyperV ][Info ] Script started at 14:02:40.827 [14:02:40.869][HyperV ][Info ] Module loaded at 14:02:40.869 [14:02:40.870][Firewall ][Info ] All existing rules are removed. [14:02:40.870][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [14:02:40.890][Firewall ][Info ] Opening ports for SMB... [14:02:40.992][Firewall ][Info ] Ports are opened [14:02:41.217][HyperV ][Info ] Creating Switch: DockerNAT... [14:02:45.528][HyperV ][Info ] Switch created. [14:02:49.202][HyperV ][Info ] Set IP address on switch [14:02:50.617][HyperV ][Info ] Creating VM MobyLinuxVM... [14:02:53.395][HyperV ][Info ] Setting CPUs to 2 and Memory to 2048 MB [14:02:54.201][HyperV ][Info ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx [14:02:55.403][HyperV ][Info ] Connect Internal Switch DockerNAT [14:02:56.439][HyperV ][Info ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso [14:02:57.895][HyperV ][Info ] Disabled Guest Service Interface [14:02:57.932][HyperV ][Info ] Enabled Heartbeat [14:02:58.041][HyperV ][Info ] Disabled Key-Value Pair Exchange [14:02:58.076][HyperV ][Info ] Enabled Shutdown [14:02:58.104][HyperV ][Info ] Enabled Time Synchronization [14:02:58.246][HyperV ][Info ] Disabled VSS [14:02:59.390][HyperV ][Info ] VM created. [14:02:59.390][HyperV ][Debug ] [create] took 00:00:18.5797427 to run [14:02:59.390][PowerShell ][Info ] Run script '(Get-VM MobyLinuxVM).Id.Guid'... [14:03:00.069][Database ][Info ] Generating CA Cert Bundle [14:03:00.158][Database ][Info ] CA Cert Bundle Generated [14:03:00.346][DataKit ][Info ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...

[14:03:00.364][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[], "debug":true, "experimental": true} [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [14:03:00.376][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [14:03:00.803][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:03:00.826][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:03:01.307][Database ][Info ] Successfully wrote 8 value(s) [14:03:01.308][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/ssl/certs/ca-certificates.crt=C:\windows\TEMP\tmp3207.tmp [14:03:01.432][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:03:01.454][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:03:01.622][Database ][Info ] Successfully wrote value [14:03:01.631][Moby ][Info ] Connecting... [14:03:01.632][Moby ][Error ] Failed to read Moby's logs: The operation has timed out. [14:03:01.635][HyperV ][Info ] Start [14:03:01.636][PowerShell ][Info ] Run script with parameters: -Start True... [14:03:01.646][HyperV ][Info ] Script started at 14:03:01.645 [14:03:01.647][PowerShell ][Info ] Run script '$(Find-NetRoute -RemoteIPAddress 8.8.8.8).InterfaceIndex[0]'... [14:03:01.787][HyperV ][Info ] Module loaded at 14:03:01.787 [14:03:01.792][HyperV ][Info ] Starting VM MobyLinuxVM... [14:03:03.038][HyperV ][Debug ] [start] took 00:00:01.4030369 to run [14:03:03.098][Database ][Info ] Writing com.docker.driver.amd64-linux/slirp/dns=nameserver 172.26.143.31 nameserver 172.29.143.30 search ent.rt.csaa.com search rt.csaa.com search csaa.com search westernunited.com search tent.trt.csaa.pri search trt.csaa.pri [14:03:03.210][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:03:03.232][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:03:03.357][Database ][Info ] Successfully wrote 1 value(s) [14:03:03.658][Moby ][Info ] Connected [14:03:04.945][VpnKit ][Info ] vpnkit.exe: Logging to stdout (stdout:true DEBUG:false)

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: Setting handler to ignore all SIGPIPE signals

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: vpnkit version befe8be9b45f6c4d50cf7c8105bfdf101dfe8982 with hostnet version uwt version 0.2.0 hvsock version 0.13.0

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: System SOMAXCONN is 2147483647

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: Will use a listen backlog of 32

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: starting port forwarding server on port_control_url:hyperv-connect://cd3bf349-5eaa-4737-a9b5-e0ca1216ebbd vsock_path:

[14:03:04.945][VpnKit ][Info ] vpnkit.exe: connecting to cd3bf349-5eaa-4737-a9b5-e0ca1216ebbd:0B95756A-9985-48AD-9470-78E060895BE7

[14:03:04.949][VpnKit ][Info ] vpnkit.exe: DNS names will map to local IP 192.168.65.1

[14:03:04.949][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:03:04.952][VpnKit ][Info ] vpnkit.exe: attempting to reconnect to database

[14:03:04.970][VpnKit ][Error ] vpnkit.exe: While watching /etc/resolv.conf: ENOENT

[14:03:04.979][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:03:04.985][VpnKit ][Info ] vpnkit.exe: hosts file has bindings for

[14:03:04.994][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousandU msize 8215

[14:03:04.996][VpnKit ][Info ] vpnkit.exe: reconnected transport layer

[14:03:04.997][VpnKit ][Info ] vpnkit.exe: remove connection limit

[14:03:05.000][VpnKit ][Info ] vpnkit.exe: allowing binds to any IP addresses

[14:03:05.001][VpnKit ][Error ] vpnkit.exe: Failed to parse IPv4 address '', using default of 192.168.65.254

[14:03:05.003][VpnKit ][Info ] vpnkit.exe: updating resolvers to use upstream DNS servers nameserver 172.29.143.30#53

[14:03:05.003][VpnKit ][Info ] order 0

[14:03:05.003][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:03:05.003][VpnKit ][Info ] order 0

[14:03:05.003][VpnKit ][Info ] search ent.rt.csaa.com

[14:03:05.003][VpnKit ][Info ] vpnkit.exe: Add(3): DNS configuration changed to: use upstream DNS servers nameserver 172.29.143.30#53

[14:03:05.003][VpnKit ][Info ] order 0

[14:03:05.003][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:03:05.003][VpnKit ][Info ] order 0

[14:03:05.003][VpnKit ][Info ] search ent.rt.csaa.com

[14:03:05.003][VpnKit ][Info ] vpnkit.exe: DNS names docker.for.win.localhost will map to local IP 192.168.65.1

[14:03:05.003][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:03:05.003][VpnKit ][Info ] vpnkit.exe: updating resolvers to use upstream DNS servers nameserver 172.29.143.30#53

[14:03:05.003][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:03:05.004][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] search ent.rt.csaa.com

[14:03:05.004][VpnKit ][Info ] vpnkit.exe: Remove(3): DNS configuration changed to: use upstream DNS servers nameserver 8.8.8.8#53

[14:03:05.004][VpnKit ][Info ] timeout 2000

[14:03:05.004][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] nameserver 8.8.4.4#53

[14:03:05.004][VpnKit ][Info ] timeout 2000

[14:03:05.004][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] vpnkit.exe: Add(3): DNS configuration changed to: use upstream DNS servers nameserver 172.29.143.30#53

[14:03:05.004][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:03:05.004][VpnKit ][Info ] order 0

[14:03:05.004][VpnKit ][Info ] search ent.rt.csaa.com

[14:03:05.004][VpnKit ][Info ] vpnkit.exe: DNS names docker.for.win.localhost will map to local IP 192.168.65.1

[14:03:05.004][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:03:05.007][VpnKit ][Info ] vpnkit.exe: Disabling transparent HTTP redirection

[14:03:05.007][VpnKit ][Info ] vpnkit.exe: Creating slirp server peer_ip:192.168.65.2 local_ip:192.168.65.1 domain_search:ent.rt.csaa.com mtu:8000 bridge:true

[14:03:05.007][VpnKit ][Info ] vpnkit.exe: connecting to cd3bf349-5eaa-4737-a9b5-e0ca1216ebbd:30D48B34-7D27-4B0B-AAAF-BBBED334DD59

[14:03:05.163][Linux ][Info ] Trying to connect to vsud... [14:03:05.571][Moby ][Info ] early console in extract_kernel [14:03:05.571][Moby ][Info ] input_data: 0x0000000001f453b4 [14:03:05.573][Moby ][Info ] input_len: 0x000000000065dff7 [14:03:05.574][Moby ][Info ] output: 0x0000000001000000 [14:03:05.574][Moby ][Info ] output_len: 0x000000000159111c [14:03:05.574][Moby ][Info ] kernel_total_size: 0x0000000001188000 [14:03:05.591][Moby ][Info ] booted via startup_64() [14:03:05.664][Moby ][Info ] Physical KASLR using RDRAND RDTSC... [14:03:05.673][Moby ][Info ] Virtual KASLR using RDRAND RDTSC... [14:03:05.677][Moby ][Info ] [14:03:11.171][Moby ][Info ] Decompressing Linux... Parsing ELF... Performing relocations... done. [14:03:11.171][Moby ][Info ] Booting the kernel. [14:03:11.206][Moby ][Info ] Linux version 4.9.36-moby (root@11fbdc1f630f) (gcc version 6.2.1 20160822 (Alpine 6.2.1) ) #1 SMP Wed Jul 12 15:29:07 UTC 2017 [14:03:11.218][Moby ][Info ] Command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate panic=1 rootdelay=300 noautodetect [14:03:11.218][Moby ][Info ] [14:03:11.231][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [14:03:11.252][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [14:03:11.273][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'

[14:03:11.308][Moby ][Info ] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [14:03:11.333][Moby ][Info ] x86/fpu: Using 'eager' FPU context switches. [14:03:11.350][Moby ][Info ] e820: BIOS-provided physical RAM map: [14:03:11.362][Moby ][Info ] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable [14:03:11.383][Moby ][Info ] BIOS-e820: [mem 0x0000000000100000-0x000000007eeedfff] usable [14:03:11.400][Moby ][Info ] BIOS-e820: [mem 0x000000007eeee000-0x000000007eef1fff] ACPI data [14:03:11.426][Moby ][Info ] BIOS-e820: [mem 0x000000007eef2000-0x000000007ef1afff] reserved [14:03:11.437][Moby ][Info ] BIOS-e820: [mem 0x000000007ef1b000-0x000000007ff9afff] usable [14:03:11.458][Moby ][Info ] BIOS-e820: [mem 0x000000007ff9b000-0x000000007fff2fff] reserved [14:03:11.480][Moby ][Info ] BIOS-e820: [mem 0x000000007fff3000-0x000000007fffafff] ACPI data [14:03:11.491][Moby ][Info ] BIOS-e820: [mem 0x000000007fffb000-0x000000007fffefff] ACPI NVS [14:03:11.507][Moby ][Info ] BIOS-e820: [mem 0x000000007ffff000-0x000000007fffffff] usable [14:03:11.522][Moby ][Info ] bootconsole [earlyser0] enabled [14:03:11.537][Moby ][Info ] NX (Execute Disable) protection: active [14:03:11.552][Moby ][Info ] efi: EFI v2.31 by EDK II [14:03:11.650][Moby ][Info ] efi: ACPI=0x7fffa000 ACPI 2.0=0x7fffa014 SMBIOS=0x7fff2000 PROP=0x419a3d8 MEMATTR=0x7f525d18 [14:03:11.662][Moby ][Info ] SMBIOS 2.4 present. [14:03:11.678][Moby ][Info ] Hypervisor detected: Microsoft HyperV [14:03:11.696][Moby ][Info ] HyperV: features 0x2e7f, hints 0x2c2c [14:03:11.715][Moby ][Info ] HyperV: LAPIC Timer Frequency: 0x1e8480 [14:03:11.730][Moby ][Info ] clocksource: hyperv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns [14:03:11.742][Moby ][Info ] tsc: Marking TSC unstable due to running on Hyper-V [14:03:11.762][Moby ][Info ] e820: last_pfn = 0x80000 max_arch_pfn = 0x400000000 [14:03:11.767][Moby ][Info ] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT
[14:03:11.810][Moby ][Info ] Memory KASLR using RDRAND RDTSC... [14:03:11.826][Moby ][Info ] Using GB pages for direct mapping [14:03:11.832][Moby ][Info ] RAMDISK: [mem 0x7793a000-0x7b0c2fff] [14:03:11.846][Moby ][Info ] ACPI: Early table checksum verification disabled [14:03:11.871][Moby ][Info ] ACPI: RSDP 0x000000007FFFA014 000024 (v02 VRTUAL) [14:03:11.902][Moby ][Info ] ACPI: XSDT 0x000000007FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:11.931][Moby ][Info ] ACPI: FACP 0x000000007FFF7000 0000F4 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:11.966][Moby ][Info ] ACPI: DSDT 0x000000007EEEF000 00256F (v02 MSFTVM DSDT01 00000001 MSFT 04000000) [14:03:12.010][Moby ][Info ] ACPI: FACS 0x000000007FFFE000 000040 [14:03:12.064][Moby ][Info ] ACPI: APIC 0x000000007FFF8000 0007D2 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:12.122][Moby ][Info ] ACPI: OEM0 0x000000007FFF6000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:12.180][Moby ][Info ] ACPI: WAET 0x000000007FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:12.220][Moby ][Info ] ACPI: OEM1 0x000000007FFF4000 00009E (v02 MSFTVM UARTS 00000001 MSFT 04000000) [14:03:12.275][Moby ][Info ] ACPI: OEM2 0x000000007FFF3000 0002E2 (v02 MSFTVM VTPM2 00000001 MSFT 04000000) [14:03:12.304][Moby ][Info ] ACPI: SRAT 0x000000007EEEE000 000190 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:03:12.357][Moby ][Info ] Zone ranges: [14:03:12.395][Moby ][Info ] DMA [mem 0x0000000000001000-0x0000000000ffffff] [14:03:12.432][Moby ][Info ] DMA32 [mem 0x0000000001000000-0x000000007fffffff] [14:03:12.463][Moby ][Info ] Normal empty [14:03:12.484][Moby ][Info ] Movable zone start for each node [14:03:12.503][Moby ][Info ] Early memory node ranges [14:03:12.521][Moby ][Info ] node 0: [mem 0x0000000000001000-0x000000000009ffff] [14:03:12.528][Moby ][Info ] node 0: [mem 0x0000000000100000-0x000000007eeedfff] [14:03:12.548][Moby ][Info ] node 0: [mem 0x000000007ef1b000-0x000000007ff9afff] [14:03:12.572][Moby ][Info ] node 0: [mem 0x000000007ffff000-0x000000007fffffff] [14:03:12.596][Moby ][Info ] Initmem setup node 0 [mem 0x0000000000001000-0x000000007fffffff] [14:03:12.623][Moby ][Info ] ACPI: PM-Timer IO Port: 0x408 [14:03:12.636][Moby ][Info ] ------------[ cut here ]------------ [14:03:12.647][Moby ][Info ] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/apic/apic.c:2065 generic_processor_info+0x149/0x24f [14:03:12.659][Moby ][Info ] Only 127 processors supported.Processor 128/0x80 and the rest are ignored. [14:03:12.683][Moby ][Info ] Modules linked in: [14:03:12.692][Moby ][Info ] CPU: 0 PID: 0 Comm: swapper Not tainted 4.9.36-moby #1 [14:03:12.706][Moby ][Info ] Hardware name: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v1.0 11/26/2012 [14:03:12.763][Moby ][Info ] 0000000000000000 ffffffffb241b245 ffffffffb2e03d40 0000000000000000 [14:03:12.814][Moby ][Info ] ffffffffb20dcf41 0000000000000080 ffffffffb2e03da0 0000000000000000 [14:03:12.887][Moby ][Info ] 0000000000000014 0000000000000000 0000000000000000 ffffffffb20dcfb4 [14:03:12.902][Moby ][Info ] Call Trace: [14:03:12.919][Moby ][Info ] [] ? dump_stack+0x5a/0x6f [14:03:12.931][Moby ][Info ] [] ? warn+0xd2/0xeb [14:03:12.942][Moby ][Info ] [] ? warn_slowpath_fmt+0x5a/0x76 [14:03:12.954][Moby ][Info ] [] ? early_ioremap+0x13d/0x1bd [14:03:12.967][Moby ][Info ] [] ? generic_processor_info+0x149/0x24f [14:03:12.971][Moby ][Info ] [] ? acpi_register_lapic+0x46/0x72 [14:03:12.985][Moby ][Info ] [] ? acpi_parse_lapic+0x3f/0x44 [14:03:12.985][Moby ][Info ] [] ? acpi_parse_entries_array+0xef/0x145 [14:03:12.985][Moby ][Info ] [] ? acpi_table_parse_entries_array+0xbe/0xf7 [14:03:13.004][Moby ][Info ] [] ? acpi_boot_init+0xed/0x45e [14:03:13.018][Moby ][Info ] [] ? pmd_val+0x7/0x8 [14:03:13.034][Moby ][Info ] [] ? pmd_page_vaddr+0x9/0x30 [14:03:13.041][Moby ][Info ] [] ? acpi_parse_x2apic_nmi+0x3c/0x3c [14:03:13.054][Moby ][Info ] [] ? dmi_ignore_irq0_timer_override+0x26/0x26 [14:03:13.063][Moby ][Info ] [] ? setup_arch+0x889/0x984 [14:03:13.072][Moby ][Info ] [] ? start_kernel+0xa9/0x44a [14:03:13.085][Moby ][Info ] [] ? early_idt_handler_array+0x120/0x120 [14:03:13.094][Moby ][Info ] [] ? x86_64_start_kernel+0x141/0x165 [14:03:13.096][Moby ][Info ] ---[ end trace 9f33d4c2c639f0ce ]--- [14:03:13.106][Moby ][Info ] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [14:03:13.149][Moby ][Info ] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23 [14:03:13.154][Moby ][Info ] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [14:03:13.165][Moby ][Info ] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [14:03:13.170][Moby ][Info ] Using ACPI (MADT) for SMP configuration information [14:03:13.179][Moby ][Info ] smpboot: 240 Processors exceeds NR_CPUS limit of 128 [14:03:13.190][Moby ][Info ] smpboot: Allowing 128 CPUs, 126 hotplug CPUs [14:03:13.202][Moby ][Info ] e820: [mem 0x80000000-0xffffffff] available for PCI devices [14:03:13.214][Moby ][Info ] Booting paravirtualized kernel on bare hardware [14:03:13.230][Moby ][Info ] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [14:03:13.243][Moby ][Info ] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:128 nr_node_ids:1 [14:03:13.258][Moby ][Info ] percpu: Embedded 35 pages/cpu @ffff8d6075800000 s105176 r8192 d29992 u262144 [14:03:13.267][Moby ][Info ] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 515799 [14:03:13.275][Moby ][Info ] Kernel command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate panic=1 rootdelay=300 noautodetect [14:03:13.275][Moby ][Info ] [14:03:13.294][Moby ][Info ] log_buf_len individual max cpu contribution: 4096 bytes [14:03:13.305][Moby ][Info ] log_buf_len total cpu_extra contributions: 520192 bytes [14:03:13.314][Moby ][Info ] log_buf_len min size: 131072 bytes [14:03:13.318][Moby ][Info ] log_buf_len: 1048576 bytes [14:03:13.338][Moby ][Info ] early log buf free: 120596(92%) [14:03:13.344][Moby ][Info ] PID hash table entries: 4096 (order: 3, 32768 bytes) [14:03:13.355][Moby ][Info ] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [14:03:13.364][Moby ][Info ] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [14:03:13.393][Moby ][Info ] Memory: 1951340K/2096184K available (8505K kernel code, 1412K rwdata, 2864K rodata, 1392K init, 600K bss, 144844K reserved, 0K cma-reserved) [14:03:13.404][Moby ][Info ] Hierarchical RCU implementation. [14:03:13.419][Moby ][Info ] Build-time adjustment of leaf fanout to 64. [14:03:13.436][Moby ][Info ] Using NULL legacy PIC [14:03:13.453][Moby ][Info ] NR_IRQS:8448 nr_irqs:1448 0 [14:03:13.491][Moby ][Info ] Console: colour dummy device 80x25 [14:03:13.532][Moby ][Info ] console [ttyS0] enabled [14:03:13.542][Moby ][Info ] console [ttyS0] enabled [14:03:13.558][Moby ][Info ] bootconsole [earlyser0] disabled [14:03:13.576][Moby ][Info ] bootconsole [earlyser0] disabled [14:03:13.714][Moby ][Info ] tsc: Fast TSC calibration failed [14:03:13.721][Moby ][Info ] tsc: Unable to calibrate against PIT [14:03:13.729][Moby ][Info ] tsc: using PMTIMER reference calibration [14:03:13.757][Moby ][Info ] tsc: Detected 2648.557 MHz processor [14:03:13.803][Moby ][Info ] Calibrating delay loop (skipped), value calculated using timer frequency.. 5297.11 BogoMIPS (lpj=26485570) [14:03:13.818][Moby ][Info ] pid_max: default: 131072 minimum: 1024 [14:03:13.834][Moby ][Info ] ACPI: Core revision 20160831 [14:03:13.874][Moby ][Info ] ACPI: 1 ACPI AML tables successfully acquired and loaded [14:03:13.896][Moby ][Info ] Security Framework initialized [14:03:13.918][Moby ][Info ] Yama: becoming mindful. [14:03:13.958][Moby ][Info ] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [14:03:13.979][Moby ][Info ] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [14:03:14.004][Moby ][Info ] CPU: Physical Processor ID: 0 [14:03:14.019][Moby ][Info ] CPU: Processor Core ID: 0 [14:03:14.056][Moby ][Info ] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024 [14:03:14.083][Moby ][Info ] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4 [14:03:14.116][Moby ][Info ] Freeing SMP alternatives memory: 24K (ffffffffb30bf000 - ffffffffb30c5000) [14:03:14.140][Moby ][Info ] ftrace: allocating 37666 entries in 148 pages [14:03:14.598][Moby ][Info ] smpboot: Max logical packages: 120 [14:03:15.369][Moby ][Info ] Switched APIC routing to physical flat. [14:03:17.187][Moby ][Info ] smpboot: CPU0: Intel(R) Core(TM) i7-4600U CPU @ 2.10GHz (family: 0x6, model: 0x45, stepping: 0x1) [14:03:18.074][Moby ][Info ] Performance Events: unsupported p6 CPU model 69 no PMU driver, software events only. [14:03:18.512][Moby ][Info ] NMI watchdog: disabled (cpu0): hardware events not enabled [14:03:19.326][Moby ][Info ] NMI watchdog: Shutting down hard lockup detector on all cpus [14:03:20.001][Moby ][Info ] x86: Booting SMP configuration: [14:03:22.529][Moby ][Info ] .... node #0, CPUs: #1calibrate_delay_direct() failed to get a good estimate for loops_per_jiffy. [14:03:24.335][Moby ][Info ] Probably due to long platform interrupts. Consider using "lpj=" boot option. [14:03:25.170][Moby ][Info ] x86: Booted up 1 node, 2 CPUs [14:03:25.525][Moby ][Info ] smpboot: Total of 2 processors activated (8044.71 BogoMIPS) [14:03:25.703][Moby ][Info ] devtmpfs: initialized [14:03:26.468][Moby ][Info ] x86/mm: Memory block size: 128MB [14:03:28.081][Moby ][Info ] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [14:03:28.812][Moby ][Info ] futex hash table entries: 32768 (order: 9, 2097152 bytes) [14:03:29.457][Moby ][Info ] NET: Registered protocol family 16 [14:03:30.033][Moby ][Info ] cpuidle: using governor ladder [14:03:30.705][Moby ][Info ] cpuidle: using governor menu [14:03:31.257][Moby ][Info ] ACPI: bus type PCI registered [14:03:32.163][Moby ][Info ] PCI: Fatal: No config space access function found [14:03:33.001][Moby ][Info ] HugeTLB registered 1 GB page size, pre-allocated 0 pages [14:03:33.916][Moby ][Info ] HugeTLB registered 2 MB page size, pre-allocated 0 pages [14:03:34.768][Moby ][Info ] ACPI: Added _OSI(Module Device) [14:03:35.335][Moby ][Info ] ACPI: Added _OSI(Processor Device) [14:03:36.038][Moby ][Info ] ACPI: Added _OSI(3.0 _SCP Extensions) [14:03:37.049][Moby ][Info ] ACPI: Added _OSI(Processor Aggregator Device) [14:03:37.922][Moby ][Info ] ACPI: Executed 1 blocks of module-level executable AML code [14:03:38.455][Moby ][Info ] ACPI: Dynamic OEM Table Load: [14:03:38.701][Moby ][Info ] ACPI: Interpreter enabled [14:03:39.036][Moby ][Info ] ACPI: (supports S0 S5) [14:03:39.636][Moby ][Info ] ACPI: Using IOAPIC for interrupt routing [14:03:41.208][Moby ][Info ] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [14:03:42.018][Moby ][Info ] ACPI: Enabled 1 GPEs in block 00 to 0F [14:03:42.283][Moby ][Info ] SCSI subsystem initialized [14:03:43.291][Moby ][Info ] pps_core: LinuxPPS API ver. 1 registered [14:03:44.410][Moby ][Info ] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it [14:03:44.698][Moby ][Info ] PTP clock support registered [14:03:45.119][Moby ][Info ] Registered efivars operations [14:03:45.374][Moby ][Info ] wmi: Mapper loaded [14:03:47.037][Moby ][Info ] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns [14:03:48.280][Moby ][Info ] hv_vmbus: Hyper-V Host Build:14393-10.0-1-0.1358; Vmbus version:4.0 [14:03:48.924][Moby ][Info ] PCI: Using ACPI for IRQ routing [14:03:49.161][Moby ][Info ] PCI: System does not support PCI [14:03:49.710][Moby ][Info ] NetLabel: Initializing [14:03:50.209][Moby ][Info ] NetLabel: domain hash size = 128 [14:03:50.566][Moby ][Info ] NetLabel: protocols = UNLABELED CIPSOv4 [14:03:51.089][Moby ][Info ] NetLabel: unlabeled traffic allowed by default [14:03:51.949][Moby ][Info ] clocksource: Switched to clocksource hyperv_clocksource_tsc_page [14:03:52.188][Moby ][Info ] FS-Cache: Loaded [14:03:52.572][Moby ][Info ] CacheFiles: Loaded [14:03:52.882][Moby ][Info ] pnp: PnP ACPI init [14:03:53.465][Moby ][Info ] pnp: PnP ACPI: found 3 devices [14:03:54.674][Moby ][Info ] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [14:03:54.955][Moby ][Info ] NET: Registered protocol family 2 [14:03:56.078][Moby ][Info ] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [14:03:56.655][Moby ][Info ] TCP bind hash table entries: 16384 (order: 6, 262144 bytes) [14:03:57.516][Moby ][Info ] TCP: Hash tables configured (established 16384 bind 16384) [14:03:58.604][Moby ][Info ] UDP hash table entries: 1024 (order: 3, 32768 bytes) [14:03:58.988][Moby ][Info ] random: fast init done [14:03:59.711][Moby ][Info ] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) [14:04:00.106][Moby ][Info ] NET: Registered protocol family 1 [14:04:00.574][Moby ][Info ] RPC: Registered named UNIX socket transport module. [14:04:00.833][Moby ][Info ] RPC: Registered udp transport module. [14:04:01.188][Moby ][Info ] RPC: Registered tcp transport module. [14:04:01.972][Moby ][Info ] RPC: Registered tcp NFSv4.1 backchannel transport module. [14:04:02.358][Moby ][Info ] Unpacking initramfs... [14:04:05.379][Linux ][Error ] Failed to start: Docker hv-sock proxy (vsudd) is not reachable. Let's retry [14:04:05.379][PowerShell ][Info ] Run script... [14:04:06.670][Moby ][Info ] Freeing initrd memory: 56868K (ffff8d607793a000 - ffff8d607b0c3000) [14:04:08.297][Moby ][Info ] RAPL PMU: API unit is 2^-32 Joules, 4 fixed counters, 10737418240 ms ovfl timer [14:04:09.172][Moby ][Info ] RAPL PMU: hw unit of domain pp0-core 2^-0 Joules [14:04:09.342][Moby ][Info ] RAPL PMU: hw unit of domain package 2^-0 Joules [14:04:09.882][Moby ][Info ] RAPL PMU: hw unit of domain dram 2^-0 Joules [14:04:10.704][Moby ][Info ] RAPL PMU: hw unit of domain pp1-gpu 2^-0 Joules [14:04:10.876][HyperV ][Info ] Hyper-V is running [14:04:10.876][PowerMode ][Info ] Stop [14:04:10.876][HyperV ][Info ] Stop [14:04:10.882][PowerShell ][Info ] Run script with parameters: -Stop True... [14:04:10.892][HyperV ][Info ] Script started at 14:04:10.891 [14:04:10.926][HyperV ][Info ] Module loaded at 14:04:10.926 [14:04:11.013][HyperV ][Info ] Stopping VM MobyLinuxVM... [14:04:12.735][Moby ][Info ] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x262d6a197c9, max_idle_ns: 440795221849 ns [14:04:12.995][Moby ][Info ] audit: [14:04:17.401][Moby ][Error ] Failed to read Moby's logs: The operation has timed out. [14:04:17.420][HyperV ][Info ] Turn Off VM ... [14:04:17.442][HyperV ][Info ] VM MobyLinuxVM is stopped [14:04:17.442][HyperV ][Debug ] [stop] took 00:00:06.5656478 to run [14:04:17.442][OptimizeDisk ][Info ] Optimize [14:04:17.442][PowerShell ][Info ] Run script... [14:04:19.104][Moby ][Info ] Stop [14:04:19.117][VpnKit ][Info ] Killing existing vpnkit with PID 13284 [14:04:19.130][DataKit ][Info ] Killing existing com.docker.db with PID 14396 [14:04:19.149][HyperV ][Info ] Destroy [14:04:19.150][PowerShell ][Info ] Run script with parameters: -Destroy True -KeepVolume True... [14:04:19.170][HyperV ][Info ] Script started at 14:04:19.170 [14:04:19.209][HyperV ][Info ] Module loaded at 14:04:19.208 [14:04:19.271][HyperV ][Info ] VM MobyLinuxVM is stopped [14:04:19.273][HyperV ][Info ] Destroying Switch DockerNAT... [14:04:23.330][HyperV ][Info ] Removing VM MobyLinuxVM... [14:04:23.502][HyperV ][Debug ] [destroy] took 00:00:04.3528952 to run [14:04:23.502][Firewall ][Info ] Closing ports... [14:04:23.502][Firewall ][Info ] Removing all existing rules... [14:04:23.603][Firewall ][Info ] All existing rules are removed. [14:04:23.604][Firewall ][Info ] Ports are closed [14:04:23.604][HyperVGuids ][Info ] Removing GUIDs... [14:04:23.607][HyperVGuids ][Info ] GUIDs removed [14:04:23.608][HyperV ][Info ] Create [14:04:23.611][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... [14:04:23.622][HyperV ][Info ] Script started at 14:04:23.621 [14:04:23.670][HyperV ][Info ] Module loaded at 14:04:23.670 [14:04:23.781][HyperV ][Info ] Creating Switch: DockerNAT... [14:04:27.254][HyperV ][Info ] Switch created. [14:04:30.677][HyperV ][Info ] Set IP address on switch [14:04:30.699][HyperV ][Info ] Creating VM MobyLinuxVM... [14:04:32.825][HyperV ][Info ] Setting CPUs to 2 and Memory to 2048 MB [14:04:33.754][HyperV ][Info ] Attach VHD C:\Users\Public\Documents\Hyper-V\Virtual Hard Disks\MobyLinuxVM.vhdx [14:04:34.583][HyperV ][Info ] Connect Internal Switch DockerNAT [14:04:35.616][HyperV ][Info ] Attach DVD C:\Program Files\Docker\Docker\Resources\mobylinux.iso [14:04:36.763][HyperV ][Info ] Disabled Guest Service Interface [14:04:36.799][HyperV ][Info ] Enabled Heartbeat [14:04:36.883][HyperV ][Info ] Disabled Key-Value Pair Exchange [14:04:36.915][HyperV ][Info ] Enabled Shutdown [14:04:36.946][HyperV ][Info ] Enabled Time Synchronization [14:04:37.055][HyperV ][Info ] Disabled VSS [14:04:38.172][HyperV ][Info ] VM created. [14:04:38.172][HyperV ][Debug ] [create] took 00:00:14.5636222 to run [14:04:38.172][PowerMode ][Info ] Stop [14:04:38.172][HyperV ][Info ] Stop [14:04:38.173][PowerShell ][Info ] Run script with parameters: -Stop True... [14:04:38.192][HyperV ][Info ] Script started at 14:04:38.192 [14:04:38.213][HyperV ][Info ] Module loaded at 14:04:38.212 [14:04:38.262][HyperV ][Info ] VM MobyLinuxVM is stopped [14:04:38.262][HyperV ][Debug ] [stop] took 00:00:00.0900056 to run [14:04:38.262][OptimizeDisk ][Info ] Optimize [14:04:38.262][PowerShell ][Info ] Run script... [14:04:39.829][Moby ][Info ] Stop [14:04:39.850][HyperVGuids ][Info ] Installing GUIDs... [14:04:39.851][HyperV ][Info ] Create [14:04:39.854][HyperVGuids ][Info ] GUIDs installed [14:04:39.854][PowerMode ][Info ] Start [14:04:39.854][Firewall ][Info ] Removing all existing rules... [14:04:39.854][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... [14:04:39.866][HyperV ][Info ] Script started at 14:04:39.866 [14:04:39.889][HyperV ][Info ] Module loaded at 14:04:39.889 [14:04:39.900][Firewall ][Info ] All existing rules are removed. [14:04:39.900][Firewall ][Info ] Opening ports for C:\Program Files\Docker\Docker\Resources\com.docker.proxy.exe... [14:04:39.904][Firewall ][Info ] Opening ports for SMB... [14:04:39.911][Firewall ][Info ] Ports are opened [14:04:40.868][HyperV ][Info ] Using existing Switch: DockerNAT [14:04:42.412][HyperV ][Info ] Using existing Switch IP address [14:04:42.450][HyperV ][Info ] Setting CPUs to 2 and Memory to 2048 MB [14:04:42.737][HyperV ][Info ] Connect Internal Switch DockerNAT [14:04:43.039][HyperV ][Info ] Disabled Guest Service Interface [14:04:43.067][HyperV ][Info ] Enabled Heartbeat [14:04:43.103][HyperV ][Info ] Disabled Key-Value Pair Exchange [14:04:43.137][HyperV ][Info ] Enabled Shutdown [14:04:43.177][HyperV ][Info ] Enabled Time Synchronization [14:04:43.211][HyperV ][Info ] Disabled VSS [14:04:43.408][HyperV ][Info ] VM created. [14:04:43.408][HyperV ][Debug ] [create] took 00:00:03.5562770 to run [14:04:43.408][PowerShell ][Info ] Run script '(Get-VM MobyLinuxVM).Id.Guid'... [14:04:43.510][Database ][Info ] Generating CA Cert Bundle [14:04:43.605][Database ][Info ] CA Cert Bundle Generated [14:04:43.758][DataKit ][Info ] Starting com.docker.db.exe 0.7.0-34-g6f04213 ...

[14:04:43.776][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/net/config=static [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/net/address=10.0.75.2 [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/net/netmask=255.255.255.0 [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/net/gateway=10.0.75.1 [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/network=hybrid [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/docker/daemon.json={"registry-mirrors":[],"insecure-registries":[], "debug":true, "experimental": true} [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/sysctl.conf= [14:04:43.787][Database ][Info ] Writing com.docker.driver.amd64-linux/native/port-forwarding=true [14:04:43.899][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:04:43.920][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:04:44.398][Database ][Info ] Successfully wrote 8 value(s) [14:04:44.399][Database ][Info ] Writing com.docker.driver.amd64-linux/etc/ssl/certs/ca-certificates.crt=C:\windows\TEMP\tmpC606.tmp [14:04:44.514][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:04:44.536][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:04:44.703][Database ][Info ] Successfully wrote value [14:04:44.704][Moby ][Info ] Connecting... [14:04:44.705][Moby ][Error ] Failed to read Moby's logs: The operation has timed out. [14:04:44.705][PowerShell ][Info ] Run script '$(Find-NetRoute -RemoteIPAddress 8.8.8.8).InterfaceIndex[0]'... [14:04:44.707][HyperV ][Info ] Start [14:04:44.708][PowerShell ][Info ] Run script with parameters: -Start True... [14:04:44.722][HyperV ][Info ] Script started at 14:04:44.721 [14:04:44.830][Database ][Info ] Writing com.docker.driver.amd64-linux/slirp/dns=nameserver 172.26.143.31 nameserver 172.29.143.30 search ent.rt.csaa.com search rt.csaa.com search csaa.com search westernunited.com search tent.trt.csaa.pri search trt.csaa.pri [14:04:44.943][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:04:44.967][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousand msize 16384

[14:04:45.085][Database ][Info ] Successfully wrote 1 value(s) [14:04:45.299][HyperV ][Info ] Module loaded at 14:04:45.298 [14:04:45.303][HyperV ][Info ] Starting VM MobyLinuxVM... [14:04:45.439][VpnKit ][Info ] vpnkit.exe: Logging to stdout (stdout:true DEBUG:false)

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: Setting handler to ignore all SIGPIPE signals

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: vpnkit version befe8be9b45f6c4d50cf7c8105bfdf101dfe8982 with hostnet version uwt version 0.2.0 hvsock version 0.13.0

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: System SOMAXCONN is 2147483647

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: Will use a listen backlog of 32

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: starting port forwarding server on port_control_url:hyperv-connect://476a2200-9f21-4f4d-81ad-78f033a6602c vsock_path:

[14:04:45.439][VpnKit ][Info ] vpnkit.exe: connecting to 476a2200-9f21-4f4d-81ad-78f033a6602c:0B95756A-9985-48AD-9470-78E060895BE7

[14:04:45.444][VpnKit ][Info ] vpnkit.exe: DNS names will map to local IP 192.168.65.1

[14:04:45.444][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:04:45.446][VpnKit ][Info ] vpnkit.exe: attempting to reconnect to database

[14:04:45.447][DataKit ][Info ] com.docker.db.exe: accepted a new connection on \.\pipe\dockerDataBase

[14:04:45.476][VpnKit ][Error ] vpnkit.exe: While watching /etc/resolv.conf: ENOENT

[14:04:45.476][VpnKit ][Info ] vpnkit.exe: hosts file has bindings for

[14:04:45.478][DataKit ][Info ] com.docker.db.exe: Using protocol TwoThousandU msize 8215

[14:04:45.479][VpnKit ][Info ] vpnkit.exe: reconnected transport layer

[14:04:45.480][VpnKit ][Info ] vpnkit.exe: remove connection limit

[14:04:45.485][VpnKit ][Info ] vpnkit.exe: allowing binds to any IP addresses

[14:04:45.486][VpnKit ][Error ] vpnkit.exe: Failed to parse IPv4 address '', using default of 192.168.65.254

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: updating resolvers to use upstream DNS servers nameserver 172.29.143.30#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] search ent.rt.csaa.com

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: Add(3): DNS configuration changed to: use upstream DNS servers nameserver 172.29.143.30#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] search ent.rt.csaa.com

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: DNS names docker.for.win.localhost will map to local IP 192.168.65.1

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: updating resolvers to use upstream DNS servers nameserver 172.29.143.30#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] search ent.rt.csaa.com

[14:04:45.486][VpnKit ][Info ] vpnkit.exe: Remove(3): DNS configuration changed to: use upstream DNS servers nameserver 8.8.8.8#53

[14:04:45.486][VpnKit ][Info ] timeout 2000

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.486][VpnKit ][Info ] nameserver 8.8.4.4#53

[14:04:45.486][VpnKit ][Info ] timeout 2000

[14:04:45.486][VpnKit ][Info ] order 0

[14:04:45.487][VpnKit ][Info ] vpnkit.exe: Add(3): DNS configuration changed to: use upstream DNS servers nameserver 172.29.143.30#53

[14:04:45.487][VpnKit ][Info ] order 0

[14:04:45.487][VpnKit ][Info ] nameserver 172.26.143.31#53

[14:04:45.487][VpnKit ][Info ] order 0

[14:04:45.487][VpnKit ][Info ] search ent.rt.csaa.com

[14:04:45.487][VpnKit ][Info ] vpnkit.exe: DNS names docker.for.win.localhost will map to local IP 192.168.65.1

[14:04:45.487][VpnKit ][Info ] vpnkit.exe: 2 upstream DNS servers are configured

[14:04:45.493][VpnKit ][Info ] vpnkit.exe: Disabling transparent HTTP redirection

[14:04:45.493][VpnKit ][Info ] vpnkit.exe: Creating slirp server peer_ip:192.168.65.2 local_ip:192.168.65.1 domain_search:ent.rt.csaa.com mtu:8000 bridge:true

[14:04:45.493][VpnKit ][Info ] vpnkit.exe: connecting to 476a2200-9f21-4f4d-81ad-78f033a6602c:30D48B34-7D27-4B0B-AAAF-BBBED334DD59

[14:04:46.175][HyperV ][Debug ] [start] took 00:00:01.4681718 to run [14:04:46.176][Linux ][Info ] Trying to connect to vsud... [14:04:46.727][Moby ][Info ] Connected [14:04:48.578][Moby ][Info ] early console in extract_kernel [14:04:48.579][Moby ][Info ] input_data: 0x0000000001f453b4 [14:04:48.581][Moby ][Info ] input_len: 0x000000000065dff7 [14:04:48.582][Moby ][Info ] output: 0x0000000001000000 [14:04:48.584][Moby ][Info ] output_len: 0x000000000159111c [14:04:48.586][Moby ][Info ] kernel_total_size: 0x0000000001188000 [14:04:48.599][Moby ][Info ] booted via startup_64() [14:04:48.662][Moby ][Info ] Physical KASLR using RDRAND RDTSC... [14:04:48.688][Moby ][Info ] Virtual KASLR using RDRAND RDTSC... [14:04:48.688][Moby ][Info ] [14:04:54.500][Moby ][Info ] Decompressing Linux... Parsing ELF... Performing relocations... done. [14:04:54.500][Moby ][Info ] Booting the kernel. [14:04:54.541][Moby ][Info ] Linux version 4.9.36-moby (root@11fbdc1f630f) (gcc version 6.2.1 20160822 (Alpine 6.2.1) ) #1 SMP Wed Jul 12 15:29:07 UTC 2017 [14:04:54.566][Moby ][Info ] Command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate panic=1 rootdelay=300 noautodetect [14:04:54.566][Moby ][Info ] [14:04:54.592][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [14:04:54.606][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [14:04:54.630][Moby ][Info ] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'

[14:04:54.667][Moby ][Info ] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [14:04:54.678][Moby ][Info ] x86/fpu: Using 'eager' FPU context switches. [14:04:54.705][Moby ][Info ] e820: BIOS-provided physical RAM map: [14:04:54.715][Moby ][Info ] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable [14:04:54.725][Moby ][Info ] BIOS-e820: [mem 0x0000000000100000-0x000000007eeedfff] usable [14:04:54.748][Moby ][Info ] BIOS-e820: [mem 0x000000007eeee000-0x000000007eef1fff] ACPI data [14:04:54.773][Moby ][Info ] BIOS-e820: [mem 0x000000007eef2000-0x000000007ef1afff] reserved [14:04:54.786][Moby ][Info ] BIOS-e820: [mem 0x000000007ef1b000-0x000000007ff9afff] usable [14:04:54.806][Moby ][Info ] BIOS-e820: [mem 0x000000007ff9b000-0x000000007fff2fff] reserved [14:04:54.814][Moby ][Info ] BIOS-e820: [mem 0x000000007fff3000-0x000000007fffafff] ACPI data [14:04:54.836][Moby ][Info ] BIOS-e820: [mem 0x000000007fffb000-0x000000007fffefff] ACPI NVS [14:04:54.857][Moby ][Info ] BIOS-e820: [mem 0x000000007ffff000-0x000000007fffffff] usable [14:04:54.870][Moby ][Info ] bootconsole [earlyser0] enabled [14:04:54.882][Moby ][Info ] NX (Execute Disable) protection: active [14:04:54.896][Moby ][Info ] efi: EFI v2.31 by EDK II [14:04:54.982][Moby ][Info ] efi: ACPI=0x7fffa000 ACPI 2.0=0x7fffa014 SMBIOS=0x7fff2000 PROP=0x419a3d8 MEMATTR=0x7f524d18 [14:04:54.994][Moby ][Info ] SMBIOS 2.4 present. [14:04:55.011][Moby ][Info ] Hypervisor detected: Microsoft HyperV [14:04:55.034][Moby ][Info ] HyperV: features 0x2e7f, hints 0x2c2c [14:04:55.056][Moby ][Info ] HyperV: LAPIC Timer Frequency: 0x1e8480 [14:04:55.070][Moby ][Info ] clocksource: hyperv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns [14:04:55.085][Moby ][Info ] tsc: Marking TSC unstable due to running on Hyper-V [14:04:55.093][Moby ][Info ] e820: last_pfn = 0x80000 max_arch_pfn = 0x400000000 [14:04:55.106][Moby ][Info ] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT
[14:04:55.143][Moby ][Info ] Memory KASLR using RDRAND RDTSC... [14:04:55.155][Moby ][Info ] Using GB pages for direct mapping [14:04:55.170][Moby ][Info ] RAMDISK: [mem 0x7793a000-0x7b0c2fff] [14:04:55.182][Moby ][Info ] ACPI: Early table checksum verification disabled [14:04:55.222][Moby ][Info ] ACPI: RSDP 0x000000007FFFA014 000024 (v02 VRTUAL) [14:04:55.245][Moby ][Info ] ACPI: XSDT 0x000000007FFF90E8 00005C (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.257][Moby ][Info ] ACPI: FACP 0x000000007FFF7000 0000F4 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.288][Moby ][Info ] ACPI: DSDT 0x000000007EEEF000 00256F (v02 MSFTVM DSDT01 00000001 MSFT 04000000) [14:04:55.355][Moby ][Info ] ACPI: FACS 0x000000007FFFE000 000040 [14:04:55.409][Moby ][Info ] ACPI: APIC 0x000000007FFF8000 0007D2 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.467][Moby ][Info ] ACPI: OEM0 0x000000007FFF6000 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.501][Moby ][Info ] ACPI: WAET 0x000000007FFF5000 000028 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.511][Moby ][Info ] ACPI: OEM1 0x000000007FFF4000 00009E (v02 MSFTVM UARTS 00000001 MSFT 04000000) [14:04:55.559][Moby ][Info ] ACPI: OEM2 0x000000007FFF3000 0002E2 (v02 MSFTVM VTPM2 00000001 MSFT 04000000) [14:04:55.607][Moby ][Info ] ACPI: SRAT 0x000000007EEEE000 000190 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001) [14:04:55.670][Moby ][Info ] Zone ranges: [14:04:55.711][Moby ][Info ] DMA [mem 0x0000000000001000-0x0000000000ffffff] [14:04:55.746][Moby ][Info ] DMA32 [mem 0x0000000001000000-0x000000007fffffff] [14:04:55.778][Moby ][Info ] Normal empty [14:04:55.799][Moby ][Info ] Movable zone start for each node [14:04:55.824][Moby ][Info ] Early memory node ranges [14:04:55.836][Moby ][Info ] node 0: [mem 0x0000000000001000-0x000000000009ffff] [14:04:55.858][Moby ][Info ] node 0: [mem 0x0000000000100000-0x000000007eeedfff] [14:04:55.865][Moby ][Info ] node 0: [mem 0x000000007ef1b000-0x000000007ff9afff] [14:04:55.882][Moby ][Info ] node 0: [mem 0x000000007ffff000-0x000000007fffffff] [14:04:55.907][Moby ][Info ] Initmem setup node 0 [mem 0x0000000000001000-0x000000007fffffff] [14:04:55.922][Moby ][Info ] ACPI: PM-Timer IO Port: 0x408 [14:04:55.939][Moby ][Info ] ------------[ cut here ]------------ [14:04:55.961][Moby ][Info ] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/apic/apic.c:2065 generic_processor_info+0x149/0x24f [14:04:55.971][Moby ][Info ] Only 127 processors supported.Processor 128/0x80 and the rest are ignored. [14:04:56.018][Moby ][Info ] Modules linked in: [14:04:56.032][Moby ][Info ] CPU: 0 PID: 0 Comm: swapper Not tainted 4.9.36-moby #1 [14:04:56.042][Moby ][Info ] Hardware name: Microsoft Corporation Virtual Machine/Virtual Machine, BIOS Hyper-V UEFI Release v1.0 11/26/2012 [14:04:56.098][Moby ][Info ] 0000000000000000 ffffffffb641b245 ffffffffb6e03d40 0000000000000000 [14:04:56.174][Moby ][Info ] ffffffffb60dcf41 0000000000000080 ffffffffb6e03da0 0000000000000000 [14:04:56.236][Moby ][Info ] 0000000000000014 0000000000000000 0000000000000000 ffffffffb60dcfb4 [14:04:56.246][Moby ][Info ] Call Trace: [14:04:56.264][Moby ][Info ] [] ? dump_stack+0x5a/0x6f [14:04:56.280][Moby ][Info ] [] ? warn+0xd2/0xeb [14:04:56.289][Moby ][Info ] [] ? warn_slowpath_fmt+0x5a/0x76 [14:04:56.296][Moby ][Info ] [] ? early_ioremap+0x13d/0x1bd [14:04:56.317][Moby ][Info ] [] ? generic_processor_info+0x149/0x24f [14:04:56.336][Moby ][Info ] [] ? acpi_register_lapic+0x46/0x72 [14:04:56.352][Moby ][Info ] [] ? acpi_parse_lapic+0x3f/0x44 [14:04:56.367][Moby ][Info ] [] ? acpi_parse_entries_array+0xef/0x145 [14:04:56.378][Moby ][Info ] [] ? acpi_table_parse_entries_array+0xbe/0xf7 [14:04:56.388][Moby ][Info ] [] ? acpi_boot_init+0xed/0x45e [14:04:56.395][Moby ][Info ] [] ? pmd_val+0x7/0x8 [14:04:56.405][Moby ][Info ] [] ? pmd_page_vaddr+0x9/0x30 [14:04:56.414][Moby ][Info ] [] ? acpi_parse_x2apic_nmi+0x3c/0x3c [14:04:56.428][Moby ][Info ] [] ? dmi_ignore_irq0_timer_override+0x26/0x26 [14:04:56.442][Moby ][Info ] [] ? setup_arch+0x889/0x984 [14:04:56.456][Moby ][Info ] [] ? start_kernel+0xa9/0x44a [14:04:56.474][Moby ][Info ] [] ? early_idt_handler_array+0x120/0x120 [14:04:56.478][Moby ][Info ] [] ? x86_64_start_kernel+0x141/0x165 [14:04:56.491][Moby ][Info ] ---[ end trace 06d708a34b744166 ]--- [14:04:56.499][Moby ][Info ] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [14:04:56.553][Moby ][Info ] IOAPIC[0]: apic_id 2, version 17, address 0xfec00000, GSI 0-23 [14:04:56.565][Moby ][Info ] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [14:04:56.571][Moby ][Info ] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [14:04:56.576][Moby ][Info ] Using ACPI (MADT) for SMP configuration information [14:04:56.586][Moby ][Info ] smpboot: 240 Processors exceeds NR_CPUS limit of 128 [14:04:56.605][Moby ][Info ] smpboot: Allowing 128 CPUs, 126 hotplug CPUs [14:04:56.610][Moby ][Info ] e820: [mem 0x80000000-0xffffffff] available for PCI devices [14:04:56.624][Moby ][Info ] Booting paravirtualized kernel on bare hardware [14:04:56.641][Moby ][Info ] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [14:04:56.645][Moby ][Info ] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:128 nr_node_ids:1 [14:04:56.658][Moby ][Info ] percpu: Embedded 35 pages/cpu @ffff8b9475800000 s105176 r8192 d29992 u262144 [14:04:56.669][Moby ][Info ] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 515799 [14:04:56.679][Moby ][Info ] Kernel command line: earlyprintk=ttyS0,115200 console=ttyS0,115200 mobyplatform=windows vsyscall=emulate panic=1 rootdelay=300 noautodetect [14:04:56.679][Moby ][Info ] [14:04:56.695][Moby ][Info ] log_buf_len individual max cpu contribution: 4096 bytes [14:04:56.706][Moby ][Info ] log_buf_len total cpu_extra contributions: 520192 bytes [14:04:56.720][Moby ][Info ] log_buf_len min size: 131072 bytes [14:04:56.731][Moby ][Info ] log_buf_len: 1048576 bytes [14:04:56.738][Moby ][Info ] early log buf free: 120596(92%) [14:04:56.748][Moby ][Info ] PID hash table entries: 4096 (order: 3, 32768 bytes) [14:04:56.765][Moby ][Info ] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [14:04:56.773][Moby ][Info ] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [14:04:56.806][Moby ][Info ] Memory: 1951304K/2096184K available (8505K kernel code, 1412K rwdata, 2864K rodata, 1392K init, 600K bss, 144880K reserved, 0K cma-reserved) [14:04:56.813][Moby ][Info ] Hierarchical RCU implementation. [14:04:56.818][Moby ][Info ] Build-time adjustment of leaf fanout to 64. [14:04:56.832][Moby ][Info ] Using NULL legacy PIC [14:04:56.846][Moby ][Info ] NR_IRQS:8448 nr_irqs:1448 0 [14:04:56.869][Moby ][Info ] Console: colour dummy device 80x25 [14:04:56.902][Moby ][Info ] console [ttyS0] enabled [14:04:56.906][Moby ][Info ] console [ttyS0] enabled [14:04:56.916][Moby ][Info ] bootconsole [earlyser0] disabled [14:04:56.923][Moby ][Info ] bootconsole [earlyser0] disabled [14:04:57.064][Moby ][Info ] tsc: Fast TSC calibration failed [14:04:57.087][Moby ][Info ] tsc: Unable to calibrate against PIT [14:04:57.109][Moby ][Info ] tsc: using PMTIMER reference calibration [14:04:57.138][Moby ][Info ] tsc: Detected 2595.067 MHz processor [14:04:57.164][Moby ][Info ] Calibrating delay loop (skipped), value calculated using timer frequency.. 5190.13 BogoMIPS (lpj=25950670) [14:04:57.178][Moby ][Info ] pid_max: default: 131072 minimum: 1024 [14:04:57.196][Moby ][Info ] ACPI: Core revision 20160831 [14:04:57.247][Moby ][Info ] ACPI: 1 ACPI AML tables successfully acquired and loaded [14:04:57.280][Moby ][Info ] Security Framework initialized [14:04:57.302][Moby ][Info ] Yama: becoming mindful. [14:04:57.338][Moby ][Info ] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [14:04:57.372][Moby ][Info ] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [14:04:57.397][Moby ][Info ] CPU: Physical Processor ID: 0 [14:04:57.422][Moby ][Info ] CPU: Processor Core ID: 0 [14:04:57.438][Moby ][Info ] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024 [14:04:57.463][Moby ][Info ] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4 [14:04:57.499][Moby ][Info ] Freeing SMP alternatives memory: 24K (ffffffffb70bf000 - ffffffffb70c5000) [14:04:57.518][Moby ][Info ] ftrace: allocating 37666 entries in 148 pages [14:04:58.004][Moby ][Info ] smpboot: Max logical packages: 120 [14:04:58.509][Moby ][Info ] Switched APIC routing to physical flat. [14:05:00.030][Moby ][Info ] smpboot: CPU0: Intel(R) Core(TM) i7-4600U CPU @ 2.10GHz (family: 0x6, model: 0x45, stepping: 0x1) [14:05:01.185][Moby ][Info ] Performance Events: unsupported p6 CPU model 69 no PMU driver, software events only. [14:05:02.299][Moby ][Info ] NMI watchdog: disabled (cpu0): hardware events not enabled [14:05:03.150][Moby ][Info ] NMI watchdog: Shutting down hard lockup detector on all cpus [14:05:03.820][Moby ][Info ] x86: Booting SMP configuration: [14:05:06.633][Moby ][Info ] .... node #0, CPUs: #1calibrate_delay_direct() failed to get a good estimate for loops_per_jiffy. [14:05:08.493][Moby ][Info ] Probably due to long platform interrupts. Consider using "lpj=" boot option. [14:05:09.254][Moby ][Info ] x86: Booted up 1 node, 2 CPUs [14:05:10.274][Moby ][Info ] smpboot: Total of 2 processors activated (7288.92 BogoMIPS) [14:05:10.716][Moby ][Info ] devtmpfs: initialized [14:05:11.449][Moby ][Info ] x86/mm: Memory block size: 128MB [14:05:12.853][Moby ][Info ] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [14:05:13.718][Moby ][Info ] futex hash table entries: 32768 (order: 9, 2097152 bytes) [14:05:14.268][Moby ][Info ] NET: Registered protocol family 16 [14:05:14.891][Moby ][Info ] cpuidle: using governor ladder [14:05:15.596][Moby ][Info ] cpuidle: using governor menu [14:05:15.877][Moby ][Info ] ACPI: bus type PCI registered [14:05:17.080][Moby ][Info ] PCI: Fatal: No config space access function found [14:05:17.467][Moby ][Info ] HugeTLB registered 1 GB page size, pre-allocated 0 pages [14:05:18.348][Moby ][Info ] HugeTLB registered 2 MB page size, pre-allocated 0 pages [14:05:19.188][Moby ][Info ] ACPI: Added _OSI(Module Device) [14:05:19.684][Moby ][Info ] ACPI: Added _OSI(Processor Device) [14:05:20.107][Moby ][Info ] ACPI: Added _OSI(3.0 _SCP Extensions) [14:05:20.969][Moby ][Info ] ACPI: Added _OSI(Processor Aggregator Device) [14:05:22.301][Moby ][Info ] ACPI: Executed 1 blocks of module-level executable AML code [14:05:23.042][Moby ][Info ] ACPI: Dynamic OEM Table Load: [14:05:23.405][Moby ][Info ] ACPI: Interpreter enabled [14:05:24.050][Moby ][Info ] ACPI: (supports S0 S5) [14:05:24.922][Moby ][Info ] ACPI: Using IOAPIC for interrupt routing [14:05:26.199][Moby ][Info ] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [14:05:27.082][Moby ][Info ] ACPI: Enabled 1 GPEs in block 00 to 0F [14:05:27.520][Moby ][Info ] SCSI subsystem initialized [14:05:27.699][Moby ][Info ] pps_core: LinuxPPS API ver. 1 registered [14:05:29.254][Moby ][Info ] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it [14:05:29.429][Moby ][Info ] PTP clock support registered [14:05:29.743][Moby ][Info ] Registered efivars operations [14:05:30.212][Moby ][Info ] wmi: Mapper loaded [14:05:31.695][Moby ][Info ] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns [14:05:32.530][Moby ][Info ] hv_vmbus: Hyper-V Host Build:14393-10.0-1-0.1358; Vmbus version:4.0 [14:05:32.814][Moby ][Info ] PCI: Using ACPI for IRQ routing [14:05:33.224][Moby ][Info ] PCI: System does not support PCI [14:05:33.698][Moby ][Info ] NetLabel: Initializing [14:05:34.484][Moby ][Info ] NetLabel: domain hash size = 128 [14:05:34.751][Moby ][Info ] NetLabel: protocols = UNLABELED CIPSOv4 [14:05:35.757][Moby ][Info ] NetLabel: unlabeled traffic allowed by default [14:05:37.476][Moby ][Info ] clocksource: Switched to clocksource hyperv_clocksource_tsc_page [14:05:37.914][Moby ][Info ] FS-Cache: Loaded [14:05:38.080][Moby ][Info ] CacheFiles: Loaded [14:05:38.444][Moby ][Info ] pnp: PnP ACPI init [14:05:38.954][Moby ][Info ] pnp: PnP ACPI: found 3 devices [14:05:40.150][Moby ][Info ] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [14:05:40.480][Moby ][Info ] NET: Registered protocol family 2 [14:05:40.922][Moby ][Info ] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [14:05:42.012][Moby ][Info ] TCP bind hash table entries: 16384 (order: 6, 262144 bytes) [14:05:43.004][Moby ][Info ] TCP: Hash tables configured (established 16384 bind 16384) [14:05:43.941][Moby ][Info ] UDP hash table entries: 1024 (order: 3, 32768 bytes) [14:05:44.388][Moby ][Info ] random: fast init done [14:05:45.071][Moby ][Info ] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) [14:05:45.899][Moby ][Info ] NET: Registered protocol family 1 [14:05:46.265][PowerMode ][Info ] Stop [14:05:46.266][HyperV ][Info ] Stop [14:05:46.267][PowerShell ][Info ] Run script with parameters: -Stop True... [14:05:46.273][HyperV ][Info ] Script started at 14:05:46.273 [14:05:46.297][HyperV ][Info ] Module loaded at 14:05:46.297 [14:05:46.360][HyperV ][Info ] Stopping VM MobyLinuxVM... [14:05:46.675][Moby ][Info ] RPC: Registered named UNIX socket transport module. [14:05:47.477][Moby ][Info ] RPC: Registered udp transport module. [14:05:47.750][Moby ][Info ] RPC: Regis [14:05:47.751][Moby ][Error ] Failed to read Moby's logs: The operation has timed out. [14:05:47.989][HyperV ][Info ] Turn Off VM ... [14:05:48.017][HyperV ][Info ] VM MobyLinuxVM killed. Waiting for state to change [14:05:52.043][HyperV ][Info ] Killed VM MobyLinuxVM is off [14:05:52.044][HyperV ][Info ] Destroying Switch DockerNAT... [14:05:56.190][HyperV ][Info ] Removing VM MobyLinuxVM... [14:05:56.420][HyperV ][Debug ] [stop] took 00:00:10.1536655 to run [14:05:56.420][OptimizeDisk ][Info ] Optimize [14:05:56.420][PowerShell ][Info ] Run script... [14:05:56.435][Moby ][Info ] Stop [14:05:56.445][VpnKit ][Info ] Killing existing vpnkit with PID 928 [14:05:56.461][DataKit ][Info ] Killing existing com.docker.db with PID 15720 [14:05:56.484][HyperV ][Info ] Destroy [14:05:56.485][PowerShell ][Info ] Run script with parameters: -Destroy True -KeepVolume True... [14:05:56.494][HyperV ][Info ] Script started at 14:05:56.493 [14:05:56.515][HyperV ][Info ] Module loaded at 14:05:56.515 [14:05:56.573][HyperV ][Info ] VM MobyLinuxVM does not exist [14:05:56.574][HyperV ][Info ] Destroying Switch DockerNAT... [14:05:56.701][HyperV ][Info ] Removing VM MobyLinuxVM... [14:05:56.733][HyperV ][Debug ] [destroy] took 00:00:00.2480370 to run [14:05:56.892][NamedPipeClient][Error ] Unable to send Start: Docker hv-sock proxy (vsudd) is not reachable [14:05:56.894][Notifications ][Error ] Docker hv-sock proxy (vsudd) is not reachable [14:05:56.733][Firewall ][Info ] Closing ports... [14:05:56.733][Firewall ][Info ] Removing all existing rules... [14:05:56.876][Firewall ][Info ] All existing rules are removed. [14:05:56.876][Firewall ][Info ] Ports are closed [14:05:56.876][HyperVGuids ][Info ] Removing GUIDs... [14:05:56.878][HyperVGuids ][Info ] GUIDs removed [14:05:56.884][NamedPipeServer][Error ] Unable to execute Start: Docker hv-sock proxy (vsudd) is not reachable at Docker.Backend.ContainerEngine.Linux.ConnectToVsud(TaskCompletionSource`1 vmId) at Docker.Backend.ContainerEngine.Linux.DoStart(Settings settings) at Docker.Backend.ContainerEngine.Linux.Start(Settings settings) at Docker.Core.Pipe.NamedPipeServer.<>c__DisplayClass9_0.b__0(Object[] parameters) at Docker.Core.Pipe.NamedPipeServer.RunAction(String action, Object[] parameters) [14:07:52.804][SegmentApi ][Info ] Usage statistic: actionMenuFeedback [14:07:53.139][SegmentApi ][Error ] Failed to track event actionMenuFeedback: An error occurred while sending the request. [14:07:54.889][FeedbackSettings][Info ] Open github issues [14:10:12.495][ErrorReportWindow][Info ] Open logs

Steps to reproduce the behavior

  1. ...login to window 10
  2. ...start docker for linux containers
samarkumar1 commented 7 years ago

This issue is keep coming and go .. not sure the reason and how to fix this issue

samarkumar1 commented 6 years ago

I think i figure it out the reason, this intermittent issue is coming because there is not enough memory available to Docker to run ...

if you make sure sufficient memory is available then it will be fine...

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