Logging

MAKEMSI quickly and reliably creates MSI files in a non-programmatic way

Windows Installer FAQ (the basics)

Logging

Windows Installer Basics: Logging

Windows Installer can log different levels of activity into text based log files. When all options are turned on this is generally called "verbose logging" (or mode). There is a type of "super verbose" mode which can be invoked with "x", as in "-l*vx" on the command line (probably only works with Windows Installer 3+).

For some types of situations looking at the event log is required and its always worth a quick look to see if anything is logged (particularly if trying to diagnose why Windows Installer "kicked in", for example by a user logging on or clicking a shortcut).

Be aware that badly written custom actions may write error details directly to the event log and not to the Windows Installer log. A custom action may also log progress into its own files.

How to Turn Logging On

You can turn logging on by using:

"MSIEXEC.EXE" command line switches.
Windows Installer logging policies allow you to capture Installer activity that you have no control over such as installation activity caused by advertised shortcuts (in which case you will also want to check event logs for messages).
There is a MAKEMSI explorer shell extension to easily invoke an msi install (or repair/ uninstall) with logging. The "MSI MENU facility also provides this.
It is possible for your msi to request logging (with the "MsiLogging " property) however this can be overriden with policies.[4.0+]

Examining the Log...

You can view the generated logs with almost any text editor (needs to handle unicode). You can use Notepad if you have nothing better or you can also use the "verbose log viewer" that MAKEMSI installed. The "How to Interpret Windows Installer Logs " blog entry contains an example annotated log as well as other useful information.

Not all "errors" are errors and don't look at the last one, look from the front of the log (or at least work your way backwards). I have documented some of the more likely error codes you are likely to see. Some of the error messages will include Native Windows codes, there is a good list of Windows codes by "Megos AG, Fröhlichstr" which should help although it misses the leading "-" (minus) sign on negative decimal return codes.

As an alternative, you can use this command to translate many Windows Error codes, the following shows how to translate "2":

net helpmsg 2

The above command returns:

The system cannot find the file specified.

You should be able to see your custom actions (which may also create their own log files or generate event log messages) being executed or being skipped because their execution condition was resolved to be false.

Return Value 3

In the log you will see many lines like:

MSI (s) (1C:7C) [11:10:17:578]: Doing action: RemoveExistingProducts
Action 11:10:17: RemoveExistingProducts. Removing applications
Action start 11:10:17: RemoveExistingProducts.
Action ended 11:10:17: RemoveExistingProducts. Return value 1.

The following table will help explain the return values:

Error Code Name MSIEXEC.EXE
Return
Code Logged
Return
Value Description

ERROR_FUNCTION_NOT_CALLED 1626 0 A function could not be (or was not) executed.

ERROR_SUCCESS 0 1 An action completed successfully.

ERROR_INSTALL_USEREXIT 1602 2 A user canceled installation.

ERROR_INSTALL_FAILURE 1603 3 A fatal error.

ERROR_INSTALL_SUSPEND 1604 4 The installation suspended, incomplete.

ERROR_SUCCESS 0 5 The action completed successfully.

ERROR_INVALID_HANDLE_STATE 1609 6 The handle is in an invalid state.

ERROR_INVALID_DATA 1626 7 The data is invalid.

ERROR_INSTALL_ALREADY_RUNNING 1618 8 Another installation is already in progress. Only one installation at a time can run actions in the InstallExecuteSequence, AdminExecuteSequence, or AdvtExecuteSequence.

Error Code Name	MSIEXEC.EXE Return Code	Logged Return Value	Description
ERROR_FUNCTION_NOT_CALLED	1626	0	A function could not be (or was not) executed.
ERROR_SUCCESS	0	1	An action completed successfully.
ERROR_INSTALL_USEREXIT	1602	2	A user canceled installation.
ERROR_INSTALL_FAILURE	1603	3	A fatal error.
ERROR_INSTALL_SUSPEND	1604	4	The installation suspended, incomplete.
ERROR_SUCCESS	0	5	The action completed successfully.
ERROR_INVALID_HANDLE_STATE	1609	6	The handle is in an invalid state.
ERROR_INVALID_DATA	1626	7	The data is invalid.
ERROR_INSTALL_ALREADY_RUNNING	1618	8	Another installation is already in progress. Only one installation at a time can run actions in the InstallExecuteSequence, AdminExecuteSequence, or AdvtExecuteSequence.

Check List

To help quickly locate errors:

Look for the text "error". Remember that not all errors are errors! For example code "2826" is frequently found in logs and can be ignored.
Look for the text "Return value 3" (or "ue 3"). As indicated above this marks a fatal error.
Not really an error (but can be the cause of issues), if the return code of the installation was 3010 (A restart is required to complete the install):
- Look for the text "held in use" to find problem files. You need to work out why they are in use! If they belong to a service, have you stopped it? Is the user running the program at the time?
- The actual scheduling of the reboot should be indicated with messages numbers of "1902" (schedule file rename) & "1903" (schedule file delete).

Look for the text "SELMGR", this may find lines similar to:

MSI (s) (1C:B4) [20:29:38:748]: SELMGR: Removal of a component from a feature is not supported

If you have it working on one machine and not another, then capture logs for both situations and compare them.

Need Help!

The following external links may be useful:

