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

winget 1.4.2011-preview can't install MSI-based applications #2365

Closed
manelrodero opened this issue Jul 23, 2022 · 25 comments · Fixed by #2370
Closed

winget 1.4.2011-preview can't install MSI-based applications #2365

manelrodero opened this issue Jul 23, 2022 · 25 comments · Fixed by #2370
Labels
Issue-Bug It either shouldn't be doing this or needs an investigation.
Milestone

Comments

@manelrodero
Copy link

I was trying to upgrade my winget installation (I had 1.1.12653) to be able to use --architecture with some programs.

After installing latest release available (1.4.2011-preview) I can't install any applications that are MSI-based (like Google.Chrome). Installer failed with error code 1619.

image

I've I install latest stable version (1.2.10271) I can install it without problems:

image

Log file for failed install is this one:

2022-07-23 20:37:17.459 [CORE] WinGet, version [1.4.2011-preview], activity [{BF5118D9-069A-4A79-827A-2C7916E2A8C9}]
2022-07-23 20:37:17.459 [CORE] OS: Windows.Desktop v10.0.22000.795
2022-07-23 20:37:17.459 [CORE] Command line Args: "C:\Users\WDAGUtilityAccount\AppData\Local\Microsoft\WindowsApps\winget.exe" install -e --id Google.Chrome
2022-07-23 20:37:17.459 [CORE] Package: Microsoft.DesktopAppInstaller v1.19.2011.0
2022-07-23 20:37:17.459 [CORE] IsCOMCall:0; Caller: winget-cli
2022-07-23 20:37:17.461 [CLI ] WinGet invoked with arguments: 'install' '-e' '--id' 'Google.Chrome'
2022-07-23 20:37:17.461 [CLI ] Found subcommand: install
2022-07-23 20:37:17.461 [CLI ] Leaf command to execute: root:install
2022-07-23 20:37:17.462 [CLI ] Executing command: install
2022-07-23 20:37:17.462 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped.
2022-07-23 20:37:17.462 [REPO] Default source requested, multiple sources available, adding all to source references.
2022-07-23 20:37:17.462 [REPO] Adding to source references msstore
2022-07-23 20:37:17.462 [REPO] Adding to source references winget
2022-07-23 20:37:17.463 [REPO] Multiple sources available, creating aggregated source.
2022-07-23 20:37:17.463 [REPO] Adding to aggregated source: msstore
2022-07-23 20:37:17.463 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 20:37:17.631 [REPO] Response status: 200
2022-07-23 20:37:17.631 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 20:37:17.706 [REPO] Response status: 200
2022-07-23 20:37:17.706 [REPO] Adding to aggregated source: winget
2022-07-23 20:37:17.715 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2022-07-23 20:37:17.715 [CORE] Found matching extension.
2022-07-23 20:37:17.729 [REPO] Opening SQLite Index for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe\Public\index.db'
2022-07-23 20:37:17.729 [SQL ] Opening SQLite connection: 'file:/C:/Program Files/WindowsApps/Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe/Public/index.db?immutable=1' [1, 40]
2022-07-23 20:37:17.729 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 12:01:26.000]
2022-07-23 20:37:17.835 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/packageManifests/Google.Chrome?Market=US
2022-07-23 20:37:17.879 [REPO] Response status: 200
2022-07-23 20:37:17.882 [CLI ] Found one app. App id: Google.Chrome App name: Google Chrome
2022-07-23 20:37:17.883 [REPO] Downloading manifest
2022-07-23 20:37:17.883 [CORE] WinINet downloading from url: https://cdn.winget.microsoft.com/cache/manifests/g/Google/Chrome/103.0.5060.134/9496-Google.Chrome.yaml
2022-07-23 20:37:17.894 [CORE] Download hash: c16a53e79469d05c1bd30ed3721a42b4d2264b8cd91686af103a6d4cde2699a1
2022-07-23 20:37:17.894 [CORE] Download completed.
2022-07-23 20:37:17.895 [CLI ] Manifest fields: Name [Google Chrome], Version [103.0.5060.134]
2022-07-23 20:37:17.896 [CLI ] Starting installer selection.
2022-07-23 20:37:17.896 [CLI ] Completed installer selection.
2022-07-23 20:37:17.902 [CLI ] Found existing installer file at 'C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi'. Verifying file hash.
2022-07-23 20:37:18.055 [CLI ] Existing installer file hash matches. Will use existing installer.
2022-07-23 20:37:18.055 [CLI ] Installer hash verified
2022-07-23 20:37:18.055 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi with zone: 2
2022-07-23 20:37:18.057 [CORE] Finished applying motw
2022-07-23 20:37:18.057 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 20:37:18.057 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 20:37:18.057 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 20:37:18.088 [REPO] Examining ARP entries for Machine | X64
2022-07-23 20:37:18.088 [REPO] Examining ARP entries for Machine | X86
2022-07-23 20:37:18.090 [REPO] Examining ARP entries for User | X64
2022-07-23 20:37:18.094 [CLI ] Installer args: /passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-20-37-18.094.log"
2022-07-23 20:37:18.094 [CLI ] Starting: 'C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi' with arguments '/passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-20-37-18.094.log"'
2022-07-23 20:37:18.475 [CLI ] ShellExecute installer failed: 1619
2022-07-23 20:37:18.476 [CLI ] Terminating context: 0x8a150006 at D:\a\_work\1\s\external\pkg\src\AppInstallerCLICore\Workflows\InstallFlow.cpp:1f9

