The costing operations appear to complete quickly and without any errors in the log.

Can you run the install so that the hang runs for at least 60 seconds, then post that logfile, as the timestamps for the various actions may well allow a more accurate diagnosis.

Hi Alan,
Had a closer look at the failing log this morning. What I am looking for is for each Action Start statement to have a corresponding Action Ended statement in the log.
In your failing log, the Action start 10:21:58: Welcome_Dialog has no corresponding Action End, so something in the dialog sequence is causing the hang - which corresponds with your observation that a silent install (where dialogs are not run) works OK.
From the log, it looks like the Start_Installation_Dialog might be the culprit - but since the License dialog precedes it, are there any custom actions involved with the licensing of the product, that could be stalling?
What might be happening is that the installer is waiting for an input to a dialog that the user cannot see for some reason.
So perhaps one faultfinding trick would be to disable each dialog in turn and see if the install works with one of the dialogs inactive - then at least you know where to look further.
If you run the installer on a working system, and note the keystrokes you need at each point in the install, then repeat the same sequence on Vista SP2 and enter the keystrokes associated with the dialog that would be next up if the install wasn't hanging, it might also show whether the install is hanging because it is awaiting user input (which is not happening because the next dialog is not displaying for some reason).
Hope this makes sense.

hi Ed

thanks for the review.  The log does have an Action End for Welcom_Dialog, it's just a long way from the Action Start:

Action ended 10:36:13: WiseNextDlg. Return value 1.
Action 10:37:51: Cancel. Dialog created
Action ended 10:37:53: Welcome_Dialog. Return value 2.
MSI (c) (40:50) [10:37:53:175]: Doing action: User_Exit

The customer has sent a log with a longer (one hour) delay before they canceled the install, so I'll append it here, though I don't think it's any more informative.

My test VM for Vista SP2 is almost done (takes ages) so I'll be able to poke around a bit more soon -- if I can figure out where to poke.  I'll try your good idea of using the exaact same keystrokes in Vista SP2 as in an install that works.  But my boss says this is low priority now so there may be no more news for a few days.

Log with long delay:

=== Verbose logging started: 11/5/2009  12:01:51  Build type: SHIP UNICODE 4.05.6002.00  Calling process: C:\Windows\system32\msiexec.exe ===
MSI (c) (6C:C0) [12:01:51:812]: Resetting cached policy values
MSI (c) (6C:C0) [12:01:51:812]: Machine policy value 'Debug' is 0
MSI (c) (6C:C0) [12:01:51:812]: ******* RunEngine:
           ******* Product: dneupdate.msi
           ******* Action:
           ******* CommandLine: **********
