Skip to content
This repository has been archived by the owner on Mar 24, 2020. It is now read-only.

Latest version - Linux container not running #35

Closed
tracker1 opened this issue Mar 7, 2019 · 3 comments
Closed

Latest version - Linux container not running #35

tracker1 opened this issue Mar 7, 2019 · 3 comments

Comments

@tracker1
Copy link

tracker1 commented Mar 7, 2019

LCOW: v4.14.35-v0.3.9
dockerd.exe: master-dockerproject-2019-03-06, build fc01c2b
docker.exe: master-dockerproject-2019-03-06, build 79e1cabf
Windows: Windows Server 2019 Standard, Version 1809, Build: 17763.316

I ran the following after running dockerd, and got no output...

docker run --platform linux --rm -ti busybox sh

The output from dockerd -D --experimental > ~/dockerd.log 2>&1 is below...

time="2019-03-07T14:09:25.200906200-08:00" level=warning msg="Running experimental build"
time="2019-03-07T14:09:25.205911800-08:00" level=debug msg="Listener created for HTTP on npipe (//./pipe/docker_engine)"
time="2019-03-07T14:09:25.217912000-08:00" level=info msg="Windows default isolation mode: process"
time="2019-03-07T14:09:25.218912600-08:00" level=debug msg="Using default logging driver json-file"
time="2019-03-07T14:09:25.218912600-08:00" level=debug msg="[graphdriver] trying provided driver: windowsfilter"
time="2019-03-07T14:09:25.219913300-08:00" level=debug msg="WindowsGraphDriver InitFilter at C:\\ProgramData\\docker\\windowsfilter"
time="2019-03-07T14:09:25.219913300-08:00" level=debug msg="Initialized graph driver windowsfilter"
time="2019-03-07T14:09:25.235912500-08:00" level=debug msg="[graphdriver] trying provided driver: lcow"
time="2019-03-07T14:09:25.236912400-08:00" level=info msg="lcowdriver: init: dataRoot: C:\\ProgramData\\docker\\lcow globalMode: false"
time="2019-03-07T14:09:25.237914100-08:00" level=debug msg="Initialized graph driver lcow"
time="2019-03-07T14:09:25.271942600-08:00" level=debug msg="Stackdump - waiting signal at Global\\stackdump-3980"
time="2019-03-07T14:09:25.280915400-08:00" level=debug msg="Max Concurrent Downloads: 3"
time="2019-03-07T14:09:25.280915400-08:00" level=debug msg="Max Concurrent Uploads: 5"
time="2019-03-07T14:09:25.280915400-08:00" level=info msg="Loading containers: start."
time="2019-03-07T14:09:25.283914900-08:00" level=debug msg="Loaded container 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043, isRunning: true"
time="2019-03-07T14:09:25.286915200-08:00" level=debug msg="Loaded container 1ad1509ab6fb3b80c9bcec9cf5f021c788671b9f52b7f70fee63865c9b33e482, isRunning: false"
time="2019-03-07T14:09:25.315845400-08:00" level=debug msg="restoring container" container=1ad1509ab6fb3b80c9bcec9cf5f021c788671b9f52b7f70fee63865c9b33e482 paused=false running=false
time="2019-03-07T14:09:25.315845400-08:00" level=debug msg="restore()" container=1ad1509ab6fb3b80c9bcec9cf5f021c788671b9f52b7f70fee63865c9b33e482 module=libcontainerd namespace=moby
time="2019-03-07T14:09:25.315845400-08:00" level=debug msg="hcsshim::OpenComputeSystem - Begin Operation" cid=1ad1509ab6fb3b80c9bcec9cf5f021c788671b9f52b7f70fee63865c9b33e482
time="2019-03-07T14:09:25.317846300-08:00" level=debug msg="hcsshim::OpenComputeSystem - End Operation - Success" cid=1ad1509ab6fb3b80c9bcec9cf5f021c788671b9f52b7f70fee63865c9b33e482
time="2019-03-07T14:09:25.319063200-08:00" level=debug msg="restoring container" container=28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 paused=false running=true
time="2019-03-07T14:09:25.319063200-08:00" level=debug msg="restore()" container=28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 module=libcontainerd namespace=moby
time="2019-03-07T14:09:25.319063200-08:00" level=debug msg="hcsshim::OpenComputeSystem - Begin Operation" cid=28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043
time="2019-03-07T14:09:25.322229800-08:00" level=debug msg="hcsshim::OpenComputeSystem - End Operation - Success" cid=28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043
time="2019-03-07T14:09:25.322229800-08:00" level=error msg="28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 cleanup: failed to delete container from containerd: no such container"
time="2019-03-07T14:09:25.331091200-08:00" level=debug msg="lcowdriver: get: 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043"
time="2019-03-07T14:09:25.332091800-08:00" level=debug msg="lcowdriver: getlayerchain: id 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 json C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043\\layerchain.json"
time="2019-03-07T14:09:25.333091200-08:00" level=debug msg="getting all  layers: [C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 C:\\ProgramData\\docker\\lcow\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370]"
time="2019-03-07T14:09:25.333091200-08:00" level=debug msg="lcowdriver: get: 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043: got layer mounts: [{HostPath:C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043\\sandbox.vhdx ContainerPath:/tmp/28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 CreateInUtilityVM:true ReadOnly:false Cache: AttachOnly:false} {HostPath:C:\\ProgramData\\docker\\lcow\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370\\layer.vhd ContainerPath:/tmp/c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370 CreateInUtilityVM:true ReadOnly:true Cache: AttachOnly:false}]"
time="2019-03-07T14:09:25.334092400-08:00" level=debug msg="container mounted via layerStore: &{/tmp/28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043-mount 0xc0005c42a0 [{C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043\\sandbox.vhdx /tmp/28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 true false  false} {C:\\ProgramData\\docker\\lcow\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370\\layer.vhd /tmp/c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370 true true  false}] 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 <nil> {0 0}}"
time="2019-03-07T14:09:25.334092400-08:00" level=debug msg="Option Experimental: true"
time="2019-03-07T14:09:25.334092400-08:00" level=debug msg="Option DefaultDriver: nat"
time="2019-03-07T14:09:25.334092400-08:00" level=debug msg="Option DefaultNetwork: nat"
time="2019-03-07T14:09:25.335093000-08:00" level=debug msg="Network Control Plane MTU: 1500"
time="2019-03-07T14:09:25.335093000-08:00" level=info msg="Restoring existing overlay networks from HNS into docker"
time="2019-03-07T14:09:25.335093000-08:00" level=debug msg="[GET]=>[/networks/] Request : "
time="2019-03-07T14:09:25.344476600-08:00" level=debug msg="Network Response : [{\"ActivityId\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"AdditionalParams\":{},\"CurrentEndpointCount\":1,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"E9B59CFA-2BE1-4B21-828F-B6FBDBDDC017\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"EA24CD6C-D17A-4348-9190-09F0D5BE83DD\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":0,\"Health\":{\"AddressNotificationMissedCount\":0,\"AddressNotificationSequenceNumber\":0,\"InterfaceNotificationMissedCount\":0,\"InterfaceNotificationSequenceNumber\":0,\"LastErrorCode\":0,\"LastUpdateTime\":131963739110176726,\"RouteNotificationMissedCount\":0,\"RouteNotificationSequenceNumber\":0},\"ID\":\"E584C5C6-538C-4DC8-8DB3-7945C3B64FA2\",\"IPv6\":false,\"LayeredOn\":\"2E35AC5F-6A92-4EFD-8567-CE75C61C213B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-DF-CF-FF\",\"StartMacAddress\":\"00-15-5D-DF-C0-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"ICSD9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"Policies\":[],\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{D9C4F185-518A-4A27-A5B8-0550AD5F63CE}\",\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DevicelessNic\":false,\"EndpointNicGuid\":\"43F1D438-B204-4F75-8A19-0579BE2E9BFB\",\"EndpointPortGuid\":\"B9336BCB-7495-496F-A80A-735E209ACE39\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"Hidden\":false,\"ID\":\"63375CAA-3ED0-4275-8CBC-82B7DF4E6EDF\",\"InterfaceGuid\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"IsPolicy\":false,\"IsolationId\":0,\"MacAddress\":\"00-15-5D-DF-C6-6B\",\"ManagementPort\":true,\"NicFriendlyName\":\"nat\",\"PreferredPortFriendlyName\":\"Container NIC 63375caa\",\"SwitchId\":\"7194A549-CA7F-4191-BDCE-8283D9BD196B\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AllocationOrder\":1,\"Dhcp\":false,\"Dns\":false,\"ExternalInterfaceConstraint\":0,\"Health\":{\"DHCPState\":1,\"DNSState\":1,\"ICSState\":2,\"LastErrorCode\":0,\"LastUpdateTime\":131963739122081742},\"ICSFlags\":0,\"ID\":\"4EFE47BA-E439-4254-AB24-D09672EC8F9E\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"SubnetIPAddress\":\"172.30.144.0\",\"Tag\":\"ICS\"}],\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116119158},\"ID\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0A12269C-EB43-4741-8C68-B7F3349D9645\"},\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.30.144.0/20\",\"GatewayAddress\":\"172.30.144.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"ID\":\"13F956C9-C396-4D03-ABEF-52F38917C647\",\"Policies\":[],\"State\":0}],\"TotalEndpoints\":3,\"Type\":\"nat\",\"Version\":38654705665}]"
time="2019-03-07T14:09:25.360078100-08:00" level=debug msg="Network  nat (d237f5b) restored"
time="2019-03-07T14:09:25.360078100-08:00" level=debug msg="Endpoint (523f7a8) restored to network (d237f5b)"
time="2019-03-07T14:09:25.360078100-08:00" level=info msg="Removing stale sandbox 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 (28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043)"
time="2019-03-07T14:09:25.382221100-08:00" level=info msg="Removing stale endpoint hardcore_edison (523f7a838be695c649979d1b8ecd7f3098a9dbd9784212cdb8f7b4db7bfd7764)"
time="2019-03-07T14:09:25.407003100-08:00" level=debug msg="[DELETE]=>[/endpoints/BB7D06E7-F80E-4763-A060-FA78FBE6ABD3] Request : "
time="2019-03-07T14:09:25.420860700-08:00" level=debug msg="Releasing addresses for endpoint hardcore_edison's interface on network nat"
time="2019-03-07T14:09:25.421832500-08:00" level=debug msg="ReleaseAddress(172.30.144.0/20, 172.30.154.70)"
time="2019-03-07T14:09:25.427431100-08:00" level=info msg="Fixing inconsistent endpoint_cnt for network nat. Expected=0, Actual=1"
time="2019-03-07T14:09:25.436431600-08:00" level=debug msg="[GET]=>[/networks/] Request : "
time="2019-03-07T14:09:25.442710900-08:00" level=debug msg="Network Response : [{\"ActivityId\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"AdditionalParams\":{},\"CurrentEndpointCount\":0,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"E9B59CFA-2BE1-4B21-828F-B6FBDBDDC017\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"EA24CD6C-D17A-4348-9190-09F0D5BE83DD\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":0,\"Health\":{\"AddressNotificationMissedCount\":0,\"AddressNotificationSequenceNumber\":0,\"InterfaceNotificationMissedCount\":0,\"InterfaceNotificationSequenceNumber\":0,\"LastErrorCode\":0,\"LastUpdateTime\":131963739110176726,\"RouteNotificationMissedCount\":0,\"RouteNotificationSequenceNumber\":0},\"ID\":\"E584C5C6-538C-4DC8-8DB3-7945C3B64FA2\",\"IPv6\":false,\"LayeredOn\":\"2E35AC5F-6A92-4EFD-8567-CE75C61C213B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-DF-CF-FF\",\"StartMacAddress\":\"00-15-5D-DF-C0-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"ICSD9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"Policies\":[],\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{D9C4F185-518A-4A27-A5B8-0550AD5F63CE}\",\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DevicelessNic\":false,\"EndpointNicGuid\":\"43F1D438-B204-4F75-8A19-0579BE2E9BFB\",\"EndpointPortGuid\":\"B9336BCB-7495-496F-A80A-735E209ACE39\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"Hidden\":false,\"ID\":\"63375CAA-3ED0-4275-8CBC-82B7DF4E6EDF\",\"InterfaceGuid\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"IsPolicy\":false,\"IsolationId\":0,\"MacAddress\":\"00-15-5D-DF-C6-6B\",\"ManagementPort\":true,\"NicFriendlyName\":\"nat\",\"PreferredPortFriendlyName\":\"Container NIC 63375caa\",\"SwitchId\":\"7194A549-CA7F-4191-BDCE-8283D9BD196B\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AllocationOrder\":1,\"Dhcp\":false,\"Dns\":false,\"ExternalInterfaceConstraint\":0,\"Health\":{\"DHCPState\":1,\"DNSState\":1,\"ICSState\":2,\"LastErrorCode\":0,\"LastUpdateTime\":131963739122081742},\"ICSFlags\":0,\"ID\":\"4EFE47BA-E439-4254-AB24-D09672EC8F9E\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"SubnetIPAddress\":\"172.30.144.0\",\"Tag\":\"ICS\"}],\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116119158},\"ID\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0A12269C-EB43-4741-8C68-B7F3349D9645\"},\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.30.144.0/20\",\"GatewayAddress\":\"172.30.144.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"ID\":\"13F956C9-C396-4D03-ABEF-52F38917C647\",\"Policies\":[],\"State\":0}],\"TotalEndpoints\":3,\"Type\":\"nat\",\"Version\":38654705665}]"
time="2019-03-07T14:09:25.442710900-08:00" level=debug msg="Launching DNS server for network \"none\""
time="2019-03-07T14:09:25.464813500-08:00" level=debug msg="releasing IPv4 pools from network nat (d237f5bf5cd871330fa5b889a6dbac2938a7848ba7471c55acf2594c6bf592c1)"
time="2019-03-07T14:09:25.464813500-08:00" level=debug msg="ReleaseAddress(172.30.144.0/20, 172.30.144.1)"
time="2019-03-07T14:09:25.464813500-08:00" level=debug msg="ReleasePool(172.30.144.0/20)"
time="2019-03-07T14:09:25.470809300-08:00" level=debug msg="cleanupServiceDiscovery for network:d237f5bf5cd871330fa5b889a6dbac2938a7848ba7471c55acf2594c6bf592c1"
time="2019-03-07T14:09:25.480414900-08:00" level=debug msg="Allocating IPv4 pools for network nat (d237f5bf5cd871330fa5b889a6dbac2938a7848ba7471c55acf2594c6bf592c1)"
time="2019-03-07T14:09:25.481391400-08:00" level=debug msg="RequestPool(LocalDefault, 172.30.144.0/20, , map[], false)"
time="2019-03-07T14:09:25.481391400-08:00" level=debug msg="RequestAddress(172.30.144.0/20, 172.30.144.1, map[RequestAddressType:com.docker.network.gateway])"
time="2019-03-07T14:09:25.481391400-08:00" level=debug msg="[GET]=>[/endpoints/] Request : "
time="2019-03-07T14:09:25.487576700-08:00" level=debug msg="Network Response : []"
time="2019-03-07T14:09:25.494723200-08:00" level=debug msg="Launching DNS server for network \"nat\""
time="2019-03-07T14:09:25.495699600-08:00" level=debug msg="[GET]=>[/networks/E584C5C6-538C-4DC8-8DB3-7945C3B64FA2] Request : "
time="2019-03-07T14:09:25.499160600-08:00" level=debug msg="Network Response : {\"ActivityId\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"AdditionalParams\":{},\"CurrentEndpointCount\":0,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"E9B59CFA-2BE1-4B21-828F-B6FBDBDDC017\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"EA24CD6C-D17A-4348-9190-09F0D5BE83DD\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":0,\"Health\":{\"AddressNotificationMissedCount\":0,\"AddressNotificationSequenceNumber\":0,\"InterfaceNotificationMissedCount\":0,\"InterfaceNotificationSequenceNumber\":0,\"LastErrorCode\":0,\"LastUpdateTime\":131963739110176726,\"RouteNotificationMissedCount\":0,\"RouteNotificationSequenceNumber\":0},\"ID\":\"E584C5C6-538C-4DC8-8DB3-7945C3B64FA2\",\"IPv6\":false,\"LayeredOn\":\"2E35AC5F-6A92-4EFD-8567-CE75C61C213B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-DF-CF-FF\",\"StartMacAddress\":\"00-15-5D-DF-C0-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"ICSD9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"Policies\":[],\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{D9C4F185-518A-4A27-A5B8-0550AD5F63CE}\",\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DevicelessNic\":false,\"EndpointNicGuid\":\"43F1D438-B204-4F75-8A19-0579BE2E9BFB\",\"EndpointPortGuid\":\"B9336BCB-7495-496F-A80A-735E209ACE39\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"Hidden\":false,\"ID\":\"63375CAA-3ED0-4275-8CBC-82B7DF4E6EDF\",\"InterfaceGuid\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"IsPolicy\":false,\"IsolationId\":0,\"MacAddress\":\"00-15-5D-DF-C6-6B\",\"ManagementPort\":true,\"NicFriendlyName\":\"nat\",\"PreferredPortFriendlyName\":\"Container NIC 63375caa\",\"SwitchId\":\"7194A549-CA7F-4191-BDCE-8283D9BD196B\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AllocationOrder\":1,\"Dhcp\":false,\"Dns\":false,\"ExternalInterfaceConstraint\":0,\"Health\":{\"DHCPState\":1,\"DNSState\":1,\"ICSState\":2,\"LastErrorCode\":0,\"LastUpdateTime\":131963739122081742},\"ICSFlags\":0,\"ID\":\"4EFE47BA-E439-4254-AB24-D09672EC8F9E\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"D9C4F185-518A-4A27-A5B8-0550AD5F63CE\",\"SubnetIPAddress\":\"172.30.144.0\",\"Tag\":\"ICS\"}],\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116119158},\"ID\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0A12269C-EB43-4741-8C68-B7F3349D9645\"},\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.30.144.0/20\",\"GatewayAddress\":\"172.30.144.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131963739116156581},\"ID\":\"13F956C9-C396-4D03-ABEF-52F38917C647\",\"Policies\":[],\"State\":0}],\"TotalEndpoints\":3,\"Type\":\"nat\",\"Version\":38654705665}"
time="2019-03-07T14:09:25.499160600-08:00" level=debug msg="Binding a resolver on network nat gateway 172.30.144.1"
time="2019-03-07T14:09:25.499160600-08:00" level=debug msg="Resolver bound successfully for network nat"
time="2019-03-07T14:09:25.526684900-08:00" level=debug msg="lcowdriver: remove: id 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043"
time="2019-03-07T14:09:25.527686900-08:00" level=debug msg="lcowdriver: remove: id 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043: layerPath C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043"
time="2019-03-07T14:09:25.531723300-08:00" level=debug msg="lcowdriver: remove: id 28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043: layerPath C:\\ProgramData\\docker\\lcow\\28bb3fd9386358996988f9a3d37072a1ac917b08f1ef085443b0ef1b4a944043 succeeded"
time="2019-03-07T14:09:25.534686000-08:00" level=info msg="Loading containers: done."
time="2019-03-07T14:09:25.538685800-08:00" level=info msg="Docker daemon" commit=fc01c2b graphdriver(s)="windowsfilter (windows), lcow (linux)" version=master-dockerproject-2019-03-06
time="2019-03-07T14:09:25.538685800-08:00" level=info msg="Daemon has completed initialization"
time="2019-03-07T14:09:25.547885300-08:00" level=debug msg="Registering routers"
time="2019-03-07T14:09:25.547885300-08:00" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints"
time="2019-03-07T14:09:25.548885200-08:00" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints"
time="2019-03-07T14:09:25.548885200-08:00" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}"
time="2019-03-07T14:09:25.549885400-08:00" level=debug msg="Registering HEAD, /containers/{name:.*}/archive"
time="2019-03-07T14:09:25.549885400-08:00" level=debug msg="Registering GET, /containers/json"
time="2019-03-07T14:09:25.549885400-08:00" level=debug msg="Registering GET, /containers/{name:.*}/export"
time="2019-03-07T14:09:25.550885300-08:00" level=debug msg="Registering GET, /containers/{name:.*}/changes"
time="2019-03-07T14:09:25.560885000-08:00" level=debug msg="Registering GET, /containers/{name:.*}/json"
time="2019-03-07T14:09:25.561885900-08:00" level=debug msg="Registering GET, /containers/{name:.*}/top"
time="2019-03-07T14:09:25.561885900-08:00" level=debug msg="Registering GET, /containers/{name:.*}/logs"
time="2019-03-07T14:09:25.561885900-08:00" level=debug msg="Registering GET, /containers/{name:.*}/stats"
time="2019-03-07T14:09:25.562885400-08:00" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws"
time="2019-03-07T14:09:25.562885400-08:00" level=debug msg="Registering GET, /exec/{id:.*}/json"
time="2019-03-07T14:09:25.562885400-08:00" level=debug msg="Registering GET, /containers/{name:.*}/archive"
time="2019-03-07T14:09:25.563885400-08:00" level=debug msg="Registering POST, /containers/create"
time="2019-03-07T14:09:25.563885400-08:00" level=debug msg="Registering POST, /containers/{name:.*}/kill"
time="2019-03-07T14:09:25.563885400-08:00" level=debug msg="Registering POST, /containers/{name:.*}/pause"
time="2019-03-07T14:09:25.564885500-08:00" level=debug msg="Registering POST, /containers/{name:.*}/unpause"
time="2019-03-07T14:09:25.564885500-08:00" level=debug msg="Registering POST, /containers/{name:.*}/restart"
time="2019-03-07T14:09:25.565884500-08:00" level=debug msg="Registering POST, /containers/{name:.*}/start"
time="2019-03-07T14:09:25.565884500-08:00" level=debug msg="Registering POST, /containers/{name:.*}/stop"
time="2019-03-07T14:09:25.565884500-08:00" level=debug msg="Registering POST, /containers/{name:.*}/wait"
time="2019-03-07T14:09:25.566884700-08:00" level=debug msg="Registering POST, /containers/{name:.*}/resize"
time="2019-03-07T14:09:25.566884700-08:00" level=debug msg="Registering POST, /containers/{name:.*}/attach"
time="2019-03-07T14:09:25.566884700-08:00" level=debug msg="Registering POST, /containers/{name:.*}/copy"
time="2019-03-07T14:09:25.567886300-08:00" level=debug msg="Registering POST, /containers/{name:.*}/exec"
time="2019-03-07T14:09:25.567886300-08:00" level=debug msg="Registering POST, /exec/{name:.*}/start"
time="2019-03-07T14:09:25.567886300-08:00" level=debug msg="Registering POST, /exec/{name:.*}/resize"
time="2019-03-07T14:09:25.568885300-08:00" level=debug msg="Registering POST, /containers/{name:.*}/rename"
time="2019-03-07T14:09:25.568885300-08:00" level=debug msg="Registering POST, /containers/{name:.*}/update"
time="2019-03-07T14:09:25.569885400-08:00" level=debug msg="Registering POST, /containers/prune"
time="2019-03-07T14:09:25.569885400-08:00" level=debug msg="Registering POST, /commit"
time="2019-03-07T14:09:25.569885400-08:00" level=debug msg="Registering PUT, /containers/{name:.*}/archive"
time="2019-03-07T14:09:25.570885400-08:00" level=debug msg="Registering DELETE, /containers/{name:.*}"
time="2019-03-07T14:09:25.570885400-08:00" level=debug msg="Registering GET, /images/json"
time="2019-03-07T14:09:25.570885400-08:00" level=debug msg="Registering GET, /images/search"
time="2019-03-07T14:09:25.571885800-08:00" level=debug msg="Registering GET, /images/get"
time="2019-03-07T14:09:25.571885800-08:00" level=debug msg="Registering GET, /images/{name:.*}/get"
time="2019-03-07T14:09:25.571885800-08:00" level=debug msg="Registering GET, /images/{name:.*}/history"
time="2019-03-07T14:09:25.572885900-08:00" level=debug msg="Registering GET, /images/{name:.*}/json"
time="2019-03-07T14:09:25.572885900-08:00" level=debug msg="Registering POST, /images/load"
time="2019-03-07T14:09:25.572885900-08:00" level=debug msg="Registering POST, /images/create"
time="2019-03-07T14:09:25.573886000-08:00" level=debug msg="Registering POST, /images/{name:.*}/push"
time="2019-03-07T14:09:25.573886000-08:00" level=debug msg="Registering POST, /images/{name:.*}/tag"
time="2019-03-07T14:09:25.574886100-08:00" level=debug msg="Registering POST, /images/prune"
time="2019-03-07T14:09:25.574886100-08:00" level=debug msg="Registering DELETE, /images/{name:.*}"
time="2019-03-07T14:09:25.574886100-08:00" level=debug msg="Registering OPTIONS, /{anyroute:.*}"
time="2019-03-07T14:09:25.575886400-08:00" level=debug msg="Registering GET, /_ping"
time="2019-03-07T14:09:25.575886400-08:00" level=debug msg="Registering HEAD, /_ping"
time="2019-03-07T14:09:25.575886400-08:00" level=debug msg="Registering GET, /events"
time="2019-03-07T14:09:25.576884900-08:00" level=debug msg="Registering GET, /info"
time="2019-03-07T14:09:25.576884900-08:00" level=debug msg="Registering GET, /version"
time="2019-03-07T14:09:25.576884900-08:00" level=debug msg="Registering GET, /system/df"
time="2019-03-07T14:09:25.577886100-08:00" level=debug msg="Registering POST, /auth"
time="2019-03-07T14:09:25.577886100-08:00" level=debug msg="Registering GET, /volumes"
time="2019-03-07T14:09:25.577886100-08:00" level=debug msg="Registering GET, /volumes/{name:.*}"
time="2019-03-07T14:09:25.578886100-08:00" level=debug msg="Registering POST, /volumes/create"
time="2019-03-07T14:09:25.578886100-08:00" level=debug msg="Registering POST, /volumes/prune"
time="2019-03-07T14:09:25.578886100-08:00" level=debug msg="Registering DELETE, /volumes/{name:.*}"
time="2019-03-07T14:09:25.579886200-08:00" level=debug msg="Registering POST, /build"
time="2019-03-07T14:09:25.579886200-08:00" level=debug msg="Registering POST, /build/prune"
time="2019-03-07T14:09:25.579886200-08:00" level=debug msg="Registering POST, /build/cancel"
time="2019-03-07T14:09:25.580886100-08:00" level=debug msg="Registering POST, /session"
time="2019-03-07T14:09:25.580886100-08:00" level=debug msg="Registering POST, /swarm/init"
time="2019-03-07T14:09:25.580886100-08:00" level=debug msg="Registering POST, /swarm/join"
time="2019-03-07T14:09:25.581886300-08:00" level=debug msg="Registering POST, /swarm/leave"
time="2019-03-07T14:09:25.581886300-08:00" level=debug msg="Registering GET, /swarm"
time="2019-03-07T14:09:25.581886300-08:00" level=debug msg="Registering GET, /swarm/unlockkey"
time="2019-03-07T14:09:25.581886300-08:00" level=debug msg="Registering POST, /swarm/update"
time="2019-03-07T14:09:25.582885700-08:00" level=debug msg="Registering POST, /swarm/unlock"
time="2019-03-07T14:09:25.582885700-08:00" level=debug msg="Registering GET, /services"
time="2019-03-07T14:09:25.582885700-08:00" level=debug msg="Registering GET, /services/{id}"
time="2019-03-07T14:09:25.583886500-08:00" level=debug msg="Registering POST, /services/create"
time="2019-03-07T14:09:25.583886500-08:00" level=debug msg="Registering POST, /services/{id}/update"
time="2019-03-07T14:09:25.584886300-08:00" level=debug msg="Registering DELETE, /services/{id}"
time="2019-03-07T14:09:25.584886300-08:00" level=debug msg="Registering GET, /services/{id}/logs"
time="2019-03-07T14:09:25.584886300-08:00" level=debug msg="Registering GET, /nodes"
time="2019-03-07T14:09:25.585886200-08:00" level=debug msg="Registering GET, /nodes/{id}"
time="2019-03-07T14:09:25.585886200-08:00" level=debug msg="Registering DELETE, /nodes/{id}"
time="2019-03-07T14:09:25.585886200-08:00" level=debug msg="Registering POST, /nodes/{id}/update"
time="2019-03-07T14:09:25.586885800-08:00" level=debug msg="Registering GET, /tasks"
time="2019-03-07T14:09:25.586885800-08:00" level=debug msg="Registering GET, /tasks/{id}"
time="2019-03-07T14:09:25.586885800-08:00" level=debug msg="Registering GET, /tasks/{id}/logs"
time="2019-03-07T14:09:25.587887100-08:00" level=debug msg="Registering GET, /secrets"
time="2019-03-07T14:09:25.587887100-08:00" level=debug msg="Registering POST, /secrets/create"
time="2019-03-07T14:09:25.587887100-08:00" level=debug msg="Registering DELETE, /secrets/{id}"
time="2019-03-07T14:09:25.588886400-08:00" level=debug msg="Registering GET, /secrets/{id}"
time="2019-03-07T14:09:25.588886400-08:00" level=debug msg="Registering POST, /secrets/{id}/update"
time="2019-03-07T14:09:25.589886700-08:00" level=debug msg="Registering GET, /configs"
time="2019-03-07T14:09:25.589886700-08:00" level=debug msg="Registering POST, /configs/create"
time="2019-03-07T14:09:25.589886700-08:00" level=debug msg="Registering DELETE, /configs/{id}"
time="2019-03-07T14:09:25.590886600-08:00" level=debug msg="Registering GET, /configs/{id}"
time="2019-03-07T14:09:25.590886600-08:00" level=debug msg="Registering POST, /configs/{id}/update"
time="2019-03-07T14:09:25.590886600-08:00" level=debug msg="Registering GET, /plugins"
time="2019-03-07T14:09:25.591887100-08:00" level=debug msg="Registering GET, /plugins/{name:.*}/json"
time="2019-03-07T14:09:25.591887100-08:00" level=debug msg="Registering GET, /plugins/privileges"
time="2019-03-07T14:09:25.591887100-08:00" level=debug msg="Registering DELETE, /plugins/{name:.*}"
time="2019-03-07T14:09:25.592886900-08:00" level=debug msg="Registering POST, /plugins/{name:.*}/enable"
time="2019-03-07T14:09:25.592886900-08:00" level=debug msg="Registering POST, /plugins/{name:.*}/disable"
time="2019-03-07T14:09:25.593884000-08:00" level=debug msg="Registering POST, /plugins/pull"
time="2019-03-07T14:09:25.593884000-08:00" level=debug msg="Registering POST, /plugins/{name:.*}/push"
time="2019-03-07T14:09:25.593884000-08:00" level=debug msg="Registering POST, /plugins/{name:.*}/upgrade"
time="2019-03-07T14:09:25.594886900-08:00" level=debug msg="Registering POST, /plugins/{name:.*}/set"
time="2019-03-07T14:09:25.594886900-08:00" level=debug msg="Registering POST, /plugins/create"
time="2019-03-07T14:09:25.594886900-08:00" level=debug msg="Registering GET, /distribution/{name:.*}/json"
time="2019-03-07T14:09:25.595887300-08:00" level=debug msg="Registering GET, /networks"
time="2019-03-07T14:09:25.595887300-08:00" level=debug msg="Registering GET, /networks/"
time="2019-03-07T14:09:25.595887300-08:00" level=debug msg="Registering GET, /networks/{id:.+}"
time="2019-03-07T14:09:25.596886700-08:00" level=debug msg="Registering POST, /networks/create"
time="2019-03-07T14:09:25.596886700-08:00" level=debug msg="Registering POST, /networks/{id:.*}/connect"
time="2019-03-07T14:09:25.596886700-08:00" level=debug msg="Registering POST, /networks/{id:.*}/disconnect"
time="2019-03-07T14:09:25.597886500-08:00" level=debug msg="Registering POST, /networks/prune"
time="2019-03-07T14:09:25.597886500-08:00" level=debug msg="Registering DELETE, /networks/{id:.*}"
time="2019-03-07T14:09:25.598887300-08:00" level=info msg="API listen on //./pipe/docker_engine"
time="2019-03-07T14:09:25.598887300-08:00" level=debug msg="Config reload - waiting signal at Global\\docker-daemon-config-3980"
time="2019-03-07T14:09:37.948280800-08:00" level=debug msg="Calling HEAD /_ping"
time="2019-03-07T14:09:37.955942000-08:00" level=debug msg="Calling POST /v1.40/containers/create"
time="2019-03-07T14:09:37.955942000-08:00" level=debug msg="form data: {\"AttachStderr\":true,\"AttachStdin\":true,\"AttachStdout\":true,\"Cmd\":[\"sh\"],\"Domainname\":\"\",\"Entrypoint\":null,\"Env\":[],\"HostConfig\":{\"AutoRemove\":true,\"Binds\":null,\"BlkioDeviceReadBps\":null,\"BlkioDeviceReadIOps\":null,\"BlkioDeviceWriteBps\":null,\"BlkioDeviceWriteIOps\":null,\"BlkioWeight\":0,\"BlkioWeightDevice\":[],\"CapAdd\":null,\"CapDrop\":null,\"Capabilities\":null,\"Cgroup\":\"\",\"CgroupParent\":\"\",\"ConsoleSize\":[0,0],\"ContainerIDFile\":\"\",\"CpuCount\":0,\"CpuPercent\":0,\"CpuPeriod\":0,\"CpuQuota\":0,\"CpuRealtimePeriod\":0,\"CpuRealtimeRuntime\":0,\"CpuShares\":0,\"CpusetCpus\":\"\",\"CpusetMems\":\"\",\"DeviceCgroupRules\":null,\"Devices\":[],\"DiskQuota\":0,\"Dns\":[],\"DnsOptions\":[],\"DnsSearch\":[],\"ExtraHosts\":null,\"GroupAdd\":null,\"IOMaximumBandwidth\":0,\"IOMaximumIOps\":0,\"IpcMode\":\"\",\"Isolation\":\"\",\"KernelMemory\":0,\"KernelMemoryTCP\":0,\"Links\":null,\"LogConfig\":{\"Config\":{},\"Type\":\"\"},\"MaskedPaths\":null,\"Memory\":0,\"MemoryReservation\":0,\"MemorySwap\":0,\"MemorySwappiness\":-1,\"NanoCpus\":0,\"NetworkMode\":\"default\",\"OomKillDisable\":false,\"OomScoreAdj\":0,\"PidMode\":\"\",\"PidsLimit\":0,\"PortBindings\":{},\"Privileged\":false,\"PublishAllPorts\":false,\"ReadonlyPaths\":null,\"ReadonlyRootfs\":false,\"RestartPolicy\":{\"MaximumRetryCount\":0,\"Name\":\"no\"},\"SecurityOpt\":null,\"ShmSize\":0,\"UTSMode\":\"\",\"Ulimits\":null,\"UsernsMode\":\"\",\"VolumeDriver\":\"\",\"VolumesFrom\":null},\"Hostname\":\"\",\"Image\":\"busybox\",\"Labels\":{},\"NetworkingConfig\":{\"EndpointsConfig\":{}},\"OnBuild\":null,\"OpenStdin\":true,\"StdinOnce\":true,\"Tty\":true,\"User\":\"\",\"Volumes\":{},\"WorkingDir\":\"\"}"
time="2019-03-07T14:09:37.962946600-08:00" level=debug msg="lcowdriver: createreadwrite: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c"
time="2019-03-07T14:09:37.962946600-08:00" level=debug msg="lcowdriver: create: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c parent: c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370"
time="2019-03-07T14:09:37.962946600-08:00" level=debug msg="lcowdriver: getlayerchain: id c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370 json C:\\ProgramData\\docker\\lcow\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370\\layerchain.json"
time="2019-03-07T14:09:37.963947600-08:00" level=debug msg="lcowdriver: exists: id c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370 true"
time="2019-03-07T14:09:37.963947600-08:00" level=debug msg="lcowdriver: create: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c: creating C:\\ProgramData\\docker\\lcow\\ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c"
time="2019-03-07T14:09:37.964947400-08:00" level=debug msg="lcowdriver: setlayerchain: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c json C:\\ProgramData\\docker\\lcow\\ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c\\layerchain.json"
time="2019-03-07T14:09:37.965948100-08:00" level=debug msg="lcowdriver: create: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c: success"
time="2019-03-07T14:09:37.966947100-08:00" level=debug msg="lcowdriver: createreadwrite: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c: locking cachedSandboxMutex"
time="2019-03-07T14:09:37.966947100-08:00" level=debug msg="lcowdriver: createreadwrite: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c: releasing cachedSandboxMutex"
time="2019-03-07T14:09:37.966947100-08:00" level=debug msg="lcowdriver: createreadwrite: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c: using cached sandbox to populate"
time="2019-03-07T14:09:38.017077700-08:00" level=debug msg="Calling POST /v1.40/containers/ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c/attach?stderr=1&stdin=1&stdout=1&stream=1"
time="2019-03-07T14:09:38.018083300-08:00" level=debug msg="attach: stdin: begin"
time="2019-03-07T14:09:38.018083300-08:00" level=debug msg="attach: stdout: begin"
time="2019-03-07T14:09:38.018083300-08:00" level=debug msg="attach: stderr: begin"
time="2019-03-07T14:09:38.021016100-08:00" level=debug msg="Calling POST /v1.40/containers/ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c/wait?condition=removed"
time="2019-03-07T14:09:38.024016400-08:00" level=debug msg="Calling POST /v1.40/containers/ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c/start"
time="2019-03-07T14:09:38.027019200-08:00" level=debug msg="Assigning addresses for endpoint pensive_poincare's interface on network nat"
time="2019-03-07T14:09:38.028019000-08:00" level=debug msg="RequestAddress(172.30.144.0/20, <nil>, map[])"
time="2019-03-07T14:09:38.028019000-08:00" level=debug msg="endpointStruct.EnableInternalDNS =[false]"
time="2019-03-07T14:09:38.028019000-08:00" level=debug msg="[POST]=>[/endpoints/] Request : {\"VirtualNetwork\":\"E584C5C6-538C-4DC8-8DB3-7945C3B64FA2\",\"EnableInternalDNS\":true}"
time="2019-03-07T14:09:38.031483200-08:00" level=debug msg="Network Response : {\"ActivityId\":\"DB050FCA-C52C-4B20-97A6-48F1C03E4E5B\",\"AdditionalParams\":{},\"CreateProcessingStartTime\":131964701780314832,\"DNSServerList\":\"172.30.144.1,192.168.60.25,192.168.60.26\",\"EnableInternalDNS\":true,\"EnableLowInterfaceMetric\":true,\"GatewayAddress\":\"172.30.144.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131964701780314832},\"ID\":\"12A8EBAC-1AC0-4012-B2EE-4C48BCB4E34F\",\"IPAddress\":\"172.30.153.212\",\"MacAddress\":\"00-15-5D-DF-C2-2B\",\"Name\":\"Ethernet\",\"Policies\":[],\"PrefixLength\":20,\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":131964701780314832},\"ID\":\"DB050FCA-C52C-4B20-97A6-48F1C03E4E5B\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"F26DA2DF-2BB9-4D18-9A55-E355A1DCBB59\"},\"SharedContainers\":[],\"State\":1,\"Type\":\"nat\",\"Version\":38654705665,\"VirtualNetwork\":\"E584C5C6-538C-4DC8-8DB3-7945C3B64FA2\",\"VirtualNetworkName\":\"nat\"}"
time="2019-03-07T14:09:38.054104800-08:00" level=debug msg="Assigning addresses for endpoint pensive_poincare's interface on network nat"
time="2019-03-07T14:09:38.067077400-08:00" level=debug msg="hcsshim::OpenComputeSystem - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:38.067077400-08:00" level=debug msg="hcsshim::OpenComputeSystem - End Operation - Success" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:38.072728700-08:00" level=debug msg="Programming external connectivity on endpoint pensive_poincare (19540433bcdb6cd05d0530d4a7ab3eea5eca8318d0319edabaf3f6f45d89982d)"
time="2019-03-07T14:09:38.073727800-08:00" level=debug msg="EnableService ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c START"
time="2019-03-07T14:09:38.073727800-08:00" level=debug msg="EnableService ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c DONE"
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="lcowdriver: getmetadata: id ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c"
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="libcontainerd: createLinux(): containerId ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c "
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="hcsshim::NameToGuid" name=c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="hcsshim::NameToGuid - succeeded" guid=dd6d8738-07c4-5310-a2ff-71fc0483b87c name=c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="hcsshim::CreateComputeSystem - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:38.076974300-08:00" level=debug msg="HCS ComputeSystem Document" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c json="{\"SystemType\":\"container\",\"Name\":\"ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c\",\"Owner\":\"docker\",\"LayerFolderPath\":\"C:\\\\ProgramData\\\\docker\\\\lcow\\\\ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c\",\"Layers\":[{\"ID\":\"dd6d8738-07c4-5310-a2ff-71fc0483b87c\",\"Path\":\"C:\\\\ProgramData\\\\docker\\\\lcow\\\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370\\\\layer.vhd\"}],\"HvPartition\":true,\"EndpointList\":[\"12A8EBAC-1AC0-4012-B2EE-4C48BCB4E34F\"],\"HvRuntime\":{\"ImagePath\":\"C:\\\\Program Files\\\\Linux Containers\",\"LinuxInitrdFile\":\"initrd.img\",\"LinuxKernelFile\":\"kernel\"},\"AllowUnqualifiedDNSQuery\":true,\"ContainerType\":\"linux\",\"TerminateOnLastHandleClosed\":true}"
time="2019-03-07T14:09:43.503100500-08:00" level=debug msg="hcsshim::CreateComputeSystem - End Operation - Success" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:43.503100500-08:00" level=debug msg="starting container" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c module=libcontainerd namespace=moby
time="2019-03-07T14:09:43.503100500-08:00" level=debug msg="hcsshim::ComputeSystem::Start - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:43.536925700-08:00" level=debug msg="hcsshim::ComputeSystem::Start - End Operation - Success" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:43.536925700-08:00" level=debug msg="createLinux() completed successfully" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c module=libcontainerd namespace=moby
time="2019-03-07T14:09:43.537925700-08:00" level=debug msg="hcsshim::ComputeSystem::CreateProcess - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:43.537925700-08:00" level=debug msg="HCS ComputeSystem Process Document" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c json="{\"CommandArgs\":[\"sh\"],\"WorkingDirectory\":\"/\",\"Environment\":{\"HOSTNAME\":\"ae27310ebb9c\",\"PATH\":\"/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin\",\"TERM\":\"xterm\"},\"EmulateConsole\":true,\"CreateStdInPipe\":true,\"CreateStdOutPipe\":true,\"ConsoleSize\":[0,0],\"OCISpecification\":{\"ociVersion\":\"1.0.1-dev\",\"process\":{\"terminal\":true,\"consoleSize\":{\"height\":0,\"width\":0},\"user\":{\"uid\":0,\"gid\":0},\"args\":[\"sh\"],\"env\":[\"PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin\",\"HOSTNAME=ae27310ebb9c\",\"TERM=xterm\"],\"cwd\":\"/\",\"capabilities\":{\"bounding\":[\"CAP_CHOWN\",\"CAP_DAC_OVERRIDE\",\"CAP_FSETID\",\"CAP_FOWNER\",\"CAP_MKNOD\",\"CAP_NET_RAW\",\"CAP_SETGID\",\"CAP_SETUID\",\"CAP_SETFCAP\",\"CAP_SETPCAP\",\"CAP_NET_BIND_SERVICE\",\"CAP_SYS_CHROOT\",\"CAP_KILL\",\"CAP_AUDIT_WRITE\"],\"effective\":[\"CAP_CHOWN\",\"CAP_DAC_OVERRIDE\",\"CAP_FSETID\",\"CAP_FOWNER\",\"CAP_MKNOD\",\"CAP_NET_RAW\",\"CAP_SETGID\",\"CAP_SETUID\",\"CAP_SETFCAP\",\"CAP_SETPCAP\",\"CAP_NET_BIND_SERVICE\",\"CAP_SYS_CHROOT\",\"CAP_KILL\",\"CAP_AUDIT_WRITE\"],\"inheritable\":[\"CAP_CHOWN\",\"CAP_DAC_OVERRIDE\",\"CAP_FSETID\",\"CAP_FOWNER\",\"CAP_MKNOD\",\"CAP_NET_RAW\",\"CAP_SETGID\",\"CAP_SETUID\",\"CAP_SETFCAP\",\"CAP_SETPCAP\",\"CAP_NET_BIND_SERVICE\",\"CAP_SYS_CHROOT\",\"CAP_KILL\",\"CAP_AUDIT_WRITE\"],\"permitted\":[\"CAP_CHOWN\",\"CAP_DAC_OVERRIDE\",\"CAP_FSETID\",\"CAP_FOWNER\",\"CAP_MKNOD\",\"CAP_NET_RAW\",\"CAP_SETGID\",\"CAP_SETUID\",\"CAP_SETFCAP\",\"CAP_SETPCAP\",\"CAP_NET_BIND_SERVICE\",\"CAP_SYS_CHROOT\",\"CAP_KILL\",\"CAP_AUDIT_WRITE\"]}},\"root\":{\"path\":\"rootfs\"},\"hostname\":\"ae27310ebb9c\",\"mounts\":[{\"destination\":\"/proc\",\"type\":\"proc\",\"source\":\"proc\",\"options\":[\"nosuid\",\"noexec\",\"nodev\"]},{\"destination\":\"/dev\",\"type\":\"tmpfs\",\"source\":\"tmpfs\",\"options\":[\"nosuid\",\"strictatime\",\"mode=755\",\"size=65536k\"]},{\"destination\":\"/dev/pts\",\"type\":\"devpts\",\"source\":\"devpts\",\"options\":[\"nosuid\",\"noexec\",\"newinstance\",\"ptmxmode=0666\",\"mode=0620\",\"gid=5\"]},{\"destination\":\"/sys\",\"type\":\"sysfs\",\"source\":\"sysfs\",\"options\":[\"nosuid\",\"noexec\",\"nodev\",\"ro\"]},{\"destination\":\"/sys/fs/cgroup\",\"type\":\"cgroup\",\"source\":\"cgroup\",\"options\":[\"ro\",\"nosuid\",\"noexec\",\"nodev\"]},{\"destination\":\"/dev/mqueue\",\"type\":\"mqueue\",\"source\":\"mqueue\",\"options\":[\"nosuid\",\"noexec\",\"nodev\"]},{\"destination\":\"/dev/shm\",\"type\":\"tmpfs\",\"source\":\"shm\",\"options\":[\"nosuid\",\"noexec\",\"nodev\",\"mode=1777\"]}],\"linux\":{\"resources\":{},\"namespaces\":[{\"type\":\"mount\"},{\"type\":\"network\"},{\"type\":\"uts\"},{\"type\":\"pid\"},{\"type\":\"ipc\"}],\"maskedPaths\":[\"/proc/asound\",\"/proc/acpi\",\"/proc/kcore\",\"/proc/keys\",\"/proc/latency_stats\",\"/proc/timer_list\",\"/proc/timer_stats\",\"/proc/sched_debug\",\"/proc/scsi\",\"/sys/firmware\"],\"readonlyPaths\":[\"/proc/bus\",\"/proc/fs\",\"/proc/irq\",\"/proc/sys\",\"/proc/sysrq-trigger\"]},\"windows\":{\"layerFolders\":[\"C:\\\\ProgramData\\\\docker\\\\lcow\\\\c9b6eb079932d9b5c24d0ef381ce2f6959d3de4052b6769b04bdf6760e154370\",\"C:\\\\ProgramData\\\\docker\\\\lcow\\\\ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c\"],\"resources\":{\"memory\":{\"limit\":0},\"cpu\":{\"count\":0,\"shares\":0,\"maximum\":0},\"storage\":{\"iops\":0,\"bps\":0}},\"hyperv\":{},\"network\":{\"endpointList\":[\"12A8EBAC-1AC0-4012-B2EE-4C48BCB4E34F\"],\"allowUnqualifiedDNSQuery\":true}}}}"
time="2019-03-07T14:09:43.558934200-08:00" level=info msg="sending event" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c event=create module=libcontainerd namespace=moby
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="HCS ComputeSystem CreateProcess PID" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c pid=267
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="hcsshim::ComputeSystem::CreateProcess - End Operation - Success" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="init process started" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c module=libcontainerd namespace=moby pid=267
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="hcsshim::Process::Stdio - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c pid=267
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="hcsshim::Process::Stdio - End Operation - Success" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c pid=267
time="2019-03-07T14:09:43.920129600-08:00" level=debug msg="start() completed" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c module=libcontainerd namespace=moby
time="2019-03-07T14:09:43.931523900-08:00" level=info msg="sending event" container=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c event=start event-info="{ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c init 267 0 0001-01-01 00:00:00 +0000 UTC false <nil>}" module=libcontainerd namespace=moby
time="2019-03-07T14:09:43.931523900-08:00" level=debug msg="hcsshim::Process::Wait - Begin Operation" cid=ae27310ebb9c4a723a57a1d128baa116efe4ce82ea54122b0794cf2e80e2058c pid=267
time="2019-03-07T14:19:20.090294900-08:00" level=debug msg="Closing buffered stdin pipe"
time="2019-03-07T14:19:20.100295800-08:00" level=debug msg="attach: stdin: end"
time="2019-03-07T14:19:20.101297100-08:00" level=debug msg="attach: stderr: end"
time="2019-03-07T14:19:20.101297100-08:00" level=debug msg="attach: stdout: end"
time="2019-03-07T14:19:20.101297100-08:00" level=debug msg="attach done"
@tracker1
Copy link
Author

tracker1 commented Mar 7, 2019

Possibly related
moby/moby#38320

@tracker1
Copy link
Author

tracker1 commented Mar 7, 2019

Okay, it does show the output from a WINDOWS container in POWERSHELL... but there's no output from a LINUX container in POWERSHELL ... for giggles, I tried it in a CMD.EXE prompt, and I'm seeing in the output.

@tracker1 tracker1 closed this as completed Mar 8, 2019
@SquallHalle
Copy link

SquallHalle commented Mar 11, 2019 •
edited
Loading

Why did you closed it ? I see a similar behavior and this is an issue ?! So no output for me in powershell and even cmd for some linux-based container

Server2019 build 17763 / Docker CE 2.0.0.3 (31259) stable build: 8858db3

for me the fix is to use the new release (v4.14.35-v0.3.9) of linuxkit/lcow now i can see output even in powershell

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@tracker1 @SquallHalle