Log file for successful install is this one:

2022-07-23 20:42:15.114 [CORE] WinGet, version [1.2.10271], activity [{F54D6FC3-852E-404E-B8EC-3E83B477939F}]
2022-07-23 20:42:15.114 [CORE] OS: Windows.Desktop v10.0.22000.795
2022-07-23 20:42:15.114 [CORE] Command line Args: "C:\Users\WDAGUtilityAccount\AppData\Local\Microsoft\WindowsApps\winget.exe" install -e --id Google.Chrome
2022-07-23 20:42:15.115 [CORE] Package: Microsoft.DesktopAppInstaller v1.17.10271.0
2022-07-23 20:42:15.115 [CORE] IsCOMCall:0; Caller: winget-cli
2022-07-23 20:42:15.117 [CLI ] WinGet invoked with arguments: 'install' '-e' '--id' 'Google.Chrome'
2022-07-23 20:42:15.117 [CLI ] Found subcommand: install
2022-07-23 20:42:15.117 [CLI ] Leaf command to execute: root:install
2022-07-23 20:42:15.118 [CLI ] Executing command: install
2022-07-23 20:42:15.118 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped.
2022-07-23 20:42:15.118 [REPO] Default source requested, multiple sources available, adding all to source references.
2022-07-23 20:42:15.118 [REPO] Adding to source references msstore
2022-07-23 20:42:15.118 [REPO] Adding to source references winget
2022-07-23 20:42:15.118 [REPO] Multiple sources available, creating aggregated source.
2022-07-23 20:42:15.118 [REPO] Adding to aggregated source: msstore
2022-07-23 20:42:15.118 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 20:42:15.193 [REPO] Response status: 200
2022-07-23 20:42:15.193 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 20:42:15.254 [REPO] Response status: 200
2022-07-23 20:42:15.254 [REPO] Adding to aggregated source: winget
2022-07-23 20:42:15.263 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2022-07-23 20:42:15.263 [CORE] Found matching extension.
2022-07-23 20:42:15.277 [REPO] Opening SQLite Index for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe\Public\index.db'
2022-07-23 20:42:15.277 [SQL ] Opening SQLite connection: 'file:/C:/Program Files/WindowsApps/Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe/Public/index.db?immutable=1' [1, 40]
2022-07-23 20:42:15.278 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 12:01:26.000]
2022-07-23 20:42:15.487 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/packageManifests/Google.Chrome?Market=US
2022-07-23 20:42:15.497 [REPO] Response status: 200
2022-07-23 20:42:15.500 [CLI ] Found one app. App id: Google.Chrome App name: Google Chrome
2022-07-23 20:42:15.501 [REPO] Downloading manifest
2022-07-23 20:42:15.501 [CORE] WinINet downloading from url: https://winget.azureedge.net/cache/manifests/g/Google/Chrome/103.0.5060.134/9496-Google.Chrome.yaml
2022-07-23 20:42:16.048 [CORE] Download hash: c16a53e79469d05c1bd30ed3721a42b4d2264b8cd91686af103a6d4cde2699a1
2022-07-23 20:42:16.048 [CORE] Download completed.
2022-07-23 20:42:16.048 [CLI ] Manifest fields: Name [Google Chrome], Version [103.0.5060.134]
2022-07-23 20:42:16.049 [CLI ] Starting installer selection.
2022-07-23 20:42:16.049 [CLI ] Completed installer selection.
2022-07-23 20:42:16.056 [CLI ] Generated temp download path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 20:42:16.056 [CORE] Downloading to path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 20:42:16.056 [CORE] DeliveryOptimization downloading from url: https://dl.google.com/dl/chrome/install/googlechromestandaloneenterprise64.msi
2022-07-23 20:42:20.034 [CORE] Download completed.
2022-07-23 20:42:20.109 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 3
2022-07-23 20:42:20.111 [CORE] Finished applying motw
2022-07-23 20:42:20.111 [CLI ] Installer hash verified
2022-07-23 20:42:20.111 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 2
2022-07-23 20:42:20.112 [CORE] Finished applying motw
2022-07-23 20:42:20.112 [CLI ] Successfully renamed downloaded installer. Path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 20:42:20.112 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 20:42:20.112 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 20:42:20.112 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 20:42:20.141 [REPO] Examining ARP entries for Machine | X64
2022-07-23 20:42:20.141 [REPO] Examining ARP entries for Machine | X86
2022-07-23 20:42:20.142 [REPO] Examining ARP entries for User | X64
2022-07-23 20:42:20.225 [CLI ] Installer args: /passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-20-42-20.225.log"
2022-07-23 20:42:20.225 [CLI ] Starting: 'C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi' with arguments '/passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-20-42-20.225.log"'
2022-07-23 20:42:38.331 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 20:42:38.331 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 20:42:38.331 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 20:42:38.365 [REPO] Examining ARP entries for Machine | X64
2022-07-23 20:42:38.367 [REPO] Examining ARP entries for Machine | X86
2022-07-23 20:42:38.368 [REPO] Examining ARP entries for User | X64
2022-07-23 20:42:38.441 [CLI ] During package install, 1 changes to ARP were observed, 1 matches were found for the package, and 1 packages were in both
2022-07-23 20:42:38.441 [CLI ] The entry determined to be associated with the package is 'Google Chrome', with publisher 'Google LLC'
2022-07-23 20:42:38.451 [REPO] Creating new SQLite Index [4294967295.4294967295] at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 20:42:38.451 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [6, 0]
2022-07-23 20:42:38.490 [REPO] Opening SQLite Index for ReadWrite at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 20:42:38.490 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [2, 0]
2022-07-23 20:42:38.490 [REPO] Opened SQLite Index with version [1.3], last write [2022-07-23 20:42:38.000]
2022-07-23 20:42:38.526 [CLI ] Removing installer: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 20:42:38.527 [CLI ] Leaf command succeeded: root:install
@ghost ghost added the Needs-Triage Issue need to be triaged label Jul 23, 2022
@manelrodero manelrodero changed the title winget 1.4.2011-preview can't install applications MSI-based winget 1.4.2011-preview can't install MSI-based applications Jul 23, 2022
@denelon denelon added Issue-Bug It either shouldn't be doing this or needs an investigation. and removed Needs-Triage Issue need to be triaged labels Jul 23, 2022
@denelon
Copy link
Contributor