MSI (c) (6C:C0) [12:01:51:822]: Machine policy value 'DisableUserInstalls' is 0
MSI (c) (6C:C0) [12:01:51:882]: Note: 1: 1402 2: HKEY_CURRENT_USER\Software\Microsoft\Windows\CurrentVersion\Policies\Explorer 3: 2
MSI (c) (6C:C0) [12:01:51:892]: SOFTWARE RESTRICTION POLICY: Verifying package --> 'C:\Users\Jean\Desktop\DNE\dneupdate.msi' against software restriction policy
MSI (c) (6C:C0) [12:01:51:892]: SOFTWARE RESTRICTION POLICY: C:\Users\Jean\Desktop\DNE\dneupdate.msi has a digital signature
MSI (c) (6C:C0) [12:01:52:103]: SOFTWARE RESTRICTION POLICY: C:\Users\Jean\Desktop\DNE\dneupdate.msi is permitted to run at the 'unrestricted' authorization level.
MSI (c) (6C:C0) [12:01:52:273]: Cloaking enabled.
MSI (c) (6C:C0) [12:01:52:273]: Attempting to enable all disabled privileges before calling Install on Server
MSI (c) (6C:C0) [12:01:52:293]: End dialog not enabled
MSI (c) (6C:C0) [12:01:52:293]: Original package ==> C:\Users\Jean\Desktop\DNE\dneupdate.msi
MSI (c) (6C:C0) [12:01:52:293]: Package we're running from ==> C:\Users\Jean\AppData\Local\Temp\4ee20.msi
MSI (c) (6C:C0) [12:01:52:293]: APPCOMPAT: looking for appcompat database entry with ProductCode '{EC899917-C880-1017-8CB7-B932BD009007}'.
MSI (c) (6C:C0) [12:01:52:293]: APPCOMPAT: no matching ProductCode found in database.
MSI (c) (6C:C0) [12:01:52:543]: MSCOREE not loaded loading copy from system32
MSI (c) (6C:C0) [12:01:52:553]: Machine policy value 'TransformsSecure' is 0
MSI (c) (6C:C0) [12:01:52:553]: User policy value 'TransformsAtSource' is 0
MSI (c) (6C:C0) [12:01:52:553]: Note: 1: 2262 2: MsiFileHash 3: -2147287038
MSI (c) (6C:C0) [12:01:52:553]: Machine policy value 'DisablePatch' is 0
MSI (c) (6C:C0) [12:01:52:553]: Machine policy value 'AllowLockdownPatch' is 0
MSI (c) (6C:C0) [12:01:52:553]: Machine policy value 'DisableLUAPatching' is 0
MSI (c) (6C:C0) [12:01:52:553]: Machine policy value 'DisableFlyWeightPatching' is 0
MSI (c) (6C:C0) [12:01:52:553]: Enabling baseline caching for this transaction since all active patches are MSI 3.0 style MSPs or at least one MSI 3.0 minor update patch is active
MSI (c) (6C:C0) [12:01:52:573]: APPCOMPAT: looking for appcompat database entry with ProductCode '{EC899917-C880-1017-8CB7-B932BD009007}'.
MSI (c) (6C:C0) [12:01:52:573]: APPCOMPAT: no matching ProductCode found in database.
MSI (c) (6C:C0) [12:01:52:573]: Transforms are not secure.
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding MsiLogFileLocation property. Its value is 'C:\Users\Jean\Desktop\DNE\dneupdatenew.log'.
MSI (c) (6C:C0) [12:01:52:573]: Command Line: CURRENTDIRECTORY=C:\Users\Jean\Desktop\DNE CLIENTUILEVEL=0 CLIENTPROCESSID=2924
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding PackageCode property. Its value is '{ED9F97D4-C880-1017-9BFC-D5B7703CA943}'.
MSI (c) (6C:C0) [12:01:52:573]: Product Code passed to Engine.Initialize:           ''
MSI (c) (6C:C0) [12:01:52:573]: Product Code from property table before transforms: '{EC899917-C880-1017-8CB7-B932BD009007}'
MSI (c) (6C:C0) [12:01:52:573]: Product Code from property table after transforms:  '{EC899917-C880-1017-8CB7-B932BD009007}'
MSI (c) (6C:C0) [12:01:52:573]: Product not registered: beginning first-time install
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding ProductState property. Its value is '-1'.
MSI (c) (6C:C0) [12:01:52:573]: Entering CMsiConfigurationManager::SetLastUsedSource.
MSI (c) (6C:C0) [12:01:52:573]: User policy value 'SearchOrder' is 'nmu'
MSI (c) (6C:C0) [12:01:52:573]: Adding new sources is allowed.
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding PackagecodeChanging property. Its value is '1'.
MSI (c) (6C:C0) [12:01:52:573]: Package name extracted from package path: 'dneupdate.msi'
MSI (c) (6C:C0) [12:01:52:573]: Package to be registered: 'dneupdate.msi'
MSI (c) (6C:C0) [12:01:52:573]: Note: 1: 2262 2: AdminProperties 3: -2147287038
MSI (c) (6C:C0) [12:01:52:573]: Machine policy value 'DisableMsi' is 0
MSI (c) (6C:C0) [12:01:52:573]: Machine policy value 'AlwaysInstallElevated' is 0
MSI (c) (6C:C0) [12:01:52:573]: User policy value 'AlwaysInstallElevated' is 0
MSI (c) (6C:C0) [12:01:52:573]: Product installation will be elevated because user is admin and product is being installed per-machine.
MSI (c) (6C:C0) [12:01:52:573]: Running product '{EC899917-C880-1017-8CB7-B932BD009007}' with elevated privileges: Product is assigned.
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding CURRENTDIRECTORY property. Its value is 'C:\Users\Jean\Desktop\DNE'.
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding CLIENTUILEVEL property. Its value is '0'.
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding CLIENTPROCESSID property. Its value is '2924'.
MSI (c) (6C:C0) [12:01:52:573]: TRANSFORMS property is now:
MSI (c) (6C:C0) [12:01:52:573]: PROPERTY CHANGE: Adding VersionDatabase property. Its value is '150'.
MSI (c) (6C:C0) [12:01:52:573]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming
MSI (c) (6C:C0) [12:01:52:573]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\Favorites
MSI (c) (6C:C0) [12:01:52:573]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Network Shortcuts
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\Documents
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Printer Shortcuts
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Recent
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\SendTo
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Templates
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Local
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\Pictures
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData\Microsoft\Windows\Start Menu\Programs\Administrative Tools
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData\Microsoft\Windows\Start Menu\Programs\Startup
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData\Microsoft\Windows\Start Menu\Programs
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData\Microsoft\Windows\Start Menu
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Public\Desktop
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Start Menu\Programs\Administrative Tools
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Start Menu\Programs\Startup
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Start Menu\Programs
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Start Menu
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Users\Jean\Desktop
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\ProgramData\Microsoft\Windows\Templates
MSI (c) (6C:C0) [12:01:52:583]: SHELL32::SHGetFolderPath returned: C:\Windows\Fonts
MSI (c) (6C:C0) [12:01:52:583]: Note: 1: 2898 2: MS Sans Serif 3: MS Sans Serif 4: 0 5: 16
MSI (c) (6C:C0) [12:01:52:593]: MSI_LUA: Setting AdminUser property to 1 because this is the client or the user has already permitted elevation
MSI (c) (6C:C0) [12:01:52:593]: MSI_LUA: Setting MsiRunningElevated property to 1 because the install is already running elevated.
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding MsiRunningElevated property. Its value is '1'.
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding Privileged property. Its value is '1'.
MSI (c) (6C:C0) [12:01:52:593]: Note: 1: 1402 2: HKEY_CURRENT_USER\Software\Microsoft\MS Setup (ACME)\User Info 3: 2
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding USERNAME property. Its value is 'Jean'.
MSI (c) (6C:C0) [12:01:52:593]: Note: 1: 1402 2: HKEY_CURRENT_USER\Software\Microsoft\MS Setup (ACME)\User Info 3: 2
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding DATABASE property. Its value is 'C:\Users\Jean\AppData\Local\Temp\4ee20.msi'.
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding OriginalDatabase property. Its value is 'C:\Users\Jean\Desktop\DNE\dneupdate.msi'.
MSI (c) (6C:C0) [12:01:52:593]: Machine policy value 'MsiDisableEmbeddedUI' is 0
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding SourceDir property. Its value is 'C:\Users\Jean\Desktop\DNE\'.
MSI (c) (6C:C0) [12:01:52:593]: PROPERTY CHANGE: Adding SOURCEDIR property. Its value is 'C:\Users\Jean\Desktop\DNE\'.
MSI (c) (6C:EC) [12:01:52:593]: PROPERTY CHANGE: Adding VersionHandler property. Its value is '4.05'.
=== Logging started: 11/5/2009  12:01:52 ===
MSI (c) (6C:C0) [12:01:52:603]: Note: 1: 2205 2:  3: PatchPackage
MSI (c) (6C:C0) [12:01:52:603]: Machine policy value 'DisableRollback' is 0
MSI (c) (6C:C0) [12:01:52:603]: User policy value 'DisableRollback' is 0
MSI (c) (6C:C0) [12:01:52:603]: PROPERTY CHANGE: Adding UILevel property. Its value is '5'.
MSI (c) (6C:C0) [12:01:52:603]: PROPERTY CHANGE: Adding ACTION property. Its value is 'INSTALL'.
MSI (c) (6C:C0) [12:01:52:603]: Doing action: INSTALL
Action 12:01:52: INSTALL.
Action start 12:01:52: INSTALL.
MSI (c) (6C:C0) [12:01:52:613]: UI Sequence table 'InstallUISequence' is present and populated.
MSI (c) (6C:C0) [12:01:52:613]: Running UISequence
MSI (c) (6C:C0) [12:01:52:613]: PROPERTY CHANGE: Adding EXECUTEACTION property. Its value is 'INSTALL'.
MSI (c) (6C:C0) [12:01:52:613]: Doing action: WiseUpgradeCheck
Action 12:01:52: WiseUpgradeCheck.
Action start 12:01:52: WiseUpgradeCheck.
MSI (c) (6C:C0) [12:01:52:613]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseUpgradeCheck'
MSI (c) (6C:C0) [12:01:52:613]: Creating MSIHANDLE (1) of type 790542 for thread 2240
MSI (c) (6C:C0) [12:01:52:613]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSIF0FD.tmp, Entrypoint: UpgradeCheck
MSI (c) (6C:E8) [12:01:52:623]: Cloaking enabled.
MSI (c) (6C:E8) [12:01:52:623]: Attempting to enable all disabled privileges before calling Install on Server
MSI (c) (6C:E8) [12:01:52:623]: Connected to service for CA interface.
MSI (c) (6C!68) [12:01:52:854]: Creating MSIHANDLE (2) of type 790541 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Creating MSIHANDLE (3) of type 790540 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Creating MSIHANDLE (4) of type 790531 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Closing MSIHANDLE (4) of type 790531 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Creating MSIHANDLE (5) of type 790531 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Closing MSIHANDLE (5) of type 790531 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Closing MSIHANDLE (3) of type 790540 for thread 2920
MSI (c) (6C!68) [12:01:52:854]: Closing MSIHANDLE (2) of type 790541 for thread 2920
MSI (c) (6C:C0) [12:01:52:894]: Closing MSIHANDLE (1) of type 790542 for thread 2240
Action ended 12:01:52: WiseUpgradeCheck. Return value 1.
MSI (c) (6C:C0) [12:01:52:894]: Doing action: LaunchConditions
Action 12:01:52: LaunchConditions. Evaluating launch conditions...
Action start 12:01:52: LaunchConditions.
Action ended 12:01:52: LaunchConditions. Return value 1.
MSI (c) (6C:C0) [12:01:52:904]: Doing action: WiseSetProfilesFolder
Action 12:01:52: WiseSetProfilesFolder.
Action start 12:01:52: WiseSetProfilesFolder.
MSI (c) (6C:C0) [12:01:52:904]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseSetProfilesFolder'
MSI (c) (6C:C0) [12:01:52:904]: Creating MSIHANDLE (6) of type 790542 for thread 2240
MSI (c) (6C:20) [12:01:52:904]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSIF221.tmp, Entrypoint: SetProfilesFolder
MSI (c) (6C!34) [12:01:52:934]: PROPERTY CHANGE: Adding ProfilesFolder property. Its value is 'C:\Users\'.
MSI (c) (6C:20) [12:01:52:934]: Closing MSIHANDLE (6) of type 790542 for thread 2240
Action ended 12:01:52: WiseSetProfilesFolder. Return value 1.
MSI (c) (6C:C0) [12:01:52:934]: Skipping action: SetPatchMode (condition is false)
MSI (c) (6C:C0) [12:01:52:934]: Skipping action: SetPatchReinstallMode (condition is false)
MSI (c) (6C:C0) [12:01:52:934]: Doing action: Setup_Dialog
Action 12:01:52: Setup_Dialog.
Action start 12:01:52: Setup_Dialog.
MSI (c) (6C:C0) [12:01:52:934]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'Setup_Dialog'
Info 2898. For MSSansSerif8 textstyle, the system created a 'MS Sans Serif' font, in 1 character set, of 13 pixels height.
Info 2898. For Arial10 textstyle, the system created a 'Arial' font, in 1 character set, of 16 pixels height.
Info 2898. For Arial14 textstyle, the system created a 'Arial' font, in 1 character set, of 22 pixels height.
Action 12:01:52: Setup_Dialog. Dialog created
Action ended 12:01:53: Setup_Dialog. Return value 1.
MSI (c) (6C:C0) [12:01:53:014]: Doing action: FindRelatedProducts
Action 12:01:53: FindRelatedProducts. Searching for related applications
Action start 12:01:53: FindRelatedProducts.
Action ended 12:01:53: FindRelatedProducts. Return value 1.
MSI (c) (6C:C0) [12:01:53:104]: Doing action: WiseUpgradeCheckEx
Action 12:01:53: WiseUpgradeCheckEx.
Action start 12:01:53: WiseUpgradeCheckEx.
MSI (c) (6C:C0) [12:01:53:144]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseUpgradeCheckEx'
MSI (c) (6C:C0) [12:01:53:144]: Creating MSIHANDLE (7) of type 790542 for thread 2240
MSI (c) (6C:80) [12:01:53:144]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSIF312.tmp, Entrypoint: UpgradeCheckEx
MSI (c) (6C:80) [12:01:53:304]: Closing MSIHANDLE (7) of type 790542 for thread 2240
Action ended 12:01:53: WiseUpgradeCheckEx. Return value 1.
MSI (c) (6C:C0) [12:01:53:304]: Doing action: AppSearch
Action 12:01:53: AppSearch. Searching for installed applications...
Action start 12:01:53: AppSearch.
AppSearch: Property: DN_DNE_PI_ORDER_REG_VER.70087FC1_04DB_4518_94D2_44D3901E8D17
Signature: AppReg.70087FC1_04DB_4518_94D2_44D3901E8D17
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: Signature 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: CompLocator 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 1402 2: HKEY_LOCAL_MACHINE\SOFTWARE\DeterministicNetworks\DNE\Parameters\Order 3: 2
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: IniLocator 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: DrLocator 3: -2147287038
AppSearch: Property: DN_DNE_PI_ORDER_REG_VER.70087FC1_04DB_4518_94D2_44D3901E8D17
Signature: AppReg1.70087FC1_04DB_4518_94D2_44D3901E8D17
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: Signature 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: CompLocator 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 1402 2: HKEY_LOCAL_MACHINE\System\CurrentControlSet\Services\DNE\Parameters\Order 3: 2
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: IniLocator 3: -2147287038
MSI (c) (6C:C0) [12:01:53:304]: Note: 1: 2262 2: DrLocator 3: -2147287038
Action ended 12:01:53: AppSearch. Return value 1.
MSI (c) (6C:C0) [12:01:53:304]: Skipping action: CCPSearch (condition is false)
MSI (c) (6C:C0) [12:01:53:304]: Skipping action: CCPDialog (condition is false)
MSI (c) (6C:C0) [12:01:53:304]: Skipping action: RMCCPSearch (condition is false)
MSI (c) (6C:C0) [12:01:53:304]: Doing action: ValidateProductID
Action 12:01:53: ValidateProductID.
Action start 12:01:53: ValidateProductID.
Action ended 12:01:53: ValidateProductID. Return value 1.
MSI (c) (6C:C0) [12:01:53:304]: Doing action: CostInitialize
Action 12:01:53: CostInitialize. Computing space requirements...
Action start 12:01:53: CostInitialize.
MSI (c) (6C:C0) [12:01:53:304]: Machine policy value 'MaxPatchCacheSize' is 10
MSI (c) (6C:C0) [12:01:53:304]: Baseline: Sorting baselines for {EC899917-C880-1017-8CB7-B932BD009007}.
MSI (c) (6C:C0) [12:01:53:304]: Baseline: New baseline 3.22.5 from transaction.
MSI (c) (6C:C0) [12:01:53:304]: Baseline: Sorted order Native: Order 0.
MSI (c) (6C:C0) [12:01:53:304]: Baseline Data Table:
MSI (c) (6C:C0) [12:01:53:304]: ProductCode: {EC899917-C880-1017-8CB7-B932BD009007} Version: 3.22.5 Attributes: 0 PatchId: Native BaselineId: -2147483648 Order: 0
MSI (c) (6C:C0) [12:01:53:304]: Baseline File Table:
MSI (c) (6C:C0) [12:01:53:324]: PROPERTY CHANGE: Adding ROOTDRIVE property. Its value is 'C:\'.
MSI (c) (6C:C0) [12:01:53:324]: PROPERTY CHANGE: Adding CostingComplete property. Its value is '0'.
Action ended 12:01:53: CostInitialize. Return value 1.
MSI (c) (6C:C0) [12:01:53:324]: Doing action: FileCost
Action 12:01:53: FileCost. Computing space requirements...
Action start 12:01:53: FileCost.
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: RemoveFile 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: MsiAssembly 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: TypeLib 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: IniFile 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: MoveFile 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: DuplicateFile 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: ReserveCost 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: Shortcut 3: -2147287038
Action ended 12:01:53: FileCost. Return value 1.
MSI (c) (6C:C0) [12:01:53:324]: Doing action: IsolateComponents
Action 12:01:53: IsolateComponents.
Action start 12:01:53: IsolateComponents.
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:324]: Note: 1: 2205 2:  3: Patch
Action ended 12:01:53: IsolateComponents. Return value 1.
MSI (c) (6C:C0) [12:01:53:334]: Doing action: CostFinalize
Action 12:01:53: CostFinalize. Computing space requirements...
Action start 12:01:53: CostFinalize.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding OutOfDiskSpace property. Its value is '0'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding OutOfNoRbDiskSpace property. Its value is '0'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceAvailable property. Its value is '0'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceRequired property. Its value is '0'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceRemaining property. Its value is '0'.
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2205 2:  3: Patch
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: Condition 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding TARGETDIR property. Its value is 'C:\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding GAC property. Its value is 'C:\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding WWWROOT property. Its value is 'C:\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding SystemFolder.61E46690_5629_4B8D_AB15_2910F5F466E3 property. Its value is 'C:\Windows\system32\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding WinSxS property. Its value is 'C:\Windows\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding CommonFilesFolder.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 property. Its value is 'C:\Program Files\Common Files\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding Deterministic_Networks.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 property. Its value is 'C:\Program Files\Common Files\Deterministic Networks\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding Support.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 property. Its value is 'C:\Program Files\Common Files\Deterministic Networks\Common Files\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding CommonFilesFolder.61E46690_5629_4B8D_AB15_2910F5F466E3 property. Its value is 'C:\Program Files\Common Files\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding Deterministic_Networks.61E46690_5629_4B8D_AB15_2910F5F466E3 property. Its value is 'C:\Program Files\Common Files\Deterministic Networks\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding DNE.61E46690_5629_4B8D_AB15_2910F5F466E3 property. Its value is 'C:\Program Files\Common Files\Deterministic Networks\DNE\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding Common_files.61E46690_5629_4B8D_AB15_2910F5F466E3 property. Its value is 'C:\Program Files\Common Files\Deterministic Networks\Common files\'.
MSI (c) (6C:C0) [12:01:53:334]: PROPERTY CHANGE: Adding CommonFilesFolder.70087FC1_04DB_4518_94D2_44D3901E8D17 property. Its value is 'C:\Program Files\Common Files\'.
MSI (c) (6C:C0) [12:01:53:334]: Target path resolution complete. Dumping Directory table...
MSI (c) (6C:C0) [12:01:53:334]: Note: target paths subject to change (via custom actions or browsing)
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: TARGETDIR    , Object: C:\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: GAC    , Object: C:\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: WWWROOT    , Object: C:\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: LocalAppDataFolder    , Object: C:\Users\Jean\AppData\Local\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: CommonAppDataFolder    , Object: C:\ProgramData\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: WindowsFolder    , Object: C:\Windows\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: System16Folder    , Object: C:\Windows\system\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: SystemFolder    , Object: C:\Windows\system32\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: SystemFolder.61E46690_5629_4B8D_AB15_2910F5F466E3    , Object: C:\Windows\system32\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: TempFolder    , Object: C:\Users\Jean\AppData\Local\Temp\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: FontsFolder    , Object: C:\Windows\Fonts\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: WinSxS    , Object: C:\Windows\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: ProfilesFolder    , Object: C:\Users\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: NetHoodFolder    , Object: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Network Shortcuts\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: PrintHoodFolder    , Object: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Printer Shortcuts\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: StartMenuFolder    , Object: C:\ProgramData\Microsoft\Windows\Start Menu\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: ProgramMenuFolder    , Object: C:\ProgramData\Microsoft\Windows\Start Menu\Programs\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: StartupFolder    , Object: C:\ProgramData\Microsoft\Windows\Start Menu\Programs\Startup\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: DesktopFolder    , Object: C:\Users\Public\Desktop\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: RecentFolder    , Object: C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Recent\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: ProgramFilesFolder    , Object: C:\Program Files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: CommonFilesFolder    , Object: C:\Program Files\Common Files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: CommonFilesFolder.08E7C257_17C5_4174_9AFF_0BB9FF8BED18    , Object: C:\Program Files\Common Files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: Deterministic_Networks.08E7C257_17C5_4174_9AFF_0BB9FF8BED18    , Object: C:\Program Files\Common Files\Deterministic Networks\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: Support.08E7C257_17C5_4174_9AFF_0BB9FF8BED18    , Object: C:\Program Files\Common Files\Deterministic Networks\Common Files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: CommonFilesFolder.61E46690_5629_4B8D_AB15_2910F5F466E3    , Object: C:\Program Files\Common Files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: Deterministic_Networks.61E46690_5629_4B8D_AB15_2910F5F466E3    , Object: C:\Program Files\Common Files\Deterministic Networks\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: DNE.61E46690_5629_4B8D_AB15_2910F5F466E3    , Object: C:\Program Files\Common Files\Deterministic Networks\DNE\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: Common_files.61E46690_5629_4B8D_AB15_2910F5F466E3    , Object: C:\Program Files\Common Files\Deterministic Networks\Common files\
MSI (c) (6C:C0) [12:01:53:334]: Dir (target): Key: CommonFilesFolder.70087FC1_04DB_4518_94D2_44D3901E8D17    , Object: C:\Program Files\Common Files\
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: IsolatedComponent 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:C0) [12:01:53:334]: Note: 1: 2262 2: RemoveFile 3: -2147287038
Action ended 12:01:53: CostFinalize. Return value 1.
MSI (c) (6C:C0) [12:01:53:334]: Doing action: MigrateFeatureStates
Action 12:01:53: MigrateFeatureStates. Migrating feature states from related applications
Action start 12:01:53: MigrateFeatureStates.
Action ended 12:01:53: MigrateFeatureStates. Return value 0.
MSI (c) (6C:C0) [12:01:53:334]: Doing action: SetWizardProperty1
Action 12:01:53: SetWizardProperty1.
Action start 12:01:53: SetWizardProperty1.
MSI (c) (6C:C0) [12:01:53:344]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'SetWizardProperty1'
MSI (c) (6C:C0) [12:01:53:344]: PROPERTY CHANGE: Adding WiseCurrentWizard property. Its value is 'Welcome_Dialog'.
Action ended 12:01:53: SetWizardProperty1. Return value 1.
MSI (c) (6C:C0) [12:01:53:344]: Doing action: Welcome_Dialog
Action 12:01:53: Welcome_Dialog.
Action start 12:01:53: Welcome_Dialog.
MSI (c) (6C:C0) [12:01:53:344]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'Welcome_Dialog'
Action 12:01:53: Welcome_Dialog. Dialog created
MSI (c) (6C:EC) [12:01:56:639]: Doing action: WiseNextDlg
Action 12:01:56: WiseNextDlg.
Action start 12:01:56: WiseNextDlg.
MSI (c) (6C:EC) [12:01:56:639]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (6C:EC) [12:01:56:639]: Creating MSIHANDLE (8) of type 790542 for thread 1516
MSI (c) (6C:38) [12:01:56:649]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSIBA.tmp, Entrypoint: WiseNextDlg
MSI (c) (6C!4C) [12:01:56:719]: PROPERTY CHANGE: Adding WiseCurrentDialog property. Its value is 'Welcome_Dialog'.
MSI (c) (6C!4C) [12:01:56:719]: Creating MSIHANDLE (9) of type 790541 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Creating MSIHANDLE (10) of type 790540 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Creating MSIHANDLE (11) of type 790531 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Closing MSIHANDLE (11) of type 790531 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Creating MSIHANDLE (12) of type 790531 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: PROPERTY CHANGE: Adding WiseNextDialog property. Its value is 'License_Dialog'.
MSI (c) (6C!4C) [12:01:56:719]: PROPERTY CHANGE: Adding WiseDialogStack property. Its value is 'Welcome_Dialog'.
MSI (c) (6C!4C) [12:01:56:719]: Closing MSIHANDLE (12) of type 790531 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Closing MSIHANDLE (10) of type 790540 for thread 2380
MSI (c) (6C!4C) [12:01:56:719]: Closing MSIHANDLE (9) of type 790541 for thread 2380
MSI (c) (6C:38) [12:01:56:719]: Closing MSIHANDLE (8) of type 790542 for thread 1516
Action ended 12:01:56: WiseNextDlg. Return value 1.
Info 2898. For Arial8 textstyle, the system created a 'Arial' font, in 1 character set, of 14 pixels height.
Action 12:01:56: License_Dialog. Dialog created
MSI (c) (6C:EC) [12:01:58:912]: PROPERTY CHANGE: Modifying Accept property. Its current value is 'No'. Its new value: 'Yes'.
MSI (c) (6C:EC) [12:02:01:176]: Doing action: WiseNextDlg
Action 12:02:01: WiseNextDlg.
Action start 12:02:01: WiseNextDlg.
MSI (c) (6C:EC) [12:02:01:176]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (6C:EC) [12:02:01:176]: Creating MSIHANDLE (13) of type 790542 for thread 1516
MSI (c) (6C:88) [12:02:01:176]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSI1273.tmp, Entrypoint: WiseNextDlg
MSI (c) (6C!64) [12:02:01:186]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'Welcome_Dialog'. Its new value: 'License_Dialog'.
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (14) of type 790541 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (15) of type 790540 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (16) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (16) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (17) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (17) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (18) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (18) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (19) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (19) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (20) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (20) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (21) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (21) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (22) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (22) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Creating MSIHANDLE (23) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: PROPERTY CHANGE: Modifying WiseNextDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (6C!64) [12:02:01:186]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog'.
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (23) of type 790531 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (15) of type 790540 for thread 868
MSI (c) (6C!64) [12:02:01:186]: Closing MSIHANDLE (14) of type 790541 for thread 868
MSI (c) (6C:88) [12:02:01:196]: Closing MSIHANDLE (13) of type 790542 for thread 1516
Action ended 12:02:01: WiseNextDlg. Return value 1.
Action 12:02:01: Start_Installation_Dialog. Dialog created
MSI (c) (6C:EC) [12:02:04:150]: Doing action: WiseNextDlg
Action 12:02:04: WiseNextDlg.
Action start 12:02:04: WiseNextDlg.
MSI (c) (6C:EC) [12:02:04:150]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (6C:EC) [12:02:04:150]: Creating MSIHANDLE (24) of type 790542 for thread 1516
MSI (c) (6C:BC) [12:02:04:150]: Invoking remote custom action. DLL: C:\Users\Jean\AppData\Local\Temp\MSI1E13.tmp, Entrypoint: WiseNextDlg
MSI (c) (6C!A4) [12:02:04:160]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (25) of type 790541 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (26) of type 790540 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (27) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (27) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (28) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (28) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (29) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (29) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (30) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (30) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (31) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (31) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (32) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (32) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (33) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (33) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Creating MSIHANDLE (34) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (34) of type 790531 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: PROPERTY CHANGE: Deleting WiseNextDialog property. Its current value is 'Start_Installation_Dialog'.
MSI (c) (6C!A4) [12:02:04:160]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog|License_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog|Start_Installation_Dialog'.
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (26) of type 790540 for thread 420
MSI (c) (6C!A4) [12:02:04:160]: Closing MSIHANDLE (25) of type 790541 for thread 420
MSI (c) (6C:BC) [12:02:04:160]: Closing MSIHANDLE (24) of type 790542 for thread 1516
Action ended 12:02:04: WiseNextDlg. Return value 1.
Action 13:12:24: Cancel. Dialog created
Action ended 13:12:27: Welcome_Dialog. Return value 2.
MSI (c) (6C:C0) [13:12:27:813]: Doing action: User_Exit
Action 13:12:27: User_Exit.
Action start 13:12:27: User_Exit.
MSI (c) (6C:C0) [13:12:27:813]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'User_Exit'
Action 13:12:27: User_Exit. Dialog created
MSI (c) (6C:2C) [13:12:27:833]: Note: 1: 2262 2: DuplicateFile 3: -2147287038
MSI (c) (6C:2C) [13:12:27:833]: Note: 1: 2262 2: ReserveCost 3: -2147287038
MSI (c) (6C:2C) [13:12:27:833]: Note: 1: 2205 2:  3: _RemoveFilePath
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: TypeLib 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: ProgId 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: PublishComponent 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: SelfReg 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Font 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (6C:2C) [13:12:27:843]: Note: 1: 2727 2: 
Action ended 13:12:29: User_Exit. Return value 2.
Action ended 13:12:29: INSTALL. Return value 2.
MSI (c) (6C:C0) [13:12:29:175]: Destroying RemoteAPI object.
MSI (c) (6C:E8) [13:12:29:185]: Custom Action Manager thread ending.
Property(C): DiskPrompt = [ProductName] [1]
Property(C): CommonFilesFolder.70087FC1_04DB_4518_94D2_44D3901E8D17 = C:\Program Files\Common Files\
Property(C): UpgradeCode = {0EBA1F0C-87A9-45B6-81AF-58B5DDAF2692}
Property(C): InstallMode = Typical
Property(C): ProductVersion = 3.22.5.18002
Property(C): ProductCode = {EC899917-C880-1017-8CB7-B932BD009007}
Property(C): ProductName = DNE Update
Property(C): Manufacturer = Deterministic Networks, Inc.
Property(C): _WiseDialogFontDefault = {&MSSansSerif8}
Property(C): ReinstallFileOlderVersion = o
Property(C): ReinstallRepair = r
Property(C): ErrorDialog = ErrorDialog
Property(C): Accept = Yes
Property(C): ARPHELPLINK = http://www.deterministicnetworks.com/
Property(C): ProductID = none
Property(C): ARPCONTACT = support@deterministicnetworks.com
Property(C): ALLUSERS = 1
Property(C): ApplicationUsers = AllUsers
Property(C): _WiseDebugMode = 0
Property(C): PALMUSERS = 0
Property(C): WiseInitSuffix = Wizard...
Property(C): ARPNOMODIFY = 1
Property(C): ARPHELPTELEPHONE = +1-831-421-0388
Property(C): WiseInitAdminError = You must have administrator rights to run this installation. Please login as an administrator and re-run this installation.
Property(C): WiseInitLangDefault = English,1033
Property(C): ProductLanguage = 1033
Property(C): MsiLogging = Iwearucmopvx
Property(C): DefaultUIFont = Arial10
Property(C): INSTALLLEVEL = 3
Property(C): DN_PkgSrcRev.dneupdate.wsi = 15
Property(C): ARPURLINFOABOUT = http://www.deterministicnetworks.com/
Property(C): ARPURLUPDATEINFO = http://www.deterministicnetworks.com/
Property(C): WiseInitSpaceError = Could not create temporary file, not enough free temporary disk space. Please free up disk space and rerun this installation.
Property(C): DN_BuildNumber = 18002
Property(C): PIDTemplate = 12345<###-%%%%%%%>@@@@@
Property(C): MaintenanceMode = Repair
Property(C): WiseCRLF =

