none
Chain Installer hangs at the end. Chain MSI RRS feed

  • Question

  • Hi,
    I am facing an issue where in the Installation is hanging at the end. The finish dialog never comes up. I can see that all the files have got installed all the CAs have run properly. Details.

    I am using InstallShield Professional 2009.
    I am using Basic MSI setup.exe.
    It is a chain Installer with 3 msis.
    Its a Windows 2003 server.
    All the three chained msis are installed properly. 
    IT IS NOT PERSISTANTLY REPRODUCED. If i Uninstall and reinstall the package again, Installation will just go fine. 

    Please let me know any pointers so that i can look at them. 

    Here is the last log entry reported by the windows installer..
    I have removed few lines of log because of the limit of posting.

    Here inLine Bud Service is the last chain package to be installed. After it get installed, Installer will return to the parent package. I see in the failure log,
    Installer is not proceeding further after last chain package gets installed. 

    MSI (s) (34:FC) [16:45:39:354]: Note: 1: 1707 
    MSI (s) (34:FC) [16:45:39:354]: Product: myproduct inLine Bud Service -- Installation operation completed successfully.

    MSI (s) (34:FC) [16:45:39:354]: Windows Installer installed the product. Product Name: myproduct inLine Bud Service. Product Version: 1.0.0.1452. Product Language: 1033. Installation success or error status: 0.

    MSI (s) (34:FC) [16:45:39:354]: MainEngineThread is returning 0
    === Logging stopped: 5/2/2011 16:45:39 ===
    MSI (c) (B8:DC) [16:45:39:464]: Decrementing counter to disable shutdown. If counter >= 0, shutdown will be denied. Counter after decrement: -1
    MSI (c) (B8:DC) [16:45:39:464]: MainEngineThread is returning 0
    === Verbose logging stopped: 5/2/2011 16:45:39 ===

    MSI (s) (34:40) [16:45:39:495]: User policy value 'DisableRollback' is 0
    MSI (s) (34:40) [16:45:39:495]: Machine policy value 'DisableRollback' is 0
    MSI (s) (34:40) [16:45:39:495]: Incrementing counter to disable shutdown. Counter after increment: 0
    MSI (s) (34:68) [16:45:39:511]: Invoking remote custom action. DLL: C:\WINDOWS\Installer\MSI16DD.tmp, Entrypoint: ISChainPackagesCleanup
    MSI (s) (34:40) [16:45:39:682]: Decrementing counter to disable shutdown. If counter >= 0, shutdown will be denied. Counter after decrement: -1
    MSI (s) (34:40) [16:45:39:682]: Restoring environment variables
    MSI (s) (34:40) [16:45:39:682]: No System Restore sequence number for this installation.


    -----------------------------------------------
    But the complete installation with the Setup Finish dialog will have the following log 
    ------------------------------------------------


    MSI (s) (74:54) [22:22:17:265]: Note: 1: 1707 
    MSI (s) (74:54) [22:22:17:265]: Product: myproduct inLine Bud Service -- Installation operation completed successfully.

    MSI (s) (74:54) [22:22:17:265]: Windows Installer installed the product. Product Name: myproduct inLine Bud Service. Product Version: 1.0.0.1443. Product Language: 1033. Installation success or error status: 0.

    MSI (s) (74:54) [22:22:17:265]: MainEngineThread is returning 0
    === Logging stopped: 4/26/2011 22:22:17 ===
    MSI (c) (28:CC) [22:22:17:374]: Decrementing counter to disable shutdown. If counter >= 0, shutdown will be denied. Counter after decrement: -1
    MSI (c) (28:CC) [22:22:17:374]: MainEngineThread is returning 0
    === Verbose logging stopped: 4/26/2011 22:22:17 ===

    MSI (s) (74:20) [22:22:17:390]: User policy value 'DisableRollback' is 0
    MSI (s) (74:20) [22:22:17:390]: Machine policy value 'DisableRollback' is 0
    MSI (s) (74:20) [22:22:17:390]: Incrementing counter to disable shutdown. Counter after increment: 0
    MSI (s) (74:34) [22:22:17:406]: Invoking remote custom action. DLL: C:\WINDOWS\Installer\MSI97F.tmp, Entrypoint: ISChainPackagesCleanup
    MSI (s) (74:20) [22:22:17:562]: Decrementing counter to disable shutdown. If counter >= 0, shutdown will be denied. Counter after decrement: -1
    MSI (s) (74:20) [22:22:17:562]: Restoring environment variables
    MSI (s) (74:20) [22:22:17:562]: No System Restore sequence number for this installation.
    === Verbose logging started: 4/26/2011 22:22:17 Build type: SHIP UNICODE 4.05.6001.00 Calling process: C:\WINDOWS\Installer\MSI89B.tmp ===
    MSI (c) (28:50) [22:22:17:562]: Cloaking enabled.
    MSI (c) (28:50) [22:22:17:562]: Attempting to enable all disabled privileges before calling Install on Server
    === Verbose logging stopped: 4/26/2011 22:22:17 ===

    MSI (c) (10:EC) [22:22:17:577]: Back from server. Return value: 0
    MSI (c) (10:EC) [22:22:17:577]: Decrementing counter to disable shutdown. If counter >= 0, shutdown will be denied. Counter after decrement: -1
    MSI (c) (10:EC) [22:22:17:577]: PROPERTY CHANGE: Deleting SECONDSEQUENCE property. Its current value is '1'.
    Action ended 22:22:17: ExecuteAction. Return value 1.
    MSI (c) (10:EC) [22:22:17:577]: Doing action: DLLWrapCleanup
    Action 22:22:17: DLLWrapCleanup. 
    Action start 22:22:17: DLLWrapCleanup.
    MSI (c) (10:EC) [22:22:17:577]: Creating MSIHANDLE (710) of type 790542 for thread 6124
    (10!FC) [22:22:17:749]: Creating MSIHANDLE (748) of type 790540 for thread 2556
    M
    MSI (c) (10!FC) [22:22:17:765]: Closing MSIHANDLE (771) of type 790541 for thread 2556
    MSI (c) (10!FC) [22:22:17:765]: Closing MSIHANDLE (772) of type 790540 for thread 2556
    MSI (c) (10:B0) [22:22:17:765]: Closing MSIHANDLE (710) of type 790542 for thread 6124
    Action ended 22:22:17: DLLWrapCleanup. Return value 1.
    MSI (c) (10:EC) [22:22:17:765]: Doing action: ISSetupFilesCleanup
    Action 22:22:17: ISSetupFilesCleanup. 
    Action start 22:22:17: ISSetupFilesCleanup.
    MSI (c) (10:EC) [22:22:17:765]: Creating MSIHANDLE (774) of type 790542 for thread 6124
    MSI (c) (10:D4) [22:22:17:765]: Invoking remote custom action. DLL: C:\DOCUME~1\1\LOCALS~1\Temp\MSI982.tmp, Entrypoint: SFCleanupEx
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (775) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\AgentUISetupHelper.dll 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (775) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (776) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\importpfx.exe 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (776) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (777) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\libeay32.dll 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (777) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (778) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\SDConfig.inf 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (778) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (779) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\SDIBMConfig.dll 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (779) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (780) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\SDKyoConfig.dll 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (780) of type 790531 for thread 6112
    MSI (c) (10!E0) [22:22:17:859]: Creating MSIHANDLE (781) of type 790531 for thread 6112
    1: Deleting Support File: C:\DOCUME~1\1\LOCALS~1\Temp\{3C230D85-CB6A-47DA-A647-41CDE9F8E235}\ssleay32.dll 
    MSI (c) (10!E0) [22:22:17:859]: Closing MSIHANDLE (781) of type 790531 for thread 6112
    MSI (c) (10:D4) [22:22:17:952]: Closing MSIHANDLE (774) of type 790542 for thread 6124
    Action ended 22:22:17: ISSetupFilesCleanup. Return value 1.
    MSI (c) (10:EC) [22:22:17:952]: Doing action: SetupCompleteSuccess
    Action 22:22:17: SetupCompleteSuccess. 
    Action start 22:22:17: SetupCompleteSuccess.
    Action 22:22:17: SetupCompleteSuccess. Dialog created
    MSI (c) (10:D4) [22:36:14:511]: Doing action: ISSetupFilesCleanup
    Action 22:36:14: ISSetupFilesCleanup. 
    Action start 22:36:14: ISSetupFilesCleanup.
    MSI (c) (10:D4) [22:36:14:511]: Creating MSIHANDLE (782) of type 790542 for thread 4052
    MSI (c) (10:B0) [22:36:14:511]: Invoking remote custom action. DLL: C:\DOCUME~1\1\LOCALS~1\Temp\MSI983.tmp, Entrypoint: SFCleanupEx
    MSI (c) (10:B0) [22:36:14:558]: Closing MSIHANDLE (782) of type 790542 for thread 4052
    Action ended 22:36:14: ISSetupFilesCleanup. Return value 1.
    Action ended 22:36:14: SetupCompleteSuccess. Return value 2.
    Action ended 22:36:14: INSTALL. Return value 1.
    MSI (c) (10:EC) [22:36:14:573]: Destroying RemoteAPI object.
    MSI (c) (10:94) [22:36:14:589]: Custom Action Manager thread ending.
    Property(C): DiskPrompt = [1]
    Property(C): UpgradeCode = {39058B1C-DB70-4B21-9D96-6BCE3FF762DC}
    Property(C): ProductCode = {3C230D85-CB6A-47DA-A647-41CDE9F8E235}
    Property(C): PROCESS_EXISTS = NO
    Property(C): EXISTING_EXTENSION_RCU = 0
    Property(C): OPROCESS_EXISTS = NO
    Property(C): EXISTING_EXTENSION_VSC = 0
    Property(C): EXISTING_EXTENSION_NVPF = 0
    Property(C): CHECK_PROCESS_OK = 0
    Property(C): PORTSVALID = 1
    Property(C): PLUGIN_TYPE = 0
    Property(C): NON_HV_OS = 1
    Property(C): NO_SPACE_AVAILABLE = 0
    Property(C): CHECK_EXE_OK = 0
    Property(C): PrimaryVolumeSpaceRemaining = 0
    Property(C): PrimaryVolumeSpaceRequired = 0
    Property(C): PrimaryVolumeSpaceAvailable = 0
    Property(C): OutOfNoRbDiskSpace = 0
    Property(C): OutOfDiskSpace = 0
    Property(C): SourcedirProduct = {3C230D85-CB6A-47DA-A647-41CDE9F8E235}
    Property(C): SETUPEXECOUNT = NO
    Property(C): CostingComplete = 1
    Property(C): ROOTDRIVE = C:\
    Property(C): SDCONFIG_LIB_PATH = C:\DOCUME~1\1\LOCALS~1\Temp\SDConfig.dll
    Py(C): CommonAppDataFolder = C:\Documents and Settings\All Users\Application Data\
    Property(C): TemplateFolder = C:\Documents and Settings\All Users\Templates\
    Property(C): HS_DYMC_CERT = null
    Property(C): HSFOLDERREMOVE = 1
    Property(C): ISCHECKFORPRODUCTUPDATES = 1
    Property(C): RCU1 = 0
    Property(C): RCU11 = 0
    Property(C): SD_AgentUI = 0
    Property(C): VSC1 = 0
    Property(C): NewProperty50 = 0
    Property(C): NewProperty51 = 0
    Property(C): ApplicationUsers = AllUsers
    Property(C): NewProperty10 = 0
    Property(C): NewProperty11 = 0
    Property(C): NewProperty25 = 0
    Property(C): NewProperty195 = 0
    Property(C): NewProperty20 = 0
    Property(C): NewProperty26 = 0
    Property(C): NewProperty27 = 0
    Property(C): NewProperty37 = 0
    Property(C): AgentUI_SERVER_SSL_PORT = 8488
    Property(C): AgentUI_SERVER_COM_PORT = 8488
    Property(C): HS_MGM_PORT = 8799
    Property(C): HS_ADMIN_PORT = 8699
    Property(C): HS_FS_PORT = 8897
    Property(C): TCPIP_PORT = 808
    Property(C): HTTP_PORT = 4094
    Property(C): HTTPS_PORT = 4095
    Pro): SMHVINSTALLED = 0
    Property(C): SMVI_PLUGIN_PORT = 8044
    Property(C): SVCACCOUNTVALID = 1
    Property(C): SecureCustomProperties = ISFOUNDNEWERPRODUCTVERSION;USERNAME;COMPANYNAME;ISX_SERIALNUM;SUPPORTDIR;VSC1;RCU1;RCU11;SD_AgentUI;HS_MGM_PORT;HS_ADMIN_PORT;HS_FS_PORT;PLUGIN_PORT;TCPIP_PORT;HTTP_PORT;HTTPS_PORT;SVCUSERNAME;SVCCONFIRMUSERname;AgentUI_SKIP_VERIFY;AgentUI_SERVER_COM_PORT;AgentUI_SERVER_USERNAME;AgentUI_SERVER_SSL_PORT;AgentUI_SERVER_name;HSFOLDERREMOVE;AgentUI_SERVER_INFO;EXISTING_VSPHERE_EXTENSIONS_TEXT;VMWARE_PLUGIN_IP;VCENTER_IP;VCENTER_USERNAME;VCENTER_name;VCENTER_PORT;VC_SKIP_VERIFY;RemoveTempISFiles;AgentUI_SRV_LOGON_PASS;SMHVSRV_name;SMHVSRV_CONFIRMUSERname; SVCUSERname; SVCCONFIRMUSERname;AgentUI_SERVER_name;VCENTER_name;name;PSPOG_KEYSTORE_PASS;PSPOG_KEY_PASS;HS_DYMC_CERT
    Property(C): SetupType = Typical
    Property(C): TRANSPORT_PRT_SELECTION = 1
    Property(C): VALID_AgentUI_SRV_DETECTED = 0
    Property(C): VCACCOUNTVALID = 1
    Property(C): VENDOR = Kyo
    Property(C): VMWAREUPGRADE = 1
    Property(C): VSC = 0
    Property(C): ISReleaseFlags = X86
    Property(C): SETUPEXENAME = ocInLine-setup-mainN_110425_1615-x86.exe
    Property(C): MsiLogFileLocation = C:\DOCUME~1\1\LOCALS~1\Temp\MSI25c07.LOG
    Property(C): VMPLUGINVALID = 1
    Property(C): SendToFolder = C:\Documents and Settings\1\SendTo\
    Property(C): RecentFolder = C:\Documents and Settings\1\Recent\
    Property(C): PrintHoodFolder = C:\Documents and Settings\1\PrintHood\
    Property(C): PersonalFolder = C:\Documents and Settings\1\My Documents\
    Property(C): NetHoodFolder = C:\Documents and Settings\1\NetHood\
    Property(C): FavoritesFolder = C:\Documents and Settings\1\Favorites\
    Property(C): AppDataFolder = C:\Documents and Settings\1\Application Data\
    Property(C): TempFolder = C:\DOCUME~1\1\LOCALS~1\Temp\
    Property(C): RemoteAdminTS = 1
    Property(C): SVCUSERNAME = VIM\1
    Property(C): SVCUSERname = **********
    Property(C): System16Folder = C:\WINDOWS\system\
    Property(C): SystemFolder = C:\WINDOWS\system32\
    Property(C): WindowsVolume = C:\
    Property(C): MsiNTSuiteEnterprise = 1
    Property(C): MsiNTProductType = 3
    Property(C): _BrowseProperty = INSTALLDIR
    Property(C): ServicePackLevelMinor = 0
    Property(C): ServicePackLevel = 2
    Property(C): COMPANYNAME = Kyo
    Property(C): USERNAME = mvikram
    Property(C): AgentUI_SKIP_VERIFY = 1
    Property(C): AgentUI_SERVER_INFO = AgentUI_IP
    Property(C): AgentUI_SERVER_USERNAME = AgentUI_SERVER_USERNAME
    Property(C): WindowsBuild = 3790
    Property(C): PLUGIN_PORT = 8044
    Property(C): VersionMsi = 4.05
    Property(C): VersionDatabase = 200
    Property(C): CLIENTPROCESSID = 5904
    Property(C): CLIENTUILEVEL = 0
    Property(C): CURRENTDIRECTORY = C:\Documents and Settings\1\Desktop
    Property(C): SETUPEXEDIR = C:\Documents and Settings\1\Desktop
    Property(C): PackagecodeChanging = 1
    Property(C): ProductState = -1
    Property(C): PackageCode = {BBC4CBB2-5FC7-4683-B3C6-7CDFA4C96954}


    === Logging stopped: 4/26/2011 22:36:14 ===
    MSI (c) (10:EC) [22:36:14:620]: Note: 1: 1707 
    MSI (c) (10:EC) [22:36:14:620]: Product: myproduct inLine Bud Service -- Installation operation completed successfully.

    MSI (c) (10:EC) [22:36:14:620]: Windows Installer installed the product. Product Name: myproduct inLine Bud Service. Product Version: 1.0. Product Language: 1033. Installation success or error status: 0.

    MSI (c) (10:EC) [22:36:14:636]: Grabbed execution mutex.
    MSI (c) (10:EC) [22:36:14:636]: Cleaning up uninstalled install packages, if any exist
    MSI (c) (10:EC) [22:36:14:636]: MainEngineThread is returning 0
    === Verbose logging stopped: 4/26/2011 22:36:14 ===
    • Moved by Mike Dos Zhang Thursday, May 12, 2011 6:45 AM third party product (From:ClickOnce and Setup & Deployment Projects)
    Tuesday, May 3, 2011 2:07 PM

