winget permanently stuck after attempting to uninstall chrome canary

[nihil-2019]

Brief description of your issue

as the title says, winget is completely stuck after i tried to uninstall Google.Chrome.Canary. basic commands that don't access the package databse, like winget --info work, but any commands that actually have to do with package management such as winget list & winget install get stuck permanently - as shown in the picture below the command will just set terminal color then return, while the spinner at the top of the windows terminal tab spins permanently until i close it.

i've uninstalled chrome manually from settings, rebooted, run winget source reset --force as admin, attempted to run winget in both windows powershell and powershell from store, & updated windows from 22509 to 22518. even still, every package management command freezes.

i've attached one of my logs below. in every log where winget freezes, it stops at the line [REPO] Examining ARP entries for User | X64 then nothing else is ever written to the log.

WinGet-2021-12-11-15-03-50.044.log

Steps to reproduce

1. winget install Google.Chrome.Canary
2. winget uninstall Google.Chrome.Canary

Expected behavior

winget uninstalls chrome canary and/or successfully manages packages after the command was run

Actual behavior

winget completely fails to manage or query packages permanently after the command is run

Environment

[winget --info]
Windows Package Manager (Preview) v1.2.3411-preview
Copyright (c) Microsoft Corporation. All rights reserved.

Windows: Windows.Desktop v10.0.22518.1000
Package: Microsoft.DesktopAppInstaller v1.17.3411.0

Logs: %LOCALAPPDATA%\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir

Links
---------------------------------------------------------------------------
Privacy Statement   https://aka.ms/winget-privacy
License Agreement   https://aka.ms/winget-license
Third Party Notices https://aka.ms/winget-3rdPartyNotice
Homepage            https://aka.ms/winget
Windows Store Terms https://www.microsoft.com/en-us/storedocs/terms-of-sale

[jedieaston]

Can you run winget list --verbose-logs and post the log file? I doubt it'll get any farther, but I wonder if there's anything else in there...

[nihil-2019]

@jedieaston

WinGet-2021-12-11-17-38-07.320.log

log looks like it's stepping through the db like normal then just stopping randomly. interestingly enough, this time it created a completely empty log file named WPM-2021-12-11-15-19-40.190.log.

[jedieaston]

Since it's the weekend, nobody from MS is around, but can you make a Feedback Hub for this and post the link? That captures some more telemetry that isn't in the log.

[florelis]

I looked a bit at the logs. It stopped right after finishing adding one of the ARP entries, so I think it's crashing either on reading the next ARP entry or on the step following reading them.

I imagine it's not in reading the ARP entry but we could double check that. Could you compare the registry keys under HKCU:\SOFTWARE\Microsoft\Windows\CurrentVersion\Uninstall (the ARP entries) against the lines in the verbose logs that say Adding manifest entry for [...], starting from the line Examining ARP entries for User | X64? If there is any entry that is in the registry but not in the logs, it may be that that key is causing issues when reading it.

If that's not it, then it may be the step immediately after reading the ARP entries, which I believe is reading the installed MSIX packages. My only guess there would be to try and see if Get-AppPackage works in PS to list them, if that fails then the error would be in listing those packages.

[awg43]

Not only after installing chrome, but after the command "winget list" the command freezes. The verbose log shows: WinGet-2022-04-18-16-39-05.249.log