Google search of Web (for 1605 etc)
Replace 1605 with whatever return or error code you are looking for!
AppDeploy.com Error Reference
This has some specific information for some errors (the ones with green text).
InstallSite Runtime Errors forum
A forum you can search or where you can ask questions.
http://blogs.msdn.com/astebner/search.aspx?q=1935&p=1
The first installment is some detailed information about the dreaded 1935 (or 2908) error that sometimes happens when trying to install the .NET Framework or other MSI-based products that install managed assemblies to the GAC
http://msdn.microsoft.com/en-us/library/aa368542.aspx
List of "MSIEXEC.EXE" return codes.
http://msdn.microsoft.com/en-us/library/aa372835.aspx
List of Windows Installer Error Codes and Messages. This lists error messages but doesn't explain them...

Example: Partial Verbose Log

The following shows bits of a verbose log created during the install of "TryMeTaskSchedules.MM" (whole log is too big). You can also have a look at the "sample properties" section for an extract of the property part of a log.

=== Verbose logging started: 9/06/2006  20:29:38  Build type: SHIP UNICODE 3.01.4000.2435  Calling process: C:\WINDOWS\system32\msiexec.exe ===
MSI (c) (1C:B4) [20:29:38:748]: Resetting cached policy values
MSI (c) (1C:B4) [20:29:38:748]: Machine policy value 'Debug' is 0
MSI (c) (1C:B4) [20:29:38:748]: ******* RunEngine:
           ******* Product: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi
           ******* Action:
           ******* CommandLine: **********
