Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Chocolatey timed out immediately when execution timeout was infinite (0) #1224

Closed
basictheprogram opened this issue Mar 30, 2017 · 7 comments
Assignees
Milestone

Comments

@basictheprogram
Copy link

basictheprogram commented Mar 30, 2017

What You Are Seeing?

VirtualCloneDrive v5.5.0.20160317 [Approved]
virtualclonedrive package files install completed. Performing other installation steps.
Chocolatey timed out waiting for the command to finish. The timeout
specified (or the default value) was '0' seconds. Perhaps try a
higher --execution-timeout? See choco -h for details.
The install of virtualclonedrive was NOT successful.

Does this for any package I try to install.

What is Expected?

VirtualCloneDrive (or the named package) would be installed

How Did You Get This To Happen? (Steps to Reproduce)

PS C:\ProgramData\chocolatey\bin> choco.exe install virtualclonedrive

Workaround

Admin note: Adjust the value in the config file directly for now.

Output Log

2017-03-30 16:07:27,464 [DEBUG] - Configured chocolatey.infrastructure.logging.log4net.config.xml from assembly choco, Version=0.10.4.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb
2017-03-30 16:07:27,464 [DEBUG] - Configured chocolatey.infrastructure.logging.log4net.config.xml from assembly choco, Version=0.10.4.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb
2017-03-30 16:07:27,542 [DEBUG] - XmlConfiguration is now operational
2017-03-30 16:07:28,105 [INFO ] - ============================================================
2017-03-30 16:07:28,105 [INFO ] - Chocolatey v0.10.4
2017-03-30 16:07:28,136 [DEBUG] - Chocolatey is running on Windows v 6.2.9200.0
2017-03-30 16:07:28,151 [DEBUG] - Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
2017-03-30 16:07:28,151 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
2017-03-30 16:07:28,183 [DEBUG] - Command line: "C:\ProgramData\chocolatey\choco.exe" install virtualclonedrive --debug --verbose
2017-03-30 16:07:28,183 [DEBUG] - Received arguments: install virtualclonedrive --debug --verbose
2017-03-30 16:07:28,323 [DEBUG] - RemovePendingPackagesTask is now ready and waiting for PreRunMessage.
2017-03-30 16:07:28,355 [DEBUG] - Sending message 'PreRunMessage' out if there are subscribers...
2017-03-30 16:07:28,370 [DEBUG] - [Pending] Removing all pending packages that should not be considered installed...
2017-03-30 16:07:28,526 [DEBUG] - The source 'https://chocolatey.org/api/v2/' evaluated to a 'normal' source type
2017-03-30 16:07:28,542 [DEBUG] - 
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.
2017-03-30 16:07:28,573 [DEBUG] - Configuration: CommandName='install'|
CacheLocation='C:\Users\Administrator\AppData\Local\Temp\2\chocolatey'|

ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='0'|
WebRequestTimeoutSeconds='30'|Sources='https://chocolatey.org/api/v2/'|
SourceType='normal'|Debug='True'|Verbose='True'|Trace='False'|
Force='False'|Noop='False'|HelpRequested='False'|
UnsuccessfulParsing='False'|RegularOutput='True'|QuietOutput='False'|
PromptForConfirmation='False'|AcceptLicense='False'|
AllowUnofficialBuild='False'|Input='virtualclonedrive'|
AllVersions='False'|SkipPackageInstallProvider='False'|
PackageNames='virtualclonedrive'|Prerelease='False'|ForceX86='False'|
OverrideArguments='False'|NotSilent='False'|
ApplyPackageParametersToDependencies='False'|
ApplyInstallArgumentsToDependencies='False'|IgnoreDependencies='False'|
AllowMultipleVersions='False'|AllowDowngrade='False'|
ForceDependencies='False'|Information.PlatformType='Windows'|
Information.PlatformVersion='6.2.9200.0'|
Information.PlatformName='Windows Server 2012'|
Information.ChocolateyVersion='0.10.4.0'|
Information.ChocolateyProductVersion='0.10.4'|
Information.FullName='choco, Version=0.10.4.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64BitOperatingSystem='True'|
Information.Is64BitProcess='True'|Information.IsInteractive='True'|
Information.IsUserAdministrator='True'|
Information.IsProcessElevated='True'|
Information.IsLicensedVersion='False'|Information.LicenseType='Foss'|
Features.AutoUninstaller='True'|Features.ChecksumFiles='True'|
Features.AllowEmptyChecksums='False'|
Features.AllowEmptyChecksumsSecure='True'|
Features.FailOnAutoUninstaller='False'|
Features.FailOnStandardError='False'|Features.UsePowerShellHost='True'|
Features.LogEnvironmentValues='False'|Features.VirusCheck='False'|
Features.FailOnInvalidOrMissingLicense='False'|
Features.IgnoreInvalidOptionsSwitches='True'|
Features.UsePackageExitCodes='True'|
Features.UseFipsCompliantChecksums='False'|
Features.ShowNonElevatedWarnings='True'|
Features.ShowDownloadProgress='True'|
Features.StopOnFirstPackageFailure='False'|
Features.UseRememberedArgumentsForUpgrades='False'|
Features.ScriptsCheckLastExitCode='False'|
ListCommand.LocalOnly='False'|
ListCommand.IncludeRegistryPrograms='False'|ListCommand.PageSize='25'|
ListCommand.Exact='False'|ListCommand.ByIdOnly='False'|
ListCommand.IdStartsWith='False'|ListCommand.OrderByPopularity='False'|
ListCommand.ApprovedOnly='False'|
ListCommand.DownloadCacheAvailable='False'|
ListCommand.NotBroken='False'|
ListCommand.IncludeVersionOverrides='False'|
UpgradeCommand.FailOnUnfound='False'|
UpgradeCommand.FailOnNotInstalled='False'|
UpgradeCommand.NotifyOnlyAvailableUpgrades='False'|
UpgradeCommand.ExcludePrerelease='False'|
NewCommand.AutomaticPackage='False'|
NewCommand.UseOriginalTemplate='False'|SourceCommand.Command='unknown'|
SourceCommand.Priority='0'|SourceCommand.BypassProxy='False'|
SourceCommand.AllowSelfService='False'|
FeatureCommand.Command='unknown'|
ConfigCommand.Command='unknown'|PinCommand.Command='unknown'|
Proxy.BypassOnLocal='True'|
2017-03-30 16:07:28,620 [DEBUG] - _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
2017-03-30 16:07:28,636 [INFO ] - Installing the following packages:
2017-03-30 16:07:28,636 [INFO ] - virtualclonedrive
2017-03-30 16:07:28,636 [INFO ] - By installing you accept licenses for the packages.
2017-03-30 16:07:31,323 [INFO ] - [NuGet] Installing 'VirtualCloneDrive 5.5.0.20160317'.
2017-03-30 16:07:31,354 [DEBUG] - [NuGet] Added file 'addCertificate.ps1' to folder 'VirtualCloneDrive\tools'.
2017-03-30 16:07:31,354 [DEBUG] - [NuGet] Added file 'chocolateyInstall.ps1' to folder 'VirtualCloneDrive\tools'.
2017-03-30 16:07:31,354 [DEBUG] - [NuGet] Added file 'ElaborateBytesAG.cer' to folder 'VirtualCloneDrive\tools'.
2017-03-30 16:07:31,354 [DEBUG] - [NuGet] Added file 'ElaborateBytesAG_Expires2015.p7b' to folder 'VirtualCloneDrive\tools'.
2017-03-30 16:07:31,542 [DEBUG] - [NuGet] Added file 'VirtualCloneDrive.nuspec' to folder 'VirtualCloneDrive'.
2017-03-30 16:07:31,542 [DEBUG] - [NuGet] Added file 'VirtualCloneDrive.nupkg' to folder 'VirtualCloneDrive'.
2017-03-30 16:07:31,542 [INFO ] - [NuGet] Successfully installed 'VirtualCloneDrive 5.5.0.20160317'.
2017-03-30 16:07:31,558 [INFO ] - 
VirtualCloneDrive v5.5.0.20160317 [Approved]
2017-03-30 16:07:31,604 [INFO ] - virtualclonedrive package files install completed. Performing other installation steps.
2017-03-30 16:07:31,839 [DEBUG] - Setting installer args for VirtualCloneDrive
2017-03-30 16:07:31,854 [DEBUG] - Setting package parameters for VirtualCloneDrive
2017-03-30 16:07:31,854 [DEBUG] - Contents of 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1':
2017-03-30 16:07:31,870 [DEBUG] - $packageId = 'VirtualCloneDrive'
$fileType = 'exe'
$fileArgs = '/S /noreboot'
$url = 'https://www.elby.ch/download/SetupVCD.exe'