All replies

  • Hi Sarfu,

    For the question related to InstallShield product, then you need to post it in the InstallShield forum for more expert help.

    http://community.flexerasoftware.com/forumdisplay.php?f=133

     

    Best wishes, 


    Mike [MSFT]
    MSDN Community Support | Feedback to us
    Get or Request Code Sample from Microsoft
    Please remember to mark the replies as answers if they help and unmark them if they provide no help.

    Wednesday, May 4, 2011 7:41 AM
  • Thank you Mike.

    I understand. 

    I have already posted in the InstallShield forum and yet to receive the update.

     

    But I was just hoping that some body might have faced the similar issue might respond to me. 

     

    Can you please guide me with few debugging tools (apart from procmon, wiutil, verbose log. I tried these and they dont really help) that I can investigate as to where the installer is waiting. 

    Wednesday, May 4, 2011 7:51 AM
  • I can't see anything wrong with that log, and that perhaps means that the IS chaining mechanism is the issue.
    Phil Wilson
    • Proposed as answer by RobinDotNet Thursday, May 5, 2011 4:49 AM
    Wednesday, May 4, 2011 4:41 PM
  • Since we have no enough documents for the chain installation, and we also have not used that mechanism(it seems that the setup project doesnot support this). 

    We have less experiences on this issue.

    So I suggest you just try to contact the supporter of that product company or the experts in that company's forum. It will be more suitable than in this forum.

    And for trouble shooting the "strange issue", you also can look into the event viewer, maybe there'll be any usable information can help you locate the root cause's place.

    And I think the current system environments(hardware, software,cpu usage, memory usage, disk usage, net work usage and so on) also can affect each others' running.

    Best wishes,


    Mike [MSFT]
    MSDN Community Support | Feedback to us
    Get or Request Code Sample from Microsoft
    Please remember to mark the replies as answers if they help and unmark them if they provide no help.

    Thursday, May 5, 2011 6:24 AM
  • Thank you Phil, Mike.

     

    I will take it up with IS. 

     

    Regards,

    Sarfaraz

    Friday, May 6, 2011 2:18 PM
  • You're welcome!
    Mike [MSFT]
    MSDN Community Support | Feedback to us
    Get or Request Code Sample from Microsoft
    Please remember to mark the replies as answers if they help and unmark them if they provide no help.

    Thursday, May 12, 2011 6:46 AM