Re: Installation Error, Server Won't Start

On Mar 19, 2:04 pm, r...@iol.ie ("Raymond O'Donnell") wrote:
> On 18/03/2009 22:22, ray wrote:
>
> > I do not see an opportunity to request a log to be written.  From the
> > Psotgre site, I downloaded:
> > postgresql-8.3.7-1-windows.exe
>
> Ah, I see - that's the one-click installer, which is maintained by
> EnterpriseDB. I haven't used that one; I was thinking of the community
> installer (pgInstaller), and that's the one has the logging option.
>
> Ray.
>
> ------------------------------------------------------------------
> Raymond O'Donnell, Director of Music, Galway Cathedral, Ireland
> r...@iol.ie
> Galway Cathedral Recitals:http://www.galwaycathedral.org/recitals
> ------------------------------------------------------------------
>
> --
> Sent via pgsql-general mailing list (pgsql-gene...@postgresql.org)
> To make changes to your subscription:http://www.postgresql.org/mailpref/pgsql-general

Raymond,

I have tried it again with system changes I thought might help but
there was no change in the response.  I have included some sections
for the log, below.

The last warning message was:
Service 'PostgreSQL Database Server 8.3' (pgsql-8.3) failed to start.
Verify that you have sufficient privileges to start system services.

Since I can use a variety of system applications that start/stop
enable/automate/manual any of the system services so I don't think it
is a rights issue.

Here is the first part of the log:
=== Verbose logging started: 3/19/2009  14:48:13  Build type: SHIP
UNICODE 3.01.4000.2435  Calling process: C:\WINDOWS
\system32\msiexec.exe ===
MSI (c) (88:90) [14:48:13:707]: Resetting cached policy values
MSI (c) (88:90) [14:48:13:707]: Machine policy value 'Debug' is 0
MSI (c) (88:90) [14:48:13:707]: ******* RunEngine:
           ******* Product: C:\PostgreSQL\8.3.7\temp\postgresql-8.3-
int.msi
           ******* Action:
           ******* CommandLine: **********