$addCertificate = "$(Split-Path -parent $MyInvocation.MyCommand.Definition)\addCertificate.ps1"
Start-ChocolateyProcessAsAdmin "& `'$addCertificate`'"
Install-ChocolateyPackage $packageId $fileType $fileArgs $url

2017-03-30 16:07:31,886 [WARN ] - Chocolatey timed out waiting for the command to finish. The timeout 
 specified (or the default value) was '0' seconds. Perhaps try a 
 higher `--execution-timeout`? See `choco -h` for details.
2017-03-30 16:07:31,917 [DEBUG] - Calling command ['"C:\Windows\System32\shutdown.exe" /a']
2017-03-30 16:07:31,933 [DEBUG] - Calling built-in PowerShell host with ['[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\VirtualCloneDrive\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''']
2017-03-30 16:07:31,979 [DEBUG] - Command ['"C:\Windows\System32\shutdown.exe" /a'] exited with '1116'
2017-03-30 16:07:32,386 [DEBUG] - Capturing package files in 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive'
2017-03-30 16:07:32,386 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\VirtualCloneDrive.nupkg'
  with checksum '7565DC2381ACBECC1CE9FA27B62734D8'
2017-03-30 16:07:32,386 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\VirtualCloneDrive.nuspec'
  with checksum '8889F893F07B0476358EA5C2C1509DB5'
2017-03-30 16:07:32,401 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\addCertificate.ps1'
  with checksum '9FE329B7F11F1EFDBA31182800022AF2'
2017-03-30 16:07:32,401 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1'
  with checksum 'F8E9D46DFD1A18753DE17B583FC53649'
2017-03-30 16:07:32,401 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\ElaborateBytesAG.cer'
  with checksum 'F347B09F2CA2CBC552B2AD7D076E5872'
2017-03-30 16:07:32,401 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\ElaborateBytesAG_Expires2015.p7b'
  with checksum 'B3427BDA9E750BBAF0FF2ECB39F1DA19'
2017-03-30 16:07:32,464 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\VirtualCloneDrive.5.5.0.20160317\.arguments".
2017-03-30 16:07:32,464 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\VirtualCloneDrive.5.5.0.20160317\.version".
2017-03-30 16:07:32,464 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\VirtualCloneDrive.5.5.0.20160317\.sxs".
2017-03-30 16:07:32,464 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\VirtualCloneDrive.5.5.0.20160317\.pin".
2017-03-30 16:07:32,495 [DEBUG] - Attempting to delete directory "C:\ProgramData\chocolatey\lib-bad\VirtualCloneDrive".
2017-03-30 16:07:32,511 [DEBUG] - Sending message 'HandlePackageResultCompletedMessage' out if there are subscribers...
2017-03-30 16:07:32,526 [ERROR] - The install of virtualclonedrive was NOT successful.
2017-03-30 16:07:32,526 [ERROR] - Error while running 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1'.
 See log for details.
2017-03-30 16:07:32,558 [DEBUG] - Moving 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive'
 to 'C:\ProgramData\chocolatey\lib-bad\VirtualCloneDrive'
