Menu
▾
▴
Re: [Wrapper-user] JVM exited unexpectedly.
|
From: Leif M. <le...@ta...> - 2008-04-15 13:00:23
|
Dennis, Everything appears to be working correctly. The Wrapper starts up fine, then launches Tomcat. From the log, it looks like immediately after Tomcat starts up the JVM process terminates. Unfortunately, it is not possible to tell exactly what caused the Java process to crash. Is this reproducible? Does it happen at the same point every time? I did notice that you have set both your initial and maximum memory limits to 64MB. Is that enough memory for your application? Java does not usually crash when it is out of memory. But you might want to try increasing the maximum memory size and see what happens. Cheers, Leif Dennis Wistuba wrote: > Hello, > > I want to run a tomcat 6.0.16 with the wrapper, but after starting the topmcat with wrapper, the JVM exited unexpectedly. > > Here the debuglog: > > DEBUG | wrapper | 2008/04/14 06:48:46 | Working directory set to: /opt/tomcats/node1346-20 > DEBUG | wrapper | 2008/04/14 06:48:46 | Spawning intermediate process... > DEBUG | wrapper | 2008/04/14 06:48:46 | Spawning daemon process... > STATUS | wrapper | 2008/04/14 06:48:46 | --> Wrapper Started as Daemon > STATUS | wrapper | 2008/04/14 06:48:46 | Java Service Wrapper Community Edition 3.3.0 > STATUS | wrapper | 2008/04/14 06:48:46 | Copyright (C) 1999-2008 Tanuki Software, Inc. All Rights Reserved. > STATUS | wrapper | 2008/04/14 06:48:46 | http://wrapper.tanukisoftware.org > STATUS | wrapper | 2008/04/14 06:48:46 | > DEBUG | wrapper | 2008/04/14 06:48:46 | Using tick timer. > DEBUG | wrapperp | 2008/04/14 06:48:46 | server listening on port 32120. > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[0] : /usr/lib/java/bin/java > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[1] : -server > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[2] : -XX:+UseConcMarkSweepGC > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[3] : -Dcatalina.home=/opt/tomcats/apache-tomcat-6.0.16 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[4] : -Dcatalina.base=/opt/tomcats/node1346-20 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[5] : -Djava.io.tmpdir=/opt/tomcats/node1346-20/temp > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[6] : -Dcatalina.config=file:/opt/tomcats/node1346-20/conf/catalina.properties > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[7] : -Djava.awt.headless=true > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[8] : -XX:PermSize=96m > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[9] : -XX:MaxPermSize=96m > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[10] : -Dcom.sun.management.jmxremote > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[11] : -Dorg.tanukisoftware.wrapper.WrapperManager.mbean=true > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[12] : -Dorg.tanukisoftware.wrapper.WrapperManager.mbean.testing=false > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[13] : -Dcom.sun.management.jmxremote.port=11020 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[14] : -Dcom.sun.management.jmxremote.ssl=false > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[15] : -Dcom.sun.management.jmxremote.authenticate=true > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[16] : -Dcom.sun.management.jmxremote.password.file=/opt/tomcats/node1346-20/conf/jmxremote.password > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[17] : -Dcom.sun.management.jmxremote.access.file=/opt/tomcats/node1346-20/conf/jmxremote.access > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[18] : -Xms64m > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[19] : -Xmx64m > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[20] : -Djava.library.path=/opt/tomcats/wrapper-3.3.0/ > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[21] : -classpath > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[22] : /opt/tomcats/apache-tomcat-6.0.16/bin/bootstrap.jar:/opt/tomcats/wrapper-3.3.0/wrapper.jar > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[23] : -Dwrapper.key=gXd7WZVqU5zEClWu > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[24] : -Dwrapper.port=32120 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[25] : -Dwrapper.jvm.port.min=31000 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[26] : -Dwrapper.jvm.port.max=31999 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[27] : -Dwrapper.debug=TRUE > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[28] : -Dwrapper.pid=8543 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[29] : -Dwrapper.timer_slow_threshold=10 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[30] : -Dwrapper.version=3.3.0 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[31] : -Dwrapper.native_library=wrapper > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[32] : -Dwrapper.ignore_signals=TRUE > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[33] : -Dwrapper.service=TRUE > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[34] : -Dwrapper.disable_shutdown_hook=TRUE > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[35] : -Dwrapper.cpu.timeout=10 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[36] : -Dwrapper.jvmid=1 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[37] : org.tanukisoftware.wrapper.WrapperStartStopApp > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[38] : org.apache.catalina.startup.Bootstrap > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[39] : 1 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[40] : startd > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[41] : org.apache.catalina.startup.Bootstrap > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[42] : true > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[43] : 1 > DEBUG | wrapper | 2008/04/14 06:48:46 | Command[44] : stopd > DEBUG | wrapper | 2008/04/14 06:48:46 | Ping settings: wrapper.ping.interval=5, wrapper.ping.interval.logged=1, wrapper.ping.timeout=30 > STATUS | wrapper | 2008/04/14 06:48:46 | Launching a JVM... > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: WrapperManager class initialized by thread: main Using classloader: sun.misc.Launcher$AppClas > sLoader@1a5ab41 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager: Initializing... > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: JVM #1 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Running a 32-bit JVM. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Using wrapper > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Registered MBean with Platform MBean Server: org.tanukisoftware.wrapper:type=WrapperManager > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Load native library. One or more attempts may fail if platform specific libraries do not exis > t. This is NORMAL and is only a problem if they all fail. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Unable to load native library: libwrapper-linux-x86-32.so Cause: no wrapper-linux-x86-32 in > java.library.path > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Loaded native library: libwrapper.so > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Calling native initialization method. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperJNI Debug: Inside native WrapperManager initialization method > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Java Version : 1.5.0_05-b05 Java HotSpot(TM) Server VM > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Java VM Vendor : Sun Microsystems Inc. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Startup runner thread started. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Control event monitor thread started. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: WrapperManager.start(org.tanukisoftware.wrapper.WrapperStartStopApp@c4fe76, args["startd"]) ca > lled by thread: main > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Communications runner thread started. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Open socket to wrapper...Wrapper-Connection > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Failed attempt to bind using local port 31000 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Failed attempt to bind using local port 31001 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Failed attempt to bind using local port 31002 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Failed attempt to bind using local port 31003 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Failed attempt to bind using local port 31004 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Opened Socket from 31005 to 32120 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Send a packet KEY : gXd7WZVqU5zEClWu > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: handleSocket(Socket[addr=localhost/127.0.0.1,port=32120,localport=31005]) > DEBUG | wrapperp | 2008/04/14 06:48:47 | accepted a socket from 127.0.0.1 on port 31005 > DEBUG | wrapperp | 2008/04/14 06:48:47 | read a packet KEY : gXd7WZVqU5zEClWu > DEBUG | wrapper | 2008/04/14 06:48:47 | Got key from JVM: gXd7WZVqU5zEClWu > DEBUG | wrapperp | 2008/04/14 06:48:47 | send a packet LOW_LOG_LEVEL : 1 > DEBUG | wrapperp | 2008/04/14 06:48:47 | send a packet PING_TIMEOUT : 30 > DEBUG | wrapperp | 2008/04/14 06:48:47 | send a packet PROPERTIES : (Property Values) > DEBUG | wrapper | 2008/04/14 06:48:47 | Start Application. > DEBUG | wrapperp | 2008/04/14 06:48:47 | send a packet START : start > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Received a packet LOW_LOG_LEVEL : 1 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: LowLogLevel from Wrapper is 1 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Received a packet PING_TIMEOUT : 30 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: PingTimeout from Wrapper is 30000 > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Received a packet PROPERTIES : (Property Values) > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Received a packet START : start > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: calling WrapperListener.start() > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: Waiting for WrapperListener.start runner thread to complete. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperManager Debug: WrapperListener.start runner thread started. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperStartStopApp Debug: start(args) Will wait up to 2 seconds for the main method to complete. > INFO | jvm 1 | 2008/04/14 06:48:47 | WrapperStartStopApp Debug: invoking start main method > INFO | jvm 1 | 2008/04/14 06:48:48 | WrapperManager Debug: Send a packet START_PENDING : 5000 > DEBUG | wrapperp | 2008/04/14 06:48:48 | read a packet START_PENDING : 5000 > DEBUG | wrapper | 2008/04/14 06:48:48 | JVM signalled a start pending with waitHint of 5000 millis. > INFO | jvm 1 | 2008/04/14 06:48:48 | 14.04.2008 06:48:48 org.apache.catalina.core.AprLifecycleListener init > INFO | jvm 1 | 2008/04/14 06:48:48 | INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not > found on the java.library.path: /opt/tomcats/wrapper-3.3.0/ > INFO | jvm 1 | 2008/04/14 06:48:48 | 14.04.2008 06:48:48 org.apache.coyote.http11.Http11Protocol init > INFO | jvm 1 | 2008/04/14 06:48:48 | INFO: Initializing Coyote HTTP/1.1 on http-7120 > INFO | jvm 1 | 2008/04/14 06:48:48 | 14.04.2008 06:48:48 org.apache.catalina.startup.Catalina load > INFO | jvm 1 | 2008/04/14 06:48:48 | INFO: Initialization processed in 935 ms > INFO | jvm 1 | 2008/04/14 06:48:48 | 14.04.2008 06:48:48 org.apache.catalina.core.StandardService start > INFO | jvm 1 | 2008/04/14 06:48:48 | INFO: Starting service Catalina > INFO | jvm 1 | 2008/04/14 06:48:48 | 14.04.2008 06:48:48 org.apache.catalina.core.StandardEngine start > INFO | jvm 1 | 2008/04/14 06:48:48 | INFO: Starting Servlet Engine: Apache Tomcat/6.0.16 > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperManager Debug: Send a packet START_PENDING : 5000 > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperStartStopApp Debug: start(args) end. Main Completed=false, exitCode=null > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperManager Debug: WrapperListener.start runner thread stopped. > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperManager Debug: returned from WrapperListener.start() > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperManager Debug: Send a packet STARTED : > DEBUG | wrapperp | 2008/04/14 06:48:49 | read a packet START_PENDING : 5000 > DEBUG | wrapper | 2008/04/14 06:48:49 | JVM signalled a start pending with waitHint of 5000 millis. > DEBUG | wrapperp | 2008/04/14 06:48:49 | read a packet STARTED : > DEBUG | wrapper | 2008/04/14 06:48:49 | JVM signalled that it was started. > INFO | jvm 1 | 2008/04/14 06:48:49 | WrapperManager Debug: Startup runner thread stopped. > INFO | jvm 1 | 2008/04/14 06:48:50 | 14.04.2008 06:48:49 org.apache.coyote.http11.Http11Protocol start > INFO | jvm 1 | 2008/04/14 06:48:50 | INFO: Starting Coyote HTTP/1.1 on http-7120 > INFO | jvm 1 | 2008/04/14 06:48:50 | 14.04.2008 06:48:50 org.apache.jk.common.ChannelSocket init > INFO | jvm 1 | 2008/04/14 06:48:50 | INFO: JK: ajp13 listening on /0.0.0.0:7220 > INFO | jvm 1 | 2008/04/14 06:48:50 | 14.04.2008 06:48:50 org.apache.jk.server.JkMain start > INFO | jvm 1 | 2008/04/14 06:48:50 | INFO: Jk running ID=0 time=0/51 config=null > INFO | jvm 1 | 2008/04/14 06:48:50 | 14.04.2008 06:48:50 org.apache.catalina.startup.Catalina start > INFO | jvm 1 | 2008/04/14 06:48:50 | INFO: Server startup in 1681 ms > INFO | jvm 1 | 2008/04/14 06:48:50 | WrapperStartStopApp Debug: start main method completed > DEBUG | wrapperp | 2008/04/14 06:48:50 | send a packet PING : ping > INFO | jvm 1 | 2008/04/14 06:48:50 | WrapperManager Debug: Received a packet PING : ping > INFO | jvm 1 | 2008/04/14 06:48:50 | WrapperManager Debug: Send a packet PING : ping > DEBUG | wrapperp | 2008/04/14 06:48:50 | read a packet PING : ping > DEBUG | wrapper | 2008/04/14 06:48:51 | Signal trapped. Details: > DEBUG | wrapper | 2008/04/14 06:48:51 | signal number=17 (SIGCHLD), source="unknown" > DEBUG | wrapper | 2008/04/14 06:48:51 | Received SIGCHLD, checking JVM process status. > DEBUG | wrapper | 2008/04/14 06:48:51 | JVM process exited with a code of 0, leaving the wrapper exit code set to 0. > ERROR | wrapper | 2008/04/14 06:48:51 | JVM exited unexpectedly. > DEBUG | wrapperp | 2008/04/14 06:48:51 | server listening on port 32120. > DEBUG | wrapper | 2008/04/14 06:48:51 | JVM was only running for 5 seconds leading to a failed restart count of 1. > DEBUG | wrapper | 2008/04/14 06:48:51 | Waiting 5 seconds before launching another JVM. > > I have no idea why the JVM crashed. > Can anyone help me please? > > Regards > > Dennis > > |
