Menu
▾
▴
[Wrapper-user] JVM restart with ping-timeout
|
From: madis <ma...@ja...> - 2007-03-14 12:54:42
|
Hi Altough the system is practically idle I often get VM restarts beacuse the ping request times out. I have set the timeout for 4 minutes with wrapper.ping.timeout=240 wrapper.ping.interval=5 Does anybody know how to fix this problem without disabling VM restarts? Madis Here is the logfile for an example restart: STATUS | wrapper | 2007/03/14 14:13:17 | Starting the Jawilla Test service... STATUS | wrapper | 2007/03/14 14:13:17 | --> Wrapper Started as Service DEBUG | wrapper | 2007/03/14 14:13:17 | Using tick timer. DEBUG | wrapperp | 2007/03/14 14:13:17 | server listening on port 32000. STATUS | wrapper | 2007/03/14 14:13:17 | Launching a JVM... DEBUG | wrapper | 2007/03/14 14:13:17 | command: "H:\WINDOWS\system32\javaw.exe" -Djava.library.path="../lib" -classpath "../lib/jawilla-wrapper.jar;../lib/comm.jar" -Dwrapper.key="dNieTuNL6egp5T7P" -Dwrapper.port=32000 -Dwrapper.jvm.port.min=31000 -Dwrapper.jvm.port.max=31999 -Dwrapper.debug="TRUE" -Dwrapper.pid=4772 -Dwrapper.version="3.2.3" -Dwrapper.native_library="wrapper" -Dwrapper.service="TRUE" -Dwrapper.cpu.timeout="10" -Dwrapper.jvmid=1 com.jawilla.wrapper.Main DEBUG | wrapper | 2007/03/14 14:13:17 | JVM started (PID=508) INFO | jvm 1 | 2007/03/14 14:13:17 | Initializing... INFO | jvm 1 | 2007/03/14 14:13:17 | WrapperManager class initialized by thread: main Using classloader: sun.misc.Launcher$AppClassLoader@d9f9c3 INFO | jvm 1 | 2007/03/14 14:13:17 | Wrapper (Version 3.2.3) http://wrapper.tanukisoftware.org INFO | jvm 1 | 2007/03/14 14:13:17 | Copyright 1999-2006 Tanuki Software, Inc. All Rights Reserved. INFO | jvm 1 | 2007/03/14 14:13:17 | INFO | jvm 1 | 2007/03/14 14:13:17 | Wrapper Manager: JVM #1 INFO | jvm 1 | 2007/03/14 14:13:17 | Running a 32-bit JVM. INFO | jvm 1 | 2007/03/14 14:13:17 | Wrapper Manager: Registering shutdown hook INFO | jvm 1 | 2007/03/14 14:13:17 | Wrapper Manager: Using wrapper INFO | jvm 1 | 2007/03/14 14:13:17 | Java Version : 1.6.0-b105 Java HotSpot(TM) Client VM INFO | jvm 1 | 2007/03/14 14:13:17 | Java VM Vendor : Sun Microsystems Inc. INFO | jvm 1 | 2007/03/14 14:13:17 | INFO | jvm 1 | 2007/03/14 14:13:17 | Control event monitor thread started. INFO | jvm 1 | 2007/03/14 14:13:17 | WrapperManager.start(com.jawilla.wrapper.Main@201f9, args[]) called by thread: main INFO | jvm 1 | 2007/03/14 14:13:17 | Startup runner thread started. INFO | jvm 1 | 2007/03/14 14:13:17 | Communications runner thread started. INFO | jvm 1 | 2007/03/14 14:13:17 | Open socket to wrapper...Wrapper-Connection INFO | jvm 1 | 2007/03/14 14:13:17 | Opened Socket from 31000 to 32000 INFO | jvm 1 | 2007/03/14 14:13:17 | Send a packet KEY : dNieTuNL6egp5T7P INFO | jvm 1 | 2007/03/14 14:13:17 | handleSocket(Socket[addr=/127.0.0.1,port=32000,localport=31000]) DEBUG | wrapperp | 2007/03/14 14:13:17 | accepted a socket from 127.0.0.1 on port 31000 DEBUG | wrapperp | 2007/03/14 14:13:17 | read a packet KEY : dNieTuNL6egp5T7P DEBUG | wrapper | 2007/03/14 14:13:17 | Got key from JVM: dNieTuNL6egp5T7P DEBUG | wrapperp | 2007/03/14 14:13:17 | send a packet LOW_LOG_LEVEL : 1 DEBUG | wrapperp | 2007/03/14 14:13:17 | send a packet PING_TIMEOUT : 240 DEBUG | wrapperp | 2007/03/14 14:13:17 | send a packet PROPERTIES : (Property Values) DEBUG | wrapper | 2007/03/14 14:13:17 | Start Application. DEBUG | wrapperp | 2007/03/14 14:13:17 | send a packet START : start INFO | jvm 1 | 2007/03/14 14:13:17 | Received a packet LOW_LOG_LEVEL : 1 INFO | jvm 1 | 2007/03/14 14:13:17 | Wrapper Manager: LowLogLevel from Wrapper is 1 INFO | jvm 1 | 2007/03/14 14:13:17 | Received a packet PING_TIMEOUT : 240 INFO | jvm 1 | 2007/03/14 14:13:17 | PingTimeout from Wrapper is 240000 INFO | jvm 1 | 2007/03/14 14:13:17 | Received a packet PROPERTIES : (Property Values) INFO | jvm 1 | 2007/03/14 14:13:17 | java props:set.WRAPPER_ARCH->x86 INFO | jvm 1 | 2007/03/14 14:13:17 | java props:set.WRAPPER_BITS->32 INFO | jvm 1 | 2007/03/14 14:13:17 | java props:set.WRAPPER_FILE_SEPARATOR->\ INFO | jvm 1 | 2007/03/14 14:13:17 | java props:set.WRAPPER_OS->windows INFO | jvm 1 | 2007/03/14 14:13:17 | java props:set.WRAPPER_PATH_SEPARATOR->; INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.console.format->PM INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.console.loglevel->ERROR INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.console.title->Jawilla Test Manager INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.java.classpath.1->../lib/jawilla-wrapper.jar INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.java.classpath.2->../lib/comm.jar INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.java.command->javaw INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.java.library.path.1->../lib INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.java.mainclass->com.jawilla.wrapper.Main INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.logfile->../logs/wrapper.log INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.logfile.format->LPTM INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.logfile.loglevel->DEBUG INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.logfile.maxfiles->0 INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.logfile.maxsize->100k INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.dependency.1-> INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.description->Your add here. INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.displayname->Jawilla Test INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.interactive->true INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.name->jawillatest INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ntservice.starttype->AUTO_START INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ping.interval->5 INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.ping.timeout->240 INFO | jvm 1 | 2007/03/14 14:13:17 | java props:wrapper.syslog.loglevel->ERROR INFO | jvm 1 | 2007/03/14 14:13:17 | Received a packet START : start INFO | jvm 1 | 2007/03/14 14:13:17 | calling WrapperListener.start() INFO | jvm 1 | 2007/03/14 14:13:17 | Waiting for WrapperListener.start runner thread to complete. INFO | jvm 1 | 2007/03/14 14:13:17 | WrapperListener.start runner thread started. INFO | jvm 1 | 2007/03/14 14:13:17 | start() INFO | jvm 1 | 2007/03/14 14:13:17 | user.dir=h:\work\e-police\serviceWrapper\bin INFO | jvm 1 | 2007/03/14 14:13:17 | WrapperListener.start runner thread stopped. INFO | jvm 1 | 2007/03/14 14:13:17 | returned from WrapperListener.start() INFO | jvm 1 | 2007/03/14 14:13:17 | Send a packet STARTED : DEBUG | wrapperp | 2007/03/14 14:13:17 | read a packet STARTED : DEBUG | wrapper | 2007/03/14 14:13:17 | JVM signalled that it was started. INFO | jvm 1 | 2007/03/14 14:13:17 | Startup runner thread stopped. STATUS | wrapper | 2007/03/14 14:13:19 | Jawilla Test started. DEBUG | wrapperp | 2007/03/14 14:13:22 | send a packet PING : ping INFO | jvm 1 | 2007/03/14 14:13:22 | Received a packet PING : ping DEBUG | wrapperp | 2007/03/14 14:13:26 | send a packet PING : ping INFO | jvm 1 | 2007/03/14 14:13:26 | Received a packet PING : ping DEBUG | wrapperp | 2007/03/14 14:13:31 | send a packet PING : ping .............................................................................................................. DEBUG | wrapperp | 2007/03/14 14:17:44 | send a packet PING : ping INFO | jvm 1 | 2007/03/14 14:17:44 | Received a packet PING : ping ERROR | wrapper | 2007/03/14 14:17:47 | JVM appears hung: Timed out waiting for signal from JVM. ERROR | wrapper | 2007/03/14 14:17:47 | JVM did not exit on request, terminated DEBUG | wrapperp | 2007/03/14 14:17:47 | server listening on port 32001. DEBUG | wrapper | 2007/03/14 14:17:47 | JVM was only running for 245 seconds leading to a failed restart count of 1. DEBUG | wrapper | 2007/03/14 14:17:47 | Waiting 5 seconds before launching another JVM. STATUS | wrapper | 2007/03/14 14:17:52 | Launching a JVM... |
