search

microsoft / winget-pkgs

The Microsoft community Windows Package Manager manifest repository
MIT License
8.38k stars 4.29k forks source link

[Package Issue]: AutoHotkey.AutoHotkey #162075

Closed Atario closed 2 weeks ago

Atario commented 2 weeks ago

Please confirm these before moving forward

Category of the issue

Installation issue.

Brief description of your issue

AutoHotkey.AutoHotkey v.2.0.18 won't install. v.2.0.17 was fine. Same result whether done as Administrator or not.

Steps to reproduce

winget install autohotkey.autohotkey or winget update autohotkey.autohotkey

Actual behavior

Errors out; installation not done.

Expected behavior

Installs normally.

Environment

Windows Package Manager v1.8.1791
Copyright (c) Microsoft Corporation. All rights reserved.

Windows: Windows.Desktop v10.0.22631.3737
System Architecture: X64
Package: Microsoft.DesktopAppInstaller v1.23.1791.0

Screenshots and Logs

Command line transcript:

PS C:\Users\Atario\AppData\Local\Temp\WinGet> winget install autohotkey.autohotkey
Found AutoHotkey [AutoHotkey.AutoHotkey] Version 2.0.18
This application is licensed to you by its owner.
Microsoft is not responsible for, nor does it grant any licenses to, third-party packages.
Successfully verified installer hash
An unexpected error occurred while executing the command:
copy_file: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"
PS C:\Users\Atario\AppData\Local\Temp\WinGet>

Log:

