Build Logs for dockerd-dev.exe

dockerd_logs

time="2021-10-13T17:30:17.019446000-07:00" level=info msg="Starting up"
time="2021-10-13T17:30:17.019446000-07:00" level=warning msg="Running experimental build"
time="2021-10-13T17:30:17.019446000-07:00" level=debug msg="Listener created for HTTP on npipe (//./pipe/docker_engine)"
time="2021-10-13T17:30:17.031469000-07:00" level=info msg="Windows default isolation mode: process"
time="2021-10-13T17:30:17.031469000-07:00" level=debug msg="Stackdump - waiting signal at Global\\stackdump-5476"
time="2021-10-13T17:30:17.032387100-07:00" level=debug msg="Using default logging driver json-file"
time="2021-10-13T17:30:17.032456000-07:00" level=debug msg="[graphdriver] trying provided driver: windowsfilter"
time="2021-10-13T17:30:17.032520900-07:00" level=debug msg="WindowsGraphDriver InitFilter at C:\\ProgramData\\docker\\windowsfilter"
time="2021-10-13T17:30:17.032726000-07:00" level=debug msg="Initialized graph driver windowsfilter"
time="2021-10-13T17:30:17.051045100-07:00" level=debug msg="No quota support for local volumes in C:\\ProgramData\\docker\\volumes: Filesystem does not support, or has not enabled quotas"
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="Max Concurrent Downloads: 3"
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="Max Concurrent Uploads: 5"
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="Max Download Attempts: 5"
time="2021-10-13T17:30:17.059695300-07:00" level=info msg="Loading containers: start."
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e paused=false running=false
time="2021-10-13T17:30:17.059695300-07:00" level=debug msg="loaded container" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 paused=false running=false
time="2021-10-13T17:30:17.089140100-07:00" level=debug msg="restoring container" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e paused=false restarting=false running=false
time="2021-10-13T17:30:17.089262800-07:00" level=debug msg="restore()" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.090054700-07:00" level=debug msg="restoring container" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 paused=false restarting=false running=false
time="2021-10-13T17:30:17.090746400-07:00" level=debug msg="restore()" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.090746400-07:00" level=debug msg="alive: false" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e paused=false restarting=false running=false
time="2021-10-13T17:30:17.091294300-07:00" level=debug msg="cleaning up dead container process" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="restoring container" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c paused=false restarting=false running=false
time="2021-10-13T17:30:17.091294300-07:00" level=debug msg="alive: false" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="cleaning up dead container process" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="done restoring container" container=53d68bcde37771d218c78618bc9fcf43216f073e13b7c6480c3608cfa500e70e paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="restore()" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="done restoring container" container=56a5ecbf93f63d2f9080805b55d755ffa8e7a6507e7f4f2e553f362922d24b01 paused=false restarting=false running=false
time="2021-10-13T17:30:17.091294300-07:00" level=debug msg="restoring container" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="restore()" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="alive: false" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="cleaning up dead container process" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="restoring container" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="restore()" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="done restoring container" container=b5e455f50bb924f813f68bc641caa95e11a74989f58c70c513e66bdd5547c93c paused=false restarting=false running=false
time="2021-10-13T17:30:17.091444100-07:00" level=debug msg="alive: false" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c paused=false restarting=false running=false
time="2021-10-13T17:30:17.092641600-07:00" level=debug msg="cleaning up dead container process" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c paused=false restarting=false running=false
time="2021-10-13T17:30:17.092641600-07:00" level=debug msg="done restoring container" container=b2b5f832c1c4b442eb78cb5a6bcf0c851c7d14a5f7de83b09ac5b59ecd5cd37c paused=false restarting=false running=false
time="2021-10-13T17:30:17.092641600-07:00" level=debug msg="alive: false" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 paused=false restarting=false running=false
time="2021-10-13T17:30:17.092641600-07:00" level=debug msg="cleaning up dead container process" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 paused=false restarting=false running=false
time="2021-10-13T17:30:17.092641600-07:00" level=debug msg="done restoring container" container=323f75a40bea60d4f927889759587dca6158c57f59dd178ef077a79bf1cd5695 paused=false restarting=false running=false
time="2021-10-13T17:30:17.095855300-07:00" level=debug msg="restoring container" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb paused=false restarting=false running=false
time="2021-10-13T17:30:17.095855300-07:00" level=debug msg="restore()" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.095855300-07:00" level=debug msg="alive: false" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb paused=false restarting=false running=false
time="2021-10-13T17:30:17.095855300-07:00" level=debug msg="cleaning up dead container process" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb paused=false restarting=false running=false
time="2021-10-13T17:30:17.095855300-07:00" level=debug msg="done restoring container" container=6be842bb4a1d5d93cfdb16fe705ede027c08a4781714ddf371ab6d551b9a70cb paused=false restarting=false running=false
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="restoring container" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e paused=false restarting=false running=false
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="restore()" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e module=libcontainerd namespace=moby
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="alive: false" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e paused=false restarting=false running=false
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="cleaning up dead container process" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e paused=false restarting=false running=false
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="done restoring container" container=7a21f2b9ba536b26ae4fcc4ed412fb63e76a753bd93bc8ba11cc2bb3518d218e paused=false restarting=false running=false
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="Option Experimental: true"
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="Option DefaultDriver: nat"
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="Option DefaultNetwork: nat"
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="Network Control Plane MTU: 1500"
time="2021-10-13T17:30:17.097020200-07:00" level=info msg="Restoring existing overlay networks from HNS into docker"
time="2021-10-13T17:30:17.097020200-07:00" level=debug msg="[GET]=>[/networks/] Request : "
time="2021-10-13T17:30:17.102665300-07:00" level=debug msg="Network Response : [{\"ActivityId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"AdditionalParams\":{},\"CurrentEndpointCount\":0,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"F74F241B-440F-4433-BB28-00F89EAD20D8\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"430BDADD-BAB0-41AB-A369-94B67FA5BE0A\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":8,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332063802},\"ID\":\"364C3ED5-AB5F-4EE7-940D-4EEA8B3422B5\",\"IPv6\":false,\"LayeredOn\":\"39B7DB2F-370E-4374-9073-0D0A942A649B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-7B-8F-FF\",\"StartMacAddress\":\"00-15-5D-7B-80-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"NATC3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"Policies\":[{\"Type\":\"VLAN\",\"VLAN\":1}],\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.26.176.0/20\",\"Flags\":0,\"GatewayAddress\":\"172.26.176.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"216BE25A-693F-40B4-A1F1-8F9835ED129D\",\"IpSubnets\":[{\"AdditionalParams\":{},\"Flags\":3,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"CEE88C8F-36D5-4477-BCCA-8772B9EAA864\",\"IpAddressPrefix\":\"172.26.176.0/20\",\"ObjectType\":6,\"Policies\":[],\"State\":0}],\"ObjectType\":5,\"Policies\":[],\"State\":0}],\"TotalEndpoints\":31,\"Type\":\"nat\",\"Version\":55834574851,\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{C3C60AB1-3B2C-407F-A713-BF41C7767D02}\",\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DNSFirewallRules\":true,\"DevicelessNic\":true,\"DhcpDisabled\":true,\"EndpointNicGuid\":\"02799AE2-19DD-45B1-B016-FCB4A2CACB2B\",\"EndpointPortGuid\":\"7F0660DD-2E16-4861-BC57-C9712F8AB413\",\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"E91AA180-BE25-4217-BB84-7A236B8744C1\",\"InterfaceGuid\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"IsPolicy\":false,\"IsolationId\":1,\"MacAddress\":\"00-15-5D-7B-88-2F\",\"ManagementPort\":true,\"NcfHidden\":false,\"NicFriendlyName\":\"nat\",\"NlmHidden\":true,\"PreferredPortFriendlyName\":\"Container NIC e91aa180\",\"State\":3,\"SwitchId\":\"E3E8279A-1AB5-415A-8DDA-B43B7518E947\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AdditionalParams\":{},\"AllocationOrder\":1,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555334368484,\"NATState\":2},\"ID\":\"66DA3969-77E7-4FBF-A614-4B4CBC799F2C\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"State\":3,\"SubnetIPAddress\":\"172.26.176.0\",\"Tag\":\"NAT\"}],\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0649ECC8-1358-428D-9B3B-399CF36F442A\"}}]"
time="2021-10-13T17:30:17.111717600-07:00" level=debug msg="Network  nat (4792a89) restored"
time="2021-10-13T17:30:17.117955900-07:00" level=debug msg="[GET]=>[/networks/] Request : "
time="2021-10-13T17:30:17.122063700-07:00" level=debug msg="Network Response : [{\"ActivityId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"AdditionalParams\":{},\"CurrentEndpointCount\":0,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"F74F241B-440F-4433-BB28-00F89EAD20D8\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"430BDADD-BAB0-41AB-A369-94B67FA5BE0A\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":8,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332063802},\"ID\":\"364C3ED5-AB5F-4EE7-940D-4EEA8B3422B5\",\"IPv6\":false,\"LayeredOn\":\"39B7DB2F-370E-4374-9073-0D0A942A649B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-7B-8F-FF\",\"StartMacAddress\":\"00-15-5D-7B-80-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"NATC3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"Policies\":[{\"Type\":\"VLAN\",\"VLAN\":1}],\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.26.176.0/20\",\"Flags\":0,\"GatewayAddress\":\"172.26.176.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"216BE25A-693F-40B4-A1F1-8F9835ED129D\",\"IpSubnets\":[{\"AdditionalParams\":{},\"Flags\":3,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"CEE88C8F-36D5-4477-BCCA-8772B9EAA864\",\"IpAddressPrefix\":\"172.26.176.0/20\",\"ObjectType\":6,\"Policies\":[],\"State\":0}],\"ObjectType\":5,\"Policies\":[],\"State\":0}],\"TotalEndpoints\":31,\"Type\":\"nat\",\"Version\":55834574851,\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{C3C60AB1-3B2C-407F-A713-BF41C7767D02}\",\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DNSFirewallRules\":true,\"DevicelessNic\":true,\"DhcpDisabled\":true,\"EndpointNicGuid\":\"02799AE2-19DD-45B1-B016-FCB4A2CACB2B\",\"EndpointPortGuid\":\"7F0660DD-2E16-4861-BC57-C9712F8AB413\",\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"E91AA180-BE25-4217-BB84-7A236B8744C1\",\"InterfaceGuid\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"IsPolicy\":false,\"IsolationId\":1,\"MacAddress\":\"00-15-5D-7B-88-2F\",\"ManagementPort\":true,\"NcfHidden\":false,\"NicFriendlyName\":\"nat\",\"NlmHidden\":true,\"PreferredPortFriendlyName\":\"Container NIC e91aa180\",\"State\":3,\"SwitchId\":\"E3E8279A-1AB5-415A-8DDA-B43B7518E947\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AdditionalParams\":{},\"AllocationOrder\":1,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555334368484,\"NATState\":2},\"ID\":\"66DA3969-77E7-4FBF-A614-4B4CBC799F2C\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"State\":3,\"SubnetIPAddress\":\"172.26.176.0\",\"Tag\":\"NAT\"}],\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0649ECC8-1358-428D-9B3B-399CF36F442A\"}}]"
time="2021-10-13T17:30:17.122731100-07:00" level=debug msg="Launching DNS server for network \"none\""
time="2021-10-13T17:30:17.135270000-07:00" level=debug msg="releasing IPv4 pools from network nat (4792a894398b862e747ee70f1db387a1ffd15f0742219087c0cdf0cf9ffeda23)"
time="2021-10-13T17:30:17.135270000-07:00" level=debug msg="ReleaseAddress(172.26.176.0/20, 172.26.176.1)"
time="2021-10-13T17:30:17.135270000-07:00" level=debug msg="ReleasePool(172.26.176.0/20)"
time="2021-10-13T17:30:17.147529200-07:00" level=debug msg="cleanupServiceDiscovery for network:4792a894398b862e747ee70f1db387a1ffd15f0742219087c0cdf0cf9ffeda23"
time="2021-10-13T17:30:17.147529200-07:00" level=debug msg="cleanupServiceBindings for 4792a894398b862e747ee70f1db387a1ffd15f0742219087c0cdf0cf9ffeda23"
time="2021-10-13T17:30:17.158960600-07:00" level=debug msg="Allocating IPv4 pools for network nat (4792a894398b862e747ee70f1db387a1ffd15f0742219087c0cdf0cf9ffeda23)"
time="2021-10-13T17:30:17.159032200-07:00" level=debug msg="RequestPool(LocalDefault, 172.26.176.0/20, , map[], false)"
time="2021-10-13T17:30:17.159032200-07:00" level=debug msg="RequestAddress(172.26.176.0/20, 172.26.176.1, map[RequestAddressType:com.docker.network.gateway])"
time="2021-10-13T17:30:17.159032200-07:00" level=debug msg="[GET]=>[/endpoints/] Request : "
time="2021-10-13T17:30:17.168490300-07:00" level=debug msg="Launching DNS server for network \"nat\""
time="2021-10-13T17:30:17.169117400-07:00" level=debug msg="[GET]=>[/networks/364C3ED5-AB5F-4EE7-940D-4EEA8B3422B5] Request : "
time="2021-10-13T17:30:17.172309300-07:00" level=debug msg="Network Response : {\"ActivityId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"AdditionalParams\":{},\"CurrentEndpointCount\":0,\"Extensions\":[{\"Id\":\"E7C3B2F0-F3C5-48DF-AF2B-10FED6D72E7A\",\"IsEnabled\":false,\"Name\":\"Microsoft Windows Filtering Platform\"},{\"Id\":\"F74F241B-440F-4433-BB28-00F89EAD20D8\",\"IsEnabled\":false,\"Name\":\"Microsoft Azure VFP Switch Extension\"},{\"Id\":\"430BDADD-BAB0-41AB-A369-94B67FA5BE0A\",\"IsEnabled\":true,\"Name\":\"Microsoft NDIS Capture\"}],\"Flags\":8,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332063802},\"ID\":\"364C3ED5-AB5F-4EE7-940D-4EEA8B3422B5\",\"IPv6\":false,\"LayeredOn\":\"39B7DB2F-370E-4374-9073-0D0A942A649B\",\"MacPools\":[{\"EndMacAddress\":\"00-15-5D-7B-8F-FF\",\"StartMacAddress\":\"00-15-5D-7B-80-00\"}],\"MaxConcurrentEndpoints\":1,\"Name\":\"nat\",\"NatName\":\"NATC3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"Policies\":[{\"Type\":\"VLAN\",\"VLAN\":1}],\"State\":1,\"Subnets\":[{\"AdditionalParams\":{},\"AddressPrefix\":\"172.26.176.0/20\",\"Flags\":0,\"GatewayAddress\":\"172.26.176.1\",\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"216BE25A-693F-40B4-A1F1-8F9835ED129D\",\"IpSubnets\":[{\"AdditionalParams\":{},\"Flags\":3,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555332083939},\"ID\":\"CEE88C8F-36D5-4477-BCCA-8772B9EAA864\",\"IpAddressPrefix\":\"172.26.176.0/20\",\"ObjectType\":6,\"Policies\":[],\"State\":0}],\"ObjectType\":5,\"Policies\":[],\"State\":0}],\"TotalEndpoints\":31,\"Type\":\"nat\",\"Version\":55834574851,\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":2,\"Allocators\":[{\"AdapterNetCfgInstanceId\":\"{C3C60AB1-3B2C-407F-A713-BF41C7767D02}\",\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmendId\":0,\"Connected\":true,\"DNSFirewallRules\":true,\"DevicelessNic\":true,\"DhcpDisabled\":true,\"EndpointNicGuid\":\"02799AE2-19DD-45B1-B016-FCB4A2CACB2B\",\"EndpointPortGuid\":\"7F0660DD-2E16-4861-BC57-C9712F8AB413\",\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"E91AA180-BE25-4217-BB84-7A236B8744C1\",\"InterfaceGuid\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"IsPolicy\":false,\"IsolationId\":1,\"MacAddress\":\"00-15-5D-7B-88-2F\",\"ManagementPort\":true,\"NcfHidden\":false,\"NicFriendlyName\":\"nat\",\"NlmHidden\":true,\"PreferredPortFriendlyName\":\"Container NIC e91aa180\",\"State\":3,\"SwitchId\":\"E3E8279A-1AB5-415A-8DDA-B43B7518E947\",\"Tag\":\"Host Vnic\",\"WaitForIpv6Interface\":false,\"nonPersistentPort\":false},{\"AdditionalParams\":{},\"AllocationOrder\":1,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555334368484,\"NATState\":2},\"ID\":\"66DA3969-77E7-4FBF-A614-4B4CBC799F2C\",\"IsPolicy\":false,\"Prefix\":20,\"PrivateInterfaceGUID\":\"C3C60AB1-3B2C-407F-A713-BF41C7767D02\",\"State\":3,\"SubnetIPAddress\":\"172.26.176.0\",\"Tag\":\"NAT\"}],\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132785555333259153},\"ID\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"0649ECC8-1358-428D-9B3B-399CF36F442A\"}}"
time="2021-10-13T17:30:17.172934600-07:00" level=debug msg="Binding a resolver on network nat gateway 172.26.176.1"
time="2021-10-13T17:30:17.173601200-07:00" level=debug msg="Resolver bound successfully for network nat"
time="2021-10-13T17:30:17.184364400-07:00" level=info msg="Loading containers: done."
time="2021-10-13T17:30:17.184364400-07:00" level=info msg="Docker daemon" commit=1430d849a4 graphdriver=windowsfilter version=dev
time="2021-10-13T17:30:17.184364400-07:00" level=info msg="Daemon has completed initialization"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering routers"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/checkpoints"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Config reload - waiting signal at Global\\docker-daemon-config-5476"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/checkpoints"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering DELETE, /containers/{name}/checkpoints/{checkpoint}"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering HEAD, /containers/{name:.*}/archive"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/json"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/export"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/changes"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/json"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/top"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/logs"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/stats"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/attach/ws"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /exec/{id:.*}/json"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering GET, /containers/{name:.*}/archive"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/create"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/kill"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/pause"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/unpause"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/restart"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/start"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/stop"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/wait"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/resize"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/attach"
time="2021-10-13T17:30:17.190631200-07:00" level=debug msg="Registering POST, /containers/{name:.*}/copy"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /containers/{name:.*}/exec"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /exec/{name:.*}/start"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /exec/{name:.*}/resize"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /containers/{name:.*}/rename"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /containers/{name:.*}/update"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /containers/prune"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /commit"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering PUT, /containers/{name:.*}/archive"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering DELETE, /containers/{name:.*}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/json"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/search"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/get"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/{name:.*}/get"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/{name:.*}/history"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /images/{name:.*}/json"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /images/load"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /images/create"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /images/{name:.*}/push"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /images/{name:.*}/tag"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /images/prune"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering DELETE, /images/{name:.*}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering OPTIONS, /{anyroute:.*}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /_ping"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering HEAD, /_ping"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /events"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /info"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /version"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /system/df"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /auth"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /volumes"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /volumes/{name:.*}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /volumes/create"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /volumes/prune"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering DELETE, /volumes/{name:.*}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /build"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /build/prune"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /build/cancel"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /session"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /swarm/init"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /swarm/join"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /swarm/leave"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /swarm"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /swarm/unlockkey"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /swarm/update"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /swarm/unlock"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /services"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /services/{id}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /services/create"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering POST, /services/{id}/update"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering DELETE, /services/{id}"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /services/{id}/logs"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /nodes"
time="2021-10-13T17:30:17.200277300-07:00" level=debug msg="Registering GET, /nodes/{id}"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering DELETE, /nodes/{id}"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering POST, /nodes/{id}/update"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering GET, /tasks"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering GET, /tasks/{id}"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering GET, /tasks/{id}/logs"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering GET, /secrets"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering POST, /secrets/create"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering DELETE, /secrets/{id}"
time="2021-10-13T17:30:17.205325300-07:00" level=debug msg="Registering GET, /secrets/{id}"
time="2021-10-13T17:30:17.210425600-07:00" level=debug msg="Registering POST, /secrets/{id}/update"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /configs"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /configs/create"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering DELETE, /configs/{id}"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /configs/{id}"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /configs/{id}/update"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /plugins"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /plugins/{name:.*}/json"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /plugins/privileges"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering DELETE, /plugins/{name:.*}"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/enable"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/disable"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/pull"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/push"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/upgrade"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/{name:.*}/set"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /plugins/create"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /distribution/{name:.*}/json"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /grpc"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /networks"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /networks/"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering GET, /networks/{id:.+}"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /networks/create"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /networks/{id:.*}/connect"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /networks/{id:.*}/disconnect"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering POST, /networks/prune"
time="2021-10-13T17:30:17.210612100-07:00" level=debug msg="Registering DELETE, /networks/{id:.*}"
time="2021-10-13T17:30:17.210612100-07:00" level=info msg="API listen on //./pipe/docker_engine"
time="2021-10-13T17:45:46.737554500-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.743691500-07:00" level=debug msg="Calling GET /v1.42/version"
time="2021-10-13T17:45:46.750658000-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.753783700-07:00" level=debug msg="Calling GET /v1.42/version"
time="2021-10-13T17:45:46.757144100-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.759466600-07:00" level=debug msg="Calling GET /v1.42/info"
time="2021-10-13T17:45:46.770450300-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.773159800-07:00" level=debug msg="Calling GET /v1.42/version"
time="2021-10-13T17:45:46.775780500-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.778808700-07:00" level=debug msg="Calling GET /v1.42/info"
time="2021-10-13T17:45:46.864561500-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.864561500-07:00" level=debug msg="Calling GET /v1.42/version"
time="2021-10-13T17:45:46.864561500-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:46.880263000-07:00" level=debug msg="Calling GET /v1.42/images/adamrehn/ue4-source:4.27.0-ltsc2022-vs2019/json"
time="2021-10-13T17:45:48.904822600-07:00" level=debug msg="Calling GET /version"
time="2021-10-13T17:45:48.908074800-07:00" level=debug msg="Calling GET /v1.42/images/adamrehn/ue4-build-prerequisites:ltsc2022-vs2019/json"
time="2021-10-13T17:45:49.030746600-07:00" level=debug msg="Calling HEAD /_ping"
time="2021-10-13T17:45:49.042572500-07:00" level=debug msg="Calling POST /v1.41/build?buildargs=%7B%22BASEIMAGE%22%3A%22mcr.microsoft.com%2Fwindows%2Fservercore%3Altsc2022%22%2C%22DLLSRCIMAGE%22%3A%22mcr.microsoft.com%2Fwindows%2Fserver%3Altsc2022%22%2C%22NAMESPACE%22%3A%22adamrehn%22%2C%22VISUAL_STUDIO_BUILD_NUMBER%22%3A%2216%22%7D&cachefrom=%5B%5D&cgroupparent=&cpuperiod=0&cpuquota=0&cpusetcpus=&cpusetmems=&cpushares=0&dockerfile=Dockerfile&isolation=process&labels=%7B%7D&memory=0&memswap=0&networkmode=default&rm=1&shmsize=0&t=adamrehn%2Fue4-build-prerequisites%3Altsc2022-vs2019&target=&ulimits=null&version=1"
time="2021-10-13T17:45:49.054742200-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C #(nop)  SHELL [cmd /S /C]]"
time="2021-10-13T17:45:49.055384600-07:00" level=debug msg="Calling proc (1)" spanID=09f11491fc6f7857 traceID=3898e4280638977d8ccf82cce5d08a74
time="2021-10-13T17:45:49.055384600-07:00" level=debug msg="Calling proc (2)" spanID=09f11491fc6f7857 traceID=3898e4280638977d8ccf82cce5d08a74
time="2021-10-13T17:45:49.365147800-07:00" level=debug msg="WindowsGraphDriver Get() id 7fa192723a2d0da013c5aba58fa9843943ece99f9f59cfa7f540c1ebc63990d5 mountLabel "
time="2021-10-13T17:45:49.555686800-07:00" level=debug msg="Calling proc (1)" spanID=58053772780f658e traceID=72e9a3b4e2d93f0bbd8f051bacbcb9c0
time="2021-10-13T17:45:49.556356200-07:00" level=debug msg="Calling proc (2)" spanID=58053772780f658e traceID=72e9a3b4e2d93f0bbd8f051bacbcb9c0
time="2021-10-13T17:45:49.557619900-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C #(nop) COPY multi:a4d83dd15a5fe7223fcbdd71ac55a7cdf058bd09300f9c281762b24fa413be9b in C:\\Windows\\System32\\ ]"
time="2021-10-13T17:45:49.558247000-07:00" level=debug msg="WindowsGraphDriver Put() id 7fa192723a2d0da013c5aba58fa9843943ece99f9f59cfa7f540c1ebc63990d5"
time="2021-10-13T17:45:49.674792200-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C #(nop)  LABEL com.adamrehn.ue4-docker.sentinel=1]"
time="2021-10-13T17:45:49.675610900-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C reg add HKEY_LOCAL_MACHINE\\SYSTEM\\CurrentControlSet\\Control\\FileSystem /v LongPathsEnabled /t REG_DWORD /d 1 /f && echo. && echo.RUN directive complete. Docker will now commit the filesystem layer to disk. && echo.Note that for large filesystem layers this can take quite some time. && echo.Performing filesystem layer commit... && echo.]"
time="2021-10-13T17:45:49.676649400-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C powershell -NoProfile -ExecutionPolicy Bypass -Command \"Set-ExecutionPolicy Bypass -Scope Process -Force; [System.Net.ServicePointManager]::SecurityProtocol = [System.Net.ServicePointManager]::SecurityProtocol -bor 3072; iex ((New-Object System.Net.WebClient).DownloadString('https://chocolatey.org/install.ps1'))\" && echo. && echo.RUN directive complete. Docker will now commit the filesystem layer to disk. && echo.Note that for large filesystem layers this can take quite some time. && echo.Performing filesystem layer commit... && echo.]"
time="2021-10-13T17:45:49.677645700-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C #(nop) COPY multi:740ac45e118a0ad67bcfec7b3fd993bcc03346e456fd4e611e42a13f5bc6d74c in C:\\ ]"
time="2021-10-13T17:45:49.677645700-07:00" level=debug msg="[BUILDER] Use cached version: [cmd /S /C #(nop)  ARG VISUAL_STUDIO_BUILD_NUMBER]"
time="2021-10-13T17:45:49.677645700-07:00" level=debug msg="[BUILDER] Cache miss: [|1 VISUAL_STUDIO_BUILD_NUMBER=16 cmd /S /C C:\\install-prerequisites.bat %VISUAL_STUDIO_BUILD_NUMBER% && echo. && echo.RUN directive complete. Docker will now commit the filesystem layer to disk. && echo.Note that for large filesystem layers this can take quite some time. && echo.Performing filesystem layer commit... && echo.]"
time="2021-10-13T17:45:49.677645700-07:00" level=debug msg="[BUILDER] Command to be executed: [cmd /S /C C:\\install-prerequisites.bat %VISUAL_STUDIO_BUILD_NUMBER% && echo. && echo.RUN directive complete. Docker will now commit the filesystem layer to disk. && echo.Note that for large filesystem layers this can take quite some time. && echo.Performing filesystem layer commit... && echo.]"
time="2021-10-13T17:45:49.679659300-07:00" level=debug msg="Calling proc (1)" spanID=4f836ba145af98de traceID=e84ed32295f2be11aa5c704a837e0e71
time="2021-10-13T17:45:49.679659300-07:00" level=debug msg="Calling proc (2)" spanID=4f836ba145af98de traceID=e84ed32295f2be11aa5c704a837e0e71
time="2021-10-13T17:45:49.959217200-07:00" level=debug msg="WindowsGraphDriver Get() id 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 mountLabel "
time="2021-10-13T17:45:49.959217200-07:00" level=debug msg="attach: stderr: begin"
time="2021-10-13T17:45:49.959217200-07:00" level=debug msg="attach: stdout: begin"
time="2021-10-13T17:45:50.163467200-07:00" level=debug msg="Calling proc (1)" spanID=d2254df1a4cd0c3d traceID=d490fb3d34d5955474b4e1e47c995e96
time="2021-10-13T17:45:50.170788500-07:00" level=debug msg="Calling proc (2)" spanID=d2254df1a4cd0c3d traceID=d490fb3d34d5955474b4e1e47c995e96
time="2021-10-13T17:45:50.171465800-07:00" level=debug msg="container mounted via layerStore: &{\\\\?\\Volume{e8dc1cc7-f5d0-4167-a06d-2a2999be6c32} 0x2e3c060 0x2e3c060}" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2
time="2021-10-13T17:45:50.172807500-07:00" level=debug msg="Assigning addresses for endpoint elated_lumiere's interface on network nat"
time="2021-10-13T17:45:50.172807500-07:00" level=debug msg="RequestAddress(172.26.176.0/20, <nil>, map[])"
time="2021-10-13T17:45:50.172807500-07:00" level=debug msg="endpointStruct.EnableInternalDNS =[false]"
time="2021-10-13T17:45:50.172807500-07:00" level=debug msg="[POST]=>[/endpoints/] Request : {\"VirtualNetwork\":\"364C3ED5-AB5F-4EE7-940D-4EEA8B3422B5\",\"EnableInternalDNS\":true}"
time="2021-10-13T17:45:50.178390500-07:00" level=debug msg="Network Response : {\"ID\":\"6fae5914-46a8-467d-80c8-5cbae4998d1b\",\"Name\":\"Ethernet\",\"Version\":55834574851,\"AdditionalParams\":{},\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132786459501772402},\"ID\":\"CD507088-CBB6-40B1-8349-E557979002C9\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\"},\"State\":1,\"VirtualNetwork\":\"364c3ed5-ab5f-4ee7-940d-4eea8b3422b5\",\"VirtualNetworkName\":\"nat\",\"MacAddress\":\"00-15-5D-7B-8C-A2\",\"EnableInternalDNS\":true,\"IPAddress\":\"172.26.177.71\",\"PrefixLength\":20,\"GatewayAddress\":\"172.26.176.1\",\"IPSubnetId\":\"cee88c8f-36d5-4477-bcca-8772b9eaa864\",\"DNSServerList\":\"172.26.176.1,172.18.0.2\",\"DNSSuffix\":\"ec2.internal\",\"SharedContainers\":[]}"
time="2021-10-13T17:45:50.190524400-07:00" level=debug msg="Assigning addresses for endpoint elated_lumiere's interface on network nat"
time="2021-10-13T17:45:50.203248800-07:00" level=debug msg="[GET]=>[/endpoints/6fae5914-46a8-467d-80c8-5cbae4998d1b] Request : "
time="2021-10-13T17:45:50.206718800-07:00" level=debug msg="Network Response : {\"ID\":\"6fae5914-46a8-467d-80c8-5cbae4998d1b\",\"Name\":\"Ethernet\",\"Version\":55834574851,\"AdditionalParams\":{},\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132786459501772402},\"ID\":\"CD507088-CBB6-40B1-8349-E557979002C9\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\"},\"State\":1,\"VirtualNetwork\":\"364c3ed5-ab5f-4ee7-940d-4eea8b3422b5\",\"VirtualNetworkName\":\"nat\",\"MacAddress\":\"00-15-5D-7B-8C-A2\",\"EnableInternalDNS\":true,\"IPAddress\":\"172.26.177.71\",\"PrefixLength\":20,\"GatewayAddress\":\"172.26.176.1\",\"IPSubnetId\":\"cee88c8f-36d5-4477-bcca-8772b9eaa864\",\"DNSServerList\":\"172.26.176.1,172.18.0.2\",\"DNSSuffix\":\"ec2.internal\",\"SharedContainers\":[]}"
time="2021-10-13T17:45:50.206718800-07:00" level=debug msg="[GET]=>[/endpoints/6fae5914-46a8-467d-80c8-5cbae4998d1b] Request : "
time="2021-10-13T17:45:50.209568600-07:00" level=debug msg="Network Response : {\"ID\":\"6fae5914-46a8-467d-80c8-5cbae4998d1b\",\"Name\":\"Ethernet\",\"Version\":55834574851,\"AdditionalParams\":{},\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":0,\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132786459501772402},\"ID\":\"CD507088-CBB6-40B1-8349-E557979002C9\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\"},\"State\":1,\"VirtualNetwork\":\"364c3ed5-ab5f-4ee7-940d-4eea8b3422b5\",\"VirtualNetworkName\":\"nat\",\"MacAddress\":\"00-15-5D-7B-8C-A2\",\"EnableInternalDNS\":true,\"IPAddress\":\"172.26.177.71\",\"PrefixLength\":20,\"GatewayAddress\":\"172.26.176.1\",\"IPSubnetId\":\"cee88c8f-36d5-4477-bcca-8772b9eaa864\",\"DNSServerList\":\"172.26.176.1,172.18.0.2\",\"DNSSuffix\":\"ec2.internal\",\"SharedContainers\":[]}"
time="2021-10-13T17:45:50.215242900-07:00" level=debug msg="Programming external connectivity on endpoint elated_lumiere (aa71fdb2d942e6822d5e01b6fa901cafb25017feeafca47fd16f7abc74c1f909)"
time="2021-10-13T17:45:50.215242900-07:00" level=debug msg="EnableService 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 START"
time="2021-10-13T17:45:50.215242900-07:00" level=debug msg="EnableService 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 DONE"
time="2021-10-13T17:45:50.226824800-07:00" level=debug msg="Generated spec: {\"ociVersion\":\"1.0.2-dev\",\"process\":{\"user\":{\"uid\":0,\"gid\":0},\"commandLine\":\"cmd /S /C C:\\\\install-prerequisites.bat %VISUAL_STUDIO_BUILD_NUMBER% \\u0026\\u0026 echo. \\u0026\\u0026 echo.RUN directive complete. Docker will now commit the filesystem layer to disk. \\u0026\\u0026 echo.Note that for large filesystem layers this can take quite some time. \\u0026\\u0026 echo.Performing filesystem layer commit... \\u0026\\u0026 echo.\",\"env\":[\"VISUAL_STUDIO_BUILD_NUMBER=16\"],\"cwd\":\"C:\\\\\"},\"root\":{\"path\":\"\\\\\\\\?\\\\Volume{e8dc1cc7-f5d0-4167-a06d-2a2999be6c32}\\\\\"},\"hostname\":\"3750efd153fa\",\"windows\":{\"layerFolders\":[\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\fee0702843ba5b8d8d4e7d893b5d00ca982905546ecd06cff840c0818107bd91\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\3cbdfffb4c4c82332347bcf0ef5beddeaa931b259b8c6af1d2c3cb09dc3fbf22\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\d375487e3ca07da4b790264436482c2d0a26cee9f463f9f3108195986c46e9cd\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\610a7a5f773c3855951febaefe5508781d2ababcdfb153faf32a0646f7ab4412\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\25131e7d9d7d469c888c0908741aad15e70c75d93613166a8726d03c13dc9a38\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\373bc404905a8dcf65ab43b2ec2d0986307cc4a2c48c9ddb2c500f8772699642\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\38cdf28159168c847b1bea80b660963f5962db8cda668cc9864fceabf6145dcb\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\1c1df61b96d76ff401bd3563854929be1eefff3b841a02a7e1c16e641d56afdd\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\84d6e6c3be9be8a47d84fad76eeef3bf3cc4376f06d7b889b1280458e876bfb3\",\"C:\\\\ProgramData\\\\docker\\\\windowsfilter\\\\3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2\"],\"ignoreFlushesDuringBoot\":true,\"network\":{\"endpointList\":[\"6fae5914-46a8-467d-80c8-5cbae4998d1b\"],\"allowUnqualifiedDNSQuery\":true}}}"
time="2021-10-13T17:45:50.606790100-07:00" level=debug msg="HCS notification" notification-type=SystemCreateCompleted system-id=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2
time="2021-10-13T17:45:50.606790100-07:00" level=debug msg="starting container" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby
time="2021-10-13T17:45:51.412663300-07:00" level=debug msg="HCS notification" notification-type=SystemStartCompleted system-id=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2
time="2021-10-13T17:45:51.412663300-07:00" level=debug msg="createWindows() completed successfully" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby
time="2021-10-13T17:45:51.414238700-07:00" level=debug msg="start commandLine: cmd /S /C C:\\install-prerequisites.bat %VISUAL_STUDIO_BUILD_NUMBER% && echo. && echo.RUN directive complete. Docker will now commit the filesystem layer to disk. && echo.Note that for large filesystem layers this can take quite some time. && echo.Performing filesystem layer commit... && echo." container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby
time="2021-10-13T17:45:51.414238700-07:00" level=info msg="sending event" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 event=create module=libcontainerd namespace=moby
time="2021-10-13T17:45:51.511375100-07:00" level=debug msg="created process pid" pid=5888
time="2021-10-13T17:45:51.523752300-07:00" level=debug msg="init process started" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby pid=5888
time="2021-10-13T17:45:51.528646000-07:00" level=debug msg="start() completed" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby
time="2021-10-13T17:45:51.528646000-07:00" level=info msg="sending event" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 event=start event-info="{3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 init 5888 0 0001-01-01 00:00:00 +0000 UTC false <nil>}" module=libcontainerd namespace=moby
time="2021-10-13T17:47:52.223268200-07:00" level=debug msg="Service name To resolve: _ldap._tcp.dc._msdcs.WORKGROUP.ec2.internal."
time="2021-10-13T17:47:52.274492500-07:00" level=debug msg="Service name To resolve: _VLMCS._TCP.ec2.internal."
time="2021-10-13T17:57:57.630259800-07:00" level=debug msg="HCS notification" notification-type=ProcessExited pid=5888 system-id=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2
time="2021-10-13T17:57:57.630818900-07:00" level=debug msg="process exited" exitCode=0 spanID=ae1d1faed94cdb7d traceID=8ba56fddb3ff0a571f75f7293c8fae0e
time="2021-10-13T17:57:58.642960800-07:00" level=debug msg="HCS notification" notification-type=SystemExited system-id=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2
time="2021-10-13T17:57:58.642960800-07:00" level=debug msg="system exited" spanID=b79fea7e0cada72d traceID=a8695b7310bb538459c162b3a4d444d7
time="2021-10-13T17:57:58.644428800-07:00" level=debug msg="completed container shutdown" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 module=libcontainerd namespace=moby process=init
time="2021-10-13T17:57:58.644493200-07:00" level=info msg="sending event" container=3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 event=exit event-info="{3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 init 5888 0 2021-10-13 17:57:57.6323464 -0700 PDT m=+1660.637060401 false <nil>}" module=libcontainerd namespace=moby
time="2021-10-13T17:57:58.644905400-07:00" level=debug msg="attach: stdout: end"
time="2021-10-13T17:57:58.644989400-07:00" level=debug msg="attach: stderr: end"
time="2021-10-13T17:57:58.645198800-07:00" level=debug msg="attach done"
time="2021-10-13T17:57:58.647293500-07:00" level=debug msg="Revoking external connectivity on endpoint elated_lumiere (aa71fdb2d942e6822d5e01b6fa901cafb25017feeafca47fd16f7abc74c1f909)"
time="2021-10-13T17:57:58.647502700-07:00" level=debug msg="[GET]=>[/endpoints/6fae5914-46a8-467d-80c8-5cbae4998d1b] Request : "
time="2021-10-13T17:57:58.653642700-07:00" level=debug msg="Network Response : {\"ID\":\"6fae5914-46a8-467d-80c8-5cbae4998d1b\",\"Name\":\"Ethernet\",\"Version\":55834574851,\"AdditionalParams\":{},\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":3,\"Allocators\":[],\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132786459501772402},\"ID\":\"CD507088-CBB6-40B1-8349-E557979002C9\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\"},\"State\":4,\"VirtualNetwork\":\"364c3ed5-ab5f-4ee7-940d-4eea8b3422b5\",\"VirtualNetworkName\":\"nat\",\"MacAddress\":\"00-15-5D-7B-8C-A2\",\"EnableInternalDNS\":true,\"IPAddress\":\"172.26.177.71\",\"PrefixLength\":20,\"GatewayAddress\":\"172.26.176.1\",\"IPSubnetId\":\"cee88c8f-36d5-4477-bcca-8772b9eaa864\",\"DNSServerList\":\"172.26.176.1,172.18.0.2\",\"DNSSuffix\":\"ec2.internal\",\"SharedContainers\":[]}"
time="2021-10-13T17:57:58.654414300-07:00" level=debug msg="[GET]=>[/endpoints/6fae5914-46a8-467d-80c8-5cbae4998d1b] Request : "
time="2021-10-13T17:57:58.658474900-07:00" level=debug msg="Network Response : {\"ID\":\"6fae5914-46a8-467d-80c8-5cbae4998d1b\",\"Name\":\"Ethernet\",\"Version\":55834574851,\"AdditionalParams\":{},\"Resources\":{\"AdditionalParams\":{},\"AllocationOrder\":3,\"Allocators\":[],\"CompartmentOperationTime\":0,\"Flags\":0,\"Health\":{\"LastErrorCode\":0,\"LastUpdateTime\":132786459501772402},\"ID\":\"CD507088-CBB6-40B1-8349-E557979002C9\",\"PortOperationTime\":0,\"State\":1,\"SwitchOperationTime\":0,\"VfpOperationTime\":0,\"parentId\":\"EEA88261-C502-4E7A-8C4F-25224DBE68DE\"},\"State\":4,\"VirtualNetwork\":\"364c3ed5-ab5f-4ee7-940d-4eea8b3422b5\",\"VirtualNetworkName\":\"nat\",\"MacAddress\":\"00-15-5D-7B-8C-A2\",\"EnableInternalDNS\":true,\"IPAddress\":\"172.26.177.71\",\"PrefixLength\":20,\"GatewayAddress\":\"172.26.176.1\",\"IPSubnetId\":\"cee88c8f-36d5-4477-bcca-8772b9eaa864\",\"DNSServerList\":\"172.26.176.1,172.18.0.2\",\"DNSSuffix\":\"ec2.internal\",\"SharedContainers\":[]}"
time="2021-10-13T17:57:58.676142700-07:00" level=debug msg="[DELETE]=>[/endpoints/6fae5914-46a8-467d-80c8-5cbae4998d1b] Request : "
time="2021-10-13T17:57:58.685234400-07:00" level=debug msg="Releasing addresses for endpoint elated_lumiere's interface on network nat"
time="2021-10-13T17:57:58.685234400-07:00" level=debug msg="ReleaseAddress(172.26.176.0/20, 172.26.177.71)"
time="2021-10-13T17:57:58.691588200-07:00" level=debug msg="WindowsGraphDriver Put() id 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2"
time="2021-10-13T17:58:01.457989000-07:00" level=debug msg="WindowsGraphDriver Get() id 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2 mountLabel "
time="2021-10-13T17:58:01.597166900-07:00" level=debug msg="Calling proc (1)" spanID=d929134c8a6b96f5 traceID=6084c895af3ecc63a00f5f855fc8b146
time="2021-10-13T17:58:01.599652500-07:00" level=debug msg="Calling proc (2)" spanID=d929134c8a6b96f5 traceID=6084c895af3ecc63a00f5f855fc8b146
time="2021-10-13T17:58:01.605319600-07:00" level=debug msg="Calling proc (1)" spanID=4b8760b5aa2a13f0 traceID=33f0667a812fc9c125ae67b54301ce62
time="2021-10-13T17:58:01.605319600-07:00" level=debug msg="Calling proc (2)" spanID=4b8760b5aa2a13f0 traceID=33f0667a812fc9c125ae67b54301ce62
time="2021-10-13T17:58:01.607218200-07:00" level=debug msg="Calling proc (1)" spanID=e1ecdb61966ac1a9 traceID=141f016c176f2e3038b7ea28eabb7038
time="2021-10-13T17:58:01.608485800-07:00" level=debug msg="Calling proc (2)" spanID=e1ecdb61966ac1a9 traceID=141f016c176f2e3038b7ea28eabb7038
time="2021-10-13T18:03:02.837328600-07:00" level=debug msg="Cleaning up layer 9ea60f0d5d6bd7978d2b705d289df7d60d53c031a6b53510a9cd5aaae48a4101: re-exec error: exit status 1: output: open \\\\?\\C:\\ProgramData\\docker\\tmp\\hcs2047284100\\Files\\BuildTools\\Common7\\IDE\\CommonExtensions\\Microsoft\\TextMate\\Starterkit\\Extensions\\cmake\\Snippets\\File(Glob …).tmSnippet: The filename, directory name, or volume label syntax is incorrect."
time="2021-10-13T18:03:03.862151100-07:00" level=debug msg="WindowsGraphDriver Put() id 3750efd153facd8be74cdb9cc73409c401601282a0e2b9c2ff5a9d0920d86ad2"