MSI (c) (1C:B4) [20:29:38:748]: Machine policy value 'DisableUserInstalls' is 0
MSI (c) (1C:B4) [20:29:38:826]: SOFTWARE RESTRICTION POLICY: Verifying package --> 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi' against software restriction policy
MSI (c) (1C:B4) [20:29:38:826]: Note: 1: 2262 2: DigitalSignature 3: -2147287038
MSI (c) (1C:B4) [20:29:38:826]: SOFTWARE RESTRICTION POLICY: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi is not digitally signed
MSI (c) (1C:B4) [20:29:38:826]: SOFTWARE RESTRICTION POLICY: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi is permitted to run at the 'unrestricted' authorization level.
MSI (c) (1C:B4) [20:29:38:873]: Cloaking enabled.
MSI (c) (1C:B4) [20:29:38:873]: Attempting to enable all disabled priveleges before calling Install on Server
MSI (c) (1C:B4) [20:29:38:873]: End dialog not enabled
MSI (c) (1C:B4) [20:29:38:873]: Original package ==> C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi
MSI (c) (1C:B4) [20:29:38:873]: Package we're running from ==> C:\DOCUME~1\Dennis\LOCALS~1\Temp\c2569c.msi
MSI (c) (1C:B4) [20:29:38:888]: APPCOMPAT: looking for appcompat database entry with ProductCode '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'.
MSI (c) (1C:B4) [20:29:38:904]: APPCOMPAT: no matching ProductCode found in database.
MSI (c) (1C:B4) [20:29:38:904]: MSCOREE not loaded loading copy from system32
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'TransformsSecure' is 0
MSI (c) (1C:B4) [20:29:38:919]: User policy value 'TransformsAtSource' is 0
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'DisablePatch' is 0
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'AllowLockdownPatch' is 0
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'DisableLUAPatching' is 0
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'DisableFlyWeightPatching' is 0
MSI (c) (1C:B4) [20:29:38:919]: APPCOMPAT: looking for appcompat database entry with ProductCode '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'.
MSI (c) (1C:B4) [20:29:38:919]: APPCOMPAT: no matching ProductCode found in database.
MSI (c) (1C:B4) [20:29:38:919]: Transforms are not secure.
MSI (c) (1C:B4) [20:29:38:919]: Command Line: CURRENTDIRECTORY=C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI CLIENTUILEVEL=0 CLIENTPROCESSID=3612
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding PackageCode property. Its value is '{E9C8425D-7F9E-4856-9CDD-383CEA17FD36}'.
MSI (c) (1C:B4) [20:29:38:919]: Product Code passed to Engine.Initialize:           ''
MSI (c) (1C:B4) [20:29:38:919]: Product Code from property table before transforms: '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'
MSI (c) (1C:B4) [20:29:38:919]: Product Code from property table after transforms:  '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'
MSI (c) (1C:B4) [20:29:38:919]: Product not registered: beginning first-time install
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding ProductState property. Its value is '-1'.
MSI (c) (1C:B4) [20:29:38:919]: Entering CMsiConfigurationManager::SetLastUsedSource.
MSI (c) (1C:B4) [20:29:38:919]: User policy value 'SearchOrder' is 'nmu'
MSI (c) (1C:B4) [20:29:38:919]: Adding new sources is allowed.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding PackagecodeChanging property. Its value is '1'.
MSI (c) (1C:B4) [20:29:38:919]: Package name extracted from package path: 'TryMe.msi'
MSI (c) (1C:B4) [20:29:38:919]: Package to be registered: 'TryMe.msi'
MSI (c) (1C:B4) [20:29:38:919]: Note: 1: 2262 2: AdminProperties 3: -2147287038
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'DisableMsi' is 0
MSI (c) (1C:B4) [20:29:38:919]: Machine policy value 'AlwaysInstallElevated' is 0
MSI (c) (1C:B4) [20:29:38:919]: User policy value 'AlwaysInstallElevated' is 0
MSI (c) (1C:B4) [20:29:38:919]: Product installation will be elevated because user is admin and product is being installed per-machine.
MSI (c) (1C:B4) [20:29:38:919]: Running product '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}' with elevated privileges: Product is assigned.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding CURRENTDIRECTORY property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI'.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding CLIENTUILEVEL property. Its value is '0'.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding CLIENTPROCESSID property. Its value is '3612'.
MSI (c) (1C:B4) [20:29:38:919]: TRANSFORMS property is now:
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding VersionDatabase property. Its value is '110'.
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Application Data
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Favorites
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\NetHood
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: D:\DBAREIS
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\PrintHood
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Recent
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\SendTo
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Templates
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Application Data
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Local Settings\Application Data
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: D:\DBAREIS\My Pictures
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Start Menu\Programs\Administrative Tools
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Start Menu\Programs\Startup
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Start Menu\Programs
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Start Menu
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Desktop
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Start Menu\Programs\Administrative Tools
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Start Menu\Programs\Startup
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Start Menu\Programs
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Start Menu
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Desktop
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\All Users\Templates
MSI (c) (1C:B4) [20:29:38:919]: SHELL32::SHGetFolderPath returned: C:\WINDOWS\Fonts
MSI (c) (1C:B4) [20:29:38:919]: Note: 1: 2898 2: MS Sans Serif 3: MS Sans Serif 4: 0 5: 16
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding Privileged property. Its value is '1'.
MSI (c) (1C:B4) [20:29:38:919]: Note: 1: 1402 2: HKEY_CURRENT_USER\Software\Microsoft\MS Setup (ACME)\User Info 3: 2
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding USERNAME property. Its value is 'Schmuck'.
MSI (c) (1C:B4) [20:29:38:919]: Note: 1: 1402 2: HKEY_CURRENT_USER\Software\Microsoft\MS Setup (ACME)\User Info 3: 2
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding DATABASE property. Its value is 'C:\DOCUME~1\Dennis\LOCALS~1\Temp\c2569c.msi'.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding OriginalDatabase property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi'.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding SourceDir property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\'.
MSI (c) (1C:B4) [20:29:38:919]: PROPERTY CHANGE: Adding SOURCEDIR property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\'.
MSI (c) (1C:38) [20:29:38:951]: PROPERTY CHANGE: Adding VersionHandler property. Its value is '3.01'.
=== Logging started: 9/06/2006  20:29:38 ===
MSI (c) (1C:B4) [20:29:38:966]: Note: 1: 2205 2:  3: PatchPackage
MSI (c) (1C:B4) [20:29:38:966]: Machine policy value 'DisableRollback' is 0
MSI (c) (1C:B4) [20:29:38:966]: User policy value 'DisableRollback' is 0
MSI (c) (1C:B4) [20:29:38:966]: PROPERTY CHANGE: Adding UILevel property. Its value is '5'.
MSI (c) (1C:B4) [20:29:38:966]: PROPERTY CHANGE: Adding ACTION property. Its value is 'INSTALL'.
MSI (c) (1C:B4) [20:29:38:966]: Doing action: INSTALL
Action 20:29:38: INSTALL.
Action start 20:29:38: INSTALL.
MSI (c) (1C:B4) [20:29:38:966]: UI Sequence table 'InstallUISequence' is present and populated.
MSI (c) (1C:B4) [20:29:38:966]: Running UISequence
MSI (c) (1C:B4) [20:29:38:966]: PROPERTY CHANGE: Adding EXECUTEACTION property. Its value is 'INSTALL'.
MSI (c) (1C:B4) [20:29:38:966]: Doing action: LaunchConditions
Action 20:29:38: LaunchConditions. Evaluating launch conditions
Action start 20:29:38: LaunchConditions.
MSI (c) (1C:B4) [20:29:38:966]: Note: 1: 2205 2:  3: LaunchCondition
MSI (c) (1C:B4) [20:29:38:966]: Note: 1: 2228 2:  3: LaunchCondition 4: SELECT `Condition`, `Description` FROM `LaunchCondition`
Action ended 20:29:38: LaunchConditions. Return value 0.
MSI (c) (1C:B4) [20:29:38:966]: Doing action: PrepareDlg
Action 20:29:38: PrepareDlg.
Action start 20:29:38: PrepareDlg.
Info 2898. DlgFont8, Tahoma, 1
DEBUG: Error 2826:  Control BottomLine on dialog PrepareDlg extends beyond the boundaries of the dialog to the right by 5 pixels
The installer has encountered an unexpected error installing this package. This may indicate a problem with this package. The error code is 2826. The arguments are: PrepareDlg, BottomLine, to the right
Info 2898. VerdanaBold13, Verdana, 1
Info 2898. UISAMPLE_LEFTSIDE_TEXT, Tahoma, 1
Action 20:29:38: PrepareDlg. Dialog created
Action ended 20:29:38: PrepareDlg. Return value 1.
MSI (c) (1C:B4) [20:29:38:998]: Doing action: FindRelatedProducts
Action 20:29:38: FindRelatedProducts. Searching for related applications
Action start 20:29:38: FindRelatedProducts.
Action ended 20:29:38: FindRelatedProducts. Return value 1.
MSI (c) (1C:B4) [20:29:38:998]: Doing action: AppSearch
Action 20:29:38: AppSearch. Searching for installed applications
Action start 20:29:38: AppSearch.
MSI (c) (1C:B4) [20:29:38:998]: Note: 1: 2205 2:  3: AppSearch
MSI (c) (1C:B4) [20:29:38:998]: Note: 1: 2228 2:  3: AppSearch 4: SELECT `Property`, `Signature_` FROM `AppSearch`
Action ended 20:29:38: AppSearch. Return value 0.
MSI (c) (1C:B4) [20:29:38:998]: Doing action: CCPSearch
Action 20:29:38: CCPSearch. Searching for qualifying products
Action start 20:29:38: CCPSearch.
MSI (c) (1C:B4) [20:29:38:998]: Note: 1: 2205 2:  3: CCPSearch
MSI (c) (1C:B4) [20:29:38:998]: Note: 1: 2228 2:  3: CCPSearch 4: SELECT `Signature_` FROM `CCPSearch`
Action ended 20:29:38: CCPSearch. Return value 0.
MSI (c) (1C:B4) [20:29:38:998]: Doing action: RMCCPSearch
Action 20:29:38: RMCCPSearch. Searching for qualifying products
Action start 20:29:38: RMCCPSearch.
MSI (c) (1C:B4) [20:29:39:013]: Note: 1: 2205 2:  3: CCPSearch
MSI (c) (1C:B4) [20:29:39:013]: Note: 1: 2228 2:  3: CCPSearch 4: SELECT `Signature_` FROM `CCPSearch`
Action ended 20:29:39: RMCCPSearch. Return value 0.
MSI (c) (1C:B4) [20:29:39:013]: Doing action: CostInitialize
Action 20:29:39: CostInitialize. Computing space requirements
Action start 20:29:39: CostInitialize.
MSI (c) (1C:B4) [20:29:39:013]: Machine policy value 'MaxPatchCacheSize' is 10
MSI (c) (1C:B4) [20:29:39:029]: PROPERTY CHANGE: Adding ROOTDRIVE property. Its value is 'Z:\'.
MSI (c) (1C:B4) [20:29:39:029]: PROPERTY CHANGE: Adding CostingComplete property. Its value is '0'.
Action ended 20:29:39: CostInitialize. Return value 1.
MSI (c) (1C:B4) [20:29:39:044]: Doing action: FileCost
Action 20:29:39: FileCost. Computing space requirements
Action start 20:29:39: FileCost.
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: MsiAssembly
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Registry
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Registry
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Class
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Extension
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: TypeLib
Action ended 20:29:39: FileCost. Return value 1.
MSI (c) (1C:B4) [20:29:39:044]: Doing action: CostFinalize
Action 20:29:39: CostFinalize. Computing space requirements
Action start 20:29:39: CostFinalize.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding OutOfDiskSpace property. Its value is '0'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding OutOfNoRbDiskSpace property. Its value is '0'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceAvailable property. Its value is '0'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceRequired property. Its value is '0'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding PrimaryVolumeSpaceRemaining property. Its value is '0'.
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Patch
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: Condition
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding TARGETDIR property. Its value is 'Z:\'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION_MY_COMPANY property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\My Company\'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding MAKEMSI_DOCO property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\My Company\My Name\'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_TRYME_MAKEMSI_SAMPLE property. Its value is 'C:\Program Files\TryMe (makemsi sample)\'.
MSI (c) (1C:B4) [20:29:39:044]: PROPERTY CHANGE: Adding INSTALLDIR property. Its value is 'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\'.
MSI (c) (1C:B4) [20:29:39:044]: Target path resolution complete. Dumping Directory table...
MSI (c) (1C:B4) [20:29:39:044]: Note: target paths subject to change (via custom actions or browsing)
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: TARGETDIR    , Object: Z:\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: ProgramFilesFolder   , Object: C:\Program Files\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION    , Object: C:\Program Files\MAKEMSI Package Documentation\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION_MY_COMPANY , Object: C:\Program Files\MAKEMSI Package Documentation\My Company\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: MAKEMSI_DOCO , Object: C:\Program Files\MAKEMSI Package Documentation\My Company\My Name\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: _PROGRAMFILESFOLDER_TRYME_MAKEMSI_SAMPLE , Object: C:\Program Files\TryMe (makemsi sample)\
MSI (c) (1C:B4) [20:29:39:044]: Dir (target): Key: INSTALLDIR   , Object: C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2205 2:  3: MsiAssembly
MSI (c) (1C:B4) [20:29:39:044]: Note: 1: 2228 2:  3: MsiAssembly 4:  SELECT `MsiAssembly`.`Attributes`, `MsiAssembly`.`File_Application`, `MsiAssembly`.`File_Manifest`,  `Component`.`KeyPath` FROM `MsiAssembly`, `Component` WHERE  `MsiAssembly`.`Component_` = `Component`.`Component` AND `MsiAssembly`.`Component_` = ?
Action ended 20:29:39: CostFinalize. Return value 1.
MSI (c) (1C:B4) [20:29:39:060]: Doing action: MigrateFeatureStates
Action 20:29:39: MigrateFeatureStates. Migrating feature states from related applications
Action start 20:29:39: MigrateFeatureStates.
Action ended 20:29:39: MigrateFeatureStates. Return value 0.
MSI (c) (1C:B4) [20:29:39:060]: Doing action: WelcomeDlg
Action 20:29:39: WelcomeDlg.
Action start 20:29:39: WelcomeDlg.
DEBUG: Error 2826:  Control BottomLine on dialog WelcomeDlg extends beyond the boundaries of the dialog to the right by 5 pixels
The installer has encountered an unexpected error installing this package. This may indicate a problem with this package. The error code is 2826. The arguments are: WelcomeDlg, BottomLine, to the right
Action 20:29:39: WelcomeDlg. Dialog created
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: _RemoveFilePath
MSI (c) (1C:38) [20:29:39:138]: PROPERTY CHANGE: Modifying CostingComplete property. Its current value is '0'. Its new value: '1'.
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: Registry
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: BindImage
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: ProgId
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: PublishComponent
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: SelfReg
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: Extension
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: Font
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: Shortcut
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2205 2:  3: Class
MSI (c) (1C:38) [20:29:39:138]: Note: 1: 2727 2:
DEBUG: Error 2826:  Control BannerBitmap on dialog LicenseAgreementDlg extends beyond the boundaries of the dialog to the right by 5 pixels
The installer has encountered an unexpected error installing this package. This may indicate a problem with this package. The error code is 2826. The arguments are: LicenseAgreementDlg, BannerBitmap, to the right
DEBUG: Error 2826:  Control BannerLine on dialog LicenseAgreementDlg extends beyond the boundaries of the dialog to the right by 5 pixels
The installer has encountered an unexpected error installing this package. This may indicate a problem with this package. The error code is 2826. The arguments are: LicenseAgreementDlg, BannerLine, to the right
DEBUG: Error 2826:  Control BottomLine on dialog LicenseAgreementDlg extends beyond the boundaries of the dialog to the right by 5 pixels
The installer has encountered an unexpected error installing this package. This may indicate a problem with this package. The error code is 2826. The arguments are: LicenseAgreementDlg, BottomLine, to the right
Info 2898. DlgFontBold8, Tahoma, 1
Info 2898. BrandingUL, Tahoma, 1
Info 2898. BrandingLR, Tahoma, 1
Action 20:29:40: LicenseAgreementDlg. Dialog created
MSI (c) (1C:38) [20:29:41:216]: PROPERTY CHANGE: Modifying IAgree property. Its current value is 'No'. Its new value: 'Yes'.