2024-07-09 03:20:17.633 [CORE] WinGet, version [1.8.1791], activity [{A5232280-516F-4F02-BCD7-0F35D97D8DCA}]
2024-07-09 03:20:17.633 [CORE] OS: Windows.Desktop v10.0.22631.3737
2024-07-09 03:20:17.633 [CORE] Command line Args: "C:\Users\Atario\AppData\Local\Microsoft\WindowsApps\winget.exe" install autohotkey.autohotkey
2024-07-09 03:20:17.633 [CORE] Package: Microsoft.DesktopAppInstaller v1.23.1791.0
2024-07-09 03:20:17.633 [CORE] IsCOMCall:0; Caller: winget-cli
2024-07-09 03:20:17.636 [CLI ] WinGet invoked with arguments: 'install' 'autohotkey.autohotkey'
2024-07-09 03:20:17.637 [CLI ] Found subcommand: install
2024-07-09 03:20:17.637 [CLI ] Leaf command to execute: root:install
2024-07-09 03:20:17.637 [CLI ] Executing command: install
2024-07-09 03:20:17.642 [REPO] Default source requested, multiple sources available, adding all to source references.
2024-07-09 03:20:17.642 [REPO] Adding to source references msstore
2024-07-09 03:20:17.642 [CORE] Default proxy is not set
2024-07-09 03:20:17.642 [REPO] REST HTTP Client helper does not use proxy
2024-07-09 03:20:17.642 [REPO] Adding to source references winget
2024-07-09 03:20:17.643 [CLI ] Created authentication arguments. Mode: silentPreferred, Account: 
2024-07-09 03:20:17.651 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2024-07-09 03:20:17.651 [CORE] Found matching extension.
2024-07-09 03:20:17.653 [REPO] Source `winget` after auto update time [15 mins]; it has been at least 17 mins
2024-07-09 03:20:17.656 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2024-07-09 03:20:17.656 [CORE] Found matching extension.
2024-07-09 03:20:17.740 [REPO] Multiple sources available, creating aggregated source.
2024-07-09 03:20:17.740 [REPO] Adding to aggregated source: msstore
2024-07-09 03:20:17.740 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2024-07-09 03:20:17.818 [REPO] Response status: 200
2024-07-09 03:20:17.818 [REPO] Authentication node not found. Assuming authentication type none.
2024-07-09 03:20:17.818 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2024-07-09 03:20:17.845 [REPO] Response status: 200
2024-07-09 03:20:17.845 [REPO] Authentication node not found. Assuming authentication type none.
2024-07-09 03:20:17.845 [REPO] Adding to aggregated source: winget
2024-07-09 03:20:17.849 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2024-07-09 03:20:17.849 [CORE] Found matching extension.
2024-07-09 03:20:17.864 [REPO] Opening database for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2024.709.1034.32_neutral__8wekyb3d8bbwe\Public\index.db'
2024-07-09 03:20:17.865 [REPO] Opened SQLite Index with version [1.7], last write [2024-07-09 02:32:59.000]
2024-07-09 03:20:18.022 [REPO] Creating new SQLite Index with version [Latest] at ':memory:'
2024-07-09 03:20:18.025 [REPO] Reading MSI UpgradeCodes
2024-07-09 03:20:18.091 [REPO] Reading MSI UpgradeCodes
2024-07-09 03:20:18.385 [REPO] Opening database for ReadWrite at 'C:\Users\Atario\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\StoreEdgeFD\installed.db'
2024-07-09 03:20:18.385 [REPO] Opened SQLite Index with version [1.3], last write [2024-01-10 09:32:07.000]
2024-07-09 03:20:18.389 [REPO] Sending http POST request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/manifestSearch
2024-07-09 03:20:18.411 [REPO] Response status: 200
2024-07-09 03:20:18.414 [REPO] Opening database for ReadWrite at 'C:\Users\Atario\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2024-07-09 03:20:18.414 [REPO] Opened SQLite Index with version [1.6], last write [2024-07-09 02:55:25.000]
2024-07-09 03:20:18.442 [CLI ] Found one app. App id: AutoHotkey.AutoHotkey App name: AutoHotkey
2024-07-09 03:20:18.445 [REPO] Attempting to open pinning database: C:\Users\Atario\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\pinning.db
2024-07-09 03:20:18.445 [REPO] ... opening existing pinning database
2024-07-09 03:20:18.445 [REPO] Opening database for Read at 'C:\Users\Atario\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\pinning.db'
2024-07-09 03:20:18.445 [REPO] Opened Pinning Index with version [1.0], last write [2024-01-10 12:59:02.000]
2024-07-09 03:20:18.446 [CLI ] Manifest fields: Name [AutoHotkey], Version [2.0.18]
2024-07-09 03:20:18.454 [CLI ] Found existing installer file at 'C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e'. Verifying file hash.
2024-07-09 03:20:18.458 [CLI ] Existing installer file hash matches. Will use existing installer.
2024-07-09 03:20:18.458 [CLI ] Installer hash verified
2024-07-09 03:20:18.458 [CORE] Started applying motw to C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e with zone: 2
2024-07-09 03:20:18.460 [CORE] Finished applying motw
2024-07-09 03:20:18.461 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(132)\WindowsPackageManager.dll!00007FF8E02D5A15: (caller: 00007FF8E00E1B21) LogHr(1) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:18.461 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(144)\WindowsPackageManager.dll!00007FF8E02D5A55: (caller: 00007FF8E00E1B21) LogHr(2) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:18.566 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(155)\WindowsPackageManager.dll!00007FF8E02D5A95: (caller: 00007FF8E00E1B21) LogHr(3) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:18.673 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(155)\WindowsPackageManager.dll!00007FF8E02D5A95: (caller: 00007FF8E00E1B21) LogHr(4) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:18.784 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(155)\WindowsPackageManager.dll!00007FF8E02D5A95: (caller: 00007FF8E00E1B21) LogHr(5) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:18.893 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(155)\WindowsPackageManager.dll!00007FF8E02D5A95: (caller: 00007FF8E00E1B21) LogHr(6) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:19.011 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(155)\WindowsPackageManager.dll!00007FF8E02D5A95: (caller: 00007FF8E00E1B21) LogHr(7) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: rename: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:19.011 [FAIL] C:\__w\1\s\external\pkg\src\AppInstallerSharedLib\Filesystem.cpp(170)\WindowsPackageManager.dll!00007FF8E02D5AD5: (caller: 00007FF8E00E1B21) LogHr(8) tid(6f4) 8007023E {Application Error}

The exception %s (0x    Msg:[std::exception: remove: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"] 

2024-07-09 03:20:19.014 [CLI ] Caught std::exception: copy_file: Access is denied.: "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\a30af310f45d4076cf1580bb08015db9a1337ddc1a99cf61829e645b196e8b2e", "C:\Users\Atario\AppData\Local\Temp\WinGet\AutoHotkey.AutoHotkey.2.0.18\AutoHotkey_2.0.18_setup.exe"
Dragon1573 commented 2 weeks ago

Unable to reproduce in amd64 Windows Sandbox instance.

image

stephengillie commented 2 weeks ago

I also couldn't reproduce the error. This package installed normally on a Windows 10 VM: image

@Atario, was this a fresh install or an upgrade?

Atario commented 2 weeks ago

@stephengillie, initially, it was an upgrade. But uninstalling and then installing does the same thing.

Atario commented 2 weeks ago

Update: Turns out antivirus was silently screwing it up. Adding an appropriate exception made it behave. Closing.