chocolatey / choco

Chocolatey - the package manager for Windows
https://chocolatey.org
Other
10.34k stars 903 forks source link

vagrant + choco install often aborts with Process is terminated due to StackOverflowException. #277

Closed StefanScherer closed 9 years ago

StefanScherer commented 9 years ago

In the last few days I encounter a problem provisioning Windows Vagrant boxes with Chocolatey 0.9.9.5.

I have increased the memory of the VM from 768M to 1GB but still there are often errors. Sometimes it works, and sometimes it shows the issue.

The Vagrantfile I use normally uses a PowerShell Script ( provision.ps1 ) for provisioning.

Here is the output of the vagrant up running on a Mac with Fusion 7, the first StackOverflowException occurs installing the already installed DotNet 3.5. This worked fine for the last ten builds.

The Windows basebox is built from the packer-windows repo with all Windows Updates and DotNet 4 already installed.

Is there anything I can fix in the basebox configuration to increase some resources for choco.exe or is there an issue in choco.exe itself?

$ vagrant up -f win7 --provider vmware_fusion
Bringing machine 'win7' up with 'vmware_fusion' provider...
==> win7: Cloning VMware VM: 'windows_7'. This can take some time...
==> win7: Verifying vmnet devices are healthy...
==> win7: Preparing network adapters...
==> win7: Starting the VMware VM...
==> win7: Waiting for machine to boot. This may take a few minutes...
==> win7: Machine booted and ready!
==> win7: Forwarding ports...
    win7: -- 3389 => 3389
    win7: -- 22 => 2222
    win7: -- 5985 => 5985
==> win7: Setting hostname...
==> win7: Configuring network adapters within the VM...
==> win7: Configuring secondary network adapters through VMware 
==> win7: on Windows is not yet supported. You will need to manually
==> win7: configure the network adapter.
==> win7: Enabling and configuring shared folders...
    win7: -- /Users/stefan/code/esxi-playground: /vagrant
==> win7: Running provisioner: shell...
    win7: Running: scripts/provision.ps1 as c:\tmp\vagrant-shell.ps1
==> win7: Mode                LastWriteTime     Length Name                              
==> win7: 
==> win7: ----                -------------     ------ ----                              
==> win7: d----        10.05.2015     23:19            chocInstall                       
==> win7: Downloading https://chocolatey.org/api/v2/package/chocolatey/ to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: Download 7Zip commandline tool
==> win7: 
==> win7: Downloading https://chocolatey.org/7za.exe to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\7za.exe
==> win7: Extracting C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall...
==> win7: 
==> win7: 7-Zip (A) 9.20  Copyright (c) 1999-2010 Igor Pavlov  2010-11-18
==> win7: 
==> win7: Processing archive: C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: 
==> win7: Extracting  _rels\.rels
==> win7: Extracting  chocolatey.nuspec
==> win7: Extracting  tools\chocolateyInstall.ps1
==> win7: Extracting  tools\chocolateysetup.psm1
==> win7: Extracting  tools\init.ps1
==> win7: Extracting  tools\chocolateyInstall\choco.exe
==> win7: Extracting  tools\chocolateyInstall\choco.exe.ignore
==> win7: Extracting  package\services\metadata\core-properties\6f83fe2bc9c548a5aacad7eedeabf704.psmdcp
==> win7: Extracting  [Content_Types].xml
==> win7: 
==> win7: Everything is Ok
==> win7: 
==> win7: Files: 9
==> win7: Size:       3721579
==> win7: Compressed: 1255230
==> win7: Installing chocolatey on this machine
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Creating ChocolateyInstall as an environment variable (targeting 'Machine') 
==> win7: 
==> win7:   Setting ChocolateyInstall to 'C:\ProgramData\chocolatey'
==> win7: WARNING: It's very likely you will need to close and reopen your shell 
==> win7:   before you can use choco.
==> win7: Adding Modify permission for current user to 'C:\ProgramData\chocolatey'
==> win7: We are setting up the Chocolatey package repository.
==> win7: The packages themselves go to 'C:\ProgramData\chocolatey\lib'
==> win7:   (i.e. C:\ProgramData\chocolatey\lib\yourPackageName).
==> win7: A shim file for the command line goes to 'C:\ProgramData\chocolatey\bin'
==> win7:   and points to an executable in 'C:\ProgramData\chocolatey\lib\yourPackageName
==> win7: '.
==> win7: 
==> win7: Creating Chocolatey folders if they do not already exist.
==> win7: 
==> win7: WARNING: You can safely ignore errors related to missing log files when 
==> win7:   upgrading from a version of Chocolatey less than 0.9.9. 
==> win7:   'Batch file could not be found' is also safe to ignore. 
==> win7:   'The system cannot find the file specified' - also safe.
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Ensuring 'C:\ProgramData\chocolatey\lib\chocolatey' exists.
==> win7: PATH environment variable does not have C:\ProgramData\chocolatey\bin in it. Adding...
==> win7: Chocolatey (choco.exe) is now ready.
==> win7: 
==> win7: You can call choco from anywhere, command line or powershell by typing choco.
==> win7: Run choco /? for a list of functions.
==> win7: You may need to shut down and restart powershell and/or consoles
==> win7:  first prior to using choco.
==> win7: Ensuring chocolatey commands are on the path
==> win7: Chocolatey v0.9.9.5
==> win7: Installing the following packages:
==> win7: dotnet3.5
==> win7: By installing you accept licenses for the packages.
==> win7: 
==> win7: DotNet3.5 v3.5.20140403
==> win7: Process is terminated due to StackOverflowException.
==> win7: Chocolatey v0.9.9.5
==> win7: Installing the following packages:
==> win7: vmwarevsphereclient
==> win7: By installing you accept licenses for the packages.
==> win7: 
==> win7: vmwarevsphereclient v6.0.0 (forced)
==> win7:  Downloading vmwarevsphereclient 64 bit
==> win7:    from 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe'
==> win7: Process is terminated due to StackOverflowException.
==> win7:  The install of vmwarevsphereclient was successful.
==> win7: 
ferventcoder commented 9 years ago

.NET 3.5 checks a registry setting and then it's done. If it is already installed.

This is quite interesting.

I want to get to the bottom of this issue. Can you run some more tests, this time with the addition of -dv? I am assuming you have already added -y to the script...

ferventcoder commented 9 years ago

https://github.com/StefanScherer/esxi-playground/blob/esxi60/scripts/provision.ps1#L5 will likely fail, try removing the package name from the source. It's issue https://github.com/chocolatey/choco/issues/90.

StefanScherer commented 9 years ago

OK, next try. I used this script:

iex ((new-object net.webclient).DownloadString('https://chocolatey.org/install.ps1'))

choco install -dv -y dotnet3.5
# choco install -y vmwarevsphereclient -version 5.5.0.1993072
choco install -dv -y -source c:\vagrant\chocolatey\vmwarevsphereclient.6.0.0.nupkg

choco install -dv -y vagrant
# plugin from github.com/frankus0512/vagrant-esxi branch newfeatures
vagrant plugin install c:\vagrant\plugins\vagrant-esxi-0.1.1.gem

# Download vagrant SSH key to login to ESXi server
New-Item -Path "C:\Users\vagrant\.ssh" -ItemType Directory
(New-Object System.Net.WebClient).DownloadFile('https://raw.githubusercontent.com/mitchellh/vagrant/master/keys/vagrant.pub', 'C:\Users\vagrant\.ssh\id_rsa.pub')
(New-Object System.Net.WebClient).DownloadFile('https://raw.githubusercontent.com/mitchellh/vagrant/master/keys/vagrant', 'C:\Users\vagrant\.ssh\id_rsa')

Just after spinnig up the VM I have read #90 and saw that I got line 5 wrong, so this how I have to change the line 5. But the next choco install -dv -y vagrant crashed:

