You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@tomcat.apache.org by ba...@bpo.be on 2004/06/23 11:08:48 UTC

tomcat crash ... "unexpected exception"

Hi,

I have serious problems with my web aplpication (based on Apache/Tomcat), I'm a system guy 
and I'd like at least to identify where the problem is situated: system, memory, db, 
application itself, etc., but I'm not related at all to JSP or Java stuff ...

Well, here is my situation :
Apache 2.0.49 (compiled --with-mpm=worker)
Tomcat 4.1.30
mod_jk 2.0.2
Java SDK 1.4.2_02

Apache is configured to serve all requests (static) except .jsp which are transmitted to
tomcat through mod_jk2.

Here below is a copy of the error in catalina.out. Before the "unexpected exception" you
see client transactions, labeled with "ITS*", meaning clients navigate through
menus in the app, etc., then you see the exception, then somebody (huh ... me) restart all 
the stuff and it continues with normal transactions ...

the error (sorry for length) :
---------------------------------------------------------------------
(... transactions ...)
[2004-06-16 22:33:51] ITY2(0) 20ms
[2004-06-16 22:33:51] ITS6(0) 82ms
[2004-06-16 22:33:51] ITHZ(0) 16ms
[2004-06-16 22:33:51] ITA3(0) 144ms
[2004-06-16 22:33:51] ITHZ(0) 6ms
[2004-06-16 22:33:51] ITS3(0) 260ms
[2004-06-16 22:33:51] ITS3(0) 169ms

An unexpected exception has been detected in native code outside the VMn.
Unexpected Signal : 11 occurred at PC=0xFFFFFFFF7EF499A4
Function=[Unknown. Nearest: madvise+0xC0]
Library=/usr/lib/64/libc.so.1

Current Java thread:
         at appweb.NativeCall.Call_C_tpcall(Native Method)
         at appweb.NativeCall.tp_call(NativeCall.java:58)
         at appweb.AppwebDispatcher$ObjectApartment.get_result(AppwebDispatcher.java:345)
         at appweb.AppwebDispatcher$ObjectApartment.run(AppwebDispatcher.java:306)

Dynamic libraries:
0x100000000     /aplication/java/bin/sparcv9/java
0xffffffff7f300000      /usr/lib/64/libthread.so.1
0xffffffff7f500000      /usr/lib/64/libdl.so.1
0xffffffff7ef00000      /usr/lib/64/libc.so.1
0xffffffff7d400000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/server/libjvm.so
0xffffffff7d200000      /usr/lib/64/libCrun.so.1
0xffffffff7cf00000      /usr/lib/64/libsocket.so.1
0xffffffff7cd00000      /usr/lib/64/libnsl.so.1
0xffffffff7cb00000      /usr/lib/64/libm.so.1
0xffffffff7c900000      /usr/lib/64/libsched.so.1
0xffffffff7ed00000      /usr/lib/64/libw.so.1
0xffffffff7c500000      /usr/lib/64/libmp.so.2
0xffffffff7c200000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/native_threads/libhpi.so
0xffffffff7be00000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/libverify.so
0xffffffff7bc00000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/libjava.so
0xffffffff7b900000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/libzip.so
0xfffffffdae800000      /aplication/j2sdk1.4.2_04/jre/lib/sparcv9/libnet.so
0xfffffffdac900000      /aplication/thalerv1.4/webapps/appweb/nativecall/libnativecall.so
0xfffffffdac700000      /tuxweb/lib/libwsc.so.71
0xfffffffdac500000      /tuxweb/lib/libbuft.so.71
0xfffffffdac200000      /tuxweb/lib/libgpnet.so.71
0xfffffffdac000000      /tuxweb/lib/libfml.so.71
0xfffffffdabe00000      /tuxweb/lib/libfml32.so.71
0xfffffffdabb00000      /tuxweb/lib/libengine.so.71
0xfffffffdab900000      /usr/lib/64/libpthread.so.1
0xfffffffdab600000      /usr/lib/64/librt.so.1
0xfffffffdab400000      /usr/lib/64/libaio.so.1
0xfffffffdaa700000      /tuxweb/lib/registry.so