2017-03-30 16:07:32,651 [DEBUG] - Host version is 4.0, PowerShell Version is '4.0' and CLR Version is '4.0.30319.36366'.
2017-03-30 16:07:33,354 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2017-03-30 16:07:33,370 [INFO ] - VERBOSE: Exporting function 'Get-BinRoot'.
2017-03-30 16:07:33,370 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2017-03-30 16:07:33,370 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2017-03-30 16:07:33,370 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2017-03-30 16:07:33,370 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-ProcessorBits'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2017-03-30 16:07:33,386 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2017-03-30 16:07:33,401 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 16:07:33,401 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2017-03-30 16:07:33,401 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2017-03-30 16:07:33,401 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2017-03-30 16:07:33,401 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2017-03-30 16:07:33,417 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2017-03-30 16:07:33,432 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2017-03-30 16:07:33,432 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2017-03-30 16:07:33,432 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 16:07:33,432 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2017-03-30 16:07:33,432 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2017-03-30 16:07:33,448 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2017-03-30 16:07:33,448 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2017-03-30 16:07:33,448 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2017-03-30 16:07:33,448 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2017-03-30 16:07:33,448 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2017-03-30 16:07:33,464 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 16:07:33,464 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2017-03-30 16:07:33,464 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2017-03-30 16:07:33,464 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:33,464 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2017-03-30 16:07:33,479 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 16:07:33,479 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2017-03-30 16:07:33,479 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2017-03-30 16:07:33,479 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2017-03-30 16:07:33,479 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2017-03-30 16:07:33,495 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2017-03-30 16:07:33,511 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2017-03-30 16:07:33,511 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2017-03-30 16:07:33,511 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2017-03-30 16:07:33,511 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2017-03-30 16:07:33,526 [DEBUG] - Loading community extensions
2017-03-30 16:07:33,558 [DEBUG] - Importing 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'
2017-03-30 16:07:33,558 [INFO ] - VERBOSE: Loading module from path 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'.
2017-03-30 16:07:33,854 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2017-03-30 16:07:33,870 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2017-03-30 16:07:33,870 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2017-03-30 16:07:33,870 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2017-03-30 16:07:33,870 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 16:07:33,870 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2017-03-30 16:07:33,886 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2017-03-30 16:07:33,886 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2017-03-30 16:07:33,886 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2017-03-30 16:07:33,886 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2017-03-30 16:07:33,886 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2017-03-30 16:07:33,901 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2017-03-30 16:07:33,901 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2017-03-30 16:07:33,901 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2017-03-30 16:07:33,901 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2017-03-30 16:07:33,917 [INFO ] - VERBOSE: Exporting function 'Get-BinRoot'.
2017-03-30 16:07:33,917 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2017-03-30 16:07:33,917 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2017-03-30 16:07:33,917 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2017-03-30 16:07:33,917 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-ProcessorBits'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2017-03-30 16:07:33,932 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2017-03-30 16:07:33,948 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2017-03-30 16:07:33,964 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2017-03-30 16:07:33,964 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:33,964 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 16:07:33,964 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2017-03-30 16:07:33,964 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2017-03-30 16:07:33,979 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2017-03-30 16:07:33,995 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2017-03-30 16:07:33,995 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2017-03-30 16:07:33,995 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2017-03-30 16:07:33,995 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2017-03-30 16:07:33,995 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 16:07:34,011 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2017-03-30 16:07:34,026 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2017-03-30 16:07:34,042 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2017-03-30 16:07:34,042 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2017-03-30 16:07:34,042 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2017-03-30 16:07:34,042 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2017-03-30 16:07:34,042 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2017-03-30 16:07:34,057 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2017-03-30 16:07:34,057 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2017-03-30 16:07:34,057 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2017-03-30 16:07:34,073 [INFO ] - VERBOSE: Importing function 'Format-FileSize'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-BinRoot'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-ChecksumValid'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyUnzip'.
2017-03-30 16:07:34,089 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyWebFile'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariable'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariableNames'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-FtpFile'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-OSArchitectureWidth'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2017-03-30 16:07:34,104 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2017-03-30 16:07:34,120 [INFO ] - VERBOSE: Importing function 'Get-ProcessorBits'.
2017-03-30 16:07:34,120 [INFO ] - VERBOSE: Importing function 'Get-ToolsLocation'.
2017-03-30 16:07:34,120 [INFO ] - VERBOSE: Importing function 'Get-UACEnabled'.
2017-03-30 16:07:34,120 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2017-03-30 16:07:34,120 [INFO ] - VERBOSE: Importing function 'Get-VirusCheckValid'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Get-WebFile'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Get-WebFileName'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Get-WebHeaders'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Install-BinFile'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyDesktopLink'.
2017-03-30 16:07:34,136 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:34,151 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 16:07:34,151 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyFileAssociation'.
2017-03-30 16:07:34,151 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyInstallPackage'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPackage'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPath'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPowershellCommand'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyShortcut'.
2017-03-30 16:07:34,167 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyVsixPackage'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyZipPackage'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Install-Vsix'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Set-EnvironmentVariable'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Set-PowerShellExitCode'.
2017-03-30 16:07:34,182 [INFO ] - VERBOSE: Importing function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Test-ProcessAdminRights'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Uninstall-BinFile'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyPackage'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 16:07:34,198 [INFO ] - VERBOSE: Importing function 'Update-SessionEnvironment'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing function 'Write-ChocolateyFailure'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing function 'Write-ChocolateySuccess'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing function 'Write-FileUpdateLog'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing function 'Write-FunctionCallLogMessage'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing alias 'Add-BinFile'.
2017-03-30 16:07:34,214 [INFO ] - VERBOSE: Importing alias 'Generate-BinFile'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'Get-InstallRegistryKey'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'Get-OSBitness'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'Get-ProcessorBits'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'Invoke-ChocolateyProcess'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'refreshenv'.
2017-03-30 16:07:34,229 [INFO ] - VERBOSE: Importing alias 'Remove-BinFile'.
2017-03-30 16:07:34,245 [INFO ] - VERBOSE: Importing alias 'Start-ChocolateyProcess'.
2017-03-30 16:07:34,370 [DEBUG] - Running 'ChocolateyScriptRunner' for VirtualCloneDrive v5.5.0.20160317 with packageScript 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1', packageFolder:'C:\ProgramData\chocolatey\lib\VirtualCloneDrive', installArguments: '', packageParameters: '',
2017-03-30 16:07:34,417 [DEBUG] - Running 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1'
2017-03-30 16:07:34,573 [DEBUG] - Attempting to delete file "C:\Users\Administrator\AppData\Local\NuGet\Cache\VirtualCloneDrive.5.5.0.20160317.nupkg".
2017-03-30 16:07:34,620 [WARN ] - 
Chocolatey installed 0/1 packages. 1 packages failed.
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
2017-03-30 16:07:34,620 [INFO ] - 
2017-03-30 16:07:34,636 [ERROR] - Failures
2017-03-30 16:07:34,636 [ERROR] -  - virtualclonedrive (exited -1) - Error while running 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1'.
 See log for details.
2017-03-30 16:07:34,636 [ERROR] - ERROR: The term 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1' is not recognized as the name of a cmdlet, function, script file, or operable program. Check the spelling of the name, or if a path was included, verify that the path is correct and try again.
 at <ScriptBlock>, C:\ProgramData\chocolatey\helpers\chocolateyScriptRunner.ps1: line 48
at <ScriptBlock>, <No file>: line 1
2017-03-30 16:07:34,651 [DEBUG] - Sending message 'PostRunMessage' out if there are subscribers...
2017-03-30 16:07:34,651 [DEBUG] - Built-in PowerShell host called with ['[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\VirtualCloneDrive\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters '''] exited with '-1'.
2017-03-30 16:07:34,698 [DEBUG] - Exiting with -1
@basictheprogram
Copy link
Author