$ vagrant up win7 --provider vmware_fusion
WARNING: Could not load IOV methods. Check your GSSAPI C library for an update
WARNING: Could not load AEAD methods. Check your GSSAPI C library for an update
Bringing machine 'win7' up with 'vmware_fusion' provider...
==> win7: Cloning VMware VM: 'windows_7'. This can take some time...
==> win7: Verifying vmnet devices are healthy...
==> win7: Preparing network adapters...
==> win7: Starting the VMware VM...
==> win7: Waiting for machine to boot. This may take a few minutes...
==> win7: Machine booted and ready!
==> win7: Forwarding ports...
    win7: -- 3389 => 3389
    win7: -- 22 => 2222
    win7: -- 5985 => 5985
==> win7: Setting hostname...
==> win7: Configuring network adapters within the VM...
==> win7: Configuring secondary network adapters through VMware 
==> win7: on Windows is not yet supported. You will need to manually
==> win7: configure the network adapter.
==> win7: Enabling and configuring shared folders...
    win7: -- /Users/stefan/code/esxi-playground: /vagrant
==> win7: Running provisioner: shell...
    win7: Running: scripts/provision.ps1 as c:\tmp\vagrant-shell.ps1
==> win7: Mode                LastWriteTime     Length Name                              
==> win7: ----                -------------     ------ ----                              
==> win7: d----        11.05.2015     17:38            chocInstall                       
==> win7: Downloading https://chocolatey.org/api/v2/package/chocolatey/ to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: Download 7Zip commandline tool
==> win7: 
==> win7: Downloading https://chocolatey.org/7za.exe to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\7za.exe
==> win7: Extracting C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall...
==> win7: 
==> win7: 7-Zip (A) 9.20  Copyright (c) 1999-2010 Igor Pavlov  2010-11-18
==> win7: 
==> win7: Processing archive: C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: 
==> win7: Extracting  _rels\.rels
==> win7: Extracting  chocolatey.nuspec
==> win7: Extracting  tools\chocolateyInstall.ps1
==> win7: Extracting  tools\chocolateysetup.psm1
==> win7: Extracting  tools\init.ps1
==> win7: Extracting  tools\chocolateyInstall\choco.exe
==> win7: Extracting  tools\chocolateyInstall\choco.exe.ignore
==> win7: Extracting  package\services\metadata\core-properties\6f83fe2bc9c548a5aacad7eedeabf704.psmdcp
==> win7: Extracting  [Content_Types].xml
==> win7: 
==> win7: Everything is Ok
==> win7: 
==> win7: Files: 9
==> win7: Size:       3721579
==> win7: Compressed: 1255230
==> win7: Installing chocolatey on this machine
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Creating ChocolateyInstall as an environment variable (targeting 'Machine') 
==> win7: 
==> win7:   Setting ChocolateyInstall to 'C:\ProgramData\chocolatey'
==> win7: WARNING: It's very likely you will need to close and reopen your shell 
==> win7:   before you can use choco.
==> win7: Adding Modify permission for current user to 'C:\ProgramData\chocolatey'
==> win7: We are setting up the Chocolatey package repository.
==> win7: The packages themselves go to 'C:\ProgramData\chocolatey\lib'
==> win7:   (i.e. C:\ProgramData\chocolatey\lib\yourPackageName).
==> win7: A shim file for the command line goes to 'C:\ProgramData\chocolatey\bin'
==> win7:   and points to an executable in 'C:\ProgramData\chocolatey\lib\yourPackageName
==> win7: '.
==> win7: 
==> win7: Creating Chocolatey folders if they do not already exist.
==> win7: 
==> win7: WARNING: You can safely ignore errors related to missing log files when 
==> win7:   upgrading from a version of Chocolatey less than 0.9.9. 
==> win7:   'Batch file could not be found' is also safe to ignore. 
==> win7:   'The system cannot find the file specified' - also safe.
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Ensuring 'C:\ProgramData\chocolatey\lib\chocolatey' exists.
==> win7: PATH environment variable does not have C:\ProgramData\chocolatey\bin in it. Adding...
==> win7: Chocolatey (choco.exe) is now ready.
==> win7: 
==> win7: You can call choco from anywhere, command line or powershell by typing choco.
==> win7: Run choco /? for a list of functions.
==> win7: You may need to shut down and restart powershell and/or consoles
==> win7:  first prior to using choco.
==> win7: Ensuring chocolatey commands are on the path
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is running on Windows v 6.1.7601.65536
==> win7: Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
==> win7: Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y dotnet3.5
==> win7: Received arguments: install -dv -y dotnet3.5
==> win7: 
==> win7: NOTE: Hiding sensitive configuration data! Please double and triple 
==> win7:  check to be sure no sensitive data is shown, especially if copying 
==> win7:  output to a gist for review.
==> win7: Configuration: CommandName='install'|
==> win7: CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
==> win7: ContainsLegacyPackageInstalls='True'|
==> win7: CommandExecutionTimeoutSeconds='2700'|
==> win7: Sources='https://chocolatey.org/api/v2/'|Debug='True'|Verbose='True'|
==> win7: Force='False'|Noop='False'|HelpRequested='False'|RegularOutput='True'|
==> win7: PromptForConfirmation='False'|AcceptLicense='True'|
==> win7: AllowUnofficialBuild='False'|Input='dotnet3.5'|AllVersions='False'|
==> win7: SkipPackageInstallProvider='False'|PackageNames='dotnet3.5'|
==> win7: Prerelease='False'|ForceX86='False'|OverrideArguments='False'|
==> win7: NotSilent='False'|IgnoreDependencies='False'|
==> win7: AllowMultipleVersions='False'|ForceDependencies='False'|
==> win7: Information.PlatformType='Windows'|
==> win7: Information.PlatformVersion='6.1.7601.65536'|
==> win7: Information.PlatformName='Windows 7'|
==> win7: Information.ChocolateyVersion='0.9.9.5'|
==> win7: Information.ChocolateyProductVersion='0.9.9.5'|
==> win7: Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|
==> win7: 
==> win7: Information.Is64Bit='True'|Information.IsInteractive='False'|
==> win7: Information.IsUserAdministrator='True'|
==> win7: Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
==> win7: Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
==> win7: ListCommand.IncludeRegistryPrograms='False'|
==> win7: UpgradeCommand.FailOnUnfound='False'|
==> win7: NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
==> win7: FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
==> win7: PinCommand.Command='unknown'|
==> win7: _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
==> win7: Installing the following packages:
==> win7: dotnet3.5
==> win7: By installing you accept licenses for the packages.
==> win7: Installing 'DotNet3.5 3.5.20140403'.
==> win7: Added file 'dotnet.png' to folder 'DotNet3.5'.
==> win7: Added file 'ChocolateyInstall.ps1' to folder 'DotNet3.5\Tools'.
==> win7: Added file 'DotNet3.5.nupkg' to folder 'DotNet3.5'.
==> win7: Successfully installed 'DotNet3.5 3.5.20140403'.
==> win7: 
==> win7: DotNet3.5 v3.5.20140403
==> win7: Contents of 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1':
==> win7: if(-not (test-path "hklm:\SOFTWARE\Microsoft\NET Framework Setup\NDP\v3.5")) {
==> win7:     cinst NetFx3 -source windowsfeatures
==> win7: }
==> win7: else {
==> win7:      Write-Host "Microsoft .Net 3.5 Framework is already installed on your machine."
==> win7:  } 
==> win7: Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
==> win7:  DEBUG: Posh version is 2.0
==> win7:  VERBOSE: Exporting function 'Get-BinRoot'.
==> win7:  VERBOSE: Exporting function 'Get-ChecksumValid'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
==> win7:  VERBOSE: Exporting function 'Get-FtpFile'.
==> win7:  VERBOSE: Exporting function 'Get-ProcessorBits'.
==> win7:  VERBOSE: Exporting function 'Get-UACEnabled'.
==> win7:  VERBOSE: Exporting function 'Get-VirusCheckValid'.
==> win7:  VERBOSE: Exporting function 'Get-WebFile'.
==> win7:  VERBOSE: Exporting function 'Get-WebHeaders'.
==> win7:  VERBOSE: Exporting function 'Install-BinFile'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPath'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
==> win7:  VERBOSE: Exporting function 'Install-Vsix'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Set-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
==> win7:  VERBOSE: Exporting function 'Test-ProcessAdminRights'.
==> win7:  VERBOSE: Exporting function 'Uninstall-BinFile'.
==> win7:  VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'UnInstall-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Update-SessionEnvironment'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateyFailure'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateySuccess'.
==> win7:  VERBOSE: Exporting function 'Write-FileUpdateLog'.
==> win7:  VERBOSE: Exporting alias 'Generate-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Add-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Remove-BinFile'.
==> win7:  Microsoft .Net 3.5 Framework is already installed on your machine.
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import
==> win7: -module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '0'
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\extensions".
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey".
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.sxs".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.pin".
==> win7:  The install of dotnet3.5 was successful.
==> win7: 
==> win7: Chocolatey installed 1/1 package(s). 0 package(s) failed.
==> win7:  See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
==> win7: Exiting with 0
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is running on Windows v 6.1.7601.65536
==> win7: Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
==> win7: Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y -source c:\vagrant\chocolatey\vmwarevsphereclient.6.0.0.nupkg
==> win7: Received arguments: install -dv -y -source c:\vagrant\chocolatey\vmwarevsphereclient.6.0.0.nupkg
==> win7: Package name is required. Please pass at least one package name to install.
==> win7: Exiting with 1
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is running on Windows v 6.1.7601.65536
==> win7: Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
==> win7: Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y vagrant
==> win7: Received arguments: install -dv -y vagrant
==> win7: 
==> win7: NOTE: Hiding sensitive configuration data! Please double and triple 
==> win7:  check to be sure no sensitive data is shown, especially if copying 
==> win7:  output to a gist for review.
==> win7: Configuration: CommandName='install'|
==> win7: CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
==> win7: ContainsLegacyPackageInstalls='True'|
==> win7: CommandExecutionTimeoutSeconds='2700'|
==> win7: Sources='https://chocolatey.org/api/v2/'|Debug='True'|Verbose='True'|
==> win7: Force='False'|Noop='False'|HelpRequested='False'|RegularOutput='True'|
==> win7: PromptForConfirmation='False'|AcceptLicense='True'|
==> win7: AllowUnofficialBuild='False'|Input='vagrant'|AllVersions='False'|
==> win7: SkipPackageInstallProvider='False'|PackageNames='vagrant'|
==> win7: Prerelease='False'|ForceX86='False'|OverrideArguments='False'|
==> win7: NotSilent='False'|IgnoreDependencies='False'|
==> win7: AllowMultipleVersions='False'|ForceDependencies='False'|
==> win7: Information.PlatformType='Windows'|
==> win7: Information.PlatformVersion='6.1.7601.65536'|
==> win7: Information.PlatformName='Windows 7'|
==> win7: Information.ChocolateyVersion='0.9.9.5'|
==> win7: Information.ChocolateyProductVersion='0.9.9.5'|
==> win7: Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|
==> win7: 
==> win7: Information.Is64Bit='True'|Information.IsInteractive='False'|
==> win7: Information.IsUserAdministrator='True'|
==> win7: Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
==> win7: Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
==> win7: ListCommand.IncludeRegistryPrograms='False'|
==> win7: UpgradeCommand.FailOnUnfound='False'|
==> win7: NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
==> win7: FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
==> win7: PinCommand.Command='unknown'|
==> win7: _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
==> win7: Installing the following packages:
==> win7: vagrant
==> win7: By installing you accept licenses for the packages.
==> win7: Installing 'vagrant 1.7.2'.
==> win7: Added file 'chocolateyInstall.ps1' to folder 'vagrant\tools'.
==> win7: Added file 'vagrant.png' to folder 'vagrant'.
==> win7: Added file 'vagrant.nupkg' to folder 'vagrant'.
==> win7: Successfully installed 'vagrant 1.7.2'.
==> win7: 
==> win7: vagrant v1.7.2
==> win7: Contents of 'C:\ProgramData\chocolatey\lib\vagrant\tools\chocolateyInstall.ps1':
==> win7: $url = 'https://dl.bintray.com/mitchellh/vagrant/vagrant_1.7.2.msi'
==> win7: $url64 = $url
==> win7: $validExitCodes = @(0)
==> win7: Install-ChocolateyPackage "vagrant" "msi" "/quiet" "$url" "$url64"  -validExitCodes $validExitCodes
==> win7: Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vagrant\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
==> win7:  DEBUG: Posh version is 2.0
==> win7:  DEBUG: Loading community extensions
==> win7: Process is terminated due to StackOverflowException.
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import
==> win7: -module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vagrant\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\vagrant.1.7.2".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vagrant.1.7.2\.sxs".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vagrant.1.7.2\.pin".
==> win7:  The install of vagrant was successful.
==> win7: 
==> win7: Chocolatey installed 1/1 package(s). 0 package(s) failed.
==> win7:  See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
==> win7: Exiting with 0
==> win7: The term 'vagrant' is not recognized as the name of a cmdlet, function, script 
==> win7: file, or operable program. Check the spelling of the name, or if a path was inc
==> win7: luded, verify that the path is correct and try again.
==> win7: At C:\tmp\vagrant-shell.ps1:9 char:8
==> win7: + vagrant <<<<  plugin install c:\vagrant\plugins\vagrant-esxi-0.1.1.gem
==> win7:     + CategoryInfo          : ObjectNotFound: (vagrant:String) [], CommandNotF 
==> win7:    oundException
==> win7:     + FullyQualifiedErrorId : CommandNotFoundException
==> win7:  
==> win7: New-Item : Item with specified name C:\Users\vagrant\.ssh already exists.
==> win7: At C:\tmp\vagrant-shell.ps1:12 char:9
==> win7: + New-Item <<<<  -Path "C:\Users\vagrant\.ssh" -ItemType Directory
==> win7:     + CategoryInfo          : ResourceExists: (C:\Users\vagrant\.ssh:String) [ 
==> win7:    New-Item], IOException
==> win7:     + FullyQualifiedErrorId : DirectoryExist,Microsoft.PowerShell.Commands.New 
==> win7:    ItemCommand
==> win7:  