----------------------------- >8 ----------------------------

Action 20:29:47: ProgressDlg. Dialog created
Action ended 20:29:47: ProgressDlg. Return value 1.
MSI (c) (1C:B4) [20:29:47:263]: Doing action: ExecuteAction
Action 20:29:47: ExecuteAction.
Action start 20:29:47: ExecuteAction.
MSI (c) (1C:B4) [20:29:47:263]: PROPERTY CHANGE: Adding SECONDSEQUENCE property. Its value is '1'.
MSI (c) (1C:B4) [20:29:47:279]: Grabbed execution mutex.
MSI (c) (1C:B4) [20:29:47:279]: Incrementing counter to disable shutdown. Counter after increment: 0
MSI (c) (1C:B4) [20:29:47:279]: Switching to server: TARGETDIR="Z:\" _PROGRAMFILESFOLDER_TRYME_MAKEMSI_SAMPLE="C:\Program Files\TryMe (makemsi sample)\" INSTALLDIR="C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\" INSTALLLEVEL="1000" _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION="C:\Program Files\MAKEMSI Package Documentation\" _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION_MY_COMPANY="C:\Program Files\MAKEMSI Package Documentation\My Company\" MAKEMSI_DOCO="C:\Program Files\MAKEMSI Package Documentation\My Company\My Name\" CURRENTDIRECTORY="C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI" CLIENTUILEVEL="0" CLIENTPROCESSID="3612" USERNAME="Schmuck" SOURCEDIR="C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\" ACTION="INSTALL" EXECUTEACTION="INSTALL" ROOTDRIVE="Z:\" SECONDSEQUENCE="1"  ADDLOCAL=ALL.3.076.0000.TryMe_simple_MAKEMSI_te
MSI (s) (04:D8) [20:29:47:279]: Grabbed execution mutex.
MSI (s) (04:50) [20:29:47:279]: Resetting cached policy values
MSI (s) (04:50) [20:29:47:279]: Machine policy value 'Debug' is 0
MSI (s) (04:50) [20:29:47:279]: ******* RunEngine:
           ******* Product: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi
           ******* Action: INSTALL
           ******* CommandLine: **********