Heap at VM Abort:
Heap
  def new generation   total 1158784K, used 1150571K [0xfffffffdb3800000,
0xfffffffdfc5e0000, 0xfffffffe33800000)
   eden space 1123712K,  54% used [0xfffffffdb3800000, 0xfffffffdf795afc0,
0xfffffffdf8160000)
   from space 35072K, 100% used [0xfffffffdf8160000, 0xfffffffdfa3a0000, 0xfffffffdfa3a0000)
   to   space 35072K,   0% used [0xfffffffdfa3a0000, 0xfffffffdfa3a0000, 0xfffffffdfc5e0000)
  tenured generation   total 2387632K, used 1880586K [0xfffffffe33800000,
0xfffffffec53ac000, 0xffffffff33800000)
    the space 2387632K,  78% used [0xfffffffe33800000, 0xfffffffea6482b68,
0xfffffffea6482c00, 0xfffffffec53ac000)
  compacting perm gen  total 16384K, used 13651K [0xffffffff33800000, 0xffffffff34800000,
0xffffffff37800000)
    the space 16384K,  83% used [0xffffffff33800000, 0xffffffff34554d08,
0xffffffff34554e00, 0xffffffff34800000)

Starting service Tomcat
Apache Tomcat/4.1.30
Jun 17, 2004 12:28:17 AM org.apache.jk.common.ChannelSocket init
INFO: JK2: ajp13 listening on /0.0.0.0:8009
Jun 17, 2004 12:28:17 AM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=1/116  config=null
Jun 17, 2004 12:28:17 AM org.apache.jk.common.ChannelSocket init
INFO: JK2: ajp13 listening on /0.0.0.0:8010
Jun 17, 2004 12:28:17 AM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/6  config=null
Dynamic Library nativecall loaded
Dispatcher constructor
WSCLIENTS=5
THREADSPERCLIENTS=3
Thread[Thread-13,5,main]: Starting...
Thread[Thread-14,5,main]: Starting...
Thread[Thread-15,5,main]: Starting...
Thread[Thread-16,5,main]: Starting...
Thread[Thread-17,5,main]: Starting...
Thread[Thread-18,5,main]: Starting...
Thread[Thread-19,5,main]: Starting...
Thread[Thread-20,5,main]: Starting...
Thread[Thread-21,5,main]: Starting...
Thread[Thread-22,5,main]: Starting...
Thread[Thread-23,5,main]: Starting...
Thread[Thread-24,5,main]: Starting...
Thread[Thread-25,5,main]: Starting...
Thread[Thread-26,5,main]: Starting...
Thread[Thread-27,5,main]: Starting...
Using Tuxedo server at address WSNADDR=0x00023334C0A8F9EA
Using user INTERNET-0
Using passwd qwerty
Using client UNIX-JSP
Using Tuxedo server at address WSNADDR=0x00023334C0A8F9EA
Using user INTERNET-1
Using passwd qwerty
Using client UNIX-JSP
Using Tuxedo server at address WSNADDR=0x00023334C0A8F9EA
Using user INTERNET-2
Using passwd qwerty
Using client UNIX-JSP
Using Tuxedo server at address WSNADDR=0x00023334C0A8F9EA
Using user INTERNET-3
Using passwd qwerty
Using client UNIX-JSP
Using Tuxedo server at address WSNADDR=0x00023334C0A8F9EA
Using user INTERNET-4
Using passwd qwerty
Using client UNIX-JSP
[2004-06-17 00:28:33] ITZZ(0) 4423ms
[2004-06-17 00:28:38] ITZZ(0) 22ms
[2004-06-17 00:28:38] ITZZ(0) 8ms
[2004-06-17 00:28:38] ITZZ(0) 12ms
[2004-06-17 00:28:38] ITZZ(0) 9ms
(... transactions ...)
---------------------------------------------------------------------

At the same time in Apache error log, I see of course that it can't connect to ajp13
connector, which is obvious.
The transactional server (with DB) is another machine than the webserver.

Above I see "from space 35072K, 100% used". I don't know anything about how java is 
managing his memory, but "100%" doesn't look good, isn't it ?
Anyway java runs with JAVA_OPTS=-Xms5120m -Xmx6144m, so it has more than 5Gb RAM to run !!

Do I have to look into apache/tomcat configuration ?
into the  application code itself ?
both ?

I'm a bit lost ...

Any available help would be very appreciated.

Thanks,

Bastien.

---------------------------------------------------------------------
To unsubscribe, e-mail: tomcat-user-unsubscribe@jakarta.apache.org
For additional commands, e-mail: tomcat-user-help@jakarta.apache.org