PS C:\Users\Administrator> choco install virtualclonedrive  --execution-timeout=600
Chocolatey v0.10.4
Installing the following packages:
virtualclonedrive
By installing you accept licenses for the packages.
Progress: Downloading VirtualCloneDrive 5.5.0.20160317... 100%

VirtualCloneDrive v5.5.0.20160317 [Approved]
virtualclonedrive package files install completed. Performing other installation steps.
ERROR: The term '      try {
        & 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\addCertificate.ps1'
      } catch {
       throw
      }' is not recognized as the name of a cmdlet, function, script file, or operable program. Check the spelling of th
e name, or if a path was included, verify that the path is correct and try again.
The install of virtualclonedrive was NOT successful.
Error while running 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolateyInstall.ps1'.
 See log for details.

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

Failures
 - virtualclonedrive (exited -1) - Error while running 'C:\ProgramData\chocolatey\lib\VirtualCloneDrive\tools\chocolatey
Install.ps1'.
 See log for details.

@AdmiringWorm
Copy link
Member

Regarding the first error message, this looks like choco isn't correctly parsing the number 0 as inifite (as it should be in 0.10.4), smells like a bug to me.

Your second error message is known already though, see #1220.
To fix the second error message you'll either downgrade to v. 0.10.3, or wait for 0.10.5 to be released (should be released quite soon I think)

@ferventcoder
Copy link
Member

Found and fixed

@ferventcoder ferventcoder changed the title Chocolatey timed out waiting for the command to finish Chocolatey timed out immediately when execution timeout was infinite Mar 30, 2017
ferventcoder added a commit that referenced this issue Mar 30, 2017
When CommandExecutionTimeoutSeconds is set to 0, do not set the
WebResponseTimeout environment variable, let it be the default.  Also
if the wait time is 0, do not set a timeout on the execute task.Wait.
ferventcoder added a commit that referenced this issue Mar 30, 2017
* stable:
  (version) 0.10.5
  (doc) update CHANGELOG/nuspec
  (GH-1224) support longer timeouts
  (doc) update CHANGELOG/nuspec
  (GH-1222) choco outdated -r output - no header
  (maint) update NuGet.Core
  (GH-1220) Use old method
  (GH-1220) Fix: PowerShell blocks fail in Start-ChocolateyProcessAsAdmin
  (doc) update CHANGELOG/nuspec
@basictheprogram
Copy link
Author

PS C:\ProgramData\chocolatey\logs> choco --version
0.10.5

Still have the problem. Same problem with virtualclonedrive, below powershell errors out.

NOTE: I assume this was fixed in 0.10.5?

PS C:\ProgramData\chocolatey\logs> choco install powershell
Chocolatey v0.10.5
Installing the following packages:
powershell
By installing you accept licenses for the packages.
Progress: Downloading PowerShell 5.1.14409.20170301... 100%

PowerShell v5.1.14409.20170301 [Approved]
powershell package files install completed. Performing other installation steps.
Chocolatey timed out waiting for the command to finish. The timeout
 specified (or the default value) was '0' seconds. Perhaps try a
 higher `--execution-timeout`? See `choco -h` for details.
The install of powershell was NOT successful.
Error while running 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'.
 See log for details.
ERROR: The term 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1' is not recognized as the name of
a cmdlet, function, script file, or operable program. Check the spelling of the name, or if a path was included, verify
that the path is correct and try again.

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

Failures
 - powershell (exited -1) - Error while running 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'.
 See log for details.

Logs