MSI (s) (04:50) [20:29:47:294]: Machine policy value 'DisableUserInstalls' is 0
MSI (s) (04:50) [20:29:47:294]: File will have security applied from OpCode.
MSI (s) (04:50) [20:29:47:294]: SOFTWARE RESTRICTION POLICY: Verifying package --> 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi' against software restriction policy
MSI (s) (04:50) [20:29:47:294]: Note: 1: 2262 2: DigitalSignature 3: -2147287038
MSI (s) (04:50) [20:29:47:294]: SOFTWARE RESTRICTION POLICY: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi is not digitally signed
MSI (s) (04:50) [20:29:47:294]: SOFTWARE RESTRICTION POLICY: C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi is permitted to run at the 'unrestricted' authorization level.
MSI (s) (04:50) [20:29:47:294]: End dialog not enabled
MSI (s) (04:50) [20:29:47:294]: Original package ==> C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\TryMe.msi
MSI (s) (04:50) [20:29:47:294]: Package we're running from ==> C:\WINDOWS\Installer\c277ef.msi
MSI (s) (04:50) [20:29:47:294]: APPCOMPAT: looking for appcompat database entry with ProductCode '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'.
MSI (s) (04:50) [20:29:47:294]: APPCOMPAT: no matching ProductCode found in database.
MSI (s) (04:50) [20:29:47:310]: MSCOREE not loaded loading copy from system32
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'TransformsSecure' is 0
MSI (s) (04:50) [20:29:47:310]: User policy value 'TransformsAtSource' is 0
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'DisablePatch' is 0
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'AllowLockdownPatch' is 0
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'DisableLUAPatching' is 0
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'DisableFlyWeightPatching' is 0
MSI (s) (04:50) [20:29:47:310]: APPCOMPAT: looking for appcompat database entry with ProductCode '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'.
MSI (s) (04:50) [20:29:47:310]: APPCOMPAT: no matching ProductCode found in database.
MSI (s) (04:50) [20:29:47:310]: Transforms are not secure.
MSI (s) (04:50) [20:29:47:310]: Command Line: TARGETDIR=Z:\ _PROGRAMFILESFOLDER_TRYME_MAKEMSI_SAMPLE=C:\Program Files\TryMe (makemsi sample)\ INSTALLDIR=C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\ INSTALLLEVEL=1000 _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION=C:\Program Files\MAKEMSI Package Documentation\ _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION_MY_COMPANY=C:\Program Files\MAKEMSI Package Documentation\My Company\ MAKEMSI_DOCO=C:\Program Files\MAKEMSI Package Documentation\My Company\My Name\ CURRENTDIRECTORY=C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI CLIENTUILEVEL=0 CLIENTPROCESSID=3612 USERNAME=Schmuck SOURCEDIR=C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\ ACTION=INSTALL EXECUTEACTION=INSTALL ROOTDRIVE=Z:\ SECONDSEQUENCE=1 ADDLOCAL=ALL.3.076.0000.TryMe_simple_MAKEMSI_te ACTION=INSTALL
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding PackageCode property. Its value is '{E9C8425D-7F9E-4856-9CDD-383CEA17FD36}'.
MSI (s) (04:50) [20:29:47:310]: Product Code passed to Engine.Initialize:           ''
MSI (s) (04:50) [20:29:47:310]: Product Code from property table before transforms: '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'
MSI (s) (04:50) [20:29:47:310]: Product Code from property table after transforms:  '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}'
MSI (s) (04:50) [20:29:47:310]: Product not registered: beginning first-time install
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding ProductState property. Its value is '-1'.
MSI (s) (04:50) [20:29:47:310]: Entering CMsiConfigurationManager::SetLastUsedSource.
MSI (s) (04:50) [20:29:47:310]: User policy value 'SearchOrder' is 'nmu'
MSI (s) (04:50) [20:29:47:310]: Adding new sources is allowed.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding PackagecodeChanging property. Its value is '1'.
MSI (s) (04:50) [20:29:47:310]: Package name extracted from package path: 'TryMe.msi'
MSI (s) (04:50) [20:29:47:310]: Package to be registered: 'TryMe.msi'
MSI (s) (04:50) [20:29:47:310]: Note: 1: 2262 2: AdminProperties 3: -2147287038
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'DisableMsi' is 0
MSI (s) (04:50) [20:29:47:310]: Machine policy value 'AlwaysInstallElevated' is 0
MSI (s) (04:50) [20:29:47:310]: User policy value 'AlwaysInstallElevated' is 0
MSI (s) (04:50) [20:29:47:310]: Product installation will be elevated because user is admin and product is being installed per-machine.
MSI (s) (04:50) [20:29:47:310]: Running product '{60ACE8CF-FF1B-42F1-9F7F-279E154D47A4}' with elevated privileges: Product is assigned.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding TARGETDIR property. Its value is 'Z:\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_TRYME_MAKEMSI_SAMPLE property. Its value is 'C:\Program Files\TryMe (makemsi sample)\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding INSTALLDIR property. Its value is 'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Modifying INSTALLLEVEL property. Its current value is '3'. Its new value: '1000'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding _PROGRAMFILESFOLDER_MAKEMSI_PACKAGE_DOCUMENTATION_MY_COMPANY property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\My Company\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding MAKEMSI_DOCO property. Its value is 'C:\Program Files\MAKEMSI Package Documentation\My Company\My Name\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding CURRENTDIRECTORY property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI'.