MSI (c) (88:90) [14:48:13:707]: Machine policy value
'DisableUserInstalls' is 0
MSI (c) (88:90) [14:48:18:314]: SOFTWARE RESTRICTION POLICY: Verifying
package --> 'C:\PostgreSQL\8.3.7\temp\postgresql-8.3-int.msi' against
software restriction policy
MSI (c) (88:90) [14:48:18:314]: Note: 1: 2262 2: DigitalSignature 3:
-2147287038
MSI (c) (88:90) [14:48:18:314]: SOFTWARE RESTRICTION POLICY: C:
\PostgreSQL\8.3.7\temp\postgresql-8.3-int.msi is not digitally signed
MSI (c) (88:90) [14:48:18:330]: SOFTWARE RESTRICTION POLICY: C:
\PostgreSQL\8.3.7\temp\postgresql-8.3-int.msi is permitted to run at
the 'unrestricted' authorization level.
MSI (c) (88:90) [14:48:18:408]: Cloaking enabled.
MSI (c) (88:90) [14:48:18:408]: Attempting to enable all disabled
priveleges before calling Install on Server
MSI (c) (88:90) [14:48:18:424]: End dialog not enabled
MSI (c) (88:90) [14:48:18:424]: Original package ==> C:\PostgreSQL
\8.3.7\temp\postgresql-8.3-int.msi
MSI (c) (88:90) [14:48:18:424]: Package we're running from ==> C:
\DOCUME~1\rjoseph\LOCALS~1\Temp\c2d01.msi
MSI (c) (88:90) [14:48:18:424]: APPCOMPAT: looking for appcompat
database entry with ProductCode '{B823632F-3B72-4514-8861-
B961CE263224}'.
MSI (c) (88:90) [14:48:18:424]: APPCOMPAT: no matching ProductCode
found in database.
MSI (c) (88:90) [14:48:18:424]: MSCOREE not loaded loading copy from
system32
MSI (c) (88:90) [14:48:18:424]: Machine policy value
'TransformsSecure' is 0
MSI (c) (88:90) [14:48:18:424]: User policy value 'TransformsAtSource'
is 0
MSI (c) (88:90) [14:48:18:424]: Machine policy value 'DisablePatch' is
0
MSI (c) (88:90) [14:48:18:424]: Machine policy value
'AllowLockdownPatch' is 0
MSI (c) (88:90) [14:48:18:424]: Machine policy value
'DisableLUAPatching' is 0
MSI (c) (88:90) [14:48:18:424]: Machine policy value
'DisableFlyWeightPatching' is 0
MSI (c) (88:90) [14:48:18:440]: APPCOMPAT: looking for appcompat
database entry with ProductCode '{B823632F-3B72-4514-8861-
B961CE263224}'.
MSI (c) (88:90) [14:48:18:440]: APPCOMPAT: no matching ProductCode
found in database.
MSI (c) (88:90) [14:48:18:440]: Transforms are not secure.
MSI (c) (88:90) [14:48:18:440]: Command Line: INTERNALLAUNCH=1
INSTALLLANG=en CURRENTDIRECTORY=C:\WINDOWS\system32 CLIENTUILEVEL=0
CLIENTPROCESSID=2952
MSI (c) (88:90) [14:48:18:440]: PROPERTY CHANGE: Adding PackageCode
property. Its value is '{FAD54106-3052-4D5E-9185-E64713E9368E}'.
MSI (c) (88:90) [14:48:18:440]: Product Code passed to
Engine.Initialize:           ''
MSI (c) (88:90) [14:48:18:440]: Product Code from property table
before transforms: '{B823632F-3B72-4514-8861-B961CE263224}'
MSI (c) (88:90) [14:48:18:440]: Product Code from property table after
transforms:  '{B823632F-3B72-4514-8861-B961CE263224}'
MSI (c) (88:90) [14:48:18:440]: Product not registered: beginning
first-time install

. . .

In this portion of the log, there is a mention of an error but I can't
tell what the conclusion was:
Action start 14:48:18: GetAvailableLocales.
MSI (c) (88:38) [14:48:18:487]: Invoking remote custom action. DLL: C:
\DOCUME~1\rjoseph\LOCALS~1\Temp\MSI5.tmp, Entrypoint:
_GetAvailableLocales@4
MSI (c) (88:28) [14:48:18:487]: Cloaking enabled.
MSI (c) (88:28) [14:48:18:487]: Attempting to enable all disabled
priveleges before calling Install on Server
MSI (c) (88:28) [14:48:18:487]: Connected to service for CA interface.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying LOCALE
property. Its current value is 'DEFAULT'. Its new value: 'C'.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'DEFAULT'. Its new value: 'SQL_ASCII'.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying CLENCODE
property. Its current value is 'DEFAULT'. Its new value: 'SQL_ASCII'.
MSI (c) (88!60) [14:48:19:035]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:051]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:098]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying LOCALE
property. Its current value is 'C'. Its new value: 'English_United
States'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'SQL_ASCII'. Its new value: 'UTF8'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'UTF8'. Its new value: 'WIN1252'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying CLENCODE
property. Its current value is 'SQL_ASCII'. Its new value: 'WIN1252'.
MSI (c) (88:38) [14:48:19:098]: Leaked MSIHANDLE (3) of type 790540
for thread 2400
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2769 2: GetAvailableLocales
3: 1
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2205 2:  3: Error
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2228 2:  3: Error 4: SELECT
`Message` FROM `Error` WHERE `Error` = 2769
DEBUG: Error 2769:  Custom Action GetAvailableLocales did not close 1
MSIHANDLEs.
The installer has encountered an unexpected error installing this
package. This may indicate a problem with this package. The error code
is 2769. The arguments are: GetAvailableLocales, 1,
Action ended 14:48:19: GetAvailableLocales. Return value 1.
MSI (c) (88:90) [14:48:19:098]: Doing action: LaunchConditions
Action 14:48:19: LaunchConditions. Evaluating launch conditions
Action start 14:48:19: LaunchConditions.
Action ended 14:48:19: LaunchConditions. Return value 1.
MSI (c) (88:90) [14:48:19:098]: Doing action: CheckAvailableDLLs
Action 14:48:19: CheckAvailableDLLs.
Action start 14:48:19: CheckAvailableDLLs.
MSI (c) (88:D0) [14:48:19:113]: Invoking remote custom action. DLL: C:
\DOCUME~1\rjoseph\LOCALS~1\Temp\MSI6.tmp, Entrypoint:
_CheckAvailableDLLs@4
MSI (c) (88!B4) [14:48:19:693]: PROPERTY CHANGE: Modifying HAS_PYTHON
property. Its current value is '0'. Its new value: '1'.
MSI (c) (88!B4) [14:48:19:693]: PROPERTY CHANGE: Modifying
SERVICEDOMAIN property. Its current value is '.'. Its new value:
'HOUC55304'.
Action ended 14:48:19: CheckAvailableDLLs. Return value 1.
MSI (c) (88:90) [14:48:19:693]: Skipping action: DisableInitdb
(condition is false)