denelon commented Jul 23, 2022

@manelrodero great detail here. I'll ask the team to dig in on Monday.

@denelon denelon added this to the v1.4-Client milestone Jul 23, 2022
@manelrodero
Copy link
Author

Just tested 1.3.1681 and it works well with MSI:

image

Here is the log:

2022-07-23 21:13:51.470 [CORE] WinGet, version [1.3.1681], activity [{9C90FF69-1392-4656-B7DC-CFFD0267A981}]
2022-07-23 21:13:51.470 [CORE] OS: Windows.Desktop v10.0.22000.795
2022-07-23 21:13:51.470 [CORE] Command line Args: winget  install -e --id Google.Chrome
2022-07-23 21:13:51.470 [CORE] Package: Microsoft.DesktopAppInstaller v1.18.1681.0
2022-07-23 21:13:51.470 [CORE] IsCOMCall:0; Caller: winget-cli
2022-07-23 21:13:51.472 [CLI ] WinGet invoked with arguments: 'install' '-e' '--id' 'Google.Chrome'
2022-07-23 21:13:51.472 [CLI ] Found subcommand: install
2022-07-23 21:13:51.472 [CLI ] Leaf command to execute: root:install
2022-07-23 21:13:51.473 [CLI ] Executing command: install
2022-07-23 21:13:51.474 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped.
2022-07-23 21:13:51.474 [REPO] Default source requested, multiple sources available, adding all to source references.
2022-07-23 21:13:51.474 [REPO] Adding to source references msstore
2022-07-23 21:13:51.474 [REPO] Adding to source references winget
2022-07-23 21:13:51.474 [REPO] Multiple sources available, creating aggregated source.
2022-07-23 21:13:51.474 [REPO] Adding to aggregated source: msstore
2022-07-23 21:13:51.474 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 21:13:51.551 [REPO] Response status: 200
2022-07-23 21:13:51.551 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 21:13:51.600 [REPO] Response status: 200
2022-07-23 21:13:51.600 [REPO] Adding to aggregated source: winget
2022-07-23 21:13:51.610 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2022-07-23 21:13:51.610 [CORE] Found matching extension.
2022-07-23 21:13:51.623 [REPO] Opening SQLite Index for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe\Public\index.db'
2022-07-23 21:13:51.623 [SQL ] Opening SQLite connection: 'file:/C:/Program Files/WindowsApps/Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe/Public/index.db?immutable=1' [1, 40]
2022-07-23 21:13:51.624 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 12:01:26.000]
2022-07-23 21:13:51.839 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/packageManifests/Google.Chrome?Market=US
2022-07-23 21:13:51.879 [REPO] Response status: 200
2022-07-23 21:13:51.882 [CLI ] Found one app. App id: Google.Chrome App name: Google Chrome
2022-07-23 21:13:51.882 [REPO] Downloading manifest
2022-07-23 21:13:51.882 [CORE] WinINet downloading from url: https://cdn.winget.microsoft.com/cache/manifests/g/Google/Chrome/103.0.5060.134/9496-Google.Chrome.yaml
2022-07-23 21:13:52.571 [CORE] Download hash: c16a53e79469d05c1bd30ed3721a42b4d2264b8cd91686af103a6d4cde2699a1
2022-07-23 21:13:52.571 [CORE] Download completed.
2022-07-23 21:13:52.572 [CLI ] Manifest fields: Name [Google Chrome], Version [103.0.5060.134]
2022-07-23 21:13:52.572 [CLI ] Starting installer selection.
2022-07-23 21:13:52.572 [CLI ] Completed installer selection.
2022-07-23 21:13:52.579 [CLI ] Generated temp download path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 21:13:52.579 [CORE] Downloading to path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 21:13:52.579 [CORE] DeliveryOptimization downloading from url: https://dl.google.com/dl/chrome/install/googlechromestandaloneenterprise64.msi
2022-07-23 21:13:56.641 [CORE] Download completed.
2022-07-23 21:13:56.717 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 3
2022-07-23 21:13:56.718 [CORE] Finished applying motw
2022-07-23 21:13:56.719 [CLI ] Installer hash verified
2022-07-23 21:13:56.719 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 2
2022-07-23 21:13:56.719 [CORE] Finished applying motw
2022-07-23 21:13:56.720 [CLI ] Successfully renamed downloaded installer. Path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 21:13:56.720 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 21:13:56.720 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 21:13:56.720 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 21:13:56.752 [REPO] Examining ARP entries for Machine | X64
2022-07-23 21:13:56.752 [REPO] Examining ARP entries for Machine | X86
2022-07-23 21:13:56.754 [REPO] Examining ARP entries for User | X64
2022-07-23 21:13:56.833 [CLI ] Installer args: /passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-21-13-56.833.log"
2022-07-23 21:13:56.833 [CLI ] Starting: 'C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi' with arguments '/passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-21-13-56.833.log"'
2022-07-23 21:14:14.470 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 21:14:14.470 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 21:14:14.470 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 21:14:14.507 [REPO] Examining ARP entries for Machine | X64
2022-07-23 21:14:14.508 [REPO] Examining ARP entries for Machine | X86
2022-07-23 21:14:14.510 [REPO] Examining ARP entries for User | X64
2022-07-23 21:14:14.580 [CLI ] During package install, 1 changes to ARP were observed, 1 matches were found for the package, and 1 packages were in both
2022-07-23 21:14:14.580 [CLI ] The entry determined to be associated with the package is 'Google Chrome', with publisher 'Google LLC'
2022-07-23 21:14:14.590 [REPO] Creating new SQLite Index [4294967295.4294967295] at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 21:14:14.590 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [6, 0]
2022-07-23 21:14:14.631 [REPO] Opening SQLite Index for ReadWrite at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 21:14:14.631 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [2, 0]
2022-07-23 21:14:14.631 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 21:14:14.000]
2022-07-23 21:14:14.665 [CLI ] Removing installer: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 21:14:14.665 [CLI ] Leaf command succeeded: root:install