----------------------------- >8 ----------------------------

MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding CLIENTUILEVEL property. Its value is '0'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding CLIENTPROCESSID property. Its value is '3612'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding USERNAME property. Its value is 'Schmuck'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding SOURCEDIR property. Its value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding ACTION property. Its value is 'INSTALL'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding EXECUTEACTION property. Its value is 'INSTALL'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding ROOTDRIVE property. Its value is 'Z:\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding SECONDSEQUENCE property. Its value is '1'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding ADDLOCAL property. Its value is 'ALL.3.076.0000.TryMe_simple_MAKEMSI_te'.
MSI (s) (04:50) [20:29:47:310]: Engine has iefSecondSequence set to true.
MSI (s) (04:50) [20:29:47:310]: TRANSFORMS property is now:
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Deleting SOURCEDIR property. Its current value is 'C:\Program Files\MakeMsi\Samples\TryMe\Create MSI Installers\out\TryMeTaskSchedules.MM\MSI\'.
MSI (s) (04:50) [20:29:47:310]: PROPERTY CHANGE: Adding VersionDatabase property. Its value is '110'.
MSI (s) (04:50) [20:29:47:310]: SHELL32::SHGetFolderPath returned: C:\Documents and Settings\Dennis\Application Data

----------------------------- >8 ----------------------------