. . .

The next section with an error entry is:
Action start 14:48:18: GetAvailableLocales.
MSI (c) (88:38) [14:48:18:487]: Invoking remote custom action. DLL: C:
\DOCUME~1\rjoseph\LOCALS~1\Temp\MSI5.tmp, Entrypoint:
_GetAvailableLocales@4
MSI (c) (88:28) [14:48:18:487]: Cloaking enabled.
MSI (c) (88:28) [14:48:18:487]: Attempting to enable all disabled
priveleges before calling Install on Server
MSI (c) (88:28) [14:48:18:487]: Connected to service for CA interface.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying LOCALE
property. Its current value is 'DEFAULT'. Its new value: 'C'.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'DEFAULT'. Its new value: 'SQL_ASCII'.
MSI (c) (88!60) [14:48:19:019]: PROPERTY CHANGE: Modifying CLENCODE
property. Its current value is 'DEFAULT'. Its new value: 'SQL_ASCII'.
MSI (c) (88!60) [14:48:19:035]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:051]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:098]: Note: 1: 2259 2:  3:  4:
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying LOCALE
property. Its current value is 'C'. Its new value: 'English_United
States'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'SQL_ASCII'. Its new value: 'UTF8'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying ENCODING
property. Its current value is 'UTF8'. Its new value: 'WIN1252'.
MSI (c) (88!60) [14:48:19:098]: PROPERTY CHANGE: Modifying CLENCODE
property. Its current value is 'SQL_ASCII'. Its new value: 'WIN1252'.
MSI (c) (88:38) [14:48:19:098]: Leaked MSIHANDLE (3) of type 790540
for thread 2400
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2769 2: GetAvailableLocales
3: 1
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2205 2:  3: Error
MSI (c) (88:38) [14:48:19:098]: Note: 1: 2228 2:  3: Error 4: SELECT
`Message` FROM `Error` WHERE `Error` = 2769
DEBUG: Error 2769:  Custom Action GetAvailableLocales did not close 1
MSIHANDLEs.
The installer has encountered an unexpected error installing this
package. This may indicate a problem with this package. The error code
is 2769. The arguments are: GetAvailableLocales, 1,
Action ended 14:48:19: GetAvailableLocales. Return value 1.
MSI (c) (88:90) [14:48:19:098]: Doing action: LaunchConditions
Action 14:48:19: LaunchConditions. Evaluating launch conditions
Action start 14:48:19: LaunchConditions.
Action ended 14:48:19: LaunchConditions. Return value 1.
MSI (c) (88:90) [14:48:19:098]: Doing action: CheckAvailableDLLs
Action 14:48:19: CheckAvailableDLLs.
Action start 14:48:19: CheckAvailableDLLs.
MSI (c) (88:D0) [14:48:19:113]: Invoking remote custom action. DLL: C:
\DOCUME~1\rjoseph\LOCALS~1\Temp\MSI6.tmp, Entrypoint:
_CheckAvailableDLLs@4
MSI (c) (88!B4) [14:48:19:693]: PROPERTY CHANGE: Modifying HAS_PYTHON
property. Its current value is '0'. Its new value: '1'.
MSI (c) (88!B4) [14:48:19:693]: PROPERTY CHANGE: Modifying
SERVICEDOMAIN property. Its current value is '.'. Its new value:
'HOUC55304'.
Action ended 14:48:19: CheckAvailableDLLs. Return value 1.
MSI (c) (88:90) [14:48:19:693]: Skipping action: DisableInitdb
(condition is false)