2017-03-30 20:12:28,091 [DEBUG] - Configured chocolatey.infrastructure.logging.log4net.config.xml from assembly choco, Version=0.10.5.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb
2017-03-30 20:12:28,091 [DEBUG] - Configured chocolatey.infrastructure.logging.log4net.config.xml from assembly choco, Version=0.10.5.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb
2017-03-30 20:12:28,185 [DEBUG] - XmlConfiguration is now operational
2017-03-30 20:12:28,888 [INFO ] - ============================================================
2017-03-30 20:12:28,904 [INFO ] - Chocolatey v0.10.5
2017-03-30 20:12:28,920 [DEBUG] - Chocolatey is running on Windows v 6.3.9600.0
2017-03-30 20:12:28,935 [DEBUG] - Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
2017-03-30 20:12:28,935 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
2017-03-30 20:12:28,951 [DEBUG] - Command line: "C:\ProgramData\chocolatey\choco.exe" install powershell
2017-03-30 20:12:28,951 [DEBUG] - Received arguments: install powershell
2017-03-30 20:12:29,091 [DEBUG] - RemovePendingPackagesTask is now ready and waiting for PreRunMessage.
2017-03-30 20:12:29,123 [DEBUG] - Sending message 'PreRunMessage' out if there are subscribers...
2017-03-30 20:12:29,138 [DEBUG] - [Pending] Removing all pending packages that should not be considered installed...
2017-03-30 20:12:29,310 [DEBUG] - The source 'https://chocolatey.org/api/v2/' evaluated to a 'normal' source type
2017-03-30 20:12:29,326 [DEBUG] - 
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.
2017-03-30 20:12:29,357 [DEBUG] - Configuration: CommandName='install'|
CacheLocation='C:\Users\Administrator\AppData\Local\Temp\3\chocolatey'|
ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='0'|
WebRequestTimeoutSeconds='30'|Sources='https://chocolatey.org/api/v2/'|
SourceType='normal'|Debug='False'|Verbose='False'|Trace='False'|
Force='False'|Noop='False'|HelpRequested='False'|
UnsuccessfulParsing='False'|RegularOutput='True'|QuietOutput='False'|
PromptForConfirmation='False'|AcceptLicense='False'|
AllowUnofficialBuild='False'|Input='powershell'|AllVersions='False'|
SkipPackageInstallProvider='False'|PackageNames='powershell'|
Prerelease='False'|ForceX86='False'|OverrideArguments='False'|
NotSilent='False'|ApplyPackageParametersToDependencies='False'|
ApplyInstallArgumentsToDependencies='False'|IgnoreDependencies='False'|
AllowMultipleVersions='False'|AllowDowngrade='False'|
ForceDependencies='False'|Information.PlatformType='Windows'|
Information.PlatformVersion='6.3.9600.0'|
Information.PlatformName='Windows Server 2012 R2'|
Information.ChocolateyVersion='0.10.5.0'|
Information.ChocolateyProductVersion='0.10.5'|
Information.FullName='choco, Version=0.10.5.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64BitOperatingSystem='True'|
Information.Is64BitProcess='True'|Information.IsInteractive='True'|
Information.IsUserAdministrator='True'|
Information.IsProcessElevated='True'|
Information.IsLicensedVersion='False'|Information.LicenseType='Foss'|
Features.AutoUninstaller='True'|Features.ChecksumFiles='True'|
Features.AllowEmptyChecksums='False'|
Features.AllowEmptyChecksumsSecure='True'|
Features.FailOnAutoUninstaller='False'|
Features.FailOnStandardError='False'|Features.UsePowerShellHost='True'|
Features.LogEnvironmentValues='False'|Features.VirusCheck='False'|
Features.FailOnInvalidOrMissingLicense='False'|
Features.IgnoreInvalidOptionsSwitches='True'|
Features.UsePackageExitCodes='True'|
Features.UseFipsCompliantChecksums='False'|
Features.ShowNonElevatedWarnings='True'|
Features.ShowDownloadProgress='True'|
Features.StopOnFirstPackageFailure='False'|
Features.UseRememberedArgumentsForUpgrades='False'|
Features.ScriptsCheckLastExitCode='False'|
ListCommand.LocalOnly='False'|
ListCommand.IncludeRegistryPrograms='False'|ListCommand.PageSize='25'|
ListCommand.Exact='False'|ListCommand.ByIdOnly='False'|
ListCommand.IdStartsWith='False'|ListCommand.OrderByPopularity='False'|
ListCommand.ApprovedOnly='False'|
ListCommand.DownloadCacheAvailable='False'|
ListCommand.NotBroken='False'|
ListCommand.IncludeVersionOverrides='False'|
UpgradeCommand.FailOnUnfound='False'|
UpgradeCommand.FailOnNotInstalled='False'|
UpgradeCommand.NotifyOnlyAvailableUpgrades='False'|
UpgradeCommand.ExcludePrerelease='False'|
NewCommand.AutomaticPackage='False'|
NewCommand.UseOriginalTemplate='False'|SourceCommand.Command='unknown'|
SourceCommand.Priority='0'|SourceCommand.BypassProxy='False'|
SourceCommand.AllowSelfService='False'|
FeatureCommand.Command='unknown'|
ConfigCommand.Command='unknown'|PinCommand.Command='unknown'|
Proxy.BypassOnLocal='True'|
2017-03-30 20:12:29,373 [DEBUG] - _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
2017-03-30 20:12:29,388 [INFO ] - Installing the following packages:
2017-03-30 20:12:29,388 [INFO ] - powershell
2017-03-30 20:12:29,388 [INFO ] - By installing you accept licenses for the packages.
2017-03-30 20:12:31,482 [INFO ] - [NuGet] Installing 'PowerShell 5.1.14409.20170301'.
2017-03-30 20:12:31,513 [DEBUG] - [NuGet] Added file 'ChocolateyInstall.ps1' to folder 'PowerShell\tools'.
2017-03-30 20:12:31,513 [DEBUG] - [NuGet] Added file 'chocolateyUninstall.ps1' to folder 'PowerShell\tools'.
2017-03-30 20:12:31,670 [DEBUG] - [NuGet] Added file 'PowerShell.nuspec' to folder 'PowerShell'.
2017-03-30 20:12:31,670 [DEBUG] - [NuGet] Added file 'PowerShell.nupkg' to folder 'PowerShell'.
2017-03-30 20:12:31,685 [INFO ] - [NuGet] Successfully installed 'PowerShell 5.1.14409.20170301'.
2017-03-30 20:12:31,685 [INFO ] - 
PowerShell v5.1.14409.20170301 [Approved]
2017-03-30 20:12:31,732 [INFO ] - powershell package files install completed. Performing other installation steps.
2017-03-30 20:12:31,967 [DEBUG] - Setting installer args for PowerShell
2017-03-30 20:12:31,982 [DEBUG] - Setting package parameters for PowerShell
2017-03-30 20:12:31,982 [DEBUG] - Contents of 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1':
2017-03-30 20:12:32,013 [DEBUG] - <#
See http://technet.microsoft.com/en-us/library/hh847769.aspx and http://technet.microsoft.com/en-us/library/hh847837.aspx
Windows PowerShell 5.0 runs on the following versions of Windows.
	Windows 10, installed by default
	Windows Server 2012 R2, install Windows Management Framework 5.0 to run Windows PowerShell 5.0
	Windows 8.1, install Windows Management Framework 5.0 to run Windows PowerShell 5.0
	Windows 7 with Service Pack 1, install Windows Management Framework 4.0 and THEN WMF 5.0 (as of 5.0.10105)
	Windows Server 2008 R2 with Service Pack 1, install Windows Management Framework 5.0 (as of 5.0.10105)
	Previous Windows versions - 5.0 is not supported.