I'll destroy the VM, fix line 5 and retry again.

StefanScherer commented 9 years ago

Next run, now with this provision.ps1 script. I have seen high CPU load while spinning up the VM and found out that there is an (bad) experience service running. So I first stop and disable it (I should move that into the packer template):

schtasks /End /TN "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser"
schtasks /Change /TN "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser" /DISABLE

iex ((new-object net.webclient).DownloadString('https://chocolatey.org/install.ps1'))

choco install -dv -y dotnet3.5
# choco install -y vmwarevsphereclient -version 5.5.0.1993072
cmd /C choco install -dv -y vmwarevsphereclient -version 6.0.0 -source c:\vagrant\chocolatey

choco install -dv -y vagrant
# plugin from github.com/frankus0512/vagrant-esxi branch newfeatures
vagrant plugin install c:\vagrant\plugins\vagrant-esxi-0.1.1.gem

# Download vagrant SSH key to login to ESXi server
New-Item -Path "C:\Users\vagrant\.ssh" -ItemType Directory
(New-Object System.Net.WebClient).DownloadFile('https://raw.githubusercontent.com/mitchellh/vagrant/master/keys/vagrant.pub', 'C:\Users\vagrant\.ssh\id_rsa.pub')
(New-Object System.Net.WebClient).DownloadFile('https://raw.githubusercontent.com/mitchellh/vagrant/master/keys/vagrant', 'C:\Users\vagrant\.ssh\id_rsa')

And the corresponding output. This time the first StackOverflowException occurs while 'installing' the dotnet3.5 package:

$ vagrant up win7 --provider vmware_fusion
WARNING: Could not load IOV methods. Check your GSSAPI C library for an update
WARNING: Could not load AEAD methods. Check your GSSAPI C library for an update
Bringing machine 'win7' up with 'vmware_fusion' provider...
==> win7: Cloning VMware VM: 'windows_7'. This can take some time...
==> win7: Verifying vmnet devices are healthy...
==> win7: Preparing network adapters...
==> win7: Starting the VMware VM...
==> win7: Waiting for machine to boot. This may take a few minutes...
==> win7: Machine booted and ready!
==> win7: Forwarding ports...
    win7: -- 3389 => 3389
    win7: -- 22 => 2222
    win7: -- 5985 => 5985
==> win7: Setting hostname...
==> win7: Configuring network adapters within the VM...
==> win7: Configuring secondary network adapters through VMware 
==> win7: on Windows is not yet supported. You will need to manually
==> win7: configure the network adapter.
==> win7: Enabling and configuring shared folders...
    win7: -- /Users/stefan/code/esxi-playground: /vagrant
==> win7: Running provisioner: shell...
    win7: Running: scripts/provision.ps1 as c:\tmp\vagrant-shell.ps1
==> win7: SUCCESS: The scheduled task "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser" has been terminated successfully.
==> win7: SUCCESS: The parameters of scheduled task "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser" have been changed.
==> win7: Mode                LastWriteTime     Length Name                              
==> win7: 
==> win7: ----                -------------     ------ ----                              
==> win7: d----        11.05.2015     18:08            chocInstall                       
==> win7: Downloading https://chocolatey.org/api/v2/package/chocolatey/ to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: Download 7Zip commandline tool
==> win7: 
==> win7: Downloading https://chocolatey.org/7za.exe to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\7za.exe
==> win7: Extracting C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall...
==> win7: 
==> win7: 7-Zip (A) 9.20  Copyright (c) 1999-2010 Igor Pavlov  2010-11-18
==> win7: 
==> win7: Processing archive: C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
==> win7: 
==> win7: Extracting  _rels\.rels
==> win7: Extracting  chocolatey.nuspec
==> win7: Extracting  tools\chocolateyInstall.ps1
==> win7: Extracting  tools\chocolateysetup.psm1
==> win7: Extracting  tools\init.ps1
==> win7: Extracting  tools\chocolateyInstall\choco.exe
==> win7: Extracting  tools\chocolateyInstall\choco.exe.ignore
==> win7: Extracting  package\services\metadata\core-properties\6f83fe2bc9c548a5aacad7eedeabf704.psmdcp
==> win7: Extracting  [Content_Types].xml
==> win7: 
==> win7: Everything is Ok
==> win7: 
==> win7: Files: 9
==> win7: Size:       3721579
==> win7: Compressed: 1255230
==> win7: Installing chocolatey on this machine
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Creating ChocolateyInstall as an environment variable (targeting 'Machine') 
==> win7: 
==> win7:   Setting ChocolateyInstall to 'C:\ProgramData\chocolatey'
==> win7: WARNING: It's very likely you will need to close and reopen your shell 
==> win7:   before you can use choco.
==> win7: Adding Modify permission for current user to 'C:\ProgramData\chocolatey'
==> win7: We are setting up the Chocolatey package repository.
==> win7: The packages themselves go to 'C:\ProgramData\chocolatey\lib'
==> win7:   (i.e. C:\ProgramData\chocolatey\lib\yourPackageName).
==> win7: A shim file for the command line goes to 'C:\ProgramData\chocolatey\bin'
==> win7:   and points to an executable in 'C:\ProgramData\chocolatey\lib\yourPackageName
==> win7: '.
==> win7: 
==> win7: Creating Chocolatey folders if they do not already exist.
==> win7: 
==> win7: WARNING: You can safely ignore errors related to missing log files when 
==> win7:   upgrading from a version of Chocolatey less than 0.9.9. 
==> win7:   'Batch file could not be found' is also safe to ignore. 
==> win7:   'The system cannot find the file specified' - also safe.
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is unpacking required files for use. Overwriting? True
==> win7: Ensuring 'C:\ProgramData\chocolatey\lib\chocolatey' exists.
==> win7: PATH environment variable does not have C:\ProgramData\chocolatey\bin in it. Adding...
==> win7: Chocolatey (choco.exe) is now ready.
==> win7: 
==> win7: You can call choco from anywhere, command line or powershell by typing choco.
==> win7: Run choco /? for a list of functions.
==> win7: You may need to shut down and restart powershell and/or consoles
==> win7:  first prior to using choco.
==> win7: Ensuring chocolatey commands are on the path
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is running on Windows v 6.1.7601.65536
==> win7: Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
==> win7: Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y dotnet3.5
==> win7: Received arguments: install -dv -y dotnet3.5
==> win7: 
==> win7: NOTE: Hiding sensitive configuration data! Please double and triple 
==> win7:  check to be sure no sensitive data is shown, especially if copying 
==> win7:  output to a gist for review.
==> win7: Configuration: CommandName='install'|
==> win7: CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
==> win7: ContainsLegacyPackageInstalls='True'|
==> win7: CommandExecutionTimeoutSeconds='2700'|
==> win7: Sources='https://chocolatey.org/api/v2/'|Debug='True'|Verbose='True'|
==> win7: Force='False'
==> win7: |Noop='False'|HelpRequested='False'|RegularOutput='True'|
==> win7: PromptForConfirmation='False'|AcceptLicense='True'|
==> win7: AllowUnofficialBuild='False'|Input='dotnet3.5'|AllVersions='False'|
==> win7: SkipPackageInstallProvider='False'|PackageNames='dotnet3.5'|
==> win7: Prerelease='False'|ForceX86='False'|OverrideArguments='False'|
==> win7: NotSilent='False'|IgnoreDependencies='False'|
==> win7: AllowMultipleVersions='False'|ForceDependencies='False'|
==> win7: Information.PlatformType='Windows'|
==> win7: Information.PlatformVersion='6.1.7601.65536'|
==> win7: Information.PlatformName='Windows 7'|
==> win7: Information.ChocolateyVersion='0.9.9.5'|
==> win7: Information.ChocolateyProductVersion='0.9.9.5'|
==> win7: Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|
==> win7: 
==> win7: Information.Is64Bit='True'|Information.IsInteractive='False'|
==> win7: Information.IsUserAdministrator='True'|
==> win7: Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
==> win7: Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
==> win7: ListCommand.IncludeRegistryPrograms='False'|
==> win7: UpgradeCommand.FailOnUnfound='False'|
==> win7: NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
==> win7: FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
==> win7: PinCommand.Command='unknown'|
==> win7: _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
==> win7: Installing the following packages:
==> win7: dotnet3.5
==> win7: By installing you accept licenses for the packages.
==> win7: Installing 'DotNet3.5 3.5.20140403'.
==> win7: Added file 'dotnet.png' to folder 'DotNet3.5'.
==> win7: Added file 'ChocolateyInstall.ps1' to folder 'DotNet3.5\Tools'.
==> win7: Added file 'DotNet3.5.nupkg' to folder 'DotNet3.5'.
==> win7: Successfully installed 'DotNet3.5 3.5.20140403'.
==> win7: 
==> win7: DotNet3.5 v3.5.20140403
==> win7: Contents of 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1':
==> win7: if(-not (test-path "hklm:\SOFTWARE\Microsoft\NET Framework Setup\NDP\v3.5")) {
==> win7:     cinst NetFx3 -source windowsfeatures
==> win7: }
==> win7: else {
==> win7:      Write-Host "Microsoft .Net 3.5 Framework is already installed on your machine."
==> win7:  } 
==> win7: 
==> win7: Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
==> win7:  DEBUG: Posh version is 2.0
==> win7:  VERBOSE: Exporting function 'Get-BinRoot'.
==> win7:  VERBOSE: Exporting function 'Get-ChecksumValid'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
==> win7:  VERBOSE: Exporting function 'Get-FtpFile'.
==> win7:  VERBOSE: Exporting function 'Get-ProcessorBits'.
==> win7:  VERBOSE: Exporting function 'Get-UACEnabled'.
==> win7:  VERBOSE: Exporting function 'Get-VirusCheckValid'.
==> win7:  VERBOSE: Exporting function 'Get-WebFile'.
==> win7:  VERBOSE: Exporting function 'Get-WebHeaders'.
==> win7:  VERBOSE: Exporting function 'Install-BinFile'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPath'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
==> win7:  VERBOSE: Exporting function 'Install-Vsix'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Set-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
==> win7:  VERBOSE: Exporting function 'Test-ProcessAdminRights'.
==> win7:  VERBOSE: Exporting function 'Uninstall-BinFile'.
==> win7:  VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'UnInstall-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Update-SessionEnvironment'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateyFailure'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateySuccess'.
==> win7:  VERBOSE: Exporting function 'Write-FileUpdateLog'.
==> win7:  VERBOSE: Exporting alias 'Generate-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Add-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Remove-BinFile'.
==> win7:  Microsoft .Net 3.5 Framework is already installed on your machine.
==> win7: Process is terminated due to StackOverflowException.
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\extensions".
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey".
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.sxs".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.pin".
==> win7:  The install of dotnet3.5 was successful.
==> win7: 
==> win7: Chocolatey installed 1/1 package(s). 0 package(s) failed.
==> win7:  See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
==> win7: Exiting with 0
==> win7: Chocolatey v0.9.9.5
==> win7: Chocolatey is running on Windows v 6.1.7601.65536
==> win7: Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
==> win7: Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y vmwarevsphereclient -version 6.0.0 -source c:\vagrant\chocolatey
==> win7: Received arguments: install -dv -y vmwarevsphereclient -version 6.0.0 -source c:\vagrant\chocolatey
==> win7: 
==> win7: NOTE: Hiding sensitive configuration data! Please double and triple 
==> win7:  check to be sure no sensitive data is shown, especially if copying 
==> win7:  output to a gist for review.
==> win7: Configuration: CommandName='install'|
==> win7: CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
==> win7: ContainsLegacyPackageInstalls='True'|
==> win7: CommandExecutionTimeoutSeconds='2700'|Sources='c:\vagrant\chocolatey'|
==> win7: Debug='True'|Verbose='True'|Force='False'|Noop='Fals
==> win7: e'|
==> win7: HelpRequested='False'|RegularOutput='True'|
==> win7: PromptForConfirmation='False'|AcceptLicense='True'|
==> win7: AllowUnofficialBuild='False'|Input='vmwarevsphereclient'|
==> win7: Version='6.0.0'|AllVersions='False'|SkipPackageInstallProvider='False'|
==> win7: PackageNames='vmwarevsphereclient'|Prerelease='False'|ForceX86='False'|
==> win7: OverrideArguments='False'|NotSilent='False'|IgnoreDependencies='False'|
==> win7: AllowMultipleVersions='False'|ForceDependencies='False'|
==> win7: Information.PlatformType='Windows'|
==> win7: Information.PlatformVersion='6.1.7601.65536'|
==> win7: Information.PlatformName='Windows 7'|
==> win7: Information.ChocolateyVersion='0.9.9.5'|
==> win7: Information.ChocolateyProductVersion='0.9.9.5'|
==> win7: Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|
==> win7: 
==> win7: Information.Is64Bit='True'|Information.IsInteractive='False'|
==> win7: Information.IsUserAdministrator='True'|
==> win7: Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
==> win7: Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
==> win7: ListCommand.IncludeRegistryPrograms='False'|
==> win7: UpgradeCommand.FailOnUnfound='False'|
==> win7: NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
==> win7: FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
==> win7: PinCommand.Command='unknown'|
==> win7: _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
==> win7: Installing the following packages:
==> win7: vmwarevsphereclient
==> win7: By installing you accept licenses for the packages.
==> win7: Attempting to resolve dependency 'dotnet3.5'.
==> win7: Installing 'vmwarevsphereclient 6.0.0'.
==> win7: Added file 'chocolateyInstall.ps1' to folder 'vmwarevsphereclient\tools'.
==> win7: Added file 'vmwarevsphereclient.png' to folder 'vmwarevsphereclient'.
==> win7: Added file 'vmwarevsphereclient.nupkg' to folder 'vmwarevsphereclient'.
==> win7: Successfully installed 'vmwarevsphereclient 6.0.0'.
==> win7: 
==> win7: vmwarevsphereclient v6.0.0
==> win7: Contents of 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1':
==> win7: $packageName = 'vmwarevsphereclient' 
==> win7: $installerType = 'exe'
==> win7: $url = 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe'
==> win7: $url64 = $url
==> win7: $silentArgs = '/s /w /v" /qb"'
==> win7: $validExitCodes = @(0)
==> win7: 
==> win7: Install-ChocolateyPackage "$packageName" "$installerType" "$silentArgs" "$url" "$url64"  -validExitCodes $validExitCodes
==> win7: Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
==> win7:  DEBUG: Posh version is 2.0
==> win7:  DEBUG: Loading community extensions
==> win7:  VERBOSE: Exporting function 'Get-BinRoot'.
==> win7:  VERBOSE: Exporting function 'Get-ChecksumValid'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
==> win7:  VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
==> win7:  VERBOSE: Exporting function 'Get-FtpFile'.
==> win7:  VERBOSE: Exporting function 'Get-ProcessorBits'.
==> win7:  VERBOSE: Exporting function 'Get-UACEnabled'.
==> win7:  VERBOSE: Exporting function 'Get-VirusCheckValid'.
==> win7:  VERBOSE: Exporting function 'Get-WebFile'.
==> win7:  VERBOSE: Exporting function 'Get-WebHeaders'.
==> win7:  VERBOSE: Exporting function 'Install-BinFile'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPath'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
==> win7:  VERBOSE: Exporting function 'Install-Vsix'.
==> win7:  VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Set-EnvironmentVariable'.
==> win7:  VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
==> win7:  VERBOSE: Exporting function 'Test-ProcessAdminRights'.
==> win7:  VERBOSE: Exporting function 'Uninstall-BinFile'.
==> win7:  VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
==> win7:  VERBOSE: Exporting function 'UnInstall-ChocolateyZipPackage'.
==> win7:  VERBOSE: Exporting function 'Update-SessionEnvironment'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateyFailure'.
==> win7:  VERBOSE: Exporting function 'Write-ChocolateySuccess'.
==> win7:  VERBOSE: Exporting function 'Write-FileUpdateLog'.
==> win7:  VERBOSE: Exporting alias 'Generate-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Add-BinFile'.
==> win7:  VERBOSE: Exporting alias 'Remove-BinFile'.
==> win7:  DEBUG: Running 'Install-ChocolateyPackage' for vmwarevsphereclient with 
==> win7:  url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
==> win7:  e', args: '/s /w /v" /qb"', fileType: 'exe', url64bit: 
==> win7:  'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe', 
==> win7:  checksum: '', checksumType: '', checksum64: '', checksumType64: '', 
==> win7:  validExitCodes: '0' 
==> win7:  DEBUG: Running 'Get-ChocolateyWebFile' for vmwarevsphereclient with 
==> win7:  url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
==> win7:  e', 
==> win7:  fileFullPath:'C:\Users\vagrant\AppData\Local\Temp\chocolatey\vmwarevsphereclien
==> win7:  t\vmwarevsphereclientInstall.exe', 
==> win7:  url64bit:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0
==> win7:  .0.exe', checksum: '', checksumType: '', checksum64: '', checksumType64: ''
==> win7:  DEBUG: Running 'Get-ProcessorBits'
==> win7:  DEBUG: CPU is 64 bit
==> win7:  DEBUG: Setting url to 
==> win7:  'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe' 
==> win7:  and bitPackage to 64
==> win7:  DEBUG: Running 'Get-WebHeaders' with 
==> win7:  url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
==> win7:  e', userAgent: 'chocolatey command line'
==> win7:  DEBUG: Setting the UserAgent to 'chocolatey command line'
==> win7:  DEBUG: Request Headers:
==> win7:  DEBUG:   'Accept':'*/*'
==> win7:  DEBUG:   'User-Agent':'chocolatey command line'
==> win7:  DEBUG: Response Headers:
==> win7:  DEBUG:   'Content-MD5':'9s3JFIrXYxXvJd0GYKjijg=='
==> win7:  DEBUG:   'Connection':'keep-alive'
==> win7:  DEBUG:   'Accept-Ranges':'bytes'
==> win7:  DEBUG:   'Content-Length':'372694720'
==> win7:  DEBUG:   'Content-Type':'application/octet-stream'
==> win7:  DEBUG:   'Date':'Mon, 11 May 2015 16:09:05 GMT'
==> win7:  DEBUG:   'ETag':'"f6cdc9148ad76315ef25dd0660a8e28e:1411497586"'
==> win7:  DEBUG:   'Last-Modified':'Thu, 18 Sep 2014 23:25:59 GMT'
==> win7:  DEBUG:   'Server':'Apache'
==> win7:  Downloading vmwarevsphereclient 64 bit
==> win7:    from 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe'
==> win7:  DEBUG: Running 'Get-WebFile' for 
==> win7:  C:\Users\vagrant\AppData\Local\Temp\chocolatey\vmwarevsphereclient\vmwarevspher
==> win7:  eclientInstall.exe with 
==> win7:  url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
==> win7:  e', userAgent: 'chocolatey command line' 
==> win7:  DEBUG: Setting the UserAgent to 'chocolatey command line'
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import
==> win7: Process is terminated due to StackOverflowException.
==> win7: 
==> win7: Process is terminated due to StackOverflowException.
==> win7: -module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'
==> win7: Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0\.sxs".
==> win7: Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0\.pin".
==> win7:  The install of vmwarevsphereclient was successful.
==> win7: 
==> win7: Chocolatey installed 1/1 package(s). 0 package(s) failed.
==> win7:  See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
==> win7: Exiting with 0
==> win7: Process is terminated due to StackOverflowException.
The following WinRM command responded with a non-zero exit status.
Vagrant assumes that this means the command failed!