Property(C): WiseEditorVersion = 7.3.0.250
Property(C): _WiseDialogSuffix = Setup
Property(C): WiseInitPrefix = Initializing
Property(C): WiseInitExistError = %s Version %s is already installed. You must uninstall the existing version before installing %s Version %s. Do you want to uninstall the existing version of %s?
Property(C): SecureCustomProperties = INSTALLDIR;UPGRADE_1;NEWERPRODUCTFOUND
Property(C): DN_PkgSrcRev.dne.wsi = 4
Property(C): DN_Product_Version = 3.22.5.18002
Property(C): ReinstallFileVersion = o
Property(C): MsiHiddenProperties = WISE_SQL_CONN_STR
Property(C): _WiseDialogTitleFontDefault = {&Arial8}
Property(C): SOURCEDIR = C:\Users\Jean\Desktop\DNE\
Property(C): TARGETDIR = C:\
Property(C): ProfilesFolder = C:\Users\
Property(C): RecentFolder = C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Recent\
Property(C): DesktopFolder = C:\Users\Public\Desktop\
Property(C): WindowsFolder = C:\Windows\
Property(C): WinSxS = C:\Windows\
Property(C): ProgramFilesFolder = C:\Program Files\
Property(C): FontsFolder = C:\Windows\Fonts\
Property(C): StartMenuFolder = C:\ProgramData\Microsoft\Windows\Start Menu\
Property(C): ProgramMenuFolder = C:\ProgramData\Microsoft\Windows\Start Menu\Programs\
Property(C): StartupFolder = C:\ProgramData\Microsoft\Windows\Start Menu\Programs\Startup\
Property(C): TempFolder = C:\Users\Jean\AppData\Local\Temp\
Property(C): PrintHoodFolder = C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Printer Shortcuts\
Property(C): SystemFolder = C:\Windows\system32\
Property(C): CommonAppDataFolder = C:\ProgramData\
Property(C): LocalAppDataFolder = C:\Users\Jean\AppData\Local\
Property(C): WWWROOT = C:\
Property(C): System16Folder = C:\Windows\system\
Property(C): GAC = C:\
Property(C): CommonFilesFolder = C:\Program Files\Common Files\
Property(C): NetHoodFolder = C:\Users\Jean\AppData\Roaming\Microsoft\Windows\Network Shortcuts\
Property(C): VersionNT = 600
Property(C): USERNAME = Jean
Property(C): WiseDialogStack = Welcome_Dialog|License_Dialog|Start_Installation_Dialog
Property(C): WiseCurrentWizard = Welcome_Dialog
Property(C): APPS_TEST = 1
Property(C): DN_PkgSrcRev.dne.61E46690_5629_4B8D_AB15_2910F5F466E3 = 76
Property(C): DN_BuildNumber.dne.61E46690_5629_4B8D_AB15_2910F5F466E3 = 18002
Property(C): DN_DNE_InstallText.61E46690_5629_4B8D_AB15_2910F5F466E3 = Managing Network Components|Installing Network Components. This may take several minutes.|Working  {([1])}
Property(C): DN_DNE_Ver.61E46690_5629_4B8D_AB15_2910F5F466E3 = 3.22.5.18001
Property(C): CRLF.61E46690_5629_4B8D_AB15_2910F5F466E3 =

