cancel
Showing results for 
Show  only  | Search instead for 
Did you mean: 
lam1278
Level 6

Unresponsive dialogs - CostingComplete the issue??

Hidenori has helped me significantly with improving the time on the ISSQLServerValidate Action on the Next button of the "LicenseAgreement" dialog ... thank you for that!

[SIZE="5"]Now I am calling ALL MSI GEEKS!!
PLEASE PLEASE HELP -- DON'T GLANCE OVER THIS BECAUSE IT IS FRIDAY, THIS ONE IS A STUMPER...
[/SIZE]

I have an oddity that I can only explain to a background MSI process making my dialogs "InstallWelcome" OR "LicenseAgreement" Unresponsive... Now... you may ask, how could that be?? My response... I DON'T KNOW!! However, since there is no set time for clicking on dialogs, I can only state that the problem occurs on one dialog or the other, not both.

In the first instance, my InstallWelcome dialog hung when I tried to click "Next":

[CODE]
MSI (c) (88:8C) [13:58:55:097]: Doing action: InstallWelcome
Action 13:58:55: InstallWelcome.
Action start 13:58:55: InstallWelcome.
Action 13:58:55: InstallWelcome. Dialog created
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:177]: Note: 1: 2205 2: 3: _RemoveFilePath
MSI (c) (88:24) [13:58:55:367]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: BindImage
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: PublishComponent
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: SelfReg
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: Font
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2727 2:
Info 2898.For MSSansBold8 textstyle, the system created a 'Tahoma' font, in 1 character set.
Info 2898.For MSSWhiteSerif8 textstyle, the system created a 'Tahoma' font, in 1 character set.
Action 13:58:58: LicenseAgreement. Dialog created
MSI (c) (88:24) [13:59:00:174]: PROPERTY CHANGE: Modifying AgreeToLicense property. Its current value is 'No'. Its new value: 'Yes'.
MSI (c) (88:24) [13:59:01:245]: Doing action: ISSQLServerValidate
Action 13:59:01: ISSQLServerValidate.
Action start 13:59:01: ISSQLServerValidate.
MSI (c) (88:08) [13:59:01:296]: Invoking remote custom action. DLL: C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\MSI15.tmp, Entrypoint: ISSQLServerValidate
MSI (c) (88!74) [13:59:03:278]: PROPERTY CHANGE: Adding IS_SQLSERVER_STATUS property. Its value is '0'.
Action ended 13:59:03: ISSQLServerValidate. Return value 1.
Action 13:59:03: ReadyToInstall. Dialog created
MSI (c) (88:24) [13:59:03:819]: Note: 1: 2727 2:
MSI (c) (88:24) [13:59:04:320]: Note: 1: 2727 2:
Action ended 13:59:04: InstallWelcome. Return value 1.
[/CODE]

In the second instance, the LicenseAgreement dialog hung when I tried to click "I accept" - there was like a 20 second delay before I could do anything on the dialog, and I even saw a "Not Responding" in the title bar when I tried to click the "I accept" radio button. In particular, I am trying to understand what could be happening so that my dialog would not be responsive and it took almost exactly 21 seconds to get from "No" to "Yes":

Action 8:19:37: LicenseAgreement. Dialog created
MSI (c) (C4:EC) [08:19:57:918]: PROPERTY CHANGE: Modifying AgreeToLicense property. Its current value is 'No'. Its new value: 'Yes'.