Windows PowerShell 4.0 runs on the following versions of Windows.
	Windows 8.1, installed by default
	Windows Server 2012 R2, installed by default
	Windows 7 with Service Pack 1, install Windows Management Framework 4.0 (http://go.microsoft.com/fwlink/?LinkId=293881) to run Windows PowerShell 4.0
	Windows Server 2008 R2 with Service Pack 1, install Windows Management Framework 4.0 (http://go.microsoft.com/fwlink/?LinkId=293881) to run Windows PowerShell 4.0

Windows PowerShell 3.0 runs on the following versions of Windows.
	Windows 8, installed by default
	Windows Server 2012, installed by default
	Windows 7 with Service Pack 1, install Windows Management Framework 3.0 to run Windows PowerShell 3.0
	Windows Server 2008 R2 with Service Pack 1, install Windows Management Framework 3.0 to run Windows PowerShell 3.0
	Windows Server 2008 with Service Pack 2, install Windows Management Framework 3.0 to run Windows PowerShell 3.0
#>

[string]$packageName="PowerShell"
[string]$installerType="msu"
[string]$ThisPackagePSHVersion = '5.1.14409.1005'
[string]$silentArgs="/quiet /norestart /log:`"$env:TEMP\PowerShell.Install.evtx`""
$toolsDir   = "$(Split-Path -parent $MyInvocation.MyCommand.Definition)"

[string]$urlWin81x86   =                 'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/Win8.1-KB3191564-x86.msu'
[string]$urlWin81x86checksum   =         'F3430A90BE556A77A30BAB3AC36DC9B92A43055D5FCC5869DA3BFDA116DBD817'
[string]$urlWin2k12R2andWin81x64 =       'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/Win8.1AndW2K12R2-KB3191564-x64.msu'
[string]$urlWin2k12R2andWin81x64checksum = 'A8D788FA31B02A999CC676FB546FC782E86C2A0ACD837976122A1891CEEE42C0'
[string]$urlWin7x86   =                  'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/Win7-KB3191566-x86.zip'
[string]$urlWin7x86checksum   =          'EB7E2C4CE2C6CB24206474A6CB8610D9F4BD3A9301F1CD8963B4FF64E529F563'
[string]$urlWin2k8R2andWin7x64 =         'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/Win7AndW2K8R2-KB3191566-x64.zip'
[string]$urlWin2k8R2andWin7x64checksum = 'F383C34AA65332662A17D95409A2DDEDADCEDA74427E35D05024CD0A6A2FA647'
[string]$urlWin2012 =                    'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/W2K12-KB3191565-x64.msu'
[string]$urlWin2012checksum =            '4A1385642C1F08E3BE7BC70F4A9D74954E239317F50D1A7F60AA444D759D4F49'
[string]$ChecksumType       =            'sha256'

[string[]] $validExitCodes = @(0, 3010) # 2359302 occurs if the package is already installed

$osversionLookup = @{
"5.1.2600" = "XP";
"5.1.3790" = "2003";
"6.0.6001" = "Vista/2008";
"6.1.7600" = "Win7/2008R2";
"6.1.7601" = "Win7 SP1/2008R2 SP1"; # SP1 or later.
"6.2.9200" = "Win8/2012";
"6.3.9600" = "Win8.1/2012R2";
"10.0.*" = "Windows 10/Server 2016"
}

function Install-PowerShell5([string]$urlx86, [string]$urlx64 = $null, [string]$checksumx86 = $null,[string]$checksumx64 = $null) {
    $Net4Version = (get-itemproperty "hklm:software\microsoft\net framework setup\ndp\v4\full" -ea silentlycontinue | Select -Expand Release -ea silentlycontinue)
    if ($Net4Version -ge 378389) {
        Install-ChocolateyPackage "$packageName" "$installerType" "$silentArgs" -url $urlx86 -url64 $urlx64 -checksum $checksumx86 -ChecksumType $ChecksumType -checksum64 $checksumx64 -ChecksumType64 $ChecksumType -validExitCodes $validExitCodes
        Write-Warning "$packageName requires a reboot to complete the installation."
    }
    else {
        throw ".NET Framework 4.5.1 or later required.  Use package named `"dotnet4.5.1`"."
    }
}

$os = Get-WmiObject Win32_OperatingSystem
$osVersion = $os.version

$ProductName = (Get-ItemProperty -Path 'HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion' -Name 'ProductName').ProductName
$EditionId = (Get-ItemProperty -Path 'HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion' -Name 'EditionID').EditionId

#This will show us if we are running on Nano Server (Kernel version alone won't show this)
Write-Output "Running on: $ProductName, ($EditionId), Windows Kernel: $osVersion"

If ((get-service wuauserv).starttype -ieq 'Disabled')
{
  Throw "Windows Update Service is disabled - PowerShell updates are distributed as windows updates and so require the service.  Consider temporarily enabling it before calling this package and disabling again afterward."
}