Note: This post from Broadcom explains that error code 1619 is related to incorrect reference of the MSI file (https://knowledge.broadcom.com/external/article/156944/windows-installer-error-1619-using-softw.html).

I hope you can find the problem ;-)

@denelon
Copy link
Contributor

denelon commented Jul 23, 2022

Thanks for the additional information. I was just about to ask about about the latest 1.3. I doubt there is much difference between the version you tested (1.3.1681) and the 1.3.1872 release candidate.

@manelrodero
Copy link
Author

Here is the info about 1.3.1872. It works well and can install MSI packages as expected.

image

2022-07-23 21:55:58.664 [CORE] WinGet, version [1.3.1872], activity [{B0164E99-C5D3-4ECD-A503-41EFF245E649}]
2022-07-23 21:55:58.664 [CORE] OS: Windows.Desktop v10.0.22000.795
2022-07-23 21:55:58.664 [CORE] Command line Args: "C:\Users\WDAGUtilityAccount\AppData\Local\Microsoft\WindowsApps\winget.exe" install -e --id Google.Chrome
2022-07-23 21:55:58.664 [CORE] Package: Microsoft.DesktopAppInstaller v1.18.1872.0
2022-07-23 21:55:58.664 [CORE] IsCOMCall:0; Caller: winget-cli
2022-07-23 21:55:58.666 [CLI ] WinGet invoked with arguments: 'install' '-e' '--id' 'Google.Chrome'
2022-07-23 21:55:58.666 [CLI ] Found subcommand: install
2022-07-23 21:55:58.666 [CLI ] Leaf command to execute: root:install
2022-07-23 21:55:58.667 [CLI ] Executing command: install
2022-07-23 21:55:58.667 [REPO] GetCurrentSourceRefs: Source named 'microsoft.builtin.desktop.frameworks' from origin Default is hidden and is dropped.
2022-07-23 21:55:58.667 [REPO] Default source requested, multiple sources available, adding all to source references.
2022-07-23 21:55:58.667 [REPO] Adding to source references msstore
2022-07-23 21:55:58.667 [REPO] Adding to source references winget
2022-07-23 21:55:58.668 [REPO] Multiple sources available, creating aggregated source.
2022-07-23 21:55:58.668 [REPO] Adding to aggregated source: msstore
2022-07-23 21:55:58.668 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 21:55:58.753 [REPO] Response status: 200
2022-07-23 21:55:58.753 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/information
2022-07-23 21:55:58.804 [REPO] Response status: 200
2022-07-23 21:55:58.804 [REPO] Adding to aggregated source: winget
2022-07-23 21:55:58.813 [CORE] Examining extension: PFN = Microsoft.Winget.Source_8wekyb3d8bbwe, ID = IndexDB
2022-07-23 21:55:58.813 [CORE] Found matching extension.
2022-07-23 21:55:58.827 [REPO] Opening SQLite Index for ImmutableRead at 'C:\Program Files\WindowsApps\Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe\Public\index.db'
2022-07-23 21:55:58.827 [SQL ] Opening SQLite connection: 'file:/C:/Program Files/WindowsApps/Microsoft.Winget.Source_2022.723.1102.118_neutral__8wekyb3d8bbwe/Public/index.db?immutable=1' [1, 40]
2022-07-23 21:55:58.827 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 12:01:26.000]
2022-07-23 21:55:59.024 [REPO] Sending http GET request to: https://storeedgefd.dsx.mp.microsoft.com/v9.0/packageManifests/Google.Chrome?Market=US
2022-07-23 21:55:59.036 [REPO] Response status: 200
2022-07-23 21:55:59.039 [CLI ] Found one app. App id: Google.Chrome App name: Google Chrome
2022-07-23 21:55:59.040 [REPO] Downloading manifest
2022-07-23 21:55:59.040 [CORE] WinINet downloading from url: https://cdn.winget.microsoft.com/cache/manifests/g/Google/Chrome/103.0.5060.134/9496-Google.Chrome.yaml
2022-07-23 21:55:59.656 [CORE] Download hash: c16a53e79469d05c1bd30ed3721a42b4d2264b8cd91686af103a6d4cde2699a1
2022-07-23 21:55:59.656 [CORE] Download completed.
2022-07-23 21:55:59.656 [CLI ] Manifest fields: Name [Google Chrome], Version [103.0.5060.134]
2022-07-23 21:55:59.657 [CLI ] Starting installer selection.
2022-07-23 21:55:59.657 [CLI ] Completed installer selection.
2022-07-23 21:55:59.664 [CLI ] Generated temp download path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 21:55:59.665 [CORE] Downloading to path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154
2022-07-23 21:55:59.665 [CORE] DeliveryOptimization downloading from url: https://dl.google.com/dl/chrome/install/googlechromestandaloneenterprise64.msi
2022-07-23 21:56:04.418 [CORE] Download completed.
2022-07-23 21:56:04.494 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 3
2022-07-23 21:56:04.495 [CORE] Finished applying motw
2022-07-23 21:56:04.496 [CLI ] Installer hash verified
2022-07-23 21:56:04.496 [CORE] Started applying motw to C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\e0bb4e70d7c0872ac8b6ebe6b5c82191b1c64ec9b36bbe0fd3b2e08cff6c5154 with zone: 2
2022-07-23 21:56:04.497 [CORE] Finished applying motw
2022-07-23 21:56:04.497 [CLI ] Successfully renamed downloaded installer. Path: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 21:56:04.497 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 21:56:04.497 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 21:56:04.497 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 21:56:04.528 [REPO] Examining ARP entries for Machine | X64
2022-07-23 21:56:04.529 [REPO] Examining ARP entries for Machine | X86
2022-07-23 21:56:04.531 [REPO] Examining ARP entries for User | X64
2022-07-23 21:56:04.605 [CLI ] Installer args: /passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-21-56-04.605.log"
2022-07-23 21:56:04.606 [CLI ] Starting: 'C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi' with arguments '/passive /log "C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\DiagOutputDir\WinGet-Google.Chrome.103.0.5060.134-2022-07-23-21-56-04.605.log"'
2022-07-23 21:56:22.384 [REPO] Creating PredefinedInstalledSource with filter [ARP]
2022-07-23 21:56:22.384 [REPO] Creating new SQLite Index [4294967295.4294967295] at ':memory:'
2022-07-23 21:56:22.384 [SQL ] Opening SQLite connection: ':memory:' [6, 0]
2022-07-23 21:56:22.423 [REPO] Examining ARP entries for Machine | X64
2022-07-23 21:56:22.424 [REPO] Examining ARP entries for Machine | X86
2022-07-23 21:56:22.426 [REPO] Examining ARP entries for User | X64
2022-07-23 21:56:22.494 [CLI ] During package install, 1 changes to ARP were observed, 1 matches were found for the package, and 1 packages were in both
2022-07-23 21:56:22.494 [CLI ] The entry determined to be associated with the package is 'Google Chrome', with publisher 'Google LLC'
2022-07-23 21:56:22.507 [REPO] Creating new SQLite Index [4294967295.4294967295] at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 21:56:22.507 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [6, 0]
2022-07-23 21:56:22.557 [REPO] Opening SQLite Index for ReadWrite at 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db'
2022-07-23 21:56:22.557 [SQL ] Opening SQLite connection: 'C:\Users\WDAGUtilityAccount\AppData\Local\Packages\Microsoft.DesktopAppInstaller_8wekyb3d8bbwe\LocalState\Microsoft.Winget.Source_8wekyb3d8bbwe\installed.db' [2, 0]
2022-07-23 21:56:22.557 [REPO] Opened SQLite Index with version [1.5], last write [2022-07-23 21:56:22.000]
2022-07-23 21:56:22.595 [CLI ] Removing installer: C:\Users\WDAGUtilityAccount\AppData\Local\Temp\WinGet\Google.Chrome.103.0.5060.134\googlechromestandaloneenterprise64.msi
2022-07-23 21:56:22.596 [CLI ] Leaf command succeeded: root:install

