Here: https://github.com/hashicorp/packer/issues/5496
On Saturday, 21 October 2017 09:08:20 UTC+13, Megan Marsh wrote: > > Hey Andrew, > > Can you open an issue on github? I've put a lot of work into trying to > make windows powershell more reliable lately and would like to take a look. > > On Thu, Oct 19, 2017 at 6:21 PM, <[email protected] <javascript:>> wrote: > > I know that this one is hard to track down, so I'm mainly writing so that > the others new that there is a potential problem and on the off-chance that > someone came across this one already. > > In a Windows Server build I'm running quite a few shell (powershell) > provisioner steps. Sometimes some of these steps fail without error. For > example: > > [00:38:53][Step 1/2] ==> windows-2012-base: Provisioning with Powershell > ... > [00:38:53][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/debloat-windows.ps1 > [00:38:53][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/install-choco.ps1 > [00:38:54][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/install-7z.ps1 > [00:38:54][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/install-vmtools.ps1 > [00:38:54][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/install-bginfo.ps1 > [00:38:55][Step 1/2] ==> windows-2012-base: Provisioning with shell script > : ./scripts/install-antivirus.ps1 > [00:38:55][Step 1/2] ==> windows-2012-base: Restarting Machine > [00:38:55][Step 1/2] ==> windows-2012-base: Waiting for machine to restart > ... > > As you can see there are no errors displayed here, yet the scripts are not > executed. There is no result of their execution in the resulting image and > there is no output these script display in the log. They don't have to fail > all together some time just one fails and it could be a different one each > time. This is what output looks like when these work: > > [08:15:50][Step 1/2] ==> windows-2012-base: Provisioning with Powershell... > [08:15:50][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/debloat-windows.ps1 > [08:17:04][Step 1/2] windows-2012-base: #< CLIXML > [08:17:05][Step 1/2] windows-2012-base: Downloading debloat zip > [08:17:13][Step 1/2] windows-2012-base: Disable Windows Defender > [08:17:29][Step 1/2] windows-2012-base: > [08:17:29][Step 1/2] windows-2012-base: Success Restart Needed Exit > Code Feature Result > [08:17:29][Step 1/2] windows-2012-base: ------- -------------- > --------- -------------- > [08:17:29][Step 1/2] windows-2012-base: False No > InvalidArgs {} > [08:17:29][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1 <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>< > /I64 <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil > /><PI>-1</PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > </SD></PR></MS></Obj><Obj S="information" RefId="1"><TN > RefId="1"><T>System.Management.Automation.InformationRecord</T><T>System.Object</T></TN><ToString>Downloading > > debloat zip</ToString><Props><Obj N="MessageData" RefId="2"><TN > RefId="2"><T>System.Management.Automation.HostInformationMessage</T><T>System.Object</T></TN><ToString>Downloading > > debloat zip</ToString><Props><S N="Message">Downloading debloat zip</S><B > N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:17:04.2414592+13:00</DT><Obj N="Tags" > RefId="3"><TN > RefId="3"><T>System.Collections.Generic.List`1[[System.String, mscorlib, > Version=4.0.0.0, Culture=neutral, > PublicKeyToken=b77a5c561934e089]]</T><T>System.Object</T></TN><LST><S>PSHOST</S></LST></Obj><S > > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">1712</U32><U32 N="NativeThreadId">1868</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="4"><TNRef RefId="1" /><ToString>Disable Windows > Defender</ToString><Props><Obj N="MessageData" RefId="5"><TNRef RefId="2" > /><ToString>Disable Windows Defender</ToString><Props><S > N="Message">Disable Windows Defender</S><B N="NoNewLine">false</B><S > N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:17:11.9285715+13:00</DT><Obj N="Tags" > RefId="6"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">1712</U32><U32 N="NativeThreadId">1868</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><S > S="Error">Uninstall-WindowsFeature : ArgumentNotValid: The role, role > service, or _x000D__x000A_</S><S S="Error">feature name is not valid: > 'Windows-Defender-Features'. The name was not found._x000D__x000A_</S><S > S="Error">At C:\Windows\Temp\script.ps1:17 char:3_x000D__x000A_</S><S > S="Error">+ Uninstall-WindowsFeature > Windows-Defender-Features_x000D__x000A_</S><S S="Error">+ > ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S > S="Error"> + CategoryInfo : InvalidArgument: > (Windows-Defender-Features:Stri _x000D__x000A_</S><S S="Error"> ng) > [Uninstall-WindowsFeature], Exception_x000D__x000A_</S><S S="Error"> + > FullyQualifiedErrorId : NameDoesNotExist,Microsoft.Windows.ServerManager > _x000D__x000A_</S><S S="Error"> > .Commands.RemoveWindowsFeatureCommand_x000D__x000A_</S></Objs> > [08:17:29][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-choco.ps1 > [08:17:40][Step 1/2] windows-2012-base: #< CLIXML > [08:17:42][Step 1/2] windows-2012-base: > [08:17:42][Step 1/2] windows-2012-base: Mode > LastWriteTime Length Name > [08:17:42][Step 1/2] windows-2012-base: ---- > ------------- ------ ---- > [08:17:42][Step 1/2] windows-2012-base: d----- 7/10/2017 8:17 > a.m. chocInstall > [08:17:42][Step 1/2] windows-2012-base: Getting latest version of the > Chocolatey package for download. > [08:17:42][Step 1/2] windows-2012-base: Getting Chocolatey from > https://chocolatey.org/api/v2/package/chocolatey/0.10.8. > [08:17:45][Step 1/2] windows-2012-base: Downloading 7-Zip commandline > tool prior to extraction. > [08:17:45][Step 1/2] windows-2012-base: Extracting > C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip > to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall... > [08:17:45][Step 1/2] windows-2012-base: Installing chocolatey on this > machine > [08:17:45][Step 1/2] windows-2012-base: Creating ChocolateyInstall as > an environment variable (targeting 'Machine') > [08:17:45][Step 1/2] windows-2012-base: Setting ChocolateyInstall to > 'C:\ProgramData\chocolatey' > [08:17:45][Step 1/2] windows-2012-base: WARNING: It's very likely you > will need to close and reopen your shell > [08:17:45][Step 1/2] windows-2012-base: before you can use choco. > [08:17:49][Step 1/2] windows-2012-base: Restricting write permissions > to Administrators > [08:17:49][Step 1/2] windows-2012-base: We are setting up the > Chocolatey package repository. > [08:17:49][Step 1/2] windows-2012-base: The packages themselves go to > 'C:\ProgramData\chocolatey\lib' > [08:17:49][Step 1/2] windows-2012-base: (i.e. > C:\ProgramData\chocolatey\lib\yourPackageName). > [08:17:49][Step 1/2] windows-2012-base: A shim file for the command > line goes to 'C:\ProgramData\chocolatey\bin' > [08:17:49][Step 1/2] windows-2012-base: and points to an executable in > 'C:\ProgramData\chocolatey\lib\yourPackageName'. > [08:17:49][Step 1/2] windows-2012-base: > [08:17:49][Step 1/2] windows-2012-base: Creating Chocolatey folders if > they do not already exist. > [08:17:49][Step 1/2] windows-2012-base: > [08:17:49][Step 1/2] windows-2012-base: WARNING: You can safely ignore > errors related to missing log files when > [08:17:49][Step 1/2] windows-2012-base: upgrading from a version of > Chocolatey less than 0.9.9. > [08:17:49][Step 1/2] windows-2012-base: 'Batch file could not be > found' is also safe to ignore. > [08:17:49][Step 1/2] windows-2012-base: 'The system cannot find the > file specified' - also safe. > [08:17:49][Step 1/2] windows-2012-base: chocolatey.nupkg file not > installed in lib. > [08:17:49][Step 1/2] windows-2012-base: Attempting to locate it from > bootstrapper. > [08:17:49][Step 1/2] windows-2012-base: PATH environment variable does > not have C:\ProgramData\chocolatey\bin in it. Adding... > [08:17:49][Step 1/2] windows-2012-base: Chocolatey (choco.exe) is now > ready. > [08:17:49][Step 1/2] windows-2012-base: You can call choco from > anywhere, command line or powershell by typing choco. > [08:17:49][Step 1/2] windows-2012-base: Run choco /? for a list of > functions. > [08:17:49][Step 1/2] windows-2012-base: You may need to shut down and > restart powershell and/or consoles > [08:17:49][Step 1/2] windows-2012-base: first prior to using choco. > [08:17:49][Step 1/2] windows-2012-base: Ensuring chocolatey commands > are on the path > [08:17:49][Step 1/2] windows-2012-base: Ensuring chocolatey.nupkg is > in the lib folder > [08:17:49][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1</I64 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>- > 1 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g></PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > > </SD></PR></MS></Obj><Obj S="information" RefId="1"><TN > RefId="1"><T>System.Management.Automation.InformationRecord</T><T>System.Object</T></TN><ToString>WARNING: > > It's very likely you will need to close and reopen your shell _x000A_ > before you can use choco.</ToString><Props><Obj N="MessageData" > RefId="2"><TN > RefId="2"><T>System.Management.Automation.HostInformationMessage</T><T>System.Object</T></TN><ToString>WARNING: > > It's very likely you will need to close and reopen your shell _x000A_ > before you can use choco.</ToString><Props><S N="Message">WARNING: It's > very likely you will need to close and reopen your shell _x000A_ before > you can use choco.</S><B N="NoNewLine">false</B><S > N="ForegroundColor">Yellow</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\tools\chocolateysetup.psm1</S><DT > > N="TimeGenerated">2017-10-07T08:17:44.6474789+13:00</DT><Obj N="Tags" > RefId="3"><TN > RefId="3"><T>System.Collections.Generic.List`1[[System.String, mscorlib, > Version=4.0.0.0, Culture=neutral, > PublicKeyToken=b77a5c561934e089]]</T><T>System.Object</T></TN><LST><S>PSHOST</S></LST></Obj><S > > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">2912</U32><U32 N="NativeThreadId">2952</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="4"><TNRef RefId="1" /><ToString>WARNING: You can safely ignore > errors related to missing log files when _x000A_ upgrading from a version > of Chocolatey less than 0.9.9. _x000A_ 'Batch file could not be found' is > also safe to ignore. _x000A_ 'The system cannot find the file specified' - > also safe.</ToString><Props><Obj N="MessageData" RefId="5"><TNRef RefId="2" > /><ToString>WARNING: You can safely ignore errors related to missing log > files when _x000A_ upgrading from a version of Chocolatey less than 0.9.9. > _x000A_ 'Batch file could not be found' is also safe to ignore. _x000A_ > 'The system cannot find the file specified' - also > safe.</ToString><Props><S N="Message">WARNING: You can safely ignore errors > related to missing log files when _x000A_ upgrading from a version of > Chocolatey less than 0.9.9. _x000A_ 'Batch file could not be found' is > also safe to ignore. _x000A_ 'The system cannot find the file specified' - > also safe.</S><B N="NoNewLine">false</B><S N="ForegroundColor">Yellow</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\tools\chocolateysetup.psm1</S><DT > > N="TimeGenerated">2017-10-07T08:17:47.663384+13:00</DT><Obj N="Tags" > RefId="6"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">2912</U32><U32 N="NativeThreadId">2952</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="7"><TNRef RefId="1" /><ToString>PATH environment variable does not > have C:\ProgramData\chocolatey\bin in it. Adding...</ToString><Props><Obj > N="MessageData" RefId="8"><TNRef RefId="2" /><ToString>PATH environment > variable does not have C:\ProgramData\chocolatey\bin in it. > Adding...</ToString><Props><S N="Message">PATH environment variable does > not have C:\ProgramData\chocolatey\bin in it. Adding...</S><B > N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\tools\chocolateyInstall\helpers\functions\Install-ChocolateyPath.ps1</S><DT > > N="TimeGenerated">2017-10-07T08:17:48.1164687+13:00</DT><Obj N="Tags" > RefId="9"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">2912</U32><U32 N="NativeThreadId">2952</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><S S="warning">Not setting tab > completion: Profile file does not exist at > 'C:\Users\vagrant\Documents\WindowsPowerShell\Microsoft.PowerShell_profile.ps1'.</S></Objs> > [08:17:49][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-7z.ps1 > [08:18:00][Step 1/2] windows-2012-base: #< CLIXML > [08:18:02][Step 1/2] windows-2012-base: Chocolatey v0.10.8 > [08:18:02][Step 1/2] windows-2012-base: Installing the following > packages: > [08:18:02][Step 1/2] windows-2012-base: 7zip > [08:18:02][Step 1/2] windows-2012-base: By installing you accept > licenses for the packages. > [08:18:08][Step 1/2] windows-2012-base: Progress: Downloading > 7zip.install 16.4.0.20170506... 100% > [08:18:11][Step 1/2] windows-2012-base: Progress: Downloading > chocolatey-core.extension 1.3.1... 100% > [08:18:13][Step 1/2] windows-2012-base: Progress: Downloading 7zip > 16.4.0.20170506... 100% > [08:18:13][Step 1/2] windows-2012-base: > [08:18:13][Step 1/2] windows-2012-base: chocolatey-core.extension > v1.3.1 [Approved] > [08:18:13][Step 1/2] windows-2012-base: chocolatey-core.extension > package files install completed. Performing other installation steps. > [08:18:15][Step 1/2] windows-2012-base: Installed/updated > chocolatey-core extensions. > [08:18:15][Step 1/2] windows-2012-base: The install of > chocolatey-core.extension was successful. > [08:18:15][Step 1/2] windows-2012-base: Software installed to > 'C:\ProgramData\chocolatey\extensions\chocolatey-core' > [08:18:15][Step 1/2] windows-2012-base: > [08:18:15][Step 1/2] windows-2012-base: 7zip.install v16.4.0.20170506 > [Approved] > [08:18:15][Step 1/2] windows-2012-base: 7zip.install package files > install completed. Performing other installation steps. > [08:18:20][Step 1/2] windows-2012-base: Installing 64 bit version > [08:18:20][Step 1/2] windows-2012-base: Installing 7zip.install... > [08:18:22][Step 1/2] windows-2012-base: 7zip.install has been > installed. > [08:18:22][Step 1/2] windows-2012-base: 7zip installed to 'C:\Program > Files\7-Zip' > [08:18:23][Step 1/2] windows-2012-base: Added > C:\ProgramData\chocolatey\bin\7z.exe shim pointed to 'c:\program > files\7-zip\7z.exe'. > [08:18:23][Step 1/2] windows-2012-base: 7zip.install may be able to be > automatically uninstalled. > [08:18:23][Step 1/2] windows-2012-base: The install of 7zip.install > was successful. > [08:18:23][Step 1/2] windows-2012-base: Software installed to > 'C:\Program Files\7-Zip\' > [08:18:23][Step 1/2] windows-2012-base: > [08:18:23][Step 1/2] windows-2012-base: 7zip v16.4.0.20170506 > [Approved] > [08:18:23][Step 1/2] windows-2012-base: 7zip package files install > completed. Performing other installation steps. > [08:18:23][Step 1/2] windows-2012-base: The install of 7zip was > successful. > [08:18:23][Step 1/2] windows-2012-base: Software install location not > explicitly set, could be in package or > [08:18:23][Step 1/2] windows-2012-base: default install location if > installer. > [08:18:23][Step 1/2] windows-2012-base: > [08:18:23][Step 1/2] windows-2012-base: Chocolatey installed 3/3 > packages. > [08:18:23][Step 1/2] windows-2012-base: See the log for details > (C:\ProgramData\chocolatey\logs\chocolatey.log). > [08:18:23][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1</I64 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>- > 1 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g></PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > > </SD></PR></MS></Obj></Objs> > [08:18:23][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-vmtools.ps1 > [08:18:35][Step 1/2] windows-2012-base: > [08:18:35][Step 1/2] windows-2012-base: #< CLIXML > [08:18:35][Step 1/2] windows-2012-base: > [08:18:35][Step 1/2] windows-2012-base: Directory: C:\Windows\Temp > [08:18:35][Step 1/2] windows-2012-base: > [08:18:35][Step 1/2] windows-2012-base: > [08:18:35][Step 1/2] windows-2012-base: Mode > LastWriteTime Length Name > [08:18:35][Step 1/2] windows-2012-base: ---- > ------------- ------ ---- > [08:18:35][Step 1/2] windows-2012-base: d----- 7/10/2017 8:18 > a.m. VmWare > [08:18:35][Step 1/2] windows-2012-base: Downloading tools > [08:18:43][Step 1/2] windows-2012-base: Extracting tools > [08:18:43][Step 1/2] windows-2012-base: > [08:18:43][Step 1/2] windows-2012-base: 7-Zip [64] 16.04 : Copyright > (c) 1999-2016 Igor Pavlov : 2016-10-04 > [08:18:43][Step 1/2] windows-2012-base: > [08:18:43][Step 1/2] windows-2012-base: Scanning the drive for > archives: > [08:18:43][Step 1/2] windows-2012-base: 1 file, 82018304 bytes (79 MiB) > [08:18:43][Step 1/2] windows-2012-base: > [08:18:43][Step 1/2] windows-2012-base: Extracting archive: > C:\Windows\Temp\windows.iso > [08:18:43][Step 1/2] windows-2012-base: -- > [08:18:43][Step 1/2] windows-2012-base: Path = > C:\Windows\Temp\windows.iso > [08:18:43][Step 1/2] windows-2012-base: Type = Iso > [08:18:43][Step 1/2] windows-2012-base: Physical Size = 82018304 > [08:18:43][Step 1/2] windows-2012-base: Created = 2017-07-19 22:54:25 > [08:18:43][Step 1/2] windows-2012-base: Modified = 2017-07-19 22:54:25 > [08:18:43][Step 1/2] windows-2012-base: > [08:18:43][Step 1/2] windows-2012-base: Everything is Ok > [08:18:43][Step 1/2] windows-2012-base: > [08:18:43][Step 1/2] windows-2012-base: Folders: 12 > [08:18:43][Step 1/2] windows-2012-base: Files: 24 > [08:18:43][Step 1/2] windows-2012-base: Size: 81835422 > [08:18:43][Step 1/2] windows-2012-base: Compressed: 82018304 > [08:18:43][Step 1/2] windows-2012-base: Running setup > [08:20:07][Step 1/2] windows-2012-base: Exit code: 3010 > [08:20:07][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1</I64 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>- > 1 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g></PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > > </SD></PR></MS></Obj><Obj S="information" RefId="1"><TN > RefId="1"><T>System.Management.Automation.InformationRecord</T><T>System.Object</T></TN><ToString>Downloading > > tools</ToString><Props><Obj N="MessageData" RefId="2"><TN > RefId="2"><T>System.Management.Automation.HostInformationMessage</T><T>System.Object</T></TN><ToString>Downloading > > tools</ToString><Props><S N="Message">Downloading tools</S><B > N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:18:34.0850342+13:00</DT><Obj N="Tags" > RefId="3"><TN > RefId="3"><T>System.Collections.Generic.List`1[[System.String, mscorlib, > Version=4.0.0.0, Culture=neutral, > PublicKeyToken=b77a5c561934e089]]</T><T>System.Object</T></TN><LST><S>PSHOST</S></LST></Obj><S > > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">864</U32><U32 N="NativeThreadId">1276</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="4"><TNRef RefId="1" /><ToString>Extracting > tools</ToString><Props><Obj N="MessageData" RefId="5"><TNRef RefId="2" > /><ToString>Extracting tools</ToString><Props><S N="Message">Extracting > tools</S><B N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:18:41.5068677+13:00</DT><Obj N="Tags" > RefId="6"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">864</U32><U32 N="NativeThreadId">1276</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="7"><TNRef RefId="1" /><ToString>Running setup</ToString><Props><Obj > N="MessageData" RefId="8"><TNRef RefId="2" /><ToString>Running > setup</ToString><Props><S N="Message">Running setup</S><B > N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:18:41.741493+13:00</DT><Obj N="Tags" > RefId="9"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">864</U32><U32 N="NativeThreadId">1276</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj><Obj S="information" > RefId="10"><TNRef RefId="1" /><ToString>Exit code: > 3010</ToString><Props><Obj N="MessageData" RefId="11"><TNRef RefId="2" > /><ToString>Exit code: 3010</ToString><Props><S N="Message">Exit code: > 3010</S><B N="NoNewLine">false</B><S N="ForegroundColor">Gray</S><S > N="BackgroundColor">Black</S></Props></Obj><S > N="Source">C:\Windows\Temp\script.ps1</S><DT > N="TimeGenerated">2017-10-07T08:20:11.9943107+13:00</DT><Obj N="Tags" > RefId="12"><TNRef RefId="3" /><LST><S>PSHOST</S></LST></Obj><S > N="User">VAGRANT-2012\vagrant</S><S N="Computer">vagrant-2012</S><U32 > N="ProcessId">864</U32><U32 N="NativeThreadId">1276</U32><U32 > N="ManagedThreadId">7</U32></Props></Obj></Objs> > [08:20:07][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-bginfo.ps1 > [08:20:19][Step 1/2] windows-2012-base: > [08:20:19][Step 1/2] windows-2012-base: #< CLIXML > [08:20:19][Step 1/2] windows-2012-base: > [08:20:19][Step 1/2] windows-2012-base: Directory: C:\Program Files > [08:20:19][Step 1/2] windows-2012-base: > [08:20:19][Step 1/2] windows-2012-base: > [08:20:19][Step 1/2] windows-2012-base: Mode > LastWriteTime Length Name > [08:20:19][Step 1/2] windows-2012-base: ---- > ------------- ------ ---- > [08:20:19][Step 1/2] windows-2012-base: d----- 7/10/2017 8:20 > a.m. BGInfo > [08:20:23][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1</I64 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>- > 1 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g></PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > > </SD></PR></MS></Obj></Objs> > [08:20:23][Step 1/2] ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-antivirus.ps1 > [08:20:35][Step 1/2] windows-2012-base: #< CLIXML > [08:23:35][Step 1/2] windows-2012-base: <Objs Version="1.1.0.1" xmlns=" > http://schemas.microsoft.com/powershell/2004/04";><Obj S="progress" > RefId="0"><TN > RefId="0"><T>System.Management.Automation.PSCustomObject</T><T>System.Object</T></TN><MS><I64 > > N="SourceId">1</I64 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g>><PR > N="Record"><AV>Preparing modules for first use.</AV><AI>0</AI><Nil /><PI>- > 1 > <https://maps.google.com/?q=1%3C/I64&entry=gmail&source=g></PI><PC>-1</PC><T>Completed</T><SR>-1</SR><SD> > > </SD></PR></MS></Obj></Objs> > [08:23:35][Step 1/2] ==> windows-2012-base: Restarting Machine > [08:23:49][Step 1/2] ==> windows-2012-base: Waiting for machine to > restart... > > This is what the relevant part of packer config looks like: > > { > "type": "windows-restart" > }, > { > "type": "powershell", > "valid_exit_codes": [ 0, 3010 ], > "scripts": [ > "./scripts/debloat-windows.ps1", > "./scripts/install-choco.ps1", > "./scripts/install-7z.ps1", > "./scripts/install-vmtools.ps1", > "./scripts/install-bginfo.ps1", > "./scripts/install-antivirus.ps1" > ] > }, > { > "type": "windows-restart" > }, > > > This is, for example, the contents of install-choco.ps1: > > iex ((New-Object System.Net.WebClient).DownloadString(' > https://chocolatey.org/install.ps1')) > > This is an excerpt from packer log when this problem is occurring: > > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Connected to machine > 2017/10/14 00:38:59 ui: ==> windows-2012-base: Machine successfully > restarted, moving on > 2017/10/14 00:38:59 [INFO] (telemetry) ending windows-restart > 2017/10/14 00:38:59 [INFO] (telemetry) Starting provisioner powershell > 2017/10/14 00:38:59 ui: ==> windows-2012-base: Provisioning with > Powershell... > 2017/10/14 00:38:59 ui: ==> windows-2012-base: Provisioning with shell > script: ./scripts/debloat-windows.ps1 > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Opening > ./scripts/debloat-windows.ps1 for reading > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Building command line > for: if (Test-Path > variable:global:ProgressPreference){$ProgressPreference='SilentlyContinue'};$env:PACKER_BUILDER_TYPE="vmware-iso"; > > $env:PACKER_BUILD_NAME="windows-2012-base"; > &'c:/Windows/Temp/script.ps1';exit $LastExitCode > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] 1308 bytes > written for 'uploadData' > 2017/10/14 00:38:59 [INFO] 1308 bytes written for 'uploadData' > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Uploading file to > 'c:/Windows/Temp/script.ps1' > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] starting remote > command: powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA== > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] command > 'powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA==' > > exited with code: 0 > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] RPC endpoint: > Communicator ended with: 0 > 2017/10/14 00:38:59 [INFO] 0 bytes written for 'stdout' > 2017/10/14 00:38:59 [INFO] 0 bytes written for 'stderr' > 2017/10/14 00:38:59 [INFO] RPC client: Communicator ended with: 0 > 2017/10/14 00:38:59 [INFO] RPC endpoint: Communicator ended with: 0 > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] 0 bytes written > for 'stderr' > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] 0 bytes written > for 'stdout' > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] RPC client: > Communicator ended with: 0 > 2017/10/14 00:38:59 ui: ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-choco.ps1 > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Opening > ./scripts/install-choco.ps1 for reading > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Building command line > for: if (Test-Path > variable:global:ProgressPreference){$ProgressPreference='SilentlyContinue'};$env:PACKER_BUILDER_TYPE="vmware-iso"; > > $env:PACKER_BUILD_NAME="windows-2012-base"; > &'c:/Windows/Temp/script.ps1';exit $LastExitCode > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 [INFO] 94 bytes > written for 'uploadData' > 2017/10/14 00:38:59 [INFO] 94 bytes written for 'uploadData' > 2017/10/14 00:38:59 packer.exe: 2017/10/14 00:38:59 Uploading file to > 'c:/Windows/Temp/script.ps1' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] starting remote > command: powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA== > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] command > 'powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA==' > > exited with code: 0 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] RPC endpoint: > Communicator ended with: 0 > 2017/10/14 00:39:00 [INFO] 0 bytes written for 'stdout' > 2017/10/14 00:39:00 [INFO] 0 bytes written for 'stderr' > 2017/10/14 00:39:00 [INFO] RPC client: Communicator ended with: 0 > 2017/10/14 00:39:00 [INFO] RPC endpoint: Communicator ended with: 0 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 0 bytes written > for 'stderr' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 0 bytes written > for 'stdout' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] RPC client: > Communicator ended with: 0 > 2017/10/14 00:39:00 ui: ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-7z.ps1 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Opening > ./scripts/install-7z.ps1 for reading > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Building command line > for: if (Test-Path > variable:global:ProgressPreference){$ProgressPreference='SilentlyContinue'};$env:PACKER_BUILDER_TYPE="vmware-iso"; > > $env:PACKER_BUILD_NAME="windows-2012-base"; > &'c:/Windows/Temp/script.ps1';exit $LastExitCode > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 15 bytes > written for 'uploadData' > 2017/10/14 00:39:00 [INFO] 15 bytes written for 'uploadData' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Uploading file to > 'c:/Windows/Temp/script.ps1' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] starting remote > command: powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA== > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] command > 'powershell -executionpolicy bypass -encodedCommand > aQBmACAAKABUAGUAcwB0AC0AUABhAHQAaAAgAHYAYQByAGkAYQBiAGwAZQA6AGcAbABvAGIAYQBsADoAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAKQB7ACQAUAByAG8AZwByAGUAcwBzAFAAcgBlAGYAZQByAGUAbgBjAGUAPQAnAFMAaQBsAGUAbgB0AGwAeQBDAG8AbgB0AGkAbgB1AGUAJwB9ADsAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAEUAUgBfAFQAWQBQAEUAPQAiAHYAbQB3AGEAcgBlAC0AaQBzAG8AIgA7ACAAJABlAG4AdgA6AFAAQQBDAEsARQBSAF8AQgBVAEkATABEAF8ATgBBAE0ARQA9ACIAdwBpAG4AZABvAHcAcwAtADIAMAAxADIALQBiAGEAcwBlACIAOwAgACYAJwBjADoALwBXAGkAbgBkAG8AdwBzAC8AVABlAG0AcAAvAHMAYwByAGkAcAB0AC4AcABzADEAJwA7AGUAeABpAHQAIAAkAEwAYQBzAHQARQB4AGkAdABDAG8AZABlAA==' > > exited with code: 0 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] RPC endpoint: > Communicator ended with: 0 > 2017/10/14 00:39:00 [INFO] 0 bytes written for 'stderr' > 2017/10/14 00:39:00 [INFO] 0 bytes written for 'stdout' > 2017/10/14 00:39:00 [INFO] RPC client: Communicator ended with: 0 > 2017/10/14 00:39:00 [INFO] RPC endpoint: Communicator ended with: 0 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 0 bytes written > for 'stdout' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 0 bytes written > for 'stderr' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] RPC client: > Communicator ended with: 0 > 2017/10/14 00:39:00 ui: ==> windows-2012-base: Provisioning with shell > script: ./scripts/install-vmtools.ps1 > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Opening > ./scripts/install-vmtools.ps1 for reading > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Building command line > for: if (Test-Path > variable:global:ProgressPreference){$ProgressPreference='SilentlyContinue'};$env:PACKER_BUILDER_TYPE="vmware-iso"; > > $env:PACKER_BUILD_NAME="windows-2012-base"; > &'c:/Windows/Temp/script.ps1';exit $LastExitCode > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 [INFO] 765 bytes > written for 'uploadData' > 2017/10/14 00:39:00 packer.exe: 2017/10/14 00:39:00 Uploading file to > 'c:/Windows/Temp > > ... -- This mailing list is governed under the HashiCorp Community Guidelines - https://www.hashicorp.com/community-guidelines.html. Behavior in violation of those guidelines may result in your removal from this mailing list. GitHub Issues: https://github.com/mitchellh/packer/issues IRC: #packer-tool on Freenode --- You received this message because you are subscribed to the Google Groups "Packer" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. To view this discussion on the web visit https://groups.google.com/d/msgid/packer-tool/657fd6ec-bf21-447a-908c-f007aa2a0b36%40googlegroups.com. For more options, visit https://groups.google.com/d/optout.