try
{
    if ($PSVersionTable -and ($PSVersionTable.PSVersion -ge [Version]$ThisPackagePSHVersion)) {
	    Write-Warning "PowerShell version, $($PSVersionTable.PSVersion), is already installed."
	}
    else {
        #The following should not occur as PowerShell 5 is already installed
        if( ([version]$osVersion).Major -eq "10" ) {
            $osVersion = "$(([version]$osVersion).Major).$(([version]$osVersion).Minor).*"
        }

        Write-Output "Installing for OS: $($osversionLookup[$osVersion])"

		    switch ($osversionLookup[$osVersion]) {
            "Vista/2008" {
                Write-Warning "PowerShell 3 is the highest supported on Windows $($osversionLookup[$osVersion])."
                Write-Output "You can install PowerShell 3 using these parameters: 'PowerShell -version 3.0.20121027'"
            }
            "Win7/2008R2" {
                Write-Warning "PowerShell $ThisPackagePSHVersion Requires SP1 for Windows $($osversionLookup[$osVersion])."
                Write-Warning "Update to SP1 and re-run this package to install WMF/PowerShell 5"
                Write-Output "You can install PowerShell 3 using these parameters: 'PowerShell -version 3.0.20121027'"
            }
            "Win7 SP1/2008R2 SP1" {
                #Special Procedures for WMF 5.1
                $Net4Version = (get-itemproperty "hklm:software\microsoft\net framework setup\ndp\v4\full" -ea silentlycontinue | Select -Expand Release -ea silentlycontinue)
                if ($Net4Version -lt 378758)
                {
                  throw ".NET Framework 4.5.1 or later required.  Use package named `"dotnet4.5.1`"."
                }
                Else
                {
                  If ($PSVersionTable.PSVersion.Major -eq 3)
                  {
                    Write-Warning "Found WMF 3 On Win 7 or Server 2008 R2"
                    If (!(test-path env:ChocolateyForce))
                    {
                        Throw "This package will not install WMF 5.1 over 3.0 on Windows 7 or Server 2008 R2 Unless you use the -Force switch on the package command line."
                    }
                    Else
                    {
                        Write-Host " " 
                        Write-Host "  ***********************************************************************************************"
                        Write-Host "  *  This machine is running Windows or Server 2008 R2 with WMF 3 installed and                 *"
                        Write-Host "  *  -Force was used, Experimental PSModulePath Backup and Attempted Restore Will Be Performed  *"
                        Write-Host "  *     What will be done:                                                                      *"
                        Write-Host "  *       1) The custom parts of the PSModulePath backed up to BackupPSModulePath               *"
                        Write-Host "  *       2) A fix up script that appends those values to the PSModulePath is written to:       *"
                        Write-Host "  *             %WINDIR%\Temp\psmodulepathfixup.ps1                                             *"
                        Write-Host "  *       3) A scheduled task is setup for the next reboot that runs the fix up script          *"
                        Write-Host "  *                                                                                             *"
                        Write-Host "  *   If you find that #3 does not work correctly, then you can use #1 or #2 with some of your  *"
                        Write-Host "  *   own automation to recover from the situation                                              *"
                        Write-Host "  ***********************************************************************************************"
                        Write-Host " " 
                        
                        $StandardPathsToFilterOut = @('%ProgramFiles%\WindowsPowerShell\Modules','%SystemRoot%\System32\WindowsPowerShell\v1.0\Modules','%SystemRoot%\System32\WindowsPowerShell\v1.0\Modules\')
                        [string[]]$currentpsmodulepath = (get-Item 'hklm:system\CurrentControlSet\Control\Session Manager\Environment').GetValue("PsModulePath","Default",[Microsoft.WIN32.RegistryValueOptions]::DoNotExpandEnvironmentNames).split(';')
                        $FilteredList = ($CurrentPSModulePath | Where {$StandardPathsToFilterOut -inotcontains $_}) -join ';'
                        Write-host "PSModulePath contains the following values that are not in the PSH 5 default values: $FilteredList, backing them up to BackupPSModulePath Environment Variable"
                        If ($FilteredList) {New-Itemproperty 'hklm:system\CurrentControlSet\Control\Session Manager\Environment' -name 'BackupPsModulePath' -PropertyType 'ExpandString' -value "$FilteredList" | out-null}
                        $WMF5Over3WasForced = $True
                    }
                  }
                  Install-ChocolateyZipPackage -PackageName "$packagename" -unziplocation "$toolsdir" -url "$urlWin7x86" -checksum "$urlWin7x86checksum" -checksumtype "$ChecksumType" -url64bit "$urlWin2k8R2andWin7x64" -checksum64 "$urlWin2k8R2andWin7x64checksum" -checksumtype64 "$ChecksumType"
                  $x64MSUName = "$toolsdir\$(($urlWin2k8R2andWin7x64.split('/') | select -last 1).replace('.zip','.msu'))"
                  $x86MSUName = "$toolsdir\$(($urlwin7x86.split('/') | select -last 1).replace('.zip','.msu'))"
                  Write-Host "64-bit file: $x64MSUName"
                  Install-ChocolateyPackage "$packageName" 'MSU' "$SilentArgs" -url $x86MSUName -url64 $x64MSUName -validExitCodes $validExitCodes
                  If ($WMF5Over3WasForced)
                  {
                    If (!$FilteredList)
                    {
                        Write-Host "PSModulePath does not contain any customized paths that need to be preserved."
                    }
                    Else
                    {
                        $scriptlocation = "$env:windir\temp\psmodulepathfixup.ps1"

                        $code = "set-Itemproperty 'hklm:system\CurrentControlSet\Control\Session Manager\Environment' -name 'PsModulePath' -value `$((get-Item 'hklm:system\CurrentControlSet\Control\Session Manager\Environment').GetValue('PsModulePath','Default',[Microsoft.WIN32.RegistryValueOptions]::DoNotExpandEnvironmentNames)" + "+`';$(invoke-expression -command '(get-variable FilteredList).value')`'" + ')'
                        $code | out-file $scriptlocation
                        "start-sleep -s 2" | out-file $scriptlocation -append
                        "schtasks.exe /delete /f /tn `"PSModulePathFixUp`"" | out-file $scriptlocation -append

                        schtasks.exe /create /tn "PSModulePathFixUp" /ru SYSTEM /Sc ONSTART /tr "powershell.exe -file $scriptlocation"

                        Write-Host "`"$scriptlocation`" is scheduled to run on reboot."

                        Write-Warning "ATTENTION: This Computer Must Be Restarted."
                    }
                  }
                }
            }
            "Win8/2012" {
                if($os.ProductType -gt 1) {
                    #Windows 2012
                    Install-PowerShell5 -urlx86 "$urlWin2012" -checksumx86 $urlWin2012checksum
                }
                else {
                    #Windows 8
                    Write-Verbose "Windows 8 (not 8.1) is not supported"
                    throw "$packageName not supported on Windows 8. You must upgrade to Windows 8.1 to install WMF/PowerShell 5.0."
                }
            }
            "Win8.1/2012R2" {
              Install-PowerShell5 -urlx86 "$urlWin81x86" -checksumx86 $urlWin81x86checksum -urlx64 "$urlWin2k12R2andWin81x64" -checksumx64 $urlWin2k12R2andWin81x64checksum -checksumtype "$ChecksumType" -checksumtype64 "$ChecksumType"
            }
            "Windows 10/Server 2016" {
                #Should never be reached.
                Write-Warning "Windows 10 / Server 2016 has WMF/PowerShell 5 pre-installed which is maintained by Windows Updates."
            }
            default {
                # Windows XP, Windows 2003, Windows Vista, or unknown?
                throw "$packageName $ThisPackagePSHVersion is not supported on $ProductName, ($EditionId), Windows Kernel: $osVersion"
            }
	    }
    }
}
catch {
  Throw $_.Exception
}

2017-03-30 20:12:32,029 [WARN ] - Chocolatey timed out waiting for the command to finish. The timeout 
 specified (or the default value) was '0' seconds. Perhaps try a 
 higher `--execution-timeout`? See `choco -h` for details.
2017-03-30 20:12:32,045 [DEBUG] - Calling command ['"C:\Windows\System32\shutdown.exe" /a']
2017-03-30 20:12:32,076 [DEBUG] - Calling built-in PowerShell host with ['[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\PowerShell\tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters ''']
2017-03-30 20:12:32,092 [DEBUG] - Command ['"C:\Windows\System32\shutdown.exe" /a'] exited with '1116'
2017-03-30 20:12:32,467 [DEBUG] - Capturing package files in 'C:\ProgramData\chocolatey\lib\PowerShell'
2017-03-30 20:12:32,467 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\PowerShell\PowerShell.nupkg'
  with checksum 'D5EC8782A19F404C74ABD74041EA1FB1'
2017-03-30 20:12:32,467 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\PowerShell\PowerShell.nuspec'
  with checksum '54DBB33B60B969EEE83167CE4877F276'
2017-03-30 20:12:32,467 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'
  with checksum 'DC7575034D442CDDCC0249D65D0AC756'
2017-03-30 20:12:32,467 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\PowerShell\tools\chocolateyUninstall.ps1'
  with checksum '06BDEE8254D1120913F843855A88FA5B'
2017-03-30 20:12:32,529 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\PowerShell.5.1.14409.20170301\.arguments".
2017-03-30 20:12:32,529 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\PowerShell.5.1.14409.20170301\.version".
2017-03-30 20:12:32,529 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\PowerShell.5.1.14409.20170301\.sxs".
2017-03-30 20:12:32,529 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\PowerShell.5.1.14409.20170301\.pin".
2017-03-30 20:12:32,545 [DEBUG] - Attempting to delete directory "C:\ProgramData\chocolatey\lib-bad\PowerShell".
2017-03-30 20:12:32,545 [DEBUG] - Sending message 'HandlePackageResultCompletedMessage' out if there are subscribers...
2017-03-30 20:12:32,560 [ERROR] - The install of powershell was NOT successful.
2017-03-30 20:12:32,576 [ERROR] - Error while running 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'.
 See log for details.