@manelrodero
Copy link
Author

I don't know if it will help, I have overridden the parameters (/qf) to see the Google Chrome interface and there is a problem reading the file.

image

If I unblock the Internet file it fails too. And the same error if I double click the downloaded MSI file.

I can test the same with PuTTY. Error installing with winget and also executing the MSI:

image

Could it be that this version does not download the files correctly and they are corrupted?

@Trenly
Copy link
Contributor

Trenly commented Jul 23, 2022

I wonder if this is related to #2324

@jedieaston
Copy link
Contributor

jedieaston commented Jul 25, 2022

It is related to #2324, I think SYSTEM needs to be able to explicitly read/write/execute (so Full Control) the MSI for it to work correctly (which makes sense, since Windows Installer's service runs as SYSTEM). Adding SYSTEM to the ACLs fixes it for me.

@JohnMcPMS
Copy link
Member

100% I would expect any new file access issues to be related to #2324 .

Will have to look into why our tests that install MSI don't fail, but I guess I can give SYSTEM explicit access. Not like it can't just take it if it wants anyway...

@ghost ghost added the In-PR Issue related to a PR label Jul 26, 2022
@ghost ghost added Resolution-Fix-Committed and removed In-PR Issue related to a PR labels Jul 26, 2022
@scimg
Copy link