powershell -ExecutionPolicy Bypass -OutputFormat Text -file c:\tmp\vagrant-shell.ps1
if ($?) { exit 0 } else { if($LASTEXITCODE) { exit $LASTEXITCODE } else { exit 1 } }

Stdout from the command:

SUCCESS: The scheduled task "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser" has been terminated successfully.
SUCCESS: The parameters of scheduled task "\Microsoft\Windows\Application Experience\Microsoft Compatibility Appraiser" have been changed.

Mode                LastWriteTime     Length Name                              
----                -------------     ------ ----                              
d----        11.05.2015     18:08            chocInstall                       
Downloading https://chocolatey.org/api/v2/package/chocolatey/ to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip
Download 7Zip commandline tool
Downloading https://chocolatey.org/7za.exe to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\7za.exe
Extracting C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip to C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall...

7-Zip (A) 9.20  Copyright (c) 1999-2010 Igor Pavlov  2010-11-18

Processing archive: C:\Users\vagrant\AppData\Local\Temp\chocolatey\chocInstall\chocolatey.zip

Extracting  _rels\.rels
Extracting  chocolatey.nuspec
Extracting  tools\chocolateyInstall.ps1
Extracting  tools\chocolateysetup.psm1
Extracting  tools\init.ps1
Extracting  tools\chocolateyInstall\choco.exe
Extracting  tools\chocolateyInstall\choco.exe.ignore
Extracting  package\services\metadata\core-properties\6f83fe2bc9c548a5aacad7eedeabf704.psmdcp
Extracting  [Content_Types].xml

