|
From: Jennifer K. <jk...@si...> - 2004-03-03 22:05:24
|
I send a couple of emails a couple of weeks ago but haven't gotten any =20= feedback-- so here is the info again-- Namely the problem is that the wrapper is exiting rather than =20 restarting when a filter trigger is matched. all other restarts operate correctly. here is the info from the previous 2 emails I send, from most to least =20= recent. I look forward to a response.. thanks Jennifer ------------- Subject: [Wrapper-user] more on problems with filters- restart = never =20 works Date: February 27, 2004 8:14:47 AM PST To: wra...@li... Reply-To: wra...@li... It appears that I never have a successful FILTER based restart.=A0 I =20= have no problem getting restarts when I call WrapperManager.restart() =20= internally.. however-- if there is an exception that I didn't catch that a filter matches, =20= then I never get a successful restart. I have had each of the following =20= filters triggered always with the same result. I noticed that there was a recent email (Patrick Woodworth 1/23/2004)=A0= =20 where another person was having similiar problems and he found =20 disabling the shutdown hooks to be a soln for him.. I've had that =20 disabled this whole time and=A0 don't see any difference. Here are my filter settings from my conf file. wrapper.filter.trigger.1=3Dcom.singingfish.werkflow.processors.ProcessorEx= =20 ception wrapper.filter.action.1=3DRESTART wrapper.filter.trigger.2=3Djava.lang.Error wrapper.filter.action.2=3DRESTART wrapper.filter.trigger.3=3Djava.lang.OutOfMemoryError wrapper.filter.action.3=3DRESTART I also have these set if it provides any help..=A0 ( I have tried =20 playing around w/ different startup timeouts and invocation times and =20= it seems to make no difference) wrapper.jvm_exit.timeout=3D30 wrapper.cpu.timeout=3D10 wrapper.ping.timeout=3D300 wrapper.ping.interval=3D5 wrapper.restart.delay=3D1 wrapper.max_failed_invocations=3D3 wrapper.successful_invocation_time=3D10 wrapper.startup.timeout=3D30 wrapper.request_thread_dump_on_failed_jvm_exit=3DFALSE wrapper.ignore_signals=3DTRUE wrapper.disable_shutdown_hook=3DTRUE And again, here is the result I see whenever a filter is triggered: STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 =20= Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() = called ... (stuff from my stacktrack) STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 =20= Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() =20= called.=A0 (IGNORED) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | java.lang.Error: =20= com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 =20= Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() =20= called.=A0 (IGNORED) ... (stuff from my stack track) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | Send a packet STOP = : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:32:59 | read a packet STOP : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | JVM requested a = shutdown. (0) DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperStopProcess(0) = called. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | Sending stop signal to = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:32:59 | send a packet STOP : NULL INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | Received a packet = STOP : INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Thread, =20 WrapperSimpleAppMain, handling the shutdown process. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | calling = listener.stop() INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | WrapperSimpleApp: = stop(0) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | returned from = listener.stop() INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Send a packet = STOPPED : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:33:00 | read a packet STOPPED : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:33:00 | JVM signalled that it = was =20 stopped. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Closing socket. DEBUG=A0 | wrapperp | 2004/02/26 19:33:00 | socket read no code =20 (closed?). INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | calling = System.exit(0) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Server daemon shut = down DEBUG=A0 | wrapper=A0 | 2004/02/26 19:33:00 | JVM exited normally. STATUS | wrapper=A0 | 2004/02/26 19:33:01 | <-- Wrapper Stopped STATUS | wrapper=A0 | 2004/02/26 19:36:28 | CrackerAgent3 removed. in comparison-- a normal restart has the following ... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:48 | 2004-02-26 = 19:31:48,107 =20 DEBUG [WrapperSimpleAppMain] WerkflowAgent=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0=A0= =A0 - WerkflowEngine =20 requested VM restart (null). Shutting down... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:48 | Send a packet = RESTART : =20 restart DEBUG=A0 | wrapperp | 2004/02/26 19:31:48 | read a packet RESTART : =20= restart STATUS | wrapper=A0 | 2004/02/26 19:31:48 | JVM requested a restart. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:48 | wrapperRestartProcess() =20= called. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:48 | Sending stop signal to = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:31:48 | send a packet STOP : NULL INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:48 | Received a packet = STOP : INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | Thread, =20 WrapperSimpleAppMain, handling the shutdown process. INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | calling = listener.stop() INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | WrapperSimpleApp: = stop(0) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | returned from = listener.stop() INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | Send a packet = STOPPED : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:31:49 | read a packet STOPPED : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:49 | JVM signalled that it = was =20 stopped. INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:49 | Closing socket. DEBUG=A0 | wrapperp | 2004/02/26 19:31:49 | socket read no code =20 (closed?). INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:50 | calling = System.exit(0) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:31:50 | Server daemon shut = down DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:50 | JVM exited normally. STATUS | wrapper=A0 | 2004/02/26 19:31:52 | Launching a JVM... DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:52 | command: =20 "C:\WINNT\system32\java.exe" =20 -Dcom.singingfish.core.utils.config.dir=3Dc:/sf/config =20 -Duser.dir=3DC:\aolrun -Dsun.rmi.loader.logLevel=3DVERBOSE =20 -Dsun.rmi.server.logLevel=3DVERBOSE -Dsun.rmi.transport.logLevel=3DVERBOSE= =20 -Dsun.rmi.transport.tcp.logLevel=3DVERBOSE =20 -Dsun.rmi.transport.proxy.logLevel=3DVERBOSE -Xms3m -Xmx96m =20 -Djava.library.path=3D"c:/sf/lib;c:/winnt;c:/winnt/system32;c:/=20 j2sdk1.4.2_02/bin" -classpath =20 "c:/sf/java/classes;c:/sf/java/jars/commons-logging-1.0.3/commons-=20 logging.jar;c:/sf/java/jars/jakarta-log4j-1.2.8/dist/lib/log4j=20 -1.2.8.jar;c:/sf/java/jars/jakarta-oro-2.0.4/jakarta-oro-2.0.4.jar;c:/=20= sf/java/jars/quicktime_6_5/QTJava.zip;c:/sf/java/jars/xerces-1_3_1/=20 xerces.jar;c:/sf/java/jars/toplink/TOPLink.jar;c:/sf/java/jars/toplink/=20= Tools.jar;c:/sf/java/jars/toplink/TOPLinkX.jar;c:/sf/java/jars/=20 oracle_jdbc_9_2_03/ojdbc14.jar;c:/sf/java/jars/commons-httpclient-2.0/=20= commons-httpclient-2.0-final.jar" -Dwrapper.key=3D"VRxfE5Fd856GSIaF" =20 -Dwrapper.port=3D32013 -Dwrapper.debug=3D"TRUE" =20 -Dwrapper.ignore_signals=3D"TRUE" -Dwrapper.service=3D"TRUE" =20 -Dwrapper.disable_shutdown_hook=3D"TRUE" -Dwrapper.cpu.timeout=3D"10" =20= -Dwrapper.jvmid=3D7 org.tanukisoftware.wrapper.WrapperSimpleApp =20 com.singingfish.werkflow.agent.WerkflowAgent =20 c:/sf/config/workflow/specs/cracker.spec CrackerAgent3 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:52 | Java Virtual Machine = started =20 (PID=3D9244) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Wrapper Manager: = JVM #7 INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Wrapper Manager: = Using =20 wrapper INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Calling native =20 initialization method. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Initializing = WrapperManager =20 native library. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Java Executable: =20= C:\WINNT\system32\java.exe INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Java Version=A0=A0 = : =20 1.4.2_02-b03 Java HotSpot(TM) Client VM INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Java VM Vendor : = Sun =20 Microsystems Inc. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Wrapper (Version = 3.0.5) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Open socket to = wrapper =20 attempted on port 32013... INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Opened Socket to = port 3242 INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | Send a packet KEY = : =20 VRxfE5Fd856GSIaF INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:31:52 | =20 handleSocket(Socket[addr=3D/127.0.0.1,port=3D32013,localport=3D3242]) DEBUG=A0 | wrapperp | 2004/02/26 19:31:52 | accepted a socket from =20 127.0.0.1 on port 3242 DEBUG=A0 | wrapperp | 2004/02/26 19:31:52 | read a packet KEY : =20 VRxfE5Fd856GSIaF DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:52 | Got key from JVM: =20 VRxfE5Fd856GSIaF DEBUG=A0 | wrapperp | 2004/02/26 19:31:52 | send a packet = LOW_LOG_LEVEL =20 : 1 DEBUG=A0 | wrapperp | 2004/02/26 19:31:52 | send a packet PING_TIMEOUT = : =20 300 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:31:52 | Start Application. .... ----------- Subject: [Wrapper-user] Restart being ignored Date: February 26, 2004 5:14:40 PM PST To: wra...@li... Reply-To: wra...@li... thanks for the speedy replies- this one has me stumped... and I am =20 hoping there is something obvious I am not understanding about when the =20= wrapper does and doesn't restart the vm. I have a java process running that throws an exception I have a filter = =20 for. the filter is set to RESTART as the action. For some reason, at some point the restart message is ignored and a =20= stop is issued which exits the service. What is happening that this is getting to an ignore state? In my config file I have 3 set for the max tries for invocation, but I = =20 thought that didn't apply to restarts once successfully past the min =20 invocation running time... any ideas?? (note this is returning a exit code of 0 instead of 1 since I=A0 was =20= seeing if that would make a difference- it doesn't) This is the 1st place any filters are matched on in any of these =20 files.. although.. there are previous successful restarts requested =20 internally by my app via the wrappermanager. Thanks Jennifer DEBUG=A0 | wrapperp | 2004/02/26 19:21:49 | read a packet PING : ok DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:49 | Got ping response from = JVM INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:50 | WrapperSimpleApp: =20= Encountered an error running main: java.lang.Error: unexpected =20 exception in completed STATUS | wrapper=A0 | 2004/02/26 19:21:50 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:50 | wrapperRestartProcess() =20= called. INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:50 | java.lang.Error: = unexpected =20 exception in completed STATUS | wrapper=A0 | 2004/02/26 19:21:50 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:50 | wrapperRestartProcess() =20= called.=A0 (IGNORED) INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:50 | Send a packet STOP = : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:21:50 | read a packet STOP : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:50 | JVM requested a = shutdown. (0) DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:50 | wrapperStopProcess(0) = called. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:50 | Sending stop signal to = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:21:50 | send a packet STOP : NULL INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:50 | Received a packet = STOP : INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | Thread, =20 WrapperSimpleAppMain, handling the shutdown process. INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | calling = listener.stop() INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | WrapperSimpleApp: = stop(0) INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | returned from = listener.stop() INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | Send a packet = STOPPED : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:21:51 | read a packet STOPPED : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:21:51 | JVM signalled that it = was =20 stopped. INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:51 | Closing socket. DEBUG=A0 | wrapperp | 2004/02/26 19:21:51 | socket read no code =20 (closed?). INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:52 | calling = System.exit(0) INFO=A0=A0 | jvm 1=A0=A0=A0 | 2004/02/26 19:21:52 | Server daemon shut = down ERROR=A0 | wrapper=A0 | 2004/02/26 19:22:27 | Shutdown failed: Timed = out =20 waiting for the JVM to terminate. ERROR=A0 | wrapper=A0 | 2004/02/26 19:22:27 | Java Virtual Machine did = not =20 exit on request, terminated STATUS | wrapper=A0 | 2004/02/26 19:22:27 | <-- Wrapper Stopped Here is a different case of the same problem INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =20 com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() =20= called. .... INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.run(WerkflowAgent.java:67) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.main(WerkflowAgent.java:=20 270) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 java.lang.reflect.Method.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:=20= 111) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 java.lang.Thread.run(Unknown Source) ... INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | WrapperSimpleApp: =20= Encountered an error running main: java.lang.Error: =20 com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() =20= called.=A0 (IGNORED) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | java.lang.Error: =20= com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:32:59 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperRestartProcess() =20= called.=A0 (IGNORED) .... INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.run(WerkflowAgent.java:67) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.main(WerkflowAgent.java:=20 270) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 java.lang.reflect.Method.invoke(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:=20= 111) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | =A0=A0=A0 at =20 java.lang.Thread.run(Unknown Source) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | Send a packet STOP = : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:32:59 | read a packet STOP : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | JVM requested a = shutdown. (0) DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | wrapperStopProcess(0) = called. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:32:59 | Sending stop signal to = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:32:59 | send a packet STOP : NULL INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:32:59 | Received a packet = STOP : INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Thread, =20 WrapperSimpleAppMain, handling the shutdown process. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | calling = listener.stop() INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | WrapperSimpleApp: = stop(0) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | returned from = listener.stop() INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Send a packet = STOPPED : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:33:00 | read a packet STOPPED : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:33:00 | JVM signalled that it = was =20 stopped. INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Closing socket. DEBUG=A0 | wrapperp | 2004/02/26 19:33:00 | socket read no code =20 (closed?). INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | calling = System.exit(0) INFO=A0=A0 | jvm 7=A0=A0=A0 | 2004/02/26 19:33:00 | Server daemon shut = down DEBUG=A0 | wrapper=A0 | 2004/02/26 19:33:00 | JVM exited normally. STATUS | wrapper=A0 | 2004/02/26 19:33:01 | <-- Wrapper Stopped STATUS | wrapper=A0 | 2004/02/26 19:36:28 | CrackerAgent3 removed. and finally a 3rd case: DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:09 | Pause reading child = output =20 to share cycles. DEBUG=A0 | wrapperp | 2004/02/26 19:28:09 | read a packet PING : # DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:09 | Got ping response from = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:28:09 | send a packet PING : ping ... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:09 | Send a packet PING = : # INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:09 | Received a packet = PING : ping INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:09 | Not responding to = pings INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | Send a packet PING = : # INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =20 com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:28:10 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | wrapperRestartProcess() =20= called. ... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.run(WerkflowAgent.java:67) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.main(WerkflowAgent.java:=20 270) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 java.lang.reflect.Method.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:=20= 111) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 java.lang.Thread.run(Unknown Source) ... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | WrapperSimpleApp: =20= Encountered an error running main: java.lang.Error: =20 com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:28:10 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | wrapperRestartProcess() =20= called.=A0 (IGNORED) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | java.lang.Error: =20= com.singingfish.werkflow.processors.ProcessorException: Unexpected =20 exception in cracker STATUS | wrapper=A0 | 2004/02/26 19:28:10 | Filter trigger matched.=A0 = =20 Restarting JVM. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | wrapperRestartProcess() =20= called.=A0 (IGNORED) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 com.singingfish.werkflow.processors.BaseCrackProcessor.process(BaseCrack=20= Processor.java:117) DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | Pause reading child = output =20 to share cycles. DEBUG=A0 | wrapperp | 2004/02/26 19:28:10 | read a packet PING : # DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | Got ping response from = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:28:10 | read a packet STOP : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | JVM requested a = shutdown. (0) DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | wrapperStopProcess(0) = called. DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:10 | Sending stop signal to = JVM DEBUG=A0 | wrapperp | 2004/02/26 19:28:10 | send a packet STOP : NULL ... INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.run(WerkflowAgent.java:67) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 com.singingfish.werkflow.agent.WerkflowAgent.main(WerkflowAgent.java:=20 270) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 java.lang.reflect.Method.invoke(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:=20= 111) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | =A0=A0=A0 at =20 java.lang.Thread.run(Unknown Source) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | Send a packet STOP = : 0 INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:10 | Received a packet = STOP : INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | Thread, =20 WrapperSimpleAppMain, handling the shutdown process. INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | calling = listener.stop() INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | WrapperSimpleApp: = stop(0) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | returned from = listener.stop() INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | Send a packet = STOPPED : 0 DEBUG=A0 | wrapperp | 2004/02/26 19:28:11 | read a packet STOPPED : 0 DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:11 | JVM signalled that it = was =20 stopped. INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:11 | Closing socket. DEBUG=A0 | wrapperp | 2004/02/26 19:28:11 | socket read no code =20 (closed?). INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:12 | calling = System.exit(0) INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:12 | Server daemon shut = down INFO=A0=A0 | jvm 6=A0=A0=A0 | 2004/02/26 19:28:12 | AWTPATH C:\Program = =20 Files\Java\j2re1.4.2_02\bin\jawt.dll DEBUG=A0 | wrapper=A0 | 2004/02/26 19:28:12 | JVM exited normally. STATUS | wrapper=A0 | 2004/02/26 19:28:12 | <-- Wrapper Stopped STATUS | wrapper=A0 | 2004/02/26 19:36:28 | CrackerAgent2 removed. =20= |