scimg commented Jul 28, 2022

The same problem for CMake, with the same winget version. Has it been resolved?

@denelon
Copy link
Contributor

denelon commented Jul 28, 2022

We still need to cut a release with the changes.

@MarcoPeraza
Copy link

MarcoPeraza commented Jul 31, 2022

Is it possible to downgrade? Or a source of daily builds perhaps?

[Edit] I see they are here: https://github.com/jedieaston/winget-build . Very cool!

@mavaddat
Copy link

I have been having this same issue with my winget for about two weeks now. Can I provide logs that might help?

@denelon
Copy link
Contributor

denelon commented Aug 1, 2022

We've merged the fix into the codebase, and we just need to cut a new release.

@denelon denelon unpinned this issue Aug 8, 2022
@xixifaha
Copy link

xixifaha commented Aug 9, 2022

I upgraded the version and I can't upgrade now. What should i do?

@xixifaha
Copy link

xixifaha commented Aug 9, 2022

I can't find a way to uninstall it.

@ItzLevvie
Copy link

ItzLevvie commented Aug 9, 2022

I upgraded the version and I can't upgrade now.

cc @xixifaha: You can install https://github.com/microsoft/winget-cli/releases/download/v1.4.2161-preview/Microsoft.DesktopAppInstaller_8wekyb3d8bbwe.msixbundle which has the issue fixed.

