[Wrapper-user] wrapper Service Start Error 1053 - failed to initialize properly (0xc0000142)

SourceForge Headquarters 1320 Columbia Street Suite 310 San Diego, CA 92101 +1 (858) 422-6466

Hallo,
Server OS: Windows2000 Adavanced Server
Hostname: BHMF061A

Running the Wrapper as service is not possible with
other Users than LocalSystem.
Error Message pops up:
  Error 1053 the service did not respond to the start
  or control request in a timely fashion

EventViewer Details:
8/1/2006 1:31:00 PM Service Control Manager Error None 7000 N/A BHMF061A
  The Test Wrapper Sample Application service
  failed to start due to the following error:
     The service did not respond to the start or control
     request in a timely fashion.
8/1/2006 1:31:00 PM Service Control Manager Error None 7009 N/A BHMF061A
  Timeout (30000 milliseconds) waiting for the
  Test Wrapper Sample Application service to connect.
8/1/2006 1:30:30 PM Application Popup Information None 26 N/A BHMF061A
  Application popup:
    wrapper.exe - Application Error : The application
    failed to initialize properly (0xc0000142).
    Click on OK to terminate the application.

I used the Wrapper "wrapper-windows-x86-32-3.2.1.zip"
for my tests.

LocalSystem is able to Start the Service
 "Test Wrapper Sample Application service"
  ..\log\wrapper.log is written

I renamed the file to ..\log\wrapper.log.LocalSystem

Then i changed the Service properties and to the local
user "adamue61" (belongig to group Administrators) and
try to start the Service ...

I got error 1053 and logfile
  ..\log\wrapper.log is NOT written.

The same User is able to start the script TestWrapper.bat
in a DOS-Shell. The file ..\log\wrapper.log is written

The User is able to start all other services then the
Wrapper ...

Any Ideas ??

regards
Edith