Everything is Ok

Files: 9
Size:       3721579
Compressed: 1255230
Installing chocolatey on this machine
Chocolatey v0.9.9.5
Chocolatey is unpacking required files for use. Overwriting? True
Creating ChocolateyInstall as an environment variable (targeting 'Machine') 
  Setting ChocolateyInstall to 'C:\ProgramData\chocolatey'
WARNING: It's very likely you will need to close and reopen your shell 
  before you can use choco.
Adding Modify permission for current user to 'C:\ProgramData\chocolatey'
We are setting up the Chocolatey package repository.
The packages themselves go to 'C:\ProgramData\chocolatey\lib'
  (i.e. C:\ProgramData\chocolatey\lib\yourPackageName).
A shim file for the command line goes to 'C:\ProgramData\chocolatey\bin'
  and points to an executable in 'C:\ProgramData\chocolatey\lib\yourPackageName
'.

Creating Chocolatey folders if they do not already exist.

WARNING: You can safely ignore errors related to missing log files when 
  upgrading from a version of Chocolatey less than 0.9.9. 
  'Batch file could not be found' is also safe to ignore. 
  'The system cannot find the file specified' - also safe.
Chocolatey v0.9.9.5
Chocolatey is unpacking required files for use. Overwriting? True
Ensuring 'C:\ProgramData\chocolatey\lib\chocolatey' exists.
PATH environment variable does not have C:\ProgramData\chocolatey\bin in it. Adding...
Chocolatey (choco.exe) is now ready.
You can call choco from anywhere, command line or powershell by typing choco.
Run choco /? for a list of functions.
You may need to shut down and restart powershell and/or consoles
 first prior to using choco.
Ensuring chocolatey commands are on the path
Chocolatey v0.9.9.5
Chocolatey is running on Windows v 6.1.7601.65536
Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y dotnet3.5
Received arguments: install -dv -y dotnet3.5

NOTE: Hiding sensitive configuration data! Please double and triple 
 check to be sure no sensitive data is shown, especially if copying 
 output to a gist for review.
Configuration: CommandName='install'|
CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='2700'|
Sources='https://chocolatey.org/api/v2/'|Debug='True'|Verbose='True'|
Force='False'|Noop='False'|HelpRequested='False'|RegularOutput='True'|
PromptForConfirmation='False'|AcceptLicense='True'|
AllowUnofficialBuild='False'|Input='dotnet3.5'|AllVersions='False'|
SkipPackageInstallProvider='False'|PackageNames='dotnet3.5'|
Prerelease='False'|ForceX86='False'|OverrideArguments='False'|
NotSilent='False'|IgnoreDependencies='False'|
AllowMultipleVersions='False'|ForceDependencies='False'|
Information.PlatformType='Windows'|
Information.PlatformVersion='6.1.7601.65536'|
Information.PlatformName='Windows 7'|
Information.ChocolateyVersion='0.9.9.5'|
Information.ChocolateyProductVersion='0.9.9.5'|
Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64Bit='True'|Information.IsInteractive='False'|
Information.IsUserAdministrator='True'|
Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
ListCommand.IncludeRegistryPrograms='False'|
UpgradeCommand.FailOnUnfound='False'|
NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
PinCommand.Command='unknown'|
_ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
Installing the following packages:
dotnet3.5
By installing you accept licenses for the packages.
Installing 'DotNet3.5 3.5.20140403'.
Added file 'dotnet.png' to folder 'DotNet3.5'.
Added file 'ChocolateyInstall.ps1' to folder 'DotNet3.5\Tools'.
Added file 'DotNet3.5.nupkg' to folder 'DotNet3.5'.
Successfully installed 'DotNet3.5 3.5.20140403'.