Property(C): DN_DNE_RemoveText.61E46690_5629_4B8D_AB15_2910F5F466E3 = Managing Network Components|Removing Network Components. This may take several minutes.|Working  {([1])}
Property(C): DN_DNE_DoRemove.61E46690_5629_4B8D_AB15_2910F5F466E3 = false
Property(C): DN_DNE_DoInstall.61E46690_5629_4B8D_AB15_2910F5F466E3 = false
Property(C): SystemFolder.61E46690_5629_4B8D_AB15_2910F5F466E3 = C:\Windows\system32\
Property(C): Common_files.61E46690_5629_4B8D_AB15_2910F5F466E3 = C:\Program Files\Common Files\Deterministic Networks\Common files\
Property(C): Deterministic_Networks.61E46690_5629_4B8D_AB15_2910F5F466E3 = C:\Program Files\Common Files\Deterministic Networks\
Property(C): CommonFilesFolder.61E46690_5629_4B8D_AB15_2910F5F466E3 = C:\Program Files\Common Files\
Property(C): DNE.61E46690_5629_4B8D_AB15_2910F5F466E3 = C:\Program Files\Common Files\Deterministic Networks\DNE\
Property(C): DN_DNE_PI_ORDER_REG_VER.70087FC1_04DB_4518_94D2_44D3901E8D17 = 0
Property(C): DN_PkgSrcRev.dneorder.wsm.70087FC1_04DB_4518_94D2_44D3901E8D17 = 1
Property(C): DN_Product_Version.dneorder.70087FC1_04DB_4518_94D2_44D3901E8D17 = 2.30.0.17809
Property(C): DN_BuildNumber.dneorder.70087FC1_04DB_4518_94D2_44D3901E8D17 = 17809
Property(C): DN_DNE_PI_ORDER_DB_VER.70087FC1_04DB_4518_94D2_44D3901E8D17 = 229
Property(C): CommonFilesFolder.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = C:\Program Files\Common Files\
Property(C): Deterministic_Networks.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = C:\Program Files\Common Files\Deterministic Networks\
Property(C): Support.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = C:\Program Files\Common Files\Deterministic Networks\Common Files\
Property(C): DN_temp.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = 42
Property(C): DN_BuildNumber.dniinfo.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = 17163
Property(C): DN_Product_Version.dniinfo.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = 1.0.3.0
Property(C): DN_PkgSrcRev.dniinfo.wsm.08E7C257_17C5_4174_9AFF_0BB9FF8BED18 = 1
Property(C): MsiLogFileLocation = C:\Users\Jean\Desktop\DNE\dneupdatenew.log
Property(C): PackageCode = {ED9F97D4-C880-1017-9BFC-D5B7703CA943}
Property(C): ProductState = -1
Property(C): PackagecodeChanging = 1
Property(C): CURRENTDIRECTORY = C:\Users\Jean\Desktop\DNE
Property(C): CLIENTUILEVEL = 0
Property(C): CLIENTPROCESSID = 2924
Property(C): VersionDatabase = 150
Property(C): VersionMsi = 4.05
Property(C): WindowsBuild = 6002
Property(C): ServicePackLevel = 2
Property(C): ServicePackLevelMinor = 0
Property(C): MsiNTProductType = 1
Property(C): WindowsVolume = C:\
Property(C): RemoteAdminTS = 1
Property(C): AppDataFolder = C:\Users\Jean\AppData\Roaming\
Property(C): FavoritesFolder = C:\Users\Jean\Favorites\
Property(C): PersonalFolder = C:\Users\Jean\Documents\
Property(C): SendToFolder = C:\Users\Jean\AppData\Roaming\Microsoft\Windows\SendTo\
Property(C): TemplateFolder = C:\ProgramData\Microsoft\Windows\Templates\
Property(C): MyPicturesFolder = C:\Users\Jean\Pictures\
Property(C): AdminToolsFolder = C:\ProgramData\Microsoft\Windows\Start Menu\Programs\Administrative Tools\
Property(C): GPTSupport = 1
Property(C): OLEAdvtSupport = 1
Property(C): ShellAdvtSupport = 1
Property(C): Intel = 6
Property(C): PhysicalMemory = 1024
Property(C): VirtualMemory = 1802
Property(C): AdminUser = 1
Property(C): LogonUser = Jean
Property(C): UserSID = S-1-5-21-3804807773-3472135883-3717794192-1000
Property(C): UserLanguageID = 1033
Property(C): ComputerName = JEAN-PC
Property(C): SystemLanguageID = 1033
Property(C): ScreenX = 1024
Property(C): ScreenY = 768
Property(C): CaptionHeight = 20
Property(C): BorderTop = 1
Property(C): BorderSide = 1
Property(C): TextHeight = 16
Property(C): TextInternalLeading = 3
Property(C): ColorBits = 32
Property(C): TTCSupport = 1
Property(C): Time = 13:12:29
Property(C): Date = 11/5/2009
Property(C): MsiNetAssemblySupport = 2.0.50727.4016
Property(C): MsiWin32AssemblySupport = 6.0.6001.18000
Property(C): RedirectedDllSupport = 2
Property(C): MsiRunningElevated = 1
Property(C): Privileged = 1
Property(C): DATABASE = C:\Users\Jean\AppData\Local\Temp\4ee20.msi
Property(C): OriginalDatabase = C:\Users\Jean\Desktop\DNE\dneupdate.msi
Property(C): SourceDir = C:\Users\Jean\Desktop\DNE\
Property(C): VersionHandler = 4.05
Property(C): UILevel = 5
Property(C): ACTION = INSTALL
Property(C): EXECUTEACTION = INSTALL
Property(C): ROOTDRIVE = C:\
Property(C): CostingComplete = 1
Property(C): OutOfDiskSpace = 0
Property(C): OutOfNoRbDiskSpace = 0
Property(C): PrimaryVolumeSpaceAvailable = 0
Property(C): PrimaryVolumeSpaceRequired = 0
Property(C): PrimaryVolumeSpaceRemaining = 0
Property(C): WiseCurrentDialog = Start_Installation_Dialog
=== Logging stopped: 11/5/2009  13:12:29 ===
MSI (c) (6C:C0) [13:12:29:275]: Note: 1: 1708
MSI (c) (6C:C0) [13:12:29:275]: Product: DNE Update -- Installation operation failed.