MSI (s) (04:50) [20:29:49:998]: Executing op: ActionStart(Name=Schedules1Installation,Description=Installing task schedule #1,)
Action 20:29:49: Schedules1Installation. Installing task schedule #1
MSI (s) (04:50) [20:29:49:998]: Executing op: CustomActionSchedule(Action=Schedules1Installation,ActionType=1030,Source='*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+*+
' Generator   : PPWIZARD version 06.154
'             : FREE tool for Windows, OS/2, DOS and UNIX by Dennis Bareis (NotReal@I.hate.spammers.)
'             : http://users.cyberone.com.au/dbareis/ppwizard.htm
' Time        : Friday, 9 Jun 2006 6:02:33pm
' Input File  : C:\Program Files\MakeMsi\Samples\TryMe\Create MSI
Action 20:29:50:     VBS-> . Custom Action "Installs_2_Schedules" starting...


    VBS-> Custom Action  : Installs_2_Schedules
    VBS-> CA Type        : DEFERRED (very limited access to properties, information passes in "CustomActionData")
    VBS-> Defined At     : TryMeTaskSchedules.MM(214)
    VBS-> Running Mode   : Custom Action
    VBS-> Product Name   : TryMe (simple MAKEMSI test MSI)
    VBS-> Product Version: 3.076.0000
    VBS-> Product MSI    : TryMe.msi
    VBS-> Extra Log      : C:\MAKEMSI_VBSCA-TryMe (simple MAKEMSI test MSI)(3.076.0000)-Friday.log
    VBS-> User's ID      : Dennis
    VBS-> User's Domain  : CN-DENNIS

    VBS-> InstallSchedule_1(): Stub STARTING
Action 20:29:50:     VBS-> . Custom Action "Installs_2_Schedules" - InstallSchedule_1()
    VBS-> : USER_InstallSchedule_1() - User function starting...
    VBS-> VbsCaCadGet(ScheduleExe)

    VBS-> VbsCaPropertyGet("CustomActionData")
    VBS-> CustomActionData => "3,_,ScheduleExe=C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE,_,INSTALLDIR=C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\,_,Schedule1Comment=Runs simple CMD.EXE task,_,Schedule2Comment=Runs VBS (logs progress)"

    VBS-> Splitting: ScheduleExe=C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE,_,INSTALLDIR=C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\,_,Schedule1Comment=Runs simple CMD.EXE task,_,Schedule2Comment=Runs VBS (logs progress)
    VBS->   - #1, ScheduleExe = C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE
    VBS->   - #2, INSTALLDIR = C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\
    VBS->   - #3, Schedule1Comment = Runs simple CMD.EXE task
    VBS->   - #4, Schedule2Comment = Runs VBS (logs progress)

    VBS-> "ScheduleExe" contained "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE"
    VBS-> Removing schedule: SillySchedule1 - (*Schedule1Comment*)
    VBS-> VbsCaCadGet(Schedule1Comment)
    VBS-> "Schedule1Comment" contained "Runs simple CMD.EXE task"
    VBS-> VbsCaCadGet(INSTALLDIR)
    VBS-> "INSTALLDIR" contained "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\"
    VBS-> VbsCaCadGet(INSTALLDIR)
    VBS-> "INSTALLDIR" contained "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\"
Action 20:29:50:     VBS-> . Removing schedule: SillySchedule1 - Runs simple CMD.EXE task
    VBS-> : Schedule doesn't exist: C:\WINDOWS\TASKS\SillySchedule1 - Runs simple CMD.EXE task.job
    VBS-> Finished removing schedule: SillySchedule1 - Runs simple CMD.EXE task
    VBS-> Creating schedule: SillySchedule1 - (*Schedule1Comment*)
    VBS-> VbsCaCadGet(Schedule1Comment)
    VBS-> "Schedule1Comment" contained "Runs simple CMD.EXE task"
    VBS-> VbsCaCadGet(INSTALLDIR)
    VBS-> "INSTALLDIR" contained "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\"
    VBS-> VbsCaCadGet(INSTALLDIR)
    VBS-> "INSTALLDIR" contained "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\"
Action 20:29:50:     VBS-> . Creating schedule: SillySchedule1 - Runs simple CMD.EXE task
    VBS-> Creating temporary command line file (to shorten command line): /SJ WorkingDirectory = "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\" ApplicationName = "%COMSPEC%" Parameters = "/C echo %DATE% %TIME%: SillySchedule1 says hello... >> \SillySchedule1.log 2>&1" Comment = "This is a comment for the schedule (INSTALLDIR = 'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\')" MaxRunTime = 3600000 KillIfGoingOnBatteries = 0 SystemRequired = 1 /CTJ Type = Weekly TypeArguments = 1,.M.W.F. StartTime = 06:00 MinutesDuration = 600 MinutesInterval = 60 HasEndDate = 0 EndDate = 00/00/0000 KillAtDuration = 1 Disabled = 0 /SC "" NULL /PJ /svj "C:\WINDOWS\TASKS\SillySchedule1 - Runs simple CMD.EXE task.job"
    VBS-> : Executing: "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE" @ "C:\DOCUME~1\Dennis\LOCALS~1\Temp\JtCl-rad0ABBC.tmp"
    VBS-> EXECUTING: "C:\WINDOWS\system32\cmd.exe" /c ""C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\JT.EXE" @ "C:\DOCUME~1\Dennis\LOCALS~1\Temp\JtCl-rad0ABBC.tmp" > "C:\DOCUME~1\Dennis\LOCALS~1\Temp\rad5B1BE.tmp" 2>&1"
    VBS-> C:\DOCUME~1\Dennis\LOCALS~1\Temp\JtCl-rad0ABBC.tmp
    VBS-> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
    VBS-> /SJ WorkingDirectory = "C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\" ApplicationName = "%COMSPEC%" Parameters = "/C echo %DATE% %TIME%: SillySchedule1 says hello... >> \SillySchedule1.log 2>&1" Comment = "This is a comment for the schedule (INSTALLDIR = 'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\')" MaxRunTime = 3600000 KillIfGoingOnBatteries = 0 SystemRequired = 1 /CTJ Type = Weekly TypeArguments = 1,.M.W.F. StartTime = 06:00 MinutesDuration = 600 MinutesInterval = 60 HasEndDate = 0 EndDate = 00/00/0000 KillAtDuration = 1 Disabled = 0 /SC "" NULL /PJ /svj "C:\WINDOWS\TASKS\SillySchedule1 - Runs simple CMD.EXE task.job"

    VBS-> REDIRECTED OUTPUT: C:\DOCUME~1\Dennis\LOCALS~1\Temp\rad5B1BE.tmp
    VBS-> ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
    VBS->  Setting job's properties
 Created trigger 0
 Setting account information
 Printing all job properties

  ApplicationName:    'C:\WINDOWS\system32\cmd.exe'
  Parameters:         '/C echo %DATE% %TIME%: SillySchedule1 says hello... >> \SillySchedule1.log 2>&1'
  WorkingDirectory:   'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\'
  Comment:            'This is a comment for the schedule (INSTALLDIR = 'C:\Program Files\TryMe (makemsi sample)\TryMeTaskSchedules.MM\')'
  Creator:            ''
  Priority:           NORMAL
  MaxRunTime:         3600000 (0d  1:00:00)
  IdleWait:           10
  IdleDeadline:       60
  MostRecentRun:      00/00/0000  0:00:00
  NextRun:            06/12/2006  6:00:00
  StartError:         SCHED_S_TASK_HAS_NOT_RUN
  ExitCode:           0
  Status:             SCHED_S_TASK_HAS_NOT_RUN
  ScheduledWorkItem Flags:
    DeleteWhenDone          = 0
    Suspend                 = 0
    StartOnlyIfIdle         = 0
    KillOnIdleEnd           = 0
    RestartOnIdleResume     = 0
    DontStartIfOnBatteries  = 0
    KillIfGoingOnBatteries  = 0
    RunOnlyIfLoggedOn       = 0
    SystemRequired          = 1
    Hidden                  = 0
  TaskFlags:          0

  1 Trigger

  Trigger 0:
    Type:            Weekly
    WeeksInterval:   1
    DaysOfTheWeek:   .M.W.F.
    StartDate:       06/09/2006
    EndDate:         00/00/1900
    StartTime:       06:00
    MinutesDuration: 600
    MinutesInterval: 60
    Flags:
      HasEndDate      = 0
      KillAtDuration  = 1
      Disabled        = 0
 Saving Job to C:\WINDOWS\TASKS\SillySchedule1 - Runs simple CMD.EXE tas
        k.job
 Save took 16 ms

    VBS-> EXE Rc = 0

    VBS-> Finished creating schedule: SillySchedule1 - Runs simple CMD.EXE task
    VBS-> : USER_InstallSchedule_1() - User Code FINISHED, RC = 0, err.number was 0

    VBS-> : Finished! USER code did not trap.
    VBS-> InstallSchedule_1(): Stub  FINISHED, RC = 0
MSI (s) (04:50) [20:29:50:654]: Executing op: ActionStart(Name=Schedules2RollBack,Description=Rolling back (removing) task schedule #2,)

----------------------------- >8 ----------------------------

Property(C): OutOfDiskSpace = 0
Property(C): OutOfNoRbDiskSpace = 0
Property(C): PrimaryVolumeSpaceAvailable = 0
Property(C): PrimaryVolumeSpaceRequired = 0
Property(C): PrimaryVolumeSpaceRemaining = 0
=== Logging stopped: 9/06/2006  20:29:59 ===
MSI (c) (1C:B4) [20:29:59:060]: Note: 1: 1707
MSI (c) (1C:B4) [20:29:59:060]: Product: TryMe (simple MAKEMSI test MSI) -- Installation completed successfully.

MSI (c) (1C:B4) [20:29:59:076]: Grabbed execution mutex.
MSI (c) (1C:B4) [20:29:59:076]: Cleaning up uninstalled install packages, if any exist
MSI (c) (1C:B4) [20:29:59:076]: MainEngineThread is returning 0
=== Verbose logging stopped: 9/06/2006  20:29:59 ===

Microsoft awarded me an MVP (Most Valuable Professional award) in 2004, 2005, 2006, 2007, 2008 & 2009 for the Windows SDK (Windows Installer) area.

Please email me any feedback, additional information or corrections.
See this page online (look for updates)