DotNet3.5 v3.5.20140403
Contents of 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1':
if(-not (test-path "hklm:\SOFTWARE\Microsoft\NET Framework Setup\NDP\v3.5")) {
    cinst NetFx3 -source windowsfeatures
}
else {
     Write-Host "Microsoft .Net 3.5 Framework is already installed on your machine."
 } 

Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
 DEBUG: Posh version is 2.0
 VERBOSE: Exporting function 'Get-BinRoot'.
 VERBOSE: Exporting function 'Get-ChecksumValid'.
 VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
 VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
 VERBOSE: Exporting function 'Get-EnvironmentVariable'.
 VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
 VERBOSE: Exporting function 'Get-FtpFile'.
 VERBOSE: Exporting function 'Get-ProcessorBits'.
 VERBOSE: Exporting function 'Get-UACEnabled'.
 VERBOSE: Exporting function 'Get-VirusCheckValid'.
 VERBOSE: Exporting function 'Get-WebFile'.
 VERBOSE: Exporting function 'Get-WebHeaders'.
 VERBOSE: Exporting function 'Install-BinFile'.
 VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
 VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
 VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
 VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
 VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
 VERBOSE: Exporting function 'Install-ChocolateyPackage'.
 VERBOSE: Exporting function 'Install-ChocolateyPath'.
 VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
 VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
 VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
 VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
 VERBOSE: Exporting function 'Install-Vsix'.
 VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
 VERBOSE: Exporting function 'Set-EnvironmentVariable'.
 VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
 VERBOSE: Exporting function 'Test-ProcessAdminRights'.
 VERBOSE: Exporting function 'Uninstall-BinFile'.
 VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
 VERBOSE: Exporting function 'UnInstall-ChocolateyZipPackage'.
 VERBOSE: Exporting function 'Update-SessionEnvironment'.
 VERBOSE: Exporting function 'Write-ChocolateyFailure'.
 VERBOSE: Exporting function 'Write-ChocolateySuccess'.
 VERBOSE: Exporting function 'Write-FileUpdateLog'.
 VERBOSE: Exporting alias 'Generate-BinFile'.
 VERBOSE: Exporting alias 'Add-BinFile'.
 VERBOSE: Exporting alias 'Remove-BinFile'.
 Microsoft .Net 3.5 Framework is already installed on your machine.
Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'
Attempting to create directory "C:\ProgramData\chocolatey\extensions".
Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey".
Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403".
Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.sxs".
Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\DotNet3.5.3.5.20140403\.pin".
 The install of dotnet3.5 was successful.

Chocolatey installed 1/1 package(s). 0 package(s) failed.
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
Exiting with 0
Chocolatey v0.9.9.5
Chocolatey is running on Windows v 6.1.7601.65536
Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
Command line: "C:\ProgramData\chocolatey\choco.exe" install -dv -y vmwarevsphereclient -version 6.0.0 -source c:\vagrant\chocolatey
Received arguments: install -dv -y vmwarevsphereclient -version 6.0.0 -source c:\vagrant\chocolatey

NOTE: Hiding sensitive configuration data! Please double and triple 
 check to be sure no sensitive data is shown, especially if copying 
 output to a gist for review.
Configuration: CommandName='install'|
CacheLocation='C:\Users\vagrant\AppData\Local\Temp'|
ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='2700'|Sources='c:\vagrant\chocolatey'|
Debug='True'|Verbose='True'|Force='False'|Noop='False'|
HelpRequested='False'|RegularOutput='True'|
PromptForConfirmation='False'|AcceptLicense='True'|
AllowUnofficialBuild='False'|Input='vmwarevsphereclient'|
Version='6.0.0'|AllVersions='False'|SkipPackageInstallProvider='False'|
PackageNames='vmwarevsphereclient'|Prerelease='False'|ForceX86='False'|
OverrideArguments='False'|NotSilent='False'|IgnoreDependencies='False'|
AllowMultipleVersions='False'|ForceDependencies='False'|
Information.PlatformType='Windows'|
Information.PlatformVersion='6.1.7601.65536'|
Information.PlatformName='Windows 7'|
Information.ChocolateyVersion='0.9.9.5'|
Information.ChocolateyProductVersion='0.9.9.5'|
Information.FullName='choco, Version=0.9.9.5, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64Bit='True'|Information.IsInteractive='False'|
Information.IsUserAdministrator='True'|
Information.IsProcessElevated='True'|Features.AutoUninstaller='False'|
Features.CheckSumFiles='True'|ListCommand.LocalOnly='False'|
ListCommand.IncludeRegistryPrograms='False'|
UpgradeCommand.FailOnUnfound='False'|
NewCommand.AutomaticPackage='False'|SourceCommand.Command='unknown'|
FeatureCommand.Command='unknown'|PushCommand.TimeoutInSeconds='0'|
PinCommand.Command='unknown'|
_ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
Installing the following packages:
vmwarevsphereclient
By installing you accept licenses for the packages.
Attempting to resolve dependency 'dotnet3.5'.
Installing 'vmwarevsphereclient 6.0.0'.
Added file 'chocolateyInstall.ps1' to folder 'vmwarevsphereclient\tools'.
Added file 'vmwarevsphereclient.png' to folder 'vmwarevsphereclient'.
Added file 'vmwarevsphereclient.nupkg' to folder 'vmwarevsphereclient'.
Successfully installed 'vmwarevsphereclient 6.0.0'.

vmwarevsphereclient v6.0.0
Contents of 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1':
$packageName = 'vmwarevsphereclient' 
$installerType = 'exe'
$url = 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe'
$url64 = $url
$silentArgs = '/s /w /v" /qb"'
$validExitCodes = @(0)

Install-ChocolateyPackage "$packageName" "$installerType" "$silentArgs" "$url" "$url64"  -validExitCodes $validExitCodes

Calling command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"']
 DEBUG: Posh version is 2.0
 DEBUG: Loading community extensions
 VERBOSE: Exporting function 'Get-BinRoot'.
 VERBOSE: Exporting function 'Get-ChecksumValid'.
 VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
 VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
 VERBOSE: Exporting function 'Get-EnvironmentVariable'.
 VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
 VERBOSE: Exporting function 'Get-FtpFile'.
 VERBOSE: Exporting function 'Get-ProcessorBits'.
 VERBOSE: Exporting function 'Get-UACEnabled'.
 VERBOSE: Exporting function 'Get-VirusCheckValid'.
 VERBOSE: Exporting function 'Get-WebFile'.
 VERBOSE: Exporting function 'Get-WebHeaders'.
 VERBOSE: Exporting function 'Install-BinFile'.
 VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
 VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
 VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
 VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
 VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
 VERBOSE: Exporting function 'Install-ChocolateyPackage'.
 VERBOSE: Exporting function 'Install-ChocolateyPath'.
 VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
 VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
 VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
 VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
 VERBOSE: Exporting function 'Install-Vsix'.
 VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
 VERBOSE: Exporting function 'Set-EnvironmentVariable'.
 VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
 VERBOSE: Exporting function 'Test-ProcessAdminRights'.
 VERBOSE: Exporting function 'Uninstall-BinFile'.
 VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
 VERBOSE: Exporting function 'UnInstall-ChocolateyZipPackage'.
 VERBOSE: Exporting function 'Update-SessionEnvironment'.
 VERBOSE: Exporting function 'Write-ChocolateyFailure'.
 VERBOSE: Exporting function 'Write-ChocolateySuccess'.
 VERBOSE: Exporting function 'Write-FileUpdateLog'.
 VERBOSE: Exporting alias 'Generate-BinFile'.
 VERBOSE: Exporting alias 'Add-BinFile'.
 VERBOSE: Exporting alias 'Remove-BinFile'.
 DEBUG: Running 'Install-ChocolateyPackage' for vmwarevsphereclient with 
 url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
 e', args: '/s /w /v" /qb"', fileType: 'exe', url64bit: 
 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe', 
 checksum: '', checksumType: '', checksum64: '', checksumType64: '', 
 validExitCodes: '0' 
 DEBUG: Running 'Get-ChocolateyWebFile' for vmwarevsphereclient with 
 url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
 e', 
 fileFullPath:'C:\Users\vagrant\AppData\Local\Temp\chocolatey\vmwarevsphereclien
 t\vmwarevsphereclientInstall.exe', 
 url64bit:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0
 .0.exe', checksum: '', checksumType: '', checksum64: '', checksumType64: ''
 DEBUG: Running 'Get-ProcessorBits'
 DEBUG: CPU is 64 bit
 DEBUG: Setting url to 
 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe' 
 and bitPackage to 64
 DEBUG: Running 'Get-WebHeaders' with 
 url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
 e', userAgent: 'chocolatey command line'
 DEBUG: Setting the UserAgent to 'chocolatey command line'
 DEBUG: Request Headers:
 DEBUG:   'Accept':'*/*'
 DEBUG:   'User-Agent':'chocolatey command line'
 DEBUG: Response Headers:
 DEBUG:   'Content-MD5':'9s3JFIrXYxXvJd0GYKjijg=='
 DEBUG:   'Connection':'keep-alive'
 DEBUG:   'Accept-Ranges':'bytes'
 DEBUG:   'Content-Length':'372694720'
 DEBUG:   'Content-Type':'application/octet-stream'
 DEBUG:   'Date':'Mon, 11 May 2015 16:09:05 GMT'
 DEBUG:   'ETag':'"f6cdc9148ad76315ef25dd0660a8e28e:1411497586"'
 DEBUG:   'Last-Modified':'Thu, 18 Sep 2014 23:25:59 GMT'
 DEBUG:   'Server':'Apache'
 Downloading vmwarevsphereclient 64 bit
   from 'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.exe'
 DEBUG: Running 'Get-WebFile' for 
 C:\Users\vagrant\AppData\Local\Temp\chocolatey\vmwarevsphereclient\vmwarevspher
 eclientInstall.exe with 
 url:'http://vsphereclient.vmware.com/vsphereclient/VMware-viclient-all-6.0.0.ex
 e', userAgent: 'chocolatey command line' 
 DEBUG: Setting the UserAgent to 'chocolatey command line'
Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\vmwarevsphereclient\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'
Attempting to create directory "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0".
Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0\.sxs".
Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\vmwarevsphereclient.6.0.0\.pin".
 The install of vmwarevsphereclient was successful.