MSI (c) (6C:C0) [13:12:29:275]: Windows Installer installed the product. Product Name: DNE Update. Product Version: 3.22.5.18002. Product Language: 1033. Installation success or error status: 1602.

MSI (c) (6C:C0) [13:12:29:275]: Grabbed execution mutex.
MSI (c) (6C:C0) [13:12:29:275]: Cleaning up uninstalled install packages, if any exist
MSI (c) (6C:C0) [13:12:29:285]: MainEngineThread is returning 1602
=== Verbose logging stopped: 11/5/2009  13:12:29 ===

(The log with an hour delay posted above is probably irrelevant.)

This MSI has three dialogs, Welcome, License Agreement and Start Installation.  On XP clicking Next in the Start Installation dialog goes on to the Updating System screen.  On Vista SP2 that click brings a popup "Please wait while the installer determines your disk space requirements" -- and that popup doesn't appear at all on XP.  The popup has only a Cancel button, which returns control to the Start Installation dialog (i.e. it doesn't cancel the install, only the disk space check popup.)  Clicking Next again gets the popup again, until one gives up and clicks Cancel on the Start Installation dialog.

The log from XP shows
PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
in the Welcome_Dialog first stage (before the License Agreement).

But on VistaSP2, CostingComplete is NOT changed until after the Cancel button has been clicked and the Welcome_Dialog action has ended.