More of Log file:
[CODE]
MSI (c) (C4:80) [08:19:35:686]: Doing action: InstallWelcome
Action 8:19:35: InstallWelcome.
Action start 8:19:35: InstallWelcome.
Action 8:19:35: InstallWelcome. Dialog created
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:19:35:767]: Note: 1: 2205 2: 3: _RemoveFilePath
Info 2898.For MSSansBold8 textstyle, the system created a 'Tahoma' font, in 0 character set.
Info 2898.For MSSWhiteSerif8 textstyle, the system created a 'Tahoma' font, in 0 character set.
Action 8:19:37: LicenseAgreement. Dialog created
MSI (c) (C4:EC) [08:19:57:918]: PROPERTY CHANGE: Modifying AgreeToLicense property. Its current value is 'No'. Its new value: 'Yes'.
MSI (c) (C4:EC) [08:20:04:528]: Doing action: ISSQLServerValidate
Action 8:20:04: ISSQLServerValidate.
Action start 8:20:04: ISSQLServerValidate.
MSI (c) (C4:F0) [08:20:04:628]: Invoking remote custom action. DLL: C:\DOCUME~1\ADMINI~1\LOCALS~1\Temp\MSI146.tmp, Entrypoint: ISSQLServerValidate
MSI (c) (C4!AC) [08:20:11:398]: PROPERTY CHANGE: Adding IS_SQLSERVER_STATUS property. Its value is '0'.
MSI (c) (C4:EC) [08:20:43:674]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (C4:EC) [08:20:43:674]: Note: 1: 2205 2: 3: BindImage
MSI (c) (C4:EC) [08:20:43:674]: Note: 1: 2205 2: 3: PublishComponent
MSI (c) (C4:EC) [08:20:43:674]: Note: 1: 2205 2: 3: SelfReg
MSI (c) (C4:EC) [08:20:43:674]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (C4:EC) [08:20:43:674]: Note: 1: 2205 2: 3: Font
MSI (c) (C4:EC) [08:20:43:744]: Note: 1: 2727 2:
Action ended 8:20:43: ISSQLServerValidate. Return value 1.
Action 8:20:43: ReadyToInstall. Dialog created
MSI (c) (C4:EC) [08:20:44:255]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:44:756]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:45:256]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:45:757]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:46:258]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:46:759]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:47:259]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:47:760]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:48:261]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:48:761]: Note: 1: 2727 2:
MSI (c) (C4:EC) [08:20:49:262]: Note: 1: 2727 2:
Action ended 8:20:49: InstallWelcome. Return value 1[/CODE]

Now to some of my questions, observations:

1. First of all, it seems to be that whatever MSI (c) (88:24) and MSI (c) (C4:EC) processes are, they are causing the problem.
2. In particular, this log snippet seems to be the culprit. If the dialog is active while this is occuring, the dialog is unresponsive, however, if the dialog is created before this occurs, it is responsive:
[CODE]
MSI (c) (88:24) [13:58:55:367]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: BindImage
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: PublishComponent
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: SelfReg
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2262 2: Extension 3: -2147287038
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2205 2: 3: Font
MSI (c) (88:24) [13:58:55:367]: Note: 1: 2727 2:
[/CODE]
3. Why would any of the above processes result in unresponsive dialogs?
4. Also, in both cases of the above log files, why does: InstallWelcome. Return value 1, occur after ReadyToInstall??

Please help me understand this.

I would like to move this process/sequence that is occurring during my UI Sequence to a different spot, perhaps during "SetupInitialization" as part of the ActionData.

However, I don't know what this process/sequence is that is setting the CostingComplete property, so I cannot move something that I don't know what it is 😞
And I also have no idea how BindImage, PublishComponent, SelfReg and Font are all occurring during my UI Sequence and why that seems to be making my dialogs unresponsive.
Labels (1)
0 Kudos
(2) Replies
Not applicable

While I can't answer the entirety of your issue, I figured I might point you toward the documentation on CostingComplete that might provide a hint:
http://msdn.microsoft.com/en-us/library/aa368049(VS.85).aspx

Essentially, it looks like this property is set by CostFinalize. If the thread suddenly appears after that standard action and never shows up again then it could be a costing issue on the local machine. Unfortunately, Microsoft doesn't document the type of actions this thread would be taking.

Specifically, though, it looks like authoring some kind of "Please wait" dialog to show up during the dialog sequence might make sense. There's a sample here:
http://msdn.microsoft.com/en-us/library/aa367760(VS.85).aspx

I'm not sure if this is specifically your issue, but you might try seeing if this does alleviate the dialog woes you're encountering.
0 Kudos
lam1278
Level 6

Bryan,

Thank you so much for pointing me in this direction... you are a gem!!

I was just in a google search for CostingComplete and found my own post with your response!!

Grrr...I think it is so odd that Microsoft says that "The CostFinalize action ends the internal installation costing process begun by the CostInitialize action." yet, they also give you the exact steps necessary to spawn a dialog just in case their costing is not complete.


Anyhoo, I am doing as they suggested, and Spawning a dialog that says "Please wait while disk space costing is completed." for both the "Next" button on the "InstallWelcome" and on the radio buttons/Next button on the "LicenseAgreement" dialog.

I'll rebuild and test on Monday! This would be awesome if it at least gives the user a better feedback system!

If I run into any other weirdness, I'll reply to this post!
0 Kudos