2022-04-18 16:39:05.250 [CORE] WinGet, version [1.2.10271], activity [{0BCD3AD6-CBE2-4541-BBDC-4B731BD54CDB}] 2022-04-18 16:39:05.250 [CORE] OS: Windows.Desktop v10.0.22000.613 2022-04-18 16:39:05.250 [CORE] Command line Args: "C:\Users\Albert\AppData\Local\Microsoft\WindowsApps\winget.exe" list 2022-04-18 16:39:05.250 [CORE] Package: Microsoft.DesktopAppInstaller v1.17.10271.0 2022-04-18 16:39:05.250 [CORE] IsCOMCall:0; Caller: winget-cli 2022-04-18 16:39:05.255 [CLI ] WinGet invoked with arguments: 'list' 2022-04-18 16:39:05.255 [CLI ] Found subcommand: list 2022-04-18 16:39:05.255 [CLI ] Leaf command to execute: root:list 2022-04-18 16:39:05.255 [CLI ] Executing command: list 2022-04-18 16:39:05.257 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped. 2022-04-18 16:39:05.257 [REPO] Default source requested, multiple sources available, adding all to source references. 2022-04-18 16:39:05.257 [REPO] Adding to source references msstore 2022-04-18 16:39:05.257 [REPO] Adding to source references winget 2022-04-18 16:39:05.258 [REPO] Source past auto update time [5 mins]; it has been at least 238 mins 2022-04-18 16:39:05.258 [REPO] Source past auto update time [5 mins]; it has been at least 238 mins 2022-04-18 16:39:06.435 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB 2022-04-18 16:39:06.435 [CORE] Found matching extension. 2022-04-18 16:39:06.438 [CORE] Downloading to path: C:\Users\Albert\AppData\Local\Temp\WinGet\Microsoft.Winget.Source_8wekyb3d8bbwe.msix 2022-04-18 16:39:06.438 [CORE] Started applying motw to C:\Users\Albert\AppData\Local\Temp\WinGet\Microsoft.Winget.Source_8wekyb3d8bbwe.msix with zone: 3 2022-04-18 16:39:06.441 [CORE] Finished applying motw 2022-04-18 16:39:06.441 [CORE] WinINet downloading from url: https://winget.azureedge.net/cache/source.msix 2022-04-18 16:39:07.536 [CORE] Download completed. 2022-04-18 16:39:07.536 [CORE] Starting AddPackage operation #0: file:///C:/Users/Albert/AppData/Local/Temp/WinGet/Microsoft.Winget.Source_8wekyb3d8bbwe.msix SkipSmartScreen: 1 2022-04-18 16:39:07.539 [CORE] Begin waiting for operation #0 2022-04-18 16:39:07.539 [CORE] Begin blocking for operation #0 2022-04-18 16:39:08.363 [CORE] Successfully completed #0 2022-04-18 16:39:08.371 [REPO] Multiple sources available, creating aggregated source. 2022-04-18 16:39:08.371 [REPO] Adding to aggregated source: msstore 2022-04-18 16:39:08.371 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information 2022-04-18 16:39:08.523 [REPO] Response status: 200 2022-04-18 16:39:08.524 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information 2022-04-18 16:39:08.615 [REPO] Response status: 200 2022-04-18 16:39:08.616 [REPO] Adding to aggregated source: winget 2022-04-18 16:39:08.629 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB 2022-04-18 16:39:08.629 [CORE] Found matching extension. 2022-04-18 16:39:08.648 [REPO] Opening SQLite Index for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2022.418.1321.908_neutral__8wekyb3d8bbwe\Public\index.db' 2022-04-18 16:39:08.648 [SQL ] Opening SQLite connection: 'file:/C:/Program Files/WindowsApps/Microsoft.Winget.Source_2022.418.1321.908_neutral__8wekyb3d8bbwe/Public/index.db?immutable=1' [1, 40] 2022-04-18 16:39:08.648 [REPO] Opened SQLite Index with version [1.3], last write [2022-04-18 14:21:06.000] 2022-04-18 16:39:08.686 [REPO] Creating PredefinedInstalledSource with filter [None] 2022-04-18 16:39:08.686 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:' 2022-04-18 16:39:08.686 [SQL ] Opening SQLite connection: ':memory:' [6, 0] 2022-04-18 16:39:08.725 [REPO] Examining ARP entries for Machine | X64 2022-04-18 16:39:08.762 [REPO] Examining ARP entries for Machine | X86 2022-04-18 16:39:08.783 [FAIL] D:\a_work\1\s\external\pkg\src\AppInstallerRepositoryCore\Microsoft\Schema\1_0\Interface_1_0.cpp(184)\WindowsPackageManager.dll!00007FFB46382465: (caller: 00007FFB4637EC83) Exception(1) tid(1ca0) 800700B7 Kan geen bestand maken dat al bestaat. 2022-04-18 16:39:08.784 [REPO] Ignoring duplicate ARP entry Machine|X86|xampp [XAMPP] 2022-04-18 16:39:08.808 [REPO] Examining ARP entries for User | X64

After the last line the window freezes, showing:

=== The command winget source reset -- force worked fine. But problem remains.

winget search works fine

How can i solve this problem?

[denelon]

@awg43

Which version of the Windows Package Manager are you using?

winget -v will display the version.

Does this same thing happen on the latest release candidate build?

[Inori]

@awg43

Which version of the Windows Package Manager are you using?

winget -v will display the version.

Does this same thing happen on the latest release candidate build?

Same here

winget -v
v1.3.2691

For me, it simply stuck at the very begin:

2022-10-19 23:12:51.314 [CORE] WinGet, version [1.3.2691], activity [{BD2FA043-885D-4677-AA33-2EA90B8BF683}]
2022-10-19 23:12:51.314 [CORE] OS: Windows.Desktop v10.0.22621.674
2022-10-19 23:12:51.314 [CORE] Command line Args: "C:\Users\bingk\AppData\Local\Microsoft\WindowsApps\winget.exe" list --verbose-logs
2022-10-19 23:12:51.314 [CORE] Package: Microsoft.DesktopAppInstaller v1.18.2691.0
2022-10-19 23:12:51.314 [CORE] IsCOMCall:0; Caller: winget-cli
2022-10-19 23:12:51.317 [CLI ] WinGet invoked with arguments: 'list' '--verbose-logs'
2022-10-19 23:12:51.317 [CLI ] Found subcommand: list
2022-10-19 23:12:51.317 [CLI ] Leaf command to execute: root:list
2022-10-19 23:12:51.317 [CLI ] Executing command: list
2022-10-19 23:12:51.320 [CORE] Setting action: Get, Type: Secure, Name: user_sources
2022-10-19 23:12:51.325 [CORE] Setting action: Get, Type: Standard, Name: sources_metadata
2022-10-19 23:12:51.325 [YAML] Detected UTF-8
2022-10-19 23:12:51.325 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped.
2022-10-19 23:12:51.325 [REPO] Default source requested, multiple sources available, adding all to source references.
2022-10-19 23:12:51.325 [REPO] Adding to source references msstore
2022-10-19 23:12:51.325 [REPO] Adding to source references winget
2022-10-19 23:12:51.326 [CORE] Setting action: Get, Type: Secure, Name: user_sources
2022-10-19 23:12:51.326 [CORE] Setting action: Get, Type: Standard, Name: sources_metadata
2022-10-19 23:12:51.326 [YAML] Detected UTF-8
2022-10-19 23:12:51.326 [REPO] Source past auto update time [5 mins]; it has been at least 27769872 mins