Why might CostingComplete not be changed during Vista's dialog sequence? What else should I look for?  This really doesn't seem like a bug in my installer code. It seems like the GUI is somehow stopping the costing property being set (hence silent installs succeed.)

The guy who had the similar problem back in August says he fixed the problem by finding and fixing an error in the directory table. But there are no (findable) errors in our MSI's tables -- it passes validation with no errors nor even warnings, and WIS finds no problems using "check tables".  He also said that the problem only happened in Virtual Machines. I'm reproducing our problem in a VM, and our customer also uses a VM. I don't have a normal Vista install to test on, so I can't check if it only happens in a VM.

Here are the dialog sections of the logs. There doesn't seem to be another significant difference between them beyond the moved CostingComplete change (which is bolded below). First the XP log:

MSI (c) (8C:4C) [18:10:19:081]: Doing action: Welcome_Dialog
Action start 18:10:19: Welcome_Dialog.
Action 18:10:19: Welcome_Dialog. Dialog created
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: DuplicateFile 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: ReserveCost 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2205 2:  3: _RemoveFilePath
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: TypeLib 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: ProgId 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: PublishComponent 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: SelfReg 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Font 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (8C:54) [18:10:19:151]: Note: 1: 2727 2: 
MSI (c) (8C:54) [18:10:24:158]: Doing action: WiseNextDlg
Action start 18:10:24: WiseNextDlg.
MSI (c) (8C:54) [18:10:24:158]: Creating MSIHANDLE (8) of type 790542 for thread 1108
MSI (c) (8C:80) [18:10:24:158]: Invoking remote custom action. DLL: C:\DOCUME~1\alan\LOCALS~1\Temp\MSI4.tmp, Entrypoint: WiseNextDlg
MSI (c) (8C!90) [18:10:24:369]: PROPERTY CHANGE: Adding WiseCurrentDialog property. Its value is 'Welcome_Dialog'.
MSI (c) (8C!90) [18:10:24:369]: Creating MSIHANDLE (9) of type 790541 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Creating MSIHANDLE (10) of type 790540 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Creating MSIHANDLE (11) of type 790531 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Closing MSIHANDLE (11) of type 790531 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Creating MSIHANDLE (12) of type 790531 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: PROPERTY CHANGE: Adding WiseNextDialog property. Its value is 'License_Dialog'.
MSI (c) (8C!90) [18:10:24:369]: PROPERTY CHANGE: Adding WiseDialogStack property. Its value is 'Welcome_Dialog'.
MSI (c) (8C!90) [18:10:24:369]: Closing MSIHANDLE (12) of type 790531 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Closing MSIHANDLE (10) of type 790540 for thread 1680
MSI (c) (8C!90) [18:10:24:369]: Closing MSIHANDLE (9) of type 790541 for thread 1680
MSI (c) (8C:80) [18:10:24:369]: Closing MSIHANDLE (8) of type 790542 for thread 1108
Action ended 18:10:24: WiseNextDlg. Return value 1.
Info 2898. Arial8, Arial, 1
Action 18:10:24: License_Dialog. Dialog created
MSI (c) (8C:54) [18:10:26:532]: PROPERTY CHANGE: Modifying Accept property. Its current value is 'No'. Its new value: 'Yes'.
MSI (c) (8C:54) [18:10:28:725]: Doing action: WiseNextDlg
Action start 18:10:28: WiseNextDlg.
MSI (c) (8C:54) [18:10:28:735]: Creating MSIHANDLE (13) of type 790542 for thread 1108
MSI (c) (8C:94) [18:10:28:735]: Invoking remote custom action. DLL: C:\DOCUME~1\alan\LOCALS~1\Temp\MSI5.tmp, Entrypoint: WiseNextDlg
MSI (c) (8C!14) [18:10:28:905]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'Welcome_Dialog'. Its new value: 'License_Dialog'.
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (14) of type 790541 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (15) of type 790540 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (16) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (16) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (17) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (17) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (18) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (18) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (19) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (19) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (20) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (20) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (21) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (21) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (22) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (22) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Creating MSIHANDLE (23) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: PROPERTY CHANGE: Modifying WiseNextDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (8C!14) [18:10:28:905]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog'.
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (23) of type 790531 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (15) of type 790540 for thread 1556
MSI (c) (8C!14) [18:10:28:905]: Closing MSIHANDLE (14) of type 790541 for thread 1556
MSI (c) (8C:94) [18:10:28:905]: Closing MSIHANDLE (13) of type 790542 for thread 1108
Action ended 18:10:28: WiseNextDlg. Return value 1.
Action 18:10:28: Start_Installation_Dialog. Dialog created
MSI (c) (8C:54) [18:10:29:416]: Note: 1: 2727 2: 
MSI (c) (8C:54) [18:10:29:917]: Note: 1: 2727 2: 
MSI (c) (8C:54) [18:10:30:417]: Note: 1: 2727 2: 
MSI (c) (8C:54) [18:10:30:918]: Note: 1: 2727 2: 
MSI (c) (8C:54) [18:10:31:058]: Doing action: WiseNextDlg
Action start 18:10:31: WiseNextDlg.
MSI (c) (8C:54) [18:10:31:058]: Creating MSIHANDLE (24) of type 790542 for thread 1108
MSI (c) (8C:48) [18:10:31:058]: Invoking remote custom action. DLL: C:\DOCUME~1\alan\LOCALS~1\Temp\MSI6.tmp, Entrypoint: WiseNextDlg
MSI (c) (8C!00) [18:10:31:229]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (25) of type 790541 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (26) of type 790540 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (27) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (27) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (28) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (28) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (29) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (29) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (30) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (30) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (31) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (31) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (32) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (32) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (33) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Closing MSIHANDLE (33) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:229]: Creating MSIHANDLE (34) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:239]: Closing MSIHANDLE (34) of type 790531 for thread 1024
MSI (c) (8C!00) [18:10:31:239]: PROPERTY CHANGE: Deleting WiseNextDialog property. Its current value is 'Start_Installation_Dialog'.
MSI (c) (8C!00) [18:10:31:239]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog|License_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog|Start_Installation_Dialog'.
MSI (c) (8C!00) [18:10:31:239]: Closing MSIHANDLE (26) of type 790540 for thread 1024
MSI (c) (8C!00) [18:10:31:239]: Closing MSIHANDLE (25) of type 790541 for thread 1024
MSI (c) (8C:48) [18:10:31:239]: Closing MSIHANDLE (24) of type 790542 for thread 1108
Action ended 18:10:31: WiseNextDlg. Return value 1.
Action ended 18:10:31: Welcome_Dialog. Return value 1.
MSI (c) (8C:4C) [18:10:31:239]: Skipping action: Resume_Install_Dialog (condition is false)
MSI (c) (8C:4C) [18:10:31:239]: Skipping action: Patch_Dialog (condition is false)
MSI (c) (8C:4C) [18:10:31:239]: Skipping action: SetWizardProperty (condition is false)
MSI (c) (8C:4C) [18:10:31:239]: Skipping action: Maintenance_Welcome_Dialog (condition is false)
MSI (c) (8C:4C) [18:10:31:239]: Doing action: Progress_Dialog
Action start 18:10:31: Progress_Dialog.
Action 18:10:31: Progress_Dialog. Dialog created
Action ended 18:10:31: Progress_Dialog. Return value 1.
MSI (c) (8C:4C) [18:10:31:259]: Doing action: ExecuteAction
Action start 18:10:31: ExecuteAction.