. . .

This last section is where the error message popped up:
Action 14:53:27: InstallServices. Installing new services
MSI (s) (18:BC) [14:53:27:448]: Executing op: ProgressTotal
(Total=1,Type=1,ByteEquivalent=1300000)
MSI (s) (18:BC) [14:53:27:448]: Executing op: ServiceInstall
(Name=pgsql-8.3,DisplayName=PostgreSQL Database Server
8.3,ImagePath="C:\Program Files\PostgreSQL\8.3\bin\pg_ctl.exe"
runservice -w -N "pgsql-8.3" -D "C:\Program Files\PostgreSQL\8.3\data
\",ServiceType=16,StartType=2,ErrorControl=32769,,,,StartName=.
\postgres,Password=**********,Description=PostgreSQL Database Server
(postmaster))
MSI (s) (18:BC) [14:53:30:886]: Executing op: ActionStart
(Name=StartServices,Description=Starting services,Template=Service:
[1])
Action 14:53:30: StartServices. Starting services
MSI (s) (18:BC) [14:53:30:886]: Executing op: ProgressTotal
(Total=2,Type=1,ByteEquivalent=1300000)
MSI (s) (18:BC) [14:53:30:886]: Executing op: ServiceControl
(,Name=pgsql-8.3,Action=1,Wait=1,)
StartServices: Service: PostgreSQL Database Server 8.3
MSI (s) (18:BC) [14:54:15:149]: Note: 1: 2205 2:  3: Error
MSI (s) (18:BC) [14:54:15:149]: Note: 1: 2228 2:  3: Error 4: SELECT
`Message` FROM `Error` WHERE `Error` = 1920
MSI (c) (88:E4) [14:54:15:149]: Note: 1: 2205 2:  3: Error
MSI (c) (88:E4) [14:54:15:149]: Note: 1: 2228 2:  3: Error 4: SELECT
`Message` FROM `Error` WHERE `Error` = 2835
DEBUG: Error 2835:  The control ErrorIcon was not found on dialog
ErrorDlg
The installer has encountered an unexpected error installing this
package. This may indicate a problem with this package. The error code
is 2835. The arguments are: ErrorIcon, ErrorDlg,
Error 1920. Service 'PostgreSQL Database Server 8.3' (pgsql-8.3)
failed to start.  Verify that you have sufficient privileges to start
system services.
Action 15:01:27: Cancel. Dialog created
MSI (s) (18:BC) [15:01:19:562]: Note: 1: 2205 2:  3: Error
MSI (s) (18:BC) [15:01:19:562]: Note: 1: 2228 2:  3: Error 4: SELECT
`Message` FROM `Error` WHERE `Error` = 1709
MSI (s) (18:BC) [15:01:19:562]: Product: PostgreSQL 8.3 -- Error 1920.
Service 'PostgreSQL Database Server 8.3' (pgsql-8.3) failed to start.
Verify that you have sufficient privileges to start system services.

I hope this log is helpful in understanding something about the
installation.  Do you have any suggestions?

Thanks,
Ray