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

Logging - GUID in software name: "Chocolatey had an error formatting string" #1543

Closed
AeliusSaionji opened this issue Apr 20, 2018 · 5 comments
Assignees
Milestone

Comments

@AeliusSaionji
Copy link

AeliusSaionji commented Apr 20, 2018

Installing the geforce-experience package. Succeeds with error. Two logs posted.

  1. cinst geforce-experience -y -dfv --log-file=c:\tools\gfexp.log
  2. cinst geforce-experience -y -dfv -n --log-file=c:\tools\gfexp2.log
    The error persists even with -n.

Log below:

2018-04-20 09:25:17,192 5288 [INFO ] - Chocolatey v0.10.10
2018-04-20 09:25:17,203 5288 [DEBUG] - Chocolatey is running on Windows v 10.0.16299.0
2018-04-20 09:25:17,208 5288 [DEBUG] - Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
2018-04-20 09:25:17,212 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
2018-04-20 09:25:17,221 5288 [DEBUG] - Command line: "C:\ProgramData\chocolatey\choco.exe" install geforce-experience -y -dfv --log-file=c:\tools\gfexp.log
2018-04-20 09:25:17,225 5288 [DEBUG] - Received arguments: install geforce-experience -y -dfv --log-file=c:\tools\gfexp.log
2018-04-20 09:25:17,262 5288 [DEBUG] - RemovePendingPackagesTask is now ready and waiting for PreRunMessage.
2018-04-20 09:25:17,272 5288 [DEBUG] - Sending message 'PreRunMessage' out if there are subscribers...
2018-04-20 09:25:17,280 5288 [DEBUG] - [Pending] Removing all pending packages that should not be considered installed...
2018-04-20 09:25:17,337 5288 [DEBUG] - The source 'https://chocolatey.org/api/v2/' evaluated to a 'normal' source type
2018-04-20 09:25:17,342 5288 [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.
2018-04-20 09:25:17,353 5288 [DEBUG] - Configuration: CommandName='install'|
CacheLocation='C:\Users\root\AppData\Local\Temp\chocolatey'|
ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='2700'|WebRequestTimeoutSeconds='30'|
Sources='https://chocolatey.org/api/v2/'|SourceType='normal'|
Debug='True'|Verbose='True'|Trace='False'|Force='True'|Noop='False'|
HelpRequested='False'|UnsuccessfulParsing='False'|RegularOutput='True'|
QuietOutput='False'|PromptForConfirmation='False'|AcceptLicense='True'|
AllowUnofficialBuild='False'|
AdditionalLogFileLocation='c:\tools\gfexp.log'|
Input='geforce-experience'|AllVersions='False'|
SkipPackageInstallProvider='False'|PackageNames='geforce-experience'|
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='10.0.16299.0'|
Information.PlatformName='Windows 10'|
Information.ChocolateyVersion='0.10.10.0'|
Information.ChocolateyProductVersion='0.10.10'|
Information.FullName='choco, Version=0.10.10.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64BitOperatingSystem='True'|
Information.Is64BitProcess='True'|Information.IsInteractive='True'|
Information.UserName='root'|Information.UserDomainName='NERV'|
Information.IsUserAdministrator='True'|
Information.IsUserSystemAccount='False'|
Information.IsUserRemoteDesktop='False'|
Information.IsUserRemote='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.LogWithoutColor='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='True'|
Features.IgnoreUnfoundPackagesOnUpgradeOutdated='False'|
Features.RemovePackageInformationOnUninstall='False'|
Features.ScriptsCheckLastExitCode='False'|
ListCommand.LocalOnly='False'|
ListCommand.IdOnly='False'|ListCommand.IncludeRegistryPrograms='False'|
ListCommand.PageSize='25'|ListCommand.Exact='False'|
ListCommand.ByIdOnly='False'|ListCommand.ByTagOnly='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'|
SourceCommand.VisibleToAdminsOnly='False'|
FeatureCommand.Command='unknown'|ConfigCommand.Command='unknown'|
PinCommand.Command='unknown'|OutdatedCommand.IgnorePinned='False'|
Proxy.BypassOnLocal='True'|
2018-04-20 09:25:17,366 5288 [DEBUG] - _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
2018-04-20 09:25:17,376 5288 [INFO ] - Installing the following packages:
2018-04-20 09:25:17,381 5288 [INFO ] - geforce-experience
2018-04-20 09:25:17,385 5288 [INFO ] - By installing you accept licenses for the packages.
2018-04-20 09:25:19,603 5288 [INFO ] - [NuGet] Installing 'geforce-experience 3.13.1.30'.
2018-04-20 09:25:19,613 5288 [DEBUG] - [NuGet] Added file 'chocolateyInstall.ps1' to folder 'geforce-experience\tools'.
2018-04-20 09:25:19,618 5288 [DEBUG] - [NuGet] Added file 'chocolateyuninstall.ps1' to folder 'geforce-experience\tools'.
2018-04-20 09:25:19,660 5288 [DEBUG] - [NuGet] Added file 'geforce-experience.nuspec' to folder 'geforce-experience'.
2018-04-20 09:25:19,667 5288 [DEBUG] - [NuGet] Added file 'geforce-experience.nupkg' to folder 'geforce-experience'.
2018-04-20 09:25:19,671 5288 [INFO ] - [NuGet] Successfully installed 'geforce-experience 3.13.1.30'.
2018-04-20 09:25:19,676 5288 [INFO ] - 
geforce-experience v3.13.1.30 (forced) [Approved]
2018-04-20 09:25:19,690 5288 [INFO ] - geforce-experience package files install completed. Performing other installation steps.
2018-04-20 09:25:19,757 5288 [DEBUG] - Setting installer args for geforce-experience
2018-04-20 09:25:19,762 5288 [DEBUG] - Setting package parameters for geforce-experience
2018-04-20 09:25:19,767 5288 [DEBUG] - Contents of 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1':
2018-04-20 09:25:19,776 5288 [DEBUG] - $packageArgs = @{
    packageName    = 'geforce-experience'
    filetype       = 'EXE'
    url            = 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe'
    checksum       = '1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746'
    checksumType   = 'sha256'
    silentArgs     = '/s /noreboot'
    validExitCodes = @(0)
    softwareName   = 'NVIDIA Geforce Experience*'
}

Install-ChocolateyPackage @packageArgs

Write-Output "If you experience errors after updating, you may need to reboot."

2018-04-20 09:25:19,791 5288 [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\geforce-experience\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters ''']
2018-04-20 09:25:19,797 5288 [DEBUG] - Redirecting System.Management.Automation.resources, Version=3.0.0.0, Culture=en-US, PublicKeyToken=31bf3856ad364e35, requested by ''
2018-04-20 09:25:19,943 5288 [DEBUG] - Host version is 5.1.16299.15, PowerShell Version is '5.1.16299.251' and CLR Version is '4.0.30319.42000'.
2018-04-20 09:25:20,410 5288 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2018-04-20 09:25:20,415 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2018-04-20 09:25:20,418 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2018-04-20 09:25:20,423 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2018-04-20 09:25:20,427 5288 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2018-04-20 09:25:20,431 5288 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2018-04-20 09:25:20,434 5288 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2018-04-20 09:25:20,438 5288 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2018-04-20 09:25:20,442 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2018-04-20 09:25:20,446 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageParametersBuiltIn'.
2018-04-20 09:25:20,450 5288 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2018-04-20 09:25:20,454 5288 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2018-04-20 09:25:20,458 5288 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2018-04-20 09:25:20,462 5288 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2018-04-20 09:25:20,466 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2018-04-20 09:25:20,471 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2018-04-20 09:25:20,475 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2018-04-20 09:25:20,479 5288 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2018-04-20 09:25:20,483 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2018-04-20 09:25:20,487 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:20,491 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2018-04-20 09:25:20,496 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2018-04-20 09:25:20,500 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2018-04-20 09:25:20,504 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2018-04-20 09:25:20,508 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2018-04-20 09:25:20,513 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2018-04-20 09:25:20,517 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2018-04-20 09:25:20,522 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2018-04-20 09:25:20,526 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2018-04-20 09:25:20,531 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2018-04-20 09:25:20,535 5288 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2018-04-20 09:25:20,540 5288 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2018-04-20 09:25:20,544 5288 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2018-04-20 09:25:20,549 5288 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2018-04-20 09:25:20,553 5288 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2018-04-20 09:25:20,558 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2018-04-20 09:25:20,562 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:20,567 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2018-04-20 09:25:20,571 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2018-04-20 09:25:20,575 5288 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2018-04-20 09:25:20,580 5288 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2018-04-20 09:25:20,584 5288 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2018-04-20 09:25:20,588 5288 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2018-04-20 09:25:20,593 5288 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2018-04-20 09:25:20,597 5288 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2018-04-20 09:25:20,602 5288 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2018-04-20 09:25:20,606 5288 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2018-04-20 09:25:20,611 5288 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2018-04-20 09:25:20,615 5288 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2018-04-20 09:25:20,619 5288 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2018-04-20 09:25:20,624 5288 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2018-04-20 09:25:20,629 5288 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2018-04-20 09:25:20,633 5288 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2018-04-20 09:25:20,640 5288 [DEBUG] - Loading community extensions
2018-04-20 09:25:20,657 5288 [DEBUG] - Importing 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'
2018-04-20 09:25:20,662 5288 [INFO ] - VERBOSE: Loading module from path 'C:\ProgramData\chocolatey\extensions\chocolatey-core\chocolatey-core.psm1'.
2018-04-20 09:25:20,794 5288 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2018-04-20 09:25:20,800 5288 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2018-04-20 09:25:20,805 5288 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2018-04-20 09:25:20,809 5288 [INFO ] - VERBOSE: Exporting function 'Get-EffectiveProxy'.
2018-04-20 09:25:20,814 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2018-04-20 09:25:20,819 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2018-04-20 09:25:20,824 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2018-04-20 09:25:20,829 5288 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2018-04-20 09:25:20,834 5288 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2018-04-20 09:25:20,838 5288 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2018-04-20 09:25:20,843 5288 [INFO ] - VERBOSE: Importing function 'Get-EffectiveProxy'.
2018-04-20 09:25:20,847 5288 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2018-04-20 09:25:20,851 5288 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2018-04-20 09:25:20,856 5288 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2018-04-20 09:25:20,860 5288 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2018-04-20 09:25:20,865 5288 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2018-04-20 09:25:20,870 5288 [DEBUG] - Importing 'C:\ProgramData\chocolatey\extensions\chocolatey-windowsupdate\chocolatey-windowsupdate.psm1'
2018-04-20 09:25:20,875 5288 [INFO ] - VERBOSE: Loading module from path 'C:\ProgramData\chocolatey\extensions\chocolatey-windowsupdate\chocolatey-windowsupdate.psm1'.
2018-04-20 09:25:20,973 5288 [INFO ] - VERBOSE: Exporting function 'Install-WindowsUpdate'.
2018-04-20 09:25:20,978 5288 [INFO ] - VERBOSE: Exporting function 'Test-WindowsUpdate'.
2018-04-20 09:25:20,983 5288 [INFO ] - VERBOSE: Importing function 'Install-WindowsUpdate'.
2018-04-20 09:25:20,987 5288 [INFO ] - VERBOSE: Importing function 'Test-WindowsUpdate'.
2018-04-20 09:25:20,992 5288 [INFO ] - VERBOSE: Exporting function 'Format-FileSize'.
2018-04-20 09:25:20,997 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChecksumValid'.
2018-04-20 09:25:21,001 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyUnzip'.
2018-04-20 09:25:21,005 5288 [INFO ] - VERBOSE: Exporting function 'Get-ChocolateyWebFile'.
2018-04-20 09:25:21,010 5288 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariable'.
2018-04-20 09:25:21,014 5288 [INFO ] - VERBOSE: Exporting function 'Get-EnvironmentVariableNames'.
2018-04-20 09:25:21,019 5288 [INFO ] - VERBOSE: Exporting function 'Get-FtpFile'.
2018-04-20 09:25:21,023 5288 [INFO ] - VERBOSE: Exporting function 'Get-OSArchitectureWidth'.
2018-04-20 09:25:21,028 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageParameters'.
2018-04-20 09:25:21,032 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageParametersBuiltIn'.
2018-04-20 09:25:21,037 5288 [INFO ] - VERBOSE: Exporting function 'Get-ToolsLocation'.
2018-04-20 09:25:21,042 5288 [INFO ] - VERBOSE: Exporting function 'Get-UACEnabled'.
2018-04-20 09:25:21,046 5288 [INFO ] - VERBOSE: Exporting function 'Get-UninstallRegistryKey'.
2018-04-20 09:25:21,050 5288 [INFO ] - VERBOSE: Exporting function 'Get-VirusCheckValid'.
2018-04-20 09:25:21,055 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebFile'.
2018-04-20 09:25:21,060 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebFileName'.
2018-04-20 09:25:21,065 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebHeaders'.
2018-04-20 09:25:21,069 5288 [INFO ] - VERBOSE: Exporting function 'Install-BinFile'.
2018-04-20 09:25:21,074 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyDesktopLink'.
2018-04-20 09:25:21,078 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:21,084 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyExplorerMenuItem'.
2018-04-20 09:25:21,088 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyFileAssociation'.
2018-04-20 09:25:21,093 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyInstallPackage'.
2018-04-20 09:25:21,097 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPackage'.
2018-04-20 09:25:21,102 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPath'.
2018-04-20 09:25:21,107 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPinnedTaskBarItem'.
2018-04-20 09:25:21,111 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyPowershellCommand'.
2018-04-20 09:25:21,116 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyShortcut'.
2018-04-20 09:25:21,121 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyVsixPackage'.
2018-04-20 09:25:21,126 5288 [INFO ] - VERBOSE: Exporting function 'Install-ChocolateyZipPackage'.
2018-04-20 09:25:21,131 5288 [INFO ] - VERBOSE: Exporting function 'Install-Vsix'.
2018-04-20 09:25:21,135 5288 [INFO ] - VERBOSE: Exporting function 'Set-EnvironmentVariable'.
2018-04-20 09:25:21,140 5288 [INFO ] - VERBOSE: Exporting function 'Set-PowerShellExitCode'.
2018-04-20 09:25:21,144 5288 [INFO ] - VERBOSE: Exporting function 'Start-ChocolateyProcessAsAdmin'.
2018-04-20 09:25:21,149 5288 [INFO ] - VERBOSE: Exporting function 'Test-ProcessAdminRights'.
2018-04-20 09:25:21,153 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-BinFile'.
2018-04-20 09:25:21,158 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:21,163 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyPackage'.
2018-04-20 09:25:21,168 5288 [INFO ] - VERBOSE: Exporting function 'Uninstall-ChocolateyZipPackage'.
2018-04-20 09:25:21,172 5288 [INFO ] - VERBOSE: Exporting function 'Update-SessionEnvironment'.
2018-04-20 09:25:21,177 5288 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateyFailure'.
2018-04-20 09:25:21,181 5288 [INFO ] - VERBOSE: Exporting function 'Write-ChocolateySuccess'.
2018-04-20 09:25:21,186 5288 [INFO ] - VERBOSE: Exporting function 'Write-FileUpdateLog'.
2018-04-20 09:25:21,191 5288 [INFO ] - VERBOSE: Exporting function 'Write-FunctionCallLogMessage'.
2018-04-20 09:25:21,195 5288 [INFO ] - VERBOSE: Exporting function 'Get-AppInstallLocation'.
2018-04-20 09:25:21,200 5288 [INFO ] - VERBOSE: Exporting function 'Get-AvailableDriveLetter'.
2018-04-20 09:25:21,205 5288 [INFO ] - VERBOSE: Exporting function 'Get-EffectiveProxy'.
2018-04-20 09:25:21,210 5288 [INFO ] - VERBOSE: Exporting function 'Get-PackageCacheLocation'.
2018-04-20 09:25:21,215 5288 [INFO ] - VERBOSE: Exporting function 'Get-WebContent'.
2018-04-20 09:25:21,219 5288 [INFO ] - VERBOSE: Exporting function 'Register-Application'.
2018-04-20 09:25:21,224 5288 [INFO ] - VERBOSE: Exporting function 'Install-WindowsUpdate'.
2018-04-20 09:25:21,229 5288 [INFO ] - VERBOSE: Exporting function 'Test-WindowsUpdate'.
2018-04-20 09:25:21,234 5288 [INFO ] - VERBOSE: Exporting alias 'Get-ProcessorBits'.
2018-04-20 09:25:21,239 5288 [INFO ] - VERBOSE: Exporting alias 'Get-OSBitness'.
2018-04-20 09:25:21,243 5288 [INFO ] - VERBOSE: Exporting alias 'Get-InstallRegistryKey'.
2018-04-20 09:25:21,248 5288 [INFO ] - VERBOSE: Exporting alias 'Generate-BinFile'.
2018-04-20 09:25:21,253 5288 [INFO ] - VERBOSE: Exporting alias 'Add-BinFile'.
2018-04-20 09:25:21,258 5288 [INFO ] - VERBOSE: Exporting alias 'Start-ChocolateyProcess'.
2018-04-20 09:25:21,262 5288 [INFO ] - VERBOSE: Exporting alias 'Invoke-ChocolateyProcess'.
2018-04-20 09:25:21,268 5288 [INFO ] - VERBOSE: Exporting alias 'Remove-BinFile'.
2018-04-20 09:25:21,272 5288 [INFO ] - VERBOSE: Exporting alias 'refreshenv'.
2018-04-20 09:25:21,277 5288 [INFO ] - VERBOSE: Importing function 'Format-FileSize'.
2018-04-20 09:25:21,281 5288 [INFO ] - VERBOSE: Importing function 'Get-AppInstallLocation'.
2018-04-20 09:25:21,286 5288 [INFO ] - VERBOSE: Importing function 'Get-AvailableDriveLetter'.
2018-04-20 09:25:21,290 5288 [INFO ] - VERBOSE: Importing function 'Get-ChecksumValid'.
2018-04-20 09:25:21,295 5288 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyUnzip'.
2018-04-20 09:25:21,300 5288 [INFO ] - VERBOSE: Importing function 'Get-ChocolateyWebFile'.
2018-04-20 09:25:21,304 5288 [INFO ] - VERBOSE: Importing function 'Get-EffectiveProxy'.
2018-04-20 09:25:21,309 5288 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariable'.
2018-04-20 09:25:21,314 5288 [INFO ] - VERBOSE: Importing function 'Get-EnvironmentVariableNames'.
2018-04-20 09:25:21,318 5288 [INFO ] - VERBOSE: Importing function 'Get-FtpFile'.
2018-04-20 09:25:21,323 5288 [INFO ] - VERBOSE: Importing function 'Get-OSArchitectureWidth'.
2018-04-20 09:25:21,327 5288 [INFO ] - VERBOSE: Importing function 'Get-PackageCacheLocation'.
2018-04-20 09:25:21,332 5288 [INFO ] - VERBOSE: Importing function 'Get-PackageParameters'.
2018-04-20 09:25:21,336 5288 [INFO ] - VERBOSE: Importing function 'Get-PackageParametersBuiltIn'.
2018-04-20 09:25:21,341 5288 [INFO ] - VERBOSE: Importing function 'Get-ToolsLocation'.
2018-04-20 09:25:21,345 5288 [INFO ] - VERBOSE: Importing function 'Get-UACEnabled'.
2018-04-20 09:25:21,351 5288 [INFO ] - VERBOSE: Importing function 'Get-UninstallRegistryKey'.
2018-04-20 09:25:21,355 5288 [INFO ] - VERBOSE: Importing function 'Get-VirusCheckValid'.
2018-04-20 09:25:21,359 5288 [INFO ] - VERBOSE: Importing function 'Get-WebContent'.
2018-04-20 09:25:21,364 5288 [INFO ] - VERBOSE: Importing function 'Get-WebFile'.
2018-04-20 09:25:21,368 5288 [INFO ] - VERBOSE: Importing function 'Get-WebFileName'.
2018-04-20 09:25:21,373 5288 [INFO ] - VERBOSE: Importing function 'Get-WebHeaders'.
2018-04-20 09:25:21,377 5288 [INFO ] - VERBOSE: Importing function 'Install-BinFile'.
2018-04-20 09:25:21,382 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyDesktopLink'.
2018-04-20 09:25:21,386 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:21,391 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyExplorerMenuItem'.
2018-04-20 09:25:21,395 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyFileAssociation'.
2018-04-20 09:25:21,400 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyInstallPackage'.
2018-04-20 09:25:21,405 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPackage'.
2018-04-20 09:25:21,409 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPath'.
2018-04-20 09:25:21,414 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPinnedTaskBarItem'.
2018-04-20 09:25:21,418 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyPowershellCommand'.
2018-04-20 09:25:21,423 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyShortcut'.
2018-04-20 09:25:21,427 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyVsixPackage'.
2018-04-20 09:25:21,431 5288 [INFO ] - VERBOSE: Importing function 'Install-ChocolateyZipPackage'.
2018-04-20 09:25:21,436 5288 [INFO ] - VERBOSE: Importing function 'Install-Vsix'.
2018-04-20 09:25:21,440 5288 [INFO ] - VERBOSE: Importing function 'Install-WindowsUpdate'.
2018-04-20 09:25:21,444 5288 [INFO ] - VERBOSE: Importing function 'Register-Application'.
2018-04-20 09:25:21,449 5288 [INFO ] - VERBOSE: Importing function 'Set-EnvironmentVariable'.
2018-04-20 09:25:21,453 5288 [INFO ] - VERBOSE: Importing function 'Set-PowerShellExitCode'.
2018-04-20 09:25:21,457 5288 [INFO ] - VERBOSE: Importing function 'Start-ChocolateyProcessAsAdmin'.
2018-04-20 09:25:21,462 5288 [INFO ] - VERBOSE: Importing function 'Test-ProcessAdminRights'.
2018-04-20 09:25:21,467 5288 [INFO ] - VERBOSE: Importing function 'Test-WindowsUpdate'.
2018-04-20 09:25:21,471 5288 [INFO ] - VERBOSE: Importing function 'Uninstall-BinFile'.
2018-04-20 09:25:21,475 5288 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyEnvironmentVariable'.
2018-04-20 09:25:21,480 5288 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyPackage'.
2018-04-20 09:25:21,484 5288 [INFO ] - VERBOSE: Importing function 'Uninstall-ChocolateyZipPackage'.
2018-04-20 09:25:21,489 5288 [INFO ] - VERBOSE: Importing function 'Update-SessionEnvironment'.
2018-04-20 09:25:21,493 5288 [INFO ] - VERBOSE: Importing function 'Write-ChocolateyFailure'.
2018-04-20 09:25:21,498 5288 [INFO ] - VERBOSE: Importing function 'Write-ChocolateySuccess'.
2018-04-20 09:25:21,502 5288 [INFO ] - VERBOSE: Importing function 'Write-FileUpdateLog'.
2018-04-20 09:25:21,507 5288 [INFO ] - VERBOSE: Importing function 'Write-FunctionCallLogMessage'.
2018-04-20 09:25:21,511 5288 [INFO ] - VERBOSE: Importing alias 'Add-BinFile'.
2018-04-20 09:25:21,515 5288 [INFO ] - VERBOSE: Importing alias 'Generate-BinFile'.
2018-04-20 09:25:21,520 5288 [INFO ] - VERBOSE: Importing alias 'Get-InstallRegistryKey'.
2018-04-20 09:25:21,524 5288 [INFO ] - VERBOSE: Importing alias 'Get-OSBitness'.
2018-04-20 09:25:21,529 5288 [INFO ] - VERBOSE: Importing alias 'Get-ProcessorBits'.
2018-04-20 09:25:21,533 5288 [INFO ] - VERBOSE: Importing alias 'Invoke-ChocolateyProcess'.
2018-04-20 09:25:21,538 5288 [INFO ] - VERBOSE: Importing alias 'refreshenv'.
2018-04-20 09:25:21,542 5288 [INFO ] - VERBOSE: Importing alias 'Remove-BinFile'.
2018-04-20 09:25:21,546 5288 [INFO ] - VERBOSE: Importing alias 'Start-ChocolateyProcess'.
2018-04-20 09:25:21,577 5288 [DEBUG] - Running 'ChocolateyScriptRunner' for geforce-experience v3.13.1.30 with packageScript 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1', packageFolder:'C:\ProgramData\chocolatey\lib\geforce-experience', installArguments: '', packageParameters: '',
2018-04-20 09:25:21,588 5288 [DEBUG] - Running 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1'
2018-04-20 09:25:21,637 5288 [DEBUG] - Running Install-ChocolateyPackage -silentArgs '/s /noreboot' -checksumType 'sha256' -url 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' -checksum '1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746' -packageName 'geforce-experience' -validExitCodes '0' -fileType 'EXE' 
2018-04-20 09:25:21,673 5288 [DEBUG] - Running Get-ChocolateyWebFile -packageName 'geforce-experience' -fileFullPath 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\geforce-experienceInstall.EXE' -url 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' -url64bit '' -checksum '1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746' -checksumType 'sha256' -checksum64 '' -checksumType64 '' -options 'System.Collections.Hashtable' -getOriginalFileName 'True' 
2018-04-20 09:25:21,687 5288 [DEBUG] - Running Get-ProcessorBits -compare '64' 
2018-04-20 09:25:21,696 5288 [DEBUG] - CPU is 64 bit
2018-04-20 09:25:21,728 5288 [DEBUG] - Running Get-WebFileName -url 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' -defaultName 'geforce-experienceInstall.EXE' 
2018-04-20 09:25:21,844 5288 [DEBUG] - Using response url to determine file name. 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe'
2018-04-20 09:25:21,851 5288 [DEBUG] - File name determined from url is 'GeForce_Experience_v3.13.1.30.exe'
2018-04-20 09:25:21,863 5288 [DEBUG] - Running Get-WebHeaders -url 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' -ErrorAction 'Stop' 
2018-04-20 09:25:21,868 5288 [DEBUG] - Setting the UserAgent to 'chocolatey command line'
2018-04-20 09:25:21,873 5288 [DEBUG] - Request Headers:
2018-04-20 09:25:21,880 5288 [DEBUG] -   'Accept':'*/*'
2018-04-20 09:25:21,884 5288 [DEBUG] -   'User-Agent':'chocolatey command line'
2018-04-20 09:25:21,952 5288 [DEBUG] - Response Headers:
2018-04-20 09:25:21,958 5288 [DEBUG] -   'X-Cache':'HIT'
2018-04-20 09:25:21,963 5288 [DEBUG] -   'Accept-Ranges':'bytes'
2018-04-20 09:25:21,967 5288 [DEBUG] -   'Content-Length':'91075776'
2018-04-20 09:25:21,971 5288 [DEBUG] -   'Cache-Control':'max-age=86400'
2018-04-20 09:25:21,975 5288 [DEBUG] -   'Content-Type':'application/octet-stream'
2018-04-20 09:25:21,979 5288 [DEBUG] -   'Date':'Fri, 20 Apr 2018 13:25:21 GMT'
2018-04-20 09:25:21,984 5288 [DEBUG] -   'Expires':'Sat, 21 Apr 2018 13:25:21 GMT'
2018-04-20 09:25:21,987 5288 [DEBUG] -   'ETag':'"1277174791"'
2018-04-20 09:25:21,992 5288 [DEBUG] -   'Last-Modified':'Wed, 14 Mar 2018 13:27:51 GMT'
2018-04-20 09:25:21,996 5288 [DEBUG] -   'Server':'ECAcc (nya/78F6)'
2018-04-20 09:25:22,004 5288 [INFO ] - Downloading geforce-experience 
  from 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe'
2018-04-20 09:25:22,027 5288 [DEBUG] - Running Get-WebFile -url 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' -fileName 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe' -options 'System.Collections.Hashtable' 
2018-04-20 09:25:22,034 5288 [DEBUG] - Setting request timeout to  30000
2018-04-20 09:25:22,038 5288 [DEBUG] - Setting read/write timeout to  2700000
2018-04-20 09:25:22,042 5288 [DEBUG] - Setting the UserAgent to 'chocolatey command line'
2018-04-20 09:25:22,172 5288 [DEBUG] - Downloading https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe to C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe
2018-04-20 09:25:29,890 5288 [INFO ] - 
2018-04-20 09:25:29,894 5288 [INFO ] - Download of GeForce_Experience_v3.13.1.30.exe (86.86 MB) completed.
2018-04-20 09:25:33,388 5288 [DEBUG] - No runtime virus checking built into FOSS Chocolatey. Check out Pro/Business - https://chocolatey.org/compare
2018-04-20 09:25:33,394 5288 [DEBUG] - Verifying package provided checksum of '1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746' for 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe'.
2018-04-20 09:25:33,404 5288 [DEBUG] - Running Get-ChecksumValid -file 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe' -checksum '1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746' -checksumType 'sha256' -originalUrl 'https://us.download.nvidia.com/GFE/GFEClient/3.13.1.30/GeForce_Experience_v3.13.1.30.exe' 
2018-04-20 09:25:33,411 5288 [DEBUG] - checksum.exe found at 'C:\ProgramData\chocolatey\helpers\..\tools\checksum.exe'
2018-04-20 09:25:33,416 5288 [DEBUG] - Executing command ['C:\ProgramData\chocolatey\helpers\..\tools\checksum.exe' -c="1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746" -t="sha256" -f="C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe"]
2018-04-20 09:25:33,976 5288 [DEBUG] - Command ['C:\ProgramData\chocolatey\helpers\..\tools\checksum.exe' -c="1cb6eb9a5e6538a6e721e9190e74ecd526d1f5d1c125fc80e268087bbf439746" -t="sha256" -f="C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe"] exited with '0'.
2018-04-20 09:25:33,998 5288 [DEBUG] - Running Install-ChocolateyInstallPackage -packageName 'geforce-experience' -fileType 'EXE' -silentArgs '/s /noreboot' -file 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe' -validExitCodes '0' -useOnlyPackageSilentArguments 'False' 
2018-04-20 09:25:34,004 5288 [DEBUG] - Running Get-ProcessorBits -compare '32' 
2018-04-20 09:25:34,010 5288 [INFO ] - Installing geforce-experience...
2018-04-20 09:25:34,048 5288 [DEBUG] - Running Start-ChocolateyProcessAsAdmin -validExitCodes '0' -workingDirectory 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30' -statements '/s /noreboot ' -exeToRun 'C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe' 
2018-04-20 09:25:34,065 5288 [DEBUG] - Test-ProcessAdminRights: returning True
2018-04-20 09:25:34,075 5288 [DEBUG] - Elevating permissions and running ["C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe" /s /noreboot ]. This may take a while, depending on the statements.
2018-04-20 09:25:58,847 5288 [DEBUG] - Command ["C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30\GeForce_Experience_v3.13.1.30.exe" /s /noreboot ] exited with '0'.
2018-04-20 09:25:58,858 5288 [DEBUG] - Finishing 'Start-ChocolateyProcessAsAdmin'
2018-04-20 09:25:58,863 5288 [INFO ] - geforce-experience has been installed.
2018-04-20 09:25:58,867 5288 [INFO ] - If you experience errors after updating, you may need to reboot.
2018-04-20 09:25:58,874 5288 [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\geforce-experience\tools\chocolateyInstall.ps1' -installArguments '' -packageParameters '''] exited with '0'.
2018-04-20 09:25:58,881 5288 [DEBUG] - Calling command ['"C:\WINDOWS\System32\shutdown.exe" /a']
2018-04-20 09:25:58,904 5288 [DEBUG] - Command ['"C:\WINDOWS\System32\shutdown.exe" /a'] exited with '1116'
2018-04-20 09:25:58,923 5288 [INFO ] -   geforce-experience may be able to be automatically uninstalled.
2018-04-20 09:25:58,965 5288 [DEBUG] - Capturing package files in 'C:\ProgramData\chocolatey\lib\geforce-experience'
2018-04-20 09:25:58,970 5288 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nupkg'
  with checksum 'EA026976AB3E42C12B90633E2590BA8B'
2018-04-20 09:25:58,974 5288 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nuspec'
  with checksum '3E5683B113C02DB048C4A48658E2EB2D'
2018-04-20 09:25:58,978 5288 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1'
  with checksum '5E72F1FC07CCF427D7BCB1A748BBCDE4'
2018-04-20 09:25:58,982 5288 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyuninstall.ps1'
  with checksum '05AB034E83F744A38BC90D758119F7D8'
2018-04-20 09:25:59,013 5288 [DEBUG] - Attempting to replace "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry"
 with "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry.5288.update".
 Backup placed at "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry.backup".
2018-04-20 09:25:59,019 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry.backup".
2018-04-20 09:25:59,025 5288 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry.5288.update"
 to "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry".
2018-04-20 09:25:59,038 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.registry.5288.update".
2018-04-20 09:25:59,049 5288 [DEBUG] - Attempting to replace "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files"
 with "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files.5288.update".
 Backup placed at "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files.backup".
2018-04-20 09:25:59,053 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files.backup".
2018-04-20 09:25:59,058 5288 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files.5288.update"
 to "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files".
2018-04-20 09:25:59,063 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.files.5288.update".
2018-04-20 09:25:59,067 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.arguments".
2018-04-20 09:25:59,077 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.extra".
2018-04-20 09:25:59,081 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.version".
2018-04-20 09:25:59,085 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.sxs".
2018-04-20 09:25:59,089 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.pin".
2018-04-20 09:25:59,094 5288 [DEBUG] - Sending message 'HandlePackageResultCompletedMessage' out if there are subscribers...
2018-04-20 09:25:59,099 5288 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\lib\geforce-experience\.chocolateyPending".
2018-04-20 09:25:59,104 5288 [INFO ] -  The install of geforce-experience was successful.
2018-04-20 09:25:59,108 5288 [ERROR] - Chocolatey had an error formatting string:
 Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
2018-04-20 09:25:59,112 5288 [INFO ] -   Software installed to 'C:\Program Files\NVIDIA Corporation\Installer2\Display.GFExperience.{518A445B-BB06-4DE0-9F71-DDBA2E9DD816}'
2018-04-20 09:25:59,116 5288 [DEBUG] - Attempting to delete file "C:\Users\root\AppData\Local\NuGet\Cache\geforce-experience.3.13.1.30.nupkg".
2018-04-20 09:25:59,128 5288 [WARN ] - 
Chocolatey installed 1/1 packages. 
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
2018-04-20 09:25:59,132 5288 [WARN ] - 
Enjoy using Chocolatey? Explore more amazing features to take your
experience to the next level at
 https://chocolatey.org/compare
2018-04-20 09:25:59,137 5288 [DEBUG] - Sending message 'PostRunMessage' out if there are subscribers...
2018-04-20 09:25:59,151 5288 [DEBUG] - Exiting with 0
2018-04-20 09:32:47,502 10708 [INFO ] - Chocolatey v0.10.10
2018-04-20 09:32:47,513 10708 [DEBUG] - Chocolatey is running on Windows v 10.0.16299.0
2018-04-20 09:32:47,518 10708 [DEBUG] - Attempting to delete file "C:/ProgramData/chocolatey/choco.exe.old".
2018-04-20 09:32:47,522 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\choco.exe.old".
2018-04-20 09:32:47,532 10708 [DEBUG] - Command line: "C:\ProgramData\chocolatey\choco.exe" install geforce-experience -y -dfv -n --log-file=c:\tools\gfexp2.log
2018-04-20 09:32:47,536 10708 [DEBUG] - Received arguments: install geforce-experience -y -dfv -n --log-file=c:\tools\gfexp2.log
2018-04-20 09:32:47,573 10708 [DEBUG] - RemovePendingPackagesTask is now ready and waiting for PreRunMessage.
2018-04-20 09:32:47,584 10708 [DEBUG] - Sending message 'PreRunMessage' out if there are subscribers...
2018-04-20 09:32:47,592 10708 [DEBUG] - [Pending] Removing all pending packages that should not be considered installed...
2018-04-20 09:32:47,651 10708 [DEBUG] - The source 'https://chocolatey.org/api/v2/' evaluated to a 'normal' source type
2018-04-20 09:32:47,656 10708 [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.
2018-04-20 09:32:47,666 10708 [DEBUG] - Configuration: CommandName='install'|
CacheLocation='C:\Users\root\AppData\Local\Temp\chocolatey'|
ContainsLegacyPackageInstalls='True'|
CommandExecutionTimeoutSeconds='2700'|WebRequestTimeoutSeconds='30'|
Sources='https://chocolatey.org/api/v2/'|SourceType='normal'|
Debug='True'|Verbose='True'|Trace='False'|Force='True'|Noop='False'|
HelpRequested='False'|UnsuccessfulParsing='False'|RegularOutput='True'|
QuietOutput='False'|PromptForConfirmation='False'|AcceptLicense='True'|
AllowUnofficialBuild='False'|
AdditionalLogFileLocation='c:\tools\gfexp2.log'|
Input='geforce-experience'|AllVersions='False'|
SkipPackageInstallProvider='True'|PackageNames='geforce-experience'|
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='10.0.16299.0'|
Information.PlatformName='Windows 10'|
Information.ChocolateyVersion='0.10.10.0'|
Information.ChocolateyProductVersion='0.10.10'|
Information.FullName='choco, Version=0.10.10.0, Culture=neutral, PublicKeyToken=79d02ea9cad655eb'|

Information.Is64BitOperatingSystem='True'|
Information.Is64BitProcess='True'|Information.IsInteractive='True'|
Information.UserName='root'|Information.UserDomainName='NERV'|
Information.IsUserAdministrator='True'|
Information.IsUserSystemAccount='False'|
Information.IsUserRemoteDesktop='False'|
Information.IsUserRemote='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.LogWithoutColor='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='True'|
Features.IgnoreUnfoundPackagesOnUpgradeOutdated='False'|
Features.RemovePackageInformationOnUninstall='False'|
Features.ScriptsCheckLastExitCode='False'|
ListCommand.LocalOnly='False'|
ListCommand.IdOnly='False'|ListCommand.IncludeRegistryPrograms='False'|
ListCommand.PageSize='25'|ListCommand.Exact='False'|
ListCommand.ByIdOnly='False'|ListCommand.ByTagOnly='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'|
SourceCommand.VisibleToAdminsOnly='False'|
FeatureCommand.Command='unknown'|ConfigCommand.Command='unknown'|
PinCommand.Command='unknown'|OutdatedCommand.IgnorePinned='False'|
Proxy.BypassOnLocal='True'|
2018-04-20 09:32:47,672 10708 [DEBUG] - _ Chocolatey:ChocolateyInstallCommand - Normal Run Mode _
2018-04-20 09:32:47,679 10708 [INFO ] - Installing the following packages:
2018-04-20 09:32:47,684 10708 [INFO ] - geforce-experience
2018-04-20 09:32:47,687 10708 [INFO ] - By installing you accept licenses for the packages.
2018-04-20 09:32:47,780 10708 [WARN ] - geforce-experience v3.13.1.30 already installed. Forcing reinstall of version '3.13.1.30'. 
 Please use upgrade if you meant to upgrade to a new version.
2018-04-20 09:32:48,716 10708 [DEBUG] - Backing up existing geforce-experience prior to operation.
2018-04-20 09:32:48,722 10708 [DEBUG] - Moving 'C:\ProgramData\chocolatey\lib\geforce-experience'
 to 'C:\ProgramData\chocolatey\lib-bkp\geforce-experience'
2018-04-20 09:32:50,727 10708 [DEBUG] - Attempting to create directory "C:\ProgramData\chocolatey\lib\geforce-experience".
2018-04-20 09:32:50,733 10708 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\lib-bkp\geforce-experience\geforce-experience.nupkg"
 to "C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nupkg".
2018-04-20 09:32:50,738 10708 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\lib-bkp\geforce-experience\geforce-experience.nuspec"
 to "C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nuspec".
2018-04-20 09:32:50,743 10708 [DEBUG] - Attempting to create directory "C:\ProgramData\chocolatey\lib\geforce-experience\tools".
2018-04-20 09:32:50,749 10708 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\lib-bkp\geforce-experience\tools\chocolateyInstall.ps1"
 to "C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1".
2018-04-20 09:32:50,753 10708 [DEBUG] - Attempting to copy "C:\ProgramData\chocolatey\lib-bkp\geforce-experience\tools\chocolateyuninstall.ps1"
 to "C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyuninstall.ps1".
2018-04-20 09:32:52,261 10708 [DEBUG] - Capturing package files in 'C:\ProgramData\chocolatey\lib\geforce-experience'
2018-04-20 09:32:52,271 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nupkg'
  with checksum 'EA026976AB3E42C12B90633E2590BA8B'
2018-04-20 09:32:52,277 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nuspec'
  with checksum '3E5683B113C02DB048C4A48658E2EB2D'
2018-04-20 09:32:52,281 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1'
  with checksum '5E72F1FC07CCF427D7BCB1A748BBCDE4'
2018-04-20 09:32:52,285 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyuninstall.ps1'
  with checksum '05AB034E83F744A38BC90D758119F7D8'
2018-04-20 09:32:52,481 10708 [INFO ] - [NuGet] Uninstalling 'geforce-experience 3.13.1.30'.
2018-04-20 09:32:52,494 10708 [DEBUG] - [NuGet] Removed file 'chocolateyInstall.ps1' to folder 'C:\ProgramData\chocolatey\lib\geforce-experience\tools'.
2018-04-20 09:32:52,498 10708 [DEBUG] - [NuGet] Removed file 'chocolateyuninstall.ps1' to folder 'C:\ProgramData\chocolatey\lib\geforce-experience\tools'.
2018-04-20 09:32:52,504 10708 [DEBUG] - [NuGet] Removed folder 'C:\ProgramData\chocolatey\lib\geforce-experience\tools'.
2018-04-20 09:32:52,508 10708 [DEBUG] - [NuGet] Removed file 'geforce-experience.nuspec' to folder 'C:\ProgramData\chocolatey\lib\geforce-experience'.
2018-04-20 09:32:52,512 10708 [DEBUG] - [NuGet] Removed file 'geforce-experience.nupkg' to folder 'C:\ProgramData\chocolatey\lib\geforce-experience'.
2018-04-20 09:32:52,516 10708 [DEBUG] - [NuGet] Removed folder 'C:\ProgramData\chocolatey\lib\geforce-experience'.
2018-04-20 09:32:52,519 10708 [INFO ] - [NuGet] Successfully uninstalled 'geforce-experience 3.13.1.30'.
2018-04-20 09:32:52,531 10708 [DEBUG] - Ensuring removal of package cache files.
2018-04-20 09:32:52,538 10708 [DEBUG] - Attempting to delete directory "C:\Users\root\AppData\Local\Temp\chocolatey\geforce-experience\3.13.1.30".
2018-04-20 09:32:52,789 10708 [INFO ] - [NuGet] Installing 'geforce-experience 3.13.1.30'.
2018-04-20 09:32:52,797 10708 [DEBUG] - [NuGet] Added file 'chocolateyInstall.ps1' to folder 'geforce-experience\tools'.
2018-04-20 09:32:52,801 10708 [DEBUG] - [NuGet] Added file 'chocolateyuninstall.ps1' to folder 'geforce-experience\tools'.
2018-04-20 09:32:52,839 10708 [DEBUG] - [NuGet] Added file 'geforce-experience.nuspec' to folder 'geforce-experience'.
2018-04-20 09:32:52,846 10708 [DEBUG] - [NuGet] Added file 'geforce-experience.nupkg' to folder 'geforce-experience'.
2018-04-20 09:32:52,850 10708 [INFO ] - [NuGet] Successfully installed 'geforce-experience 3.13.1.30'.
2018-04-20 09:32:52,854 10708 [INFO ] - 
geforce-experience v3.13.1.30 (forced) [Approved]
2018-04-20 09:32:52,863 10708 [INFO ] - geforce-experience package files install completed. Performing other installation steps.
2018-04-20 09:32:52,899 10708 [DEBUG] - Capturing package files in 'C:\ProgramData\chocolatey\lib\geforce-experience'
2018-04-20 09:32:52,903 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nupkg'
  with checksum 'EA026976AB3E42C12B90633E2590BA8B'
2018-04-20 09:32:52,906 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\geforce-experience.nuspec'
  with checksum '3E5683B113C02DB048C4A48658E2EB2D'
2018-04-20 09:32:52,910 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyInstall.ps1'
  with checksum '5E72F1FC07CCF427D7BCB1A748BBCDE4'
2018-04-20 09:32:52,913 10708 [DEBUG] -  Found 'C:\ProgramData\chocolatey\lib\geforce-experience\tools\chocolateyuninstall.ps1'
  with checksum '05AB034E83F744A38BC90D758119F7D8'
2018-04-20 09:32:52,937 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.arguments".
2018-04-20 09:32:52,949 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.extra".
2018-04-20 09:32:52,953 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.version".
2018-04-20 09:32:52,956 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.sxs".
2018-04-20 09:32:52,959 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\.chocolatey\geforce-experience.3.13.1.30\.pin".
2018-04-20 09:32:52,963 10708 [DEBUG] - Sending message 'HandlePackageResultCompletedMessage' out if there are subscribers...
2018-04-20 09:32:52,967 10708 [DEBUG] - Attempting to delete file "C:\ProgramData\chocolatey\lib\geforce-experience\.chocolateyPending".
2018-04-20 09:32:52,971 10708 [DEBUG] - Attempting to delete directory "C:\ProgramData\chocolatey\lib-bkp\geforce-experience".
2018-04-20 09:32:52,976 10708 [INFO ] -  The install of geforce-experience was successful.
2018-04-20 09:32:52,980 10708 [ERROR] - Chocolatey had an error formatting string:
 Index (zero based) must be greater than or equal to zero and less than the size of the argument list.
2018-04-20 09:32:52,984 10708 [INFO ] -   Software installed to 'C:\Program Files\NVIDIA Corporation\Installer2\Display.GFExperience.{518A445B-BB06-4DE0-9F71-DDBA2E9DD816}'
2018-04-20 09:32:52,988 10708 [DEBUG] - Attempting to delete file "C:\Users\root\AppData\Local\NuGet\Cache\geforce-experience.3.13.1.30.nupkg".
2018-04-20 09:32:52,999 10708 [WARN ] - 
Chocolatey installed 1/1 packages. 
 See the log for details (C:\ProgramData\chocolatey\logs\chocolatey.log).
2018-04-20 09:32:53,003 10708 [DEBUG] - Sending message 'PostRunMessage' out if there are subscribers...
2018-04-20 09:32:53,017 10708 [DEBUG] - Exiting with 0
@ferventcoder
Copy link
Member

I don't think it is the GUID as there are GUIDs in a lot of MSI packages.

@ferventcoder ferventcoder added this to the 0.10.11 milestone Apr 20, 2018
@ferventcoder
Copy link
Member

@AeliusSaionji we believe there is something going on with #1505 that may have caused this.

@ferventcoder
Copy link
Member

Bumping this to high.

@ferventcoder
Copy link
Member

@AeliusSaionji Do you have another piece of software where you see this? I can't really repro this without a system where this software could be installed.

@AeliusSaionji
Copy link
Author

Unfortunately no.

@ferventcoder ferventcoder self-assigned this May 4, 2018
@ferventcoder ferventcoder changed the title GUID in software name: "Chocolatey had an error formatting string" warning: GUID in software name: "Chocolatey had an error formatting string" May 4, 2018
@ferventcoder ferventcoder changed the title warning: GUID in software name: "Chocolatey had an error formatting string" logging: GUID in software name: "Chocolatey had an error formatting string" May 4, 2018
@ferventcoder ferventcoder changed the title logging: GUID in software name: "Chocolatey had an error formatting string" Logging - GUID in software name: "Chocolatey had an error formatting string" May 4, 2018
ferventcoder added a commit that referenced this issue May 4, 2018
Apparently GUID is a valid path in Windows, so be sure to escape the
install location for any curly braces before logging it to avoid errors.
ferventcoder added a commit that referenced this issue May 4, 2018
* stable:
  (version) 0.10.11
  (doc) update release notes for 0.10.11
  (GH-1540) Fix - AutoUninstaller can't find escaped quotes
  (GH-1543) Fix - log format error on install location with GUID
  (GH-1500) Fix - Wrap Write-Host if used in setup
  (GH-991) Install - Modify profile if file exists & empty
  (GH-1443) Set original config before loop
  (maint) add a note for GH-1548
  (GH-1557) Upgrade 7z to 18.5
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

3 participants