And here's the same piece of log from Vista SP2. Notice how the CostingComplete change is near the end, after the welcome dialog has finished:

MSI (c) (EC:F4) [18:06:31:359]: Doing action: Welcome_Dialog
Action 18:06:31: Welcome_Dialog.
Action start 18:06:31: Welcome_Dialog.
MSI (c) (EC:F4) [18:06:31:359]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'Welcome_Dialog'
Action 18:06:31: Welcome_Dialog. Dialog created
MSI (c) (EC:F0) [18:06:33:863]: Doing action: WiseNextDlg
Action 18:06:33: WiseNextDlg.
Action start 18:06:33: WiseNextDlg.
MSI (c) (EC:F0) [18:06:33:863]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (EC:F0) [18:06:33:863]: Creating MSIHANDLE (8) of type 790542 for thread 3056
MSI (c) (EC:E0) [18:06:33:863]: Invoking remote custom action. DLL: C:\Users\alan\AppData\Local\Temp\MSID096.tmp, Entrypoint: WiseNextDlg
MSI (c) (EC!E4) [18:06:33:953]: PROPERTY CHANGE: Adding WiseCurrentDialog property. Its value is 'Welcome_Dialog'.
MSI (c) (EC!E4) [18:06:33:953]: Creating MSIHANDLE (9) of type 790541 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Creating MSIHANDLE (10) of type 790540 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Creating MSIHANDLE (11) of type 790531 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Closing MSIHANDLE (11) of type 790531 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Creating MSIHANDLE (12) of type 790531 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: PROPERTY CHANGE: Adding WiseNextDialog property. Its value is 'License_Dialog'.
MSI (c) (EC!E4) [18:06:33:953]: PROPERTY CHANGE: Adding WiseDialogStack property. Its value is 'Welcome_Dialog'.
MSI (c) (EC!E4) [18:06:33:953]: Closing MSIHANDLE (12) of type 790531 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Closing MSIHANDLE (10) of type 790540 for thread 3300
MSI (c) (EC!E4) [18:06:33:953]: Closing MSIHANDLE (9) of type 790541 for thread 3300
MSI (c) (EC:E0) [18:06:33:953]: Closing MSIHANDLE (8) of type 790542 for thread 3056
Action ended 18:06:33: WiseNextDlg. Return value 1.
Info 2898. For Arial8 textstyle, the system created a 'Arial' font, in 1 character set, of 14 pixels height.
Action 18:06:34: License_Dialog. Dialog created
MSI (c) (EC:F0) [18:06:35:405]: PROPERTY CHANGE: Modifying Accept property. Its current value is 'No'. Its new value: 'Yes'.
MSI (c) (EC:F0) [18:06:36:657]: Doing action: WiseNextDlg
Action 18:06:36: WiseNextDlg.
Action start 18:06:36: WiseNextDlg.
MSI (c) (EC:F0) [18:06:36:657]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (EC:F0) [18:06:36:657]: Creating MSIHANDLE (13) of type 790542 for thread 3056
MSI (c) (EC:00) [18:06:36:657]: Invoking remote custom action. DLL: C:\Users\alan\AppData\Local\Temp\MSIDB81.tmp, Entrypoint: WiseNextDlg
MSI (c) (EC!04) [18:06:36:687]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'Welcome_Dialog'. Its new value: 'License_Dialog'.
MSI (c) (EC!04) [18:06:36:687]: Creating MSIHANDLE (14) of type 790541 for thread 3332
MSI (c) (EC!04) [18:06:36:687]: Creating MSIHANDLE (15) of type 790540 for thread 3332
MSI (c) (EC!04) [18:06:36:687]: Creating MSIHANDLE (16) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (16) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (17) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (17) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (18) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (18) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (19) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (19) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (20) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (20) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (21) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (21) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (22) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (22) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Creating MSIHANDLE (23) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: PROPERTY CHANGE: Modifying WiseNextDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (EC!04) [18:06:36:697]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog'.
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (23) of type 790531 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (15) of type 790540 for thread 3332
MSI (c) (EC!04) [18:06:36:697]: Closing MSIHANDLE (14) of type 790541 for thread 3332
MSI (c) (EC:00) [18:06:36:697]: Closing MSIHANDLE (13) of type 790542 for thread 3056
Action ended 18:06:36: WiseNextDlg. Return value 1.
Action 18:06:36: Start_Installation_Dialog. Dialog created
MSI (c) (EC:F0) [18:06:37:879]: Doing action: WiseNextDlg
Action 18:06:37: WiseNextDlg.
Action start 18:06:37: WiseNextDlg.
MSI (c) (EC:F0) [18:06:37:879]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'WiseNextDlg'
MSI (c) (EC:F0) [18:06:37:879]: Creating MSIHANDLE (24) of type 790542 for thread 3056
MSI (c) (EC:28) [18:06:37:879]: Invoking remote custom action. DLL: C:\Users\alan\AppData\Local\Temp\MSIE048.tmp, Entrypoint: WiseNextDlg
MSI (c) (EC!2C) [18:06:37:959]: PROPERTY CHANGE: Modifying WiseCurrentDialog property. Its current value is 'License_Dialog'. Its new value: 'Start_Installation_Dialog'.
MSI (c) (EC!2C) [18:06:37:959]: Creating MSIHANDLE (25) of type 790541 for thread 3372
MSI (c) (EC!2C) [18:06:37:959]: Creating MSIHANDLE (26) of type 790540 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (27) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (27) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (28) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (28) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (29) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (29) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (30) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (30) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (31) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (31) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (32) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (32) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (33) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (33) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Creating MSIHANDLE (34) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (34) of type 790531 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: PROPERTY CHANGE: Deleting WiseNextDialog property. Its current value is 'Start_Installation_Dialog'.
MSI (c) (EC!2C) [18:06:37:969]: PROPERTY CHANGE: Modifying WiseDialogStack property. Its current value is 'Welcome_Dialog|License_Dialog'. Its new value: 'Welcome_Dialog|License_Dialog|Start_Installation_Dialog'.
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (26) of type 790540 for thread 3372
MSI (c) (EC!2C) [18:06:37:969]: Closing MSIHANDLE (25) of type 790541 for thread 3372
MSI (c) (EC:28) [18:06:37:969]: Closing MSIHANDLE (24) of type 790542 for thread 3056
Action ended 18:06:37: WiseNextDlg. Return value 1.
Action 18:07:32: Cancel. Dialog created
Action ended 18:07:34: Welcome_Dialog. Return value 2.
MSI (c) (EC:F4) [18:07:34:220]: Doing action: User_Exit
Action 18:07:34: User_Exit.
Action start 18:07:34: User_Exit.
MSI (c) (EC:F4) [18:07:34:220]: Note: 1: 2235 2:  3: ExtendedType 4: SELECT `Action`,`Type`,`Source`,`Target`, NULL, `ExtendedType` FROM `CustomAction` WHERE `Action` = 'User_Exit'
Action 18:07:34: User_Exit. Dialog created
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: DuplicateFile 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: ReserveCost 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2205 2:  3: _RemoveFilePath
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: TypeLib 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (EC:BC) [18:07:34:250]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: BindImage 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: ProgId 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: PublishComponent 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: SelfReg 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: Font 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2262 2: Class 3: -2147287038
MSI (c) (EC:BC) [18:07:34:260]: Note: 1: 2727 2: 
Action ended 18:07:35: User_Exit. Return value 2.
Action ended 18:07:35: INSTALL. Return value 2.
MSI (c) (EC:F4) [18:07:35:702]: Destroying RemoteAPI object.
MSI (c) (EC:9C) [18:07:35:702]: Custom Action Manager thread ending.