@xixifaha
Copy link

xixifaha commented Aug 9, 2022

I upgraded the version and I can't upgrade now.

cc @xixifaha: You can install https://github.com/microsoft/winget-cli/releases/download/v1.4.2161-preview/Microsoft.DesktopAppInstaller_8wekyb3d8bbwe.msixbundle which has the issue fixed.

I can't install it when i open the file.

image

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

@xixifaha, I can't translate via the image. Can you copy paste the results or run through a translator?

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

Which packages is it trying to open?

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

It may be strange but you could try:

winget install "App Installer" -s msstore

It will get to about 90% complete and then it will hang. Just pause there for a minute or so, and the package should get updated. You will need to restart the terminal, but the upgrade should be installed after that.

@xixifaha
Copy link

xixifaha commented Aug 9, 2022

It may be strange but you could try:

winget install "App Installer" -s msstore

It will get to about 90% complete and then it will hang. Just pause there for a minute or so, and the package should get updated. You will need to restart the terminal, but the upgrade should be installed after that.

After try
"winget install "App Installer" -s msstore",
the is still v1.4.2011-preview

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

Is this on a Windows Insider build or are you in the Windows Package Manager Insiders group (You would have signed up via an online form)?

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

The next thing to try is to download the .msixbundle and the License XML file as well as the VCLibs dependency mentioned in the troubleshooting guide in the "machine wide provisioning" section and running the provisioning command in PowerShell.

@xixifaha
Copy link

xixifaha commented Aug 9, 2022

The next thing to try is to download the .msixbundle and the License XML file as well as the VCLibs dependency mentioned in the troubleshooting guide in the "machine wide provisioning" section and running the provisioning command in PowerShell.

I was in the Windows Package Manager Insiders group. I will try it after i leave the group.
If it doesn't work ,i will try that in the "machine wide provisioning" .
Thanks for help.

@denelon
Copy link
Contributor

denelon commented Aug 9, 2022

I was just confirming that you were in the group to ensure winget install "App Installer" -s msstore was going to get you on the latest released developer version. You don't need to leave the group.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Issue-Bug It either shouldn't be doing this or needs an investigation.
Projects
None yet
Development

Successfully merging a pull request may close this issue.

10 participants