#############################
<< wrapper.log.LocalSystem >>
#############################
STATUS | wrapper  | 2006/08/01 12:10:59 | Test Wrapper Sample 
Application installed.
STATUS | wrapper  | 2006/08/01 12:12:58 | --> Wrapper Started as Service
STATUS | wrapper  | 2006/08/01 12:12:58 | Launching a JVM...
INFO   | jvm 1    | 2006/08/01 12:12:59 | Initializing...
INFO   | jvm 1    | 2006/08/01 12:12:59 | Wrapper (Version 3.2.1) 
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2006/08/01 12:12:59 |
INFO   | jvm 1    | 2006/08/01 12:13:00 | start()
INFO   | jvm 1    | 2006/08/01 12:13:01 | ActionServer Enabled.
INFO   | jvm 1    | 2006/08/01 12:13:01 |   Telnet localhost 9999
INFO   | jvm 1    | 2006/08/01 12:13:01 |   Commands:
INFO   | jvm 1    | 2006/08/01 12:13:01 |     S: Shutdown
INFO   | jvm 1    | 2006/08/01 12:13:01 |     H: Expected Halt
INFO   | jvm 1    | 2006/08/01 12:13:01 |     R: Restart
INFO   | jvm 1    | 2006/08/01 12:13:01 |     D: Thread Dump
INFO   | jvm 1    | 2006/08/01 12:13:01 |     U: Unexpected Halt 
(Simulate crash)
INFO   | jvm 1    | 2006/08/01 12:13:01 |     V: Access Violation 
(Actual crash)
INFO   | jvm 1    | 2006/08/01 12:13:01 |     G: Make the JVM appear to 
be hung.
DEBUG  | wrapper  | 2006/08/01 13:21:36 | Service command: 
D:\wrapper-windows-x86-32-3.2.1\bin\wrapper.exe -s 
D:\wrapper-windows-x86-32-3.2.1\conf\wrapper.conf
STATUS | wrapper  | 2006/08/01 13:21:36 | Test Wrapper Sample 
Application installed.
STATUS | wrapper  | 2006/08/01 13:23:31 | --> Wrapper Started as Service
DEBUG  | wrapper  | 2006/08/01 13:23:31 | Using tick timer.
DEBUG  | wrapperp | 2006/08/01 13:23:31 | server listening on port 32000.
STATUS | wrapper  | 2006/08/01 13:23:31 | Launching a JVM...
DEBUG  | wrapper  | 2006/08/01 13:23:31 | command: 
"C:\WINNT\system32\java.exe" -Djava.library.path="../lib" -classpath 
"../lib/wrappertest.jar;../lib/wrapper.jar" 
-Dwrapper.key="JSNhtYvzU8Kfio4y" -Dwrapper.port=32000 
-Dwrapper.jvm.port.min=31000 -Dwrapper.jvm.port.max=31999 
-Dwrapper.debug="TRUE" -Dwrapper.pid=1924 -Dwrapper.version="3.2.1" 
-Dwrapper.native_library="wrapper" -Dwrapper.service="TRUE" 
-Dwrapper.cpu.timeout="10" -Dwrapper.jvmid=1 
org.tanukisoftware.wrapper.test.Main
DEBUG  | wrapper  | 2006/08/01 13:23:31 | JVM started (PID=3064)
INFO   | jvm 1    | 2006/08/01 13:23:32 | Initializing...
INFO   | jvm 1    | 2006/08/01 13:23:32 | WrapperManager class 
initialized by thread: main  Using classloader: 
sun.misc.Launcher$AppClassLoader@53ba3d
INFO   | jvm 1    | 2006/08/01 13:23:32 | Wrapper (Version 3.2.1) 
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2006/08/01 13:23:32 |
INFO   | jvm 1    | 2006/08/01 13:23:32 | Wrapper Manager: JVM #1
INFO   | jvm 1    | 2006/08/01 13:23:32 | Running a 32-bit JVM.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Wrapper Manager: Registering 
shutdown hook
INFO   | jvm 1    | 2006/08/01 13:23:32 | Wrapper Manager: Using wrapper
INFO   | jvm 1    | 2006/08/01 13:23:32 | Load native library.  One or 
more attempts may fail if platform specific libraries do not exist.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Loading native library failed: 
wrapper-windows-x86-32.dll  Cause: java.lang.UnsatisfiedLinkError: no 
wrapper-windows-x86-32 in java.library.path
INFO   | jvm 1    | 2006/08/01 13:23:32 | Loaded native library: wrapper.dll
INFO   | jvm 1    | 2006/08/01 13:23:32 | Calling native initialization 
method.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Initializing WrapperManager 
native library.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Java Executable: 
C:\WINNT\system32\java.exe
INFO   | jvm 1    | 2006/08/01 13:23:32 | Windows version: 5.0.2195
INFO   | jvm 1    | 2006/08/01 13:23:32 | Java Version   : 1.4.2_10-b03 
Java HotSpot(TM) Client VM
INFO   | jvm 1    | 2006/08/01 13:23:32 | Java VM Vendor : Sun 
Microsystems Inc.
INFO   | jvm 1    | 2006/08/01 13:23:32 |
INFO   | jvm 1    | 2006/08/01 13:23:32 | Startup runner thread started.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Control event monitor thread 
started.
INFO   | jvm 1    | 2006/08/01 13:23:32 | 
WrapperManager.start(org.tanukisoftware.wrapper.test.Main@506411, 
args[]) called by thread: main
INFO   | jvm 1    | 2006/08/01 13:23:32 | Communications runner thread 
started.
INFO   | jvm 1    | 2006/08/01 13:23:32 | Open socket to 
wrapper...Wrapper-Connection
INFO   | jvm 1    | 2006/08/01 13:23:32 | Opened Socket from 31000 to 32000
INFO   | jvm 1    | 2006/08/01 13:23:32 | Send a packet KEY : 
JSNhtYvzU8Kfio4y
DEBUG  | wrapperp | 2006/08/01 13:23:32 | accepted a socket from 
127.0.0.1 on port 31000
INFO   | jvm 1    | 2006/08/01 13:23:32 | 
handleSocket(Socket[addr=/127.0.0.1,port=32000,localport=31000])
DEBUG  | wrapperp | 2006/08/01 13:23:32 | read a packet KEY : 
JSNhtYvzU8Kfio4y
DEBUG  | wrapper  | 2006/08/01 13:23:32 | Got key from JVM: JSNhtYvzU8Kfio4y
DEBUG  | wrapperp | 2006/08/01 13:23:32 | send a packet LOW_LOG_LEVEL : 1
DEBUG  | wrapperp | 2006/08/01 13:23:32 | send a packet PING_TIMEOUT : 30
DEBUG  | wrapperp | 2006/08/01 13:23:32 | send a packet PROPERTIES : 
(Property Values)
DEBUG  | wrapper  | 2006/08/01 13:23:32 | Start Application.
DEBUG  | wrapperp | 2006/08/01 13:23:32 | send a packet START : start
INFO   | jvm 1    | 2006/08/01 13:23:33 | Received a packet 
LOW_LOG_LEVEL : 1
INFO   | jvm 1    | 2006/08/01 13:23:33 | Wrapper Manager: LowLogLevel 
from Wrapper is 1
INFO   | jvm 1    | 2006/08/01 13:23:33 | Received a packet PING_TIMEOUT 
: 30
INFO   | jvm 1    | 2006/08/01 13:23:33 | PingTimeout from Wrapper is 30000
INFO   | jvm 1    | 2006/08/01 13:23:33 | Received a packet PROPERTIES : 
(Property Values)
INFO   | jvm 1    | 2006/08/01 13:23:33 | Received a packet START : start
INFO   | jvm 1    | 2006/08/01 13:23:33 | calling WrapperListener.start()
INFO   | jvm 1    | 2006/08/01 13:23:33 | Waiting for 
WrapperListener.start runner thread to complete.
INFO   | jvm 1    | 2006/08/01 13:23:33 | WrapperListener.start runner 
thread started.
INFO   | jvm 1    | 2006/08/01 13:23:33 | start()
INFO   | jvm 1    | 2006/08/01 13:23:33 | ActionServer Enabled.
INFO   | jvm 1    | 2006/08/01 13:23:33 |   Telnet localhost 9999
INFO   | jvm 1    | 2006/08/01 13:23:33 |   Commands:
INFO   | jvm 1    | 2006/08/01 13:23:33 |     S: Shutdown
INFO   | jvm 1    | 2006/08/01 13:23:33 |     H: Expected Halt
INFO   | jvm 1    | 2006/08/01 13:23:33 |     R: Restart
INFO   | jvm 1    | 2006/08/01 13:23:33 |     D: Thread Dump
INFO   | jvm 1    | 2006/08/01 13:23:33 |     U: Unexpected Halt 
(Simulate crash)
INFO   | jvm 1    | 2006/08/01 13:23:33 |     V: Access Violation 
(Actual crash)
INFO   | jvm 1    | 2006/08/01 13:23:33 |     G: Make the JVM appear to 
be hung.
INFO   | jvm 1    | 2006/08/01 13:23:33 | WrapperListener.start runner 
thread stopped.
INFO   | jvm 1    | 2006/08/01 13:23:33 | returned from 
WrapperListener.start()
INFO   | jvm 1    | 2006/08/01 13:23:33 | Send a packet STARTED :
DEBUG  | wrapperp | 2006/08/01 13:23:33 | read a packet STARTED :
DEBUG  | wrapper  | 2006/08/01 13:23:33 | JVM signalled that it was started.
INFO   | jvm 1    | 2006/08/01 13:23:34 | Startup runner thread stopped.
DEBUG  | wrapperp | 2006/08/01 13:23:36 | send a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:36 | Received a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:36 | Send a packet PING : ok
DEBUG  | wrapperp | 2006/08/01 13:23:36 | read a packet PING : ok
DEBUG  | wrapper  | 2006/08/01 13:23:36 | Got ping response from JVM
DEBUG  | wrapperp | 2006/08/01 13:23:40 | send a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:40 | Received a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:40 | Send a packet PING : ok
DEBUG  | wrapperp | 2006/08/01 13:23:40 | read a packet PING : ok
DEBUG  | wrapper  | 2006/08/01 13:23:40 | Got ping response from JVM
DEBUG  | wrapperp | 2006/08/01 13:23:45 | send a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:45 | Received a packet PING : ping
INFO   | jvm 1    | 2006/08/01 13:23:45 | Send a packet PING : ok
DEBUG  | wrapperp | 2006/08/01 13:23:45 | read a packet PING : ok
DEBUG  | wrapper  | 2006/08/01 13:23:45 | Got ping response from JVM
DEBUG  | wrapperp | 2006/08/01 13:23:46 | send a packet 
SERVICE_CONTROL_CODE : 1
DEBUG  | wrapper  | 2006/08/01 13:23:46 | ServiceControlHandler(1)
DEBUG  | wrapper  | 2006/08/01 13:23:46 |   SERVICE_CONTROL_STOP
DEBUG  | wrapper  | 2006/08/01 13:23:46 | wrapperStopProcess(0) called.
INFO   | jvm 1    | 2006/08/01 13:23:46 | Received a packet 
SERVICE_CONTROL_CODE : 1
INFO   | jvm 1    | 2006/08/01 13:23:46 | ServiceControlCode from 
Wrapper with code 1
DEBUG  | wrapper  | 2006/08/01 13:23:46 | Sending stop signal to JVM
DEBUG  | wrapperp | 2006/08/01 13:23:46 | send a packet STOP : NULL
INFO   | jvm 1    | 2006/08/01 13:23:46 | Received a packet STOP :
INFO   | jvm 1    | 2006/08/01 13:23:46 | Thread, Wrapper-Connection, 
handling the shutdown process.
INFO   | jvm 1    | 2006/08/01 13:23:46 | calling listener.stop()
INFO   | jvm 1    | 2006/08/01 13:23:46 | Waiting for 
WrapperListener.stop runner thread to complete.
INFO   | jvm 1    | 2006/08/01 13:23:46 | WrapperListener.stop runner 
thread started.
INFO   | jvm 1    | 2006/08/01 13:23:46 | stop(0)
INFO   | jvm 1    | 2006/08/01 13:23:46 | WrapperListener.stop runner 
thread stopped.
INFO   | jvm 1    | 2006/08/01 13:23:46 | returned from listener.stop()
INFO   | jvm 1    | 2006/08/01 13:23:46 | Send a packet STOPPED : 0
DEBUG  | wrapperp | 2006/08/01 13:23:46 | read a packet STOPPED : 0
DEBUG  | wrapper  | 2006/08/01 13:23:46 | JVM signalled that it was stopped.
INFO   | jvm 1    | 2006/08/01 13:23:46 | Closing socket.
DEBUG  | wrapperp | 2006/08/01 13:23:46 | socket read no code (closed?).
DEBUG  | wrapperp | 2006/08/01 13:23:46 | server listening on port 32001.
INFO   | jvm 1    | 2006/08/01 13:23:47 | calling System.exit(0)
DEBUG  | wrapper  | 2006/08/01 13:23:47 | JVM process exited with a code 
of 0, leaving the wrapper exit code set to 0.
DEBUG  | wrapper  | 2006/08/01 13:23:47 | JVM exited normally.
STATUS | wrapper  | 2006/08/01 13:23:47 | <-- Wrapper Stopped

#################
SystemInfo.txt
################
System Information report written at: 08/01/2006 02:56:03 PM
[System Summary]

Item    Value
OS Name    Microsoft Windows 2000 Advanced Server
Version    5.0.2195 Service Pack 4 Build 2195
OS Manufacturer    Microsoft Corporation
System Name    BHMF061A
System Manufacturer    HP
System Model    ProLiant DL360 G3
System Type    X86-based PC
Processor    x86 Family 15 Model 2 Stepping 7 GenuineIntel ~2399 Mhz
Processor    x86 Family 15 Model 2 Stepping 7 GenuineIntel ~2399 Mhz
BIOS Version    03/01/03
Windows Directory    C:\WINNT
System Directory    C:\WINNT\system32
Boot Device    \Device\Harddisk0\Partition1
Locale    United States
User Name    SIRONA\de840713
Time Zone    W. Europe Daylight Time
Total Physical Memory    4,013,588 KB
Available Physical Memory    2,529,932 KB
Total Virtual Memory    11,002,160 KB
Available Virtual Memory    7,778,316 KB
Page File Space    6,988,572 KB
Page File    C:\pagefile.sys