OK, you didn't mention running on VM's, and that could indeed be relevant. So can I open the discussion further to enquire which VMs you are running, and whether your customer is running the same VMs - at the end of the day, if this proves to be a bug, then being able to duplicate the problem in the lab is a big first step to finding the location of the bug.
So please share with us the detailed configuration of your VMs. Presumably you have not tried this on a real machine if you are testing in VMs.

Secondly, are you able to zip and attach an example MSI which demonstrates the problem?

How can I attach a file? There seems to be no way to attach to replies, only to the initial new post.  I'll be happy to post a zipped example somewhere, or email or whatever works.

Humble apologies if not mentioning the VM wasted time!  I should have thought to say that, though I didn't know it _only_ happened in a VM until yesterday's customer email. 

I'm using a VirtualPC VM of a fresh Vista install with SP2 applied.  I suspect our customer is also using VirtualPC because they mentioned the VHD virtual disk file that (afaik) is specific to VirtualPC. Unfortunately I don't have a machine where I can try an install on a "real" non-virtual Vista SP2.  The VM settings are listed below.

Incidentally VirtualPC, MS's free tool, is very handy for install tests, because with the right settings a batch file can take one from a crashed running OS back to a clean running OS in about ten or fifteen seconds - the recovery is much less than I've found with other virtualization tools. I set the VM to have "undo disks" enabled, and save a running image. Then the batch can kill VirtualPC, restore the small VMC file, and restart VirtualPC; as the big virtual disk file doesn't get changed, this lets the kill-restart happen v

Aplogies again!
Alan

VirtualPC version 6.0.192.0 (running on host with XP SP3, 2GB RAM)
Virtual machine settings:
Vista SP2 installed (from ISO)
Memory: 1024 MB
Hard disk: 32,768 MB, dynamically expanding virtual hard disk, version 5.3
Undo disks: enabled
CD/DVD: not attached
Floppy: none
COM1/COM2/LPT2: none
Networking:one Intel PRO/100 S Desktop Adapter
Sound:enabled
Hardware Virtualization: not available
Mouse: pointer integration on
No shared folders
Display: default

The VirtualPC Virtual Machine Additions are installed - they integrate the VM window with the host OS, enabling drag-and-drop etc.

I've made a new WSI that installs only a single text file, with two dialogs: "Welcome" and "Start Install". The same problem occurs in Vista SP2 VirtualPC VM -- clicking Next on the Start Installation dialog opens a popup "Please wait while i check your disk requirements" that never closes itself. 

So it really does seem like a bug in Wise Installation Studio (or at least could be described as an incompatibility between WIS and Vista SP2 VM.)

You can only attach stuff to your original posting in the thread - it's an annoying limitation of the forum software which I hope they will fix in due course. You can use the Edit option to add stuff to your original post.
WPS8 was released recently, and the Wisescript Editor has had a number of bug fixes applied. If you have the time, you could set up the eval download and see if the wisescript editor works for Vista SP2 VMs

I have experienced this error too after upgrading MSI runtime to 4.5. The user has to click Cancel and restart the setup. The second time it works. I remember that I read that this was an MSI problem in 4.5. I'm not sure if this is the same problem.

Thanks for the help. I'm moving on without a fix, and will suggest that the customer propagates the workaround of installing silently.

I found the thread about this problem:

https://www-secure.symantec.com/connect/forums/cos...

Maybe you could try to move the Costfinalize action as suggested?