|
From: Leif M. <le...@ta...> - 2005-06-28 18:44:46
|
Faysal, The problem is that your implementation of the WrapperListener.start method never returns. The API requires that that method returns within a short period of time. Unless you really need to write your own WrapperListener, I would suggest first trying to make the WrapperSimpleApp helper class work for you. That is integration method 1. Cheers, Leif Alzabit, Faysal wrote: > Hi, > > I am using org.apache.log4j.net.SocketServer as a service to > centralize logging from different servers; the problem is that the > SocketServer starts and goes into a loop waiting for a connection; > when I implement the WrapperListener it seems that it starts the > application but it does not come back even when the application is > started as a thread; so the wrapper ends restarting the JVM !!! Any > idea how I can get the service to start and end ? > > The following is the debug message I am getting : > > STATUS | wrapper | 2005/06/27 15:48:57 | --> Wrapper Started as Console > ERROR | wrapper | 2005/06/27 15:48:57 | Unable to write to the > EventLog due to: The event log file is full. (0x5de) > ERROR | wrapper | 2005/06/27 15:48:57 | Internally setting > wrapper.syslog.loglevel=NONE to prevent further messages. > DEBUG | wrapper | 2005/06/27 15:48:57 | Using system timer. > DEBUG | wrapperp | 2005/06/27 15:48:57 | server listening on port 32000. > STATUS | wrapper | 2005/06/27 15:48:58 | Launching a JVM... > DEBUG | wrapper | 2005/06/27 15:48:58 | command: "C:\Program > Files\Java\jdk1.5.0\bin\java.exe" -Djava.library.path="../lib" > -classpath "../lib/wrapper.jar;C:/logCentral/" > -Dwrapper.key="QkmW5_uFP8Oh6kEU" -Dwrapper.port=32000 > -Dwrapper.debug="TRUE" -Dwrapper.use_system_time="TRUE" > -Dwrapper.version="3.1.2" -Dwrapper.native_library="wrapper" > -Dwrapper.cpu.timeout="10" -Dwrapper.jvmid=1 > org.unch.logcentral.core.CentralLoggerRapper 4321 > c:\\CentralLogger.properties c:\\ > > DEBUG | wrapper | 2005/06/27 15:48:58 | JVM started (PID=884) > INFO | jvm 1 | 2005/06/27 15:48:59 | fga, CentralLoggerRapper , in the > main class of centralLoggerRapper > INFO | jvm 1 | 2005/06/27 15:48:59 | fga, CentralLoggerWrapper 4321 > c:\\CentralLogger.properties c:\\ > INFO | jvm 1 | 2005/06/27 15:48:59 | WrapperManager class initialized > by thread: main Using classloader: sun.misc.Launcher$ExtClassLoader@a9c85c > > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper Manager: JVM #1 > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper Manager: Registering > shutdown hook > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper Manager: Using wrapper > INFO | jvm 1 | 2005/06/27 15:48:59 | Loaded native library: wrapper.dll > INFO | jvm 1 | 2005/06/27 15:48:59 | Calling native initialization > method. > INFO | jvm 1 | 2005/06/27 15:48:59 | Initializing WrapperManager > native library. > INFO | jvm 1 | 2005/06/27 15:48:59 | Java Executable: C:\Program > Files\Java\jdk1.5.0\bin\java.exe > INFO | jvm 1 | 2005/06/27 15:48:59 | Windows version: 5.1.2600 > INFO | jvm 1 | 2005/06/27 15:48:59 | Java Version : 1.5.0-b64 Java > HotSpot(TM) Client VM > INFO | jvm 1 | 2005/06/27 15:48:59 | Java VM Vendor : Sun Microsystems > Inc. > INFO | jvm 1 | 2005/06/27 15:48:59 | > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper (Version 3.1.2) > _http://wrapper.tanukisoftware.org_ > INFO | jvm 1 | 2005/06/27 15:48:59 | > INFO | jvm 1 | 2005/06/27 15:48:59 | > WrapperManager.start(org.unch.logcentral.core.CentralLoggerRapper@a90653, > args["4321", "c:\\CentralLogger.properties", "c:\\"]) called by > thread: main > > INFO | jvm 1 | 2005/06/27 15:48:59 | Open socket to wrapper... > INFO | jvm 1 | 2005/06/27 15:48:59 | Opened Socket > INFO | jvm 1 | 2005/06/27 15:48:59 | Send a packet KEY : QkmW5_uFP8Oh6kEU > INFO | jvm 1 | 2005/06/27 15:48:59 | > handleSocket(Socket[addr=localhost/127.0.0.1,port=32000,localport=1156]) > DEBUG | wrapperp | 2005/06/27 15:48:59 | accepted a socket from > 127.0.0.1 on port 1156 > DEBUG | wrapperp | 2005/06/27 15:48:59 | read a packet KEY : > QkmW5_uFP8Oh6kEU > DEBUG | wrapper | 2005/06/27 15:48:59 | Got key from JVM: > QkmW5_uFP8Oh6kEU > DEBUG | wrapperp | 2005/06/27 15:48:59 | send a packet LOW_LOG_LEVEL : 1 > DEBUG | wrapperp | 2005/06/27 15:48:59 | send a packet PING_TIMEOUT : 10 > DEBUG | wrapper | 2005/06/27 15:48:59 | Start Application. > DEBUG | wrapperp | 2005/06/27 15:48:59 | send a packet START : start > INFO | jvm 1 | 2005/06/27 15:48:59 | Received a packet LOW_LOG_LEVEL : 1 > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper Manager: LowLogLevel from > Wrapper is 1 > INFO | jvm 1 | 2005/06/27 15:48:59 | Received a packet PING_TIMEOUT : 10 > INFO | jvm 1 | 2005/06/27 15:48:59 | Wrapper Manager: PingTimeout from > Wrapper is 10000 > INFO | jvm 1 | 2005/06/27 15:48:59 | Received a packet START : start > INFO | jvm 1 | 2005/06/27 15:48:59 | calling listener.start() > INFO | jvm 1 | 2005/06/27 15:48:59 | in the start method of > CentralLoggerRapper > INFO | jvm 1 | 2005/06/27 15:48:59 | fga, CentralLoggerRapper, in the > run method > INFO | jvm 1 | 2005/06/27 15:48:59 | CentralLogger, in the main method > INFO | jvm 1 | 2005/06/27 15:48:59 | after the logger statment > INFO | jvm 1 | 2005/06/27 15:48:59 | SocketServer is using logger > named: org.unch.webcis.medications > INFO | jvm 1 | 2005/06/27 15:48:59 | after SocketServer initilization > in the CentralLogger start method > INFO | jvm 1 | 2005/06/27 15:48:59 | fga, CentralLoggerargv[0]: 4321 > argv[1]: c:\\CentralLogger.properties > INFO | jvm 1 | 2005/06/27 15:48:59 | 0 [Wrapper-Connection] INFO > org.apache.log4j.net.SocketServer - Listening on port 4321 > > INFO | jvm 1 | 2005/06/27 15:48:59 | 0 [Wrapper-Connection] INFO > org.apache.log4j.net.SocketServer - Waiting to accept a new client. > > ERROR | wrapper | 2005/06/27 15:49:28 | Startup failed: Timed out > waiting for signal from JVM. > STATUS | wrapper | 2005/06/27 15:49:28 | Dumping JVM state. > DEBUG | wrapper | 2005/06/27 15:49:28 | Sending BREAK event to process > group 884. > INFO | jvm 1 | 2005/06/27 15:49:28 | Full thread dump Java HotSpot(TM) > Client VM (1.5.0-b64 mixed mode, sharing): > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "DestroyJavaVM" prio=5 > tid=0x00037ee8 nid=0x140 waiting on condition [0x00000000..0x0007fae8] > > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Wrapper-Connection" prio=5 > tid=0x00acf828 nid=0x3f8 runnable [0x02ecf000..0x02ecfb68] > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.net.PlainSocketImpl.socketAccept(Native Method) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.net.PlainSocketImpl.accept(PlainSocketImpl.java:384) > INFO | jvm 1 | 2005/06/27 15:49:28 | - locked <0x22aaac20> (a > java.net.SocksSocketImpl) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.net.ServerSocket.implAccept(ServerSocket.java:450) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.net.ServerSocket.accept(ServerSocket.java:421) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.apache.log4j.net.SocketServer.main(SocketServer.java:100) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.unch.logcentral.core.CentralLogger.run(CentralLogger.java:69) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.unch.logcentral.core.CentralLogger.start(CentralLogger.java:44) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.unch.logcentral.core.CentralLoggerRapper.run(CentralLoggerRapper.java:83) > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.unch.logcentral.core.CentralLoggerRapper.start(CentralLoggerRapper.java:38) > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.tanukisoftware.wrapper.WrapperManager.startInner(WrapperManager.java:1785) > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.tanukisoftware.wrapper.WrapperManager.handleSocket(WrapperManager.java:2384) > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.tanukisoftware.wrapper.WrapperManager.run(WrapperManager.java:2696) > > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.Thread.run(Thread.java:595) > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Wrapper-Control-Event-Monitor" > daemon prio=5 tid=0x00a91298 nid=0x6b8 waiting on condition > [0x02e8f000..0x02e8fbe8] > > INFO | jvm 1 | 2005/06/27 15:49:28 | at java.lang.Thread.sleep(Native > Method) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > org.tanukisoftware.wrapper.WrapperManager$2.run(WrapperManager.java:701) > > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Low Memory Detector" daemon > prio=5 tid=0x00a6d980 nid=0x68c runnable [0x00000000..0x00000000] > > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "CompilerThread0" daemon prio=10 > tid=0x00a6c558 nid=0x690 waiting on condition [0x00000000..0x02bcf6c0] > > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Signal Dispatcher" daemon > prio=10 tid=0x00a6b848 nid=0x430 waiting on condition > [0x00000000..0x00000000] > > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Finalizer" daemon prio=9 > tid=0x00a68b18 nid=0x434 in Object.wait() [0x02b4f000..0x02b4fa68] > > INFO | jvm 1 | 2005/06/27 15:49:28 | at java.lang.Object.wait(Native > Method) > INFO | jvm 1 | 2005/06/27 15:49:28 | - waiting on <0x22f61100> (a > java.lang.ref.ReferenceQueue$Lock) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:116) > INFO | jvm 1 | 2005/06/27 15:49:28 | - locked <0x22f61100> (a > java.lang.ref.ReferenceQueue$Lock) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:132) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159) > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "Reference Handler" daemon > prio=10 tid=0x00a46770 nid=0x3d8 in Object.wait() [0x02b0f000..0x02b0fae8] > > INFO | jvm 1 | 2005/06/27 15:49:28 | at java.lang.Object.wait(Native > Method) > INFO | jvm 1 | 2005/06/27 15:49:28 | - waiting on <0x22f60ef0> (a > java.lang.ref.Reference$Lock) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.Object.wait(Object.java:474) > INFO | jvm 1 | 2005/06/27 15:49:28 | at > java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116) > INFO | jvm 1 | 2005/06/27 15:49:28 | - locked <0x22f60ef0> (a > java.lang.ref.Reference$Lock) > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "VM Thread" prio=10 > tid=0x00036908 nid=0x3c8 runnable > INFO | jvm 1 | 2005/06/27 15:49:28 | > INFO | jvm 1 | 2005/06/27 15:49:28 | "VM Periodic Task Thread" prio=10 > tid=0x00a6eb90 nid=0x5f4 waiting on condition > > INFO | jvm 1 | 2005/06/27 15:49:28 | > ERROR | wrapper | 2005/06/27 15:49:32 | JVM did not exit on request, > terminated > DEBUG | wrapper | 2005/06/27 15:49:33 | JVM was only running for 35 > seconds leading to a failed restart count of 1. > DEBUG | wrapper | 2005/06/27 15:49:33 | Waiting 5 seconds before > launching another JVM. > STATUS | wrapper | 2005/06/27 15:49:37 | Launching a JVM... > DEBUG | wrapper | 2005/06/27 15:49:37 | command: "C:\Program > Files\Java\jdk1.5.0\bin\java.exe" -Djava.library.path="../lib" > -classpath "../lib/wrapper.jar;C:/logCentral/" > -Dwrapper.key="2yqjvTR9FkXjFAvq" -Dwrapper.port=32000 > -Dwrapper.debug="TRUE" -Dwrapper.use_system_time="TRUE" > -Dwrapper.version="3.1.2" -Dwrapper.native_library="wrapper" > -Dwrapper.cpu.timeout="10" -Dwrapper.jvmid=2 > org.unch.logcentral.core.CentralLoggerRapper 4321 > c:\\CentralLogger.properties c:\\ > > DEBUG | wrapper | 2005/06/27 15:49:37 | JVM started (PID=1000) > INFO | jvm 2 | 2005/06/27 15:49:37 | fga, CentralLoggerRapper , in the > main class of centralLoggerRapper > INFO | jvm 2 | 2005/06/27 15:49:37 | fga, CentralLoggerWrapper 4321 > c:\\CentralLogger.properties c:\\ > INFO | jvm 2 | 2005/06/27 15:49:37 | WrapperManager class initialized > by thread: main Using classloader: sun.misc.Launcher$ExtClassLoader@a9c85c > > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper Manager: JVM #2 > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper Manager: Registering > shutdown hook > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper Manager: Using wrapper > INFO | jvm 2 | 2005/06/27 15:49:37 | Loaded native library: wrapper.dll > INFO | jvm 2 | 2005/06/27 15:49:37 | Calling native initialization > method. > INFO | jvm 2 | 2005/06/27 15:49:37 | Initializing WrapperManager > native library. > INFO | jvm 2 | 2005/06/27 15:49:37 | Java Executable: C:\Program > Files\Java\jdk1.5.0\bin\java.exe > INFO | jvm 2 | 2005/06/27 15:49:37 | Windows version: 5.1.2600 > INFO | jvm 2 | 2005/06/27 15:49:37 | Java Version : 1.5.0-b64 Java > HotSpot(TM) Client VM > INFO | jvm 2 | 2005/06/27 15:49:37 | Java VM Vendor : Sun Microsystems > Inc. > INFO | jvm 2 | 2005/06/27 15:49:37 | > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper (Version 3.1.2) > _http://wrapper.tanukisoftware.org_ > INFO | jvm 2 | 2005/06/27 15:49:37 | > INFO | jvm 2 | 2005/06/27 15:49:37 | > WrapperManager.start(org.unch.logcentral.core.CentralLoggerRapper@a90653, > args["4321", "c:\\CentralLogger.properties", "c:\\"]) called by > thread: main > > INFO | jvm 2 | 2005/06/27 15:49:37 | Open socket to wrapper... > INFO | jvm 2 | 2005/06/27 15:49:37 | Opened Socket > INFO | jvm 2 | 2005/06/27 15:49:37 | Send a packet KEY : 2yqjvTR9FkXjFAvq > INFO | jvm 2 | 2005/06/27 15:49:37 | > handleSocket(Socket[addr=localhost/127.0.0.1,port=32000,localport=1157]) > DEBUG | wrapperp | 2005/06/27 15:49:37 | accepted a socket from > 127.0.0.1 on port 1157 > DEBUG | wrapperp | 2005/06/27 15:49:37 | read a packet KEY : > 2yqjvTR9FkXjFAvq > DEBUG | wrapper | 2005/06/27 15:49:37 | Got key from JVM: > 2yqjvTR9FkXjFAvq > DEBUG | wrapperp | 2005/06/27 15:49:37 | send a packet LOW_LOG_LEVEL : 1 > DEBUG | wrapperp | 2005/06/27 15:49:37 | send a packet PING_TIMEOUT : 10 > DEBUG | wrapper | 2005/06/27 15:49:37 | Start Application. > DEBUG | wrapperp | 2005/06/27 15:49:37 | send a packet START : start > INFO | jvm 2 | 2005/06/27 15:49:37 | Received a packet LOW_LOG_LEVEL : 1 > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper Manager: LowLogLevel from > Wrapper is 1 > INFO | jvm 2 | 2005/06/27 15:49:37 | Received a packet PING_TIMEOUT : 10 > INFO | jvm 2 | 2005/06/27 15:49:37 | Wrapper Manager: PingTimeout from > Wrapper is 10000 > INFO | jvm 2 | 2005/06/27 15:49:37 | Received a packet START : start > INFO | jvm 2 | 2005/06/27 15:49:37 | calling listener.start() > INFO | jvm 2 | 2005/06/27 15:49:37 | in the start method of > CentralLoggerRapper > INFO | jvm 2 | 2005/06/27 15:49:37 | fga, CentralLoggerRapper, in the > run method > INFO | jvm 2 | 2005/06/27 15:49:37 | CentralLogger, in the main method > INFO | jvm 2 | 2005/06/27 15:49:37 | after the logger statment > INFO | jvm 2 | 2005/06/27 15:49:37 | SocketServer is using logger > named: org.unch.webcis.medications > INFO | jvm 2 | 2005/06/27 15:49:37 | after SocketServer initilization > in the CentralLogger start method > INFO | jvm 2 | 2005/06/27 15:49:37 | fga, CentralLoggerargv[0]: 4321 > argv[1]: c:\\CentralLogger.properties > INFO | jvm 2 | 2005/06/27 15:49:37 | 0 [Wrapper-Connection] INFO > org.apache.log4j.net.SocketServer - Listening on port 4321 > > INFO | jvm 2 | 2005/06/27 15:49:37 | 0 [Wrapper-Connection] INFO > org.apache.log4j.net.SocketServer - Waiting to accept a new client. > > __________________________________________ > Faysal G. Al-Zabit > APPLICATIONS ANALYST PROGRAMMER II > Information Services Division > 321 Meadowmont Village Circle > Chapel Hill NC 27517 > E-Mail: al...@un... > Tel. : 919-843-4011 > Fax. : 919-966-2110 > ____________________________________ > |