2017-03-30 20:12:32,592 [DEBUG] - Moving 'C:\ProgramData\chocolatey\lib\PowerShell'
 to 'C:\ProgramData\chocolatey\lib-bad\PowerShell'
2017-03-30 20:12:32,732 [DEBUG] - Host version is 4.0, PowerShell Version is '4.0' and CLR Version is '4.0.30319.36366'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2017-03-30 20:12:33,092 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2017-03-30 20:12:33,107 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2017-03-30 20:12:33,123 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2017-03-30 20:12:33,138 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2017-03-30 20:12:33,154 [DEBUG] - Loading community extensions
2017-03-30 20:12:33,170 [DEBUG] - Importing 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'
2017-03-30 20:12:33,170 [INFO ] - VERBOSE: Loading module from path 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2017-03-30 20:12:33,388 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2017-03-30 20:12:33,404 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2017-03-30 20:12:33,420 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2017-03-30 20:12:33,435 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2017-03-30 20:12:33,451 [INFO ] - VERBOSE: Importing function 'Format-FileSize'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-ChecksumValid'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyUnzip'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyWebFile'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariable'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariableNames'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-FtpFile'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-OSArchitectureWidth'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-ToolsLocation'.
2017-03-30 20:12:33,467 [INFO ] - VERBOSE: Importing function 'Get-UACEnabled'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-VirusCheckValid'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-WebFile'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-WebFileName'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Get-WebHeaders'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-BinFile'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyDesktopLink'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyExplorerMenuItem'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyFileAssociation'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyInstallPackage'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPackage'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPath'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPinnedTaskBarItem'.
2017-03-30 20:12:33,482 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPowershellCommand'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyShortcut'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyVsixPackage'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyZipPackage'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Install-Vsix'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Set-EnvironmentVariable'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Set-PowerShellExitCode'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Start-ChocolateyProcessAsAdmin'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Test-ProcessAdminRights'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Uninstall-BinFile'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyEnvironmentVariable'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyPackage'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyZipPackage'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Update-SessionEnvironment'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Write-ChocolateyFailure'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Write-ChocolateySuccess'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Write-FileUpdateLog'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing function 'Write-FunctionCallLogMessage'.
2017-03-30 20:12:33,498 [INFO ] - VERBOSE: Importing alias 'Add-BinFile'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Generate-BinFile'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Get-InstallRegistryKey'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Get-OSBitness'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Get-ProcessorBits'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Invoke-ChocolateyProcess'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'refreshenv'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Remove-BinFile'.
2017-03-30 20:12:33,513 [INFO ] - VERBOSE: Importing alias 'Start-ChocolateyProcess'.
2017-03-30 20:12:33,623 [DEBUG] - Running 'ChocolateyScriptRunner' for PowerShell v5.1.14409.20170301 with packageScript 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1', packageFolder:'C:\ProgramData\chocolatey\lib\PowerShell', installArguments: '', packageParameters: '',
2017-03-30 20:12:33,670 [DEBUG] - Running 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'
2017-03-30 20:12:33,904 [ERROR] - ERROR: The term 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1' is not recognized as the name of a cmdlet, function, script file, or operable program. Check the spelling of the name, or if a path was included, verify that the path is correct and try again.
2017-03-30 20:12:33,904 [DEBUG] - Built-in PowerShell host called with ['[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\PowerShell\tools\ChocolateyInstall.ps1' -installArguments '' -packageParameters '''] exited with '-1'.
2017-03-30 20:12:34,607 [DEBUG] - Attempting to delete file "C:\Users\Administrator\AppData\Local\NuGet\Cache\PowerShell.5.1.14409.20170301.nupkg".
2017-03-30 20:12:34,654 [WARN ] - 
Chocolatey installed 0/1 packages. 1 packages failed.
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
2017-03-30 20:12:34,654 [INFO ] - 
2017-03-30 20:12:34,654 [ERROR] - Failures
2017-03-30 20:12:34,670 [ERROR] -  - powershell (exited -1) - Error while running 'C:\ProgramData\chocolatey\lib\PowerShell\tools\ChocolateyInstall.ps1'.
 See log for details.
2017-03-30 20:12:34,670 [DEBUG] - Sending message 'PostRunMessage' out if there are subscribers...
2017-03-30 20:12:34,717 [DEBUG] - Exiting with -1

@basictheprogram
Copy link
Author

PS C:\ProgramData\chocolatey\logs> choco install powershell --execution-timeout=600
Chocolatey v0.10.5
Installing the following packages:
powershell
By installing you accept licenses for the packages.
Progress: Downloading PowerShell 5.1.14409.20170301... 100%

PowerShell v5.1.14409.20170301 [Approved]
powershell package files install completed. Performing other installation steps.
Running on: Windows Server 2012 R2 Standard, (ServerStandard), Windows Kernel: 6.3.9600
Installing for OS: Win8.1/2012R2
Downloading PowerShell 64 bit
  from 'https://download.microsoft.com/download/6/F/5/6F5FF66C-6775-42B0-86C4-47D41F2DA187/Win8.1AndW2K12R2-KB3191564-x6
4.msu'
Progress: 100% - Completed download of C:\Users\Administrator\AppData\Local\Temp\3\chocolatey\PowerShell\5.1.14409.20170
301\Win8.1AndW2K12R2-KB3191564-x64.msu (18.96 MB).
Download of Win8.1AndW2K12R2-KB3191564-x64.msu (18.96 MB) completed.
Hashes match.
Installing PowerShell...
PowerShell has been installed.
WARNING: PowerShell requires a reboot to complete the installation.
 The install of powershell was successful.
  Software installed as 'msu', install location is likely default.

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

Packages requiring reboot:
 - powershell (exit code 3010)

The recent package changes indicate a reboot is necessary.
 Please reboot at your earliest convenience.

@ferventcoder ferventcoder reopened this Mar 31, 2017
@ferventcoder
Copy link
Member

I passed the 0 in on the command line, looks like there is more work to do as it did not accept it. Led me to believe this was fixed in a cursory test of the functionality.

@ferventcoder ferventcoder modified the milestones: 0.10.6, 0.10.5 Mar 31, 2017
@ferventcoder ferventcoder changed the title Chocolatey timed out immediately when execution timeout was infinite Chocolatey timed out immediately when execution timeout was infinite (0) Mar 31, 2017
@ferventcoder
Copy link
Member

@basictheprogram give this a shot - https://chocolatey.box.com/s/zt84mz4rh9hvgsy4hnk35pohtfoseqn0

Instructions for anyone who needs them:

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

No branches or pull requests

4 participants