Chocolatey installed 1/1 package(s). 0 package(s) failed.
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
Exiting with 0

Stderr from the command:

Process is terminated due to StackOverflowException.

Process is terminated due to StackOverflowException.

Process is terminated due to StackOverflowException.

Process is terminated due to StackOverflowException.

I can see four error logs in the Event Viewer

bildschirmfoto 2015-05-11 um 18 23 48

.NET Runtime version : 2.0.50727.5485 - Application Error
.NET Runtime version : 2.0.50727.5485 - Application Error
.NET Runtime version : 2.0.50727.5485 - Application Error
.NET Runtime version : 2.0.50727.5485 - No debugger found.No registered JIT debugger was specified. 

Click on Retry to have the process wait while attaching a debugger manually.
Click on Cancel to abort the JIT debug request.

Is there more I can investigate?

StefanScherer commented 9 years ago

Strange. Spinning up the same provisioning script with a VirtualBox VM ( vagrant up win7 --provider virtualbox ) does not show these errors. My basebox for VirtualBox is older (from December 2014), so I will create a more up-to-date basebox to have similar baseboxes for VMware Fusion and VirtualBox.

My test environment:

ferventcoder commented 9 years ago

These look like powershell issues.

==> win7:  Microsoft .Net 3.5 Framework is already installed on your machine.
==> win7: Process is terminated due to StackOverflowException.
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[System.Threading.Thread]::CurrentThread.CurrentCulture = '';[System.Threading.Thread]::CurrentThread.CurrentUICulture = ''; & import-module -name 'C:\ProgramData\chocolatey\helpers\chocolateyInstaller.psm1'; & 'C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1' -packageScript 'C:\ProgramData\chocolatey\lib\DotNet3.5\Tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''"'] exited with '-2147023895'

It might be helpful to see the color output here. Or the underlying choco log.

ferventcoder commented 9 years ago

275 was a similar powershell issue, but related to virtualbox and shared folders.

ferventcoder commented 9 years ago

Try running a powershell command outside of choco against the box.

ferventcoder commented 9 years ago
==> win7:  Microsoft .Net 3.5 Framework is already installed on your machine.
==> win7: Process is terminated due to StackOverflowException.
==> win7: Command ['"C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe" -NoProfile -NoLogo -ExecutionPolicy Bypass -Command "[...]"] exited with '-2147023895'

Note that PowerShell is exiting with -2147023895 (which is 0x800703e9 or ERROR_STACK_OVERFLOW - MSDN 1001 (0x3E9)).

StefanScherer commented 9 years ago

Speeding up my test loop with

vagrant up win7 --provider vmware_fusion --no-provision
vagrant snap take win7

and then

vagrant provision win7
vagrant snap rollback win7

Much faster :smile:

The StackOverflowException is not always at dotnet3.5 installation, but then in one or more of the next choco install commands.

Then I tried the clean snapshot and opened a PowerShell window on the Windows desktop and then entered c:\vagrant\scripts\provision.ps1 to run the script in an interactive shell. This worked fine without any problem.

So it might have to do with the remote WinRM provisioning of Vagrant that gives choco.exe a different environment/stack size/allowed window handles/...

ferventcoder commented 9 years ago

@StefanScherer I see this is with

I think the event viewer errors are leading towards a debugger wanting to attach to the Powershell process.

ferventcoder commented 9 years ago

Good point, what are your winrm settings?

ferventcoder commented 9 years ago

It's possible something about the powershell run is swallowing up memory and eventually causes an error. Or that powershell is trying to run powershell is trying to run powershell... and stackoverflow. No idea if or why that is happening yet.

StefanScherer commented 9 years ago

@ferventcoder The winrm settings are here in the basebox Autounattend.xml: https://github.com/StefanScherer/packer-windows/blob/my/answer_files/7/Autounattend.xml#L123-L197

I'll spin up the VM with 2GB RAM and see what it is doing then.

StefanScherer commented 9 years ago

Still a StackOverflowException with 2GB RAM, eating up memory doesn't seem to be the issue as Task Manager shows this: bildschirmfoto 2015-05-11 um 19 51 40

ferventcoder commented 9 years ago

https://github.com/StefanScherer/packer-windows/blob/my/answer_files/7/Autounattend.xml#L141-L142 - so 300MB max memory per shell. I wonder how much of that is used up by vagrant, scheduled tasks, etc and what is left for choco and powershell to use.

StefanScherer commented 9 years ago

OK. I'll increase this

Microsoft Windows [Version 6.1.7601]
Copyright (c) 2009 Microsoft Corporation.  All rights reserved.

C:\Users\vagrant>cmd.exe /c winrm set winrm/config/winrs @{MaxMemoryPerShellMB="
600"}
Winrs
    AllowRemoteShellAccess = true
    IdleTimeout = 180000
    MaxConcurrentUsers = 5
    MaxShellRunTime = 2147483647
    MaxProcessesPerShell = 15
    MaxMemoryPerShellMB = 600
    MaxShellsPerUser = 5

C:\Users\vagrant>net stop winrm
The Windows Remote Management (WS-Management) service is stopping.
The Windows Remote Management (WS-Management) service was stopped successfully.

C:\Users\vagrant>net start winrm
The Windows Remote Management (WS-Management) service is starting.
The Windows Remote Management (WS-Management) service was started successfully.

and then from my host machine:

vagrant provision win7

bildschirmfoto 2015-05-11 um 20 00 53

Now it works! OK. Thank you very much! I think I have to create a PR in joefitzgerald/packer-windows repo :smile:

Is there a more reasonable value for MaxMemoryPerShellMB?

StefanScherer commented 9 years ago

The boxcutter/windows repo has 800MB: https://github.com/boxcutter/windows/blob/master/floppy/install-winrm.cmd#L55

I'll increase it to this value and recreate my baseboxes and create a PR.

Thanks @ferventcoder. Can't wait to get my T-Shirt :shirt: :smile:

ferventcoder commented 9 years ago

:+1: