Menu
▾
▴
RE: [Wrapper-user] Tomcat 5.5.9/JRockit won't shutdown cleanly
|
From: Brad B. <bb...@gm...> - 2005-08-22 21:42:10
|
.. here's the new log section with the thread info:
INFO | jvm 1 | 2005/08/22 15:38:12 | WrapperStartStopApp: stopping.
Waiting for 6 threads to complete.
ERROR | wrapper | 2005/08/22 15:38:12 | Shutdown failed: Timed out waiting
for signal from JVM.
STATUS | wrapper | 2005/08/22 15:38:12 | Dumping JVM state.
DEBUG | wrapper | 2005/08/22 15:38:12 | Sending BREAK event to process
group 2092.
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | ===== FULL THREAD DUMP
===============
INFO | jvm 1 | 2005/08/22 15:38:12 | Mon Aug 22 15:38:12 2005
INFO | jvm 1 | 2005/08/22 15:38:12 | BEA JRockit(R) R25.2.0-28
dra-45238-20050523-2021-win-ia32
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "Thread-1" id=14 idx=0x2 tid=2188
prio=5 alive, in native, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(Signal Handler)" id=2 idx=0x4
tid=196 prio=5 alive, in native, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(Code Generation Thread 1)" id=3
idx=0x6 tid=3672 prio=5 alive, in native, native_waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(Code Optimization Thread 1)"
id=4 idx=0x8 tid=3664 prio=5 alive, in native, native_waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(GC Main Thread)" id=5 idx=0xa
tid=412 prio=5 alive, in native, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(GC Worker Thread 1)" id=6
idx=0xc tid=384 prio=5 alive, in native, native_waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "(Hotspot Detector)" id=7 idx=0xe
tid=3100 prio=10 alive, in native, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "Finalizer" id=8 idx=0x10 tid=3556
prio=8 alive, in native, native_waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/memory/Finalizer.getPendingFinalizee(Z)Ljava/lang/Object;(Native
Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/memory/Finalizer.access$100(Z)Ljava/lang/Object;(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/memory/Finalizer$4.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/Thread.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/RNI.c2java()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "Reference Handler" id=9 idx=0x12
tid=2260 prio=10 alive, in native, native_waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/ref/Reference.getPending()Ljava/lang/ref/Reference;(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/ref/Reference.access$000()Ljava/lang/ref/Reference;(Unknown
Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/ref/Reference$ReferenceHandler.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/RNI.c2java()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "Wrapper-Control-Event-Monitor"
id=12 idx=0x14 tid=584 prio=5 alive, in native, sleeping, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 | -- Waiting for notification
on: java/lang/Object@0x008A0AB0[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Threads.waitForSignalWithTimeout(J)V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Locks.wait(Ljava/lang/Object;J)V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/Thread.sleep(J)V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | ^-- Lock released while
waiting: java/lang/Object@0x008A0AB0[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperStartStopApp.stop(I)I(WrapperStartStopApp.
java:300)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.stopInner(I)V(WrapperManager.java:
1982)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.stop(I)V(WrapperManager.java:1514)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperStartStopApp.controlEvent(I)V(WrapperStart
StopApp.java:360)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.controlEvent(I)V(WrapperManager.ja
va:2061)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.access$1700(I)V(WrapperManager.jav
a:260)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager$2.run()V(WrapperManager.java:694)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/RNI.c2java()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "Wrapper-Connection" id=13
idx=0x16 tid=1932 prio=10 alive, in native
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/net/SocketNativeIO.read(IIII)I(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/net/SocketNativeIO.read(Ljava/io/FileDescriptor;III)I(Unknown
Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/net/AbstractSocketImpl$1.read(II)I(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | ^-- Holding lock:
java/net/AbstractSocketImpl$1@0x0077B0E0[recursive]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/io/NativeIOInputStream.read(I[BI)I(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/io/NativeIOInputStream.read()I(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | ^-- Holding lock:
java/net/AbstractSocketImpl$1@0x0077B0E0[thin lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/io/DataInputStream.readByte()B(DataInputStream.java:241)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.handleSocket()V(WrapperManager.jav
a:2348)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/tanukisoftware/wrapper/WrapperManager.run()V(WrapperManager.java:2696)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/Thread.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/RNI.c2java()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "http-8080-Processor24" id=40
idx=0x4a tid=1064 prio=5 alive, in native, sleeping, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 | -- Waiting for notification
on: java/lang/Object@0x008D21B0[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Threads.waitForSignalWithTimeout(J)V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Locks.wait(Ljava/lang/Object;J)V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/Thread.sleep(J)V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | ^-- Lock released while
waiting: java/lang/Object@0x008D21B0[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/apache/tomcat/util/net/LeaderFollowerWorkerThread.runIt([Ljava/lang/Obje
ct;)V(LeaderFollowerWorkerThread.java:61)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
org/apache/tomcat/util/threads/ThreadPool$ControlRunnable.run()V(ThreadPool.
java:684)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
java/lang/Thread.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/RNI.c2java()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:12 |
INFO | jvm 1 | 2005/08/22 15:38:12 | "TP-Processor4" id=46 idx=0x56
tid=3432 prio=5 alive, in native, waiting, daemon
INFO | jvm 1 | 2005/08/22 15:38:12 | -- Waiting for notification
on: org/apache/jk/common/ChannelSocket@0x00659528[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Threads.waitForSignal()V(Native Method)
INFO | jvm 1 | 2005/08/22 15:38:12 | at
jrockit/vm/Locks.wait(Ljava/lang/Object;)V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:13 | at
org/apache/jk/common/ChannelSocket.accept(Lorg/apache/jk/core/MsgContext;)V(
ChannelSocket.java:289)
INFO | jvm 1 | 2005/08/22 15:38:13 | ^-- Lock released while
waiting: org/apache/jk/common/ChannelSocket@0x00659528[fat lock]
INFO | jvm 1 | 2005/08/22 15:38:13 | at
org/apache/jk/common/ChannelSocket.acceptConnections()V(ChannelSocket.java:6
41)
INFO | jvm 1 | 2005/08/22 15:38:13 | at
org/apache/jk/common/SocketAcceptor.runIt([Ljava/lang/Object;)V(ChannelSocke
t.java:852)
INFO | jvm 1 | 2005/08/22 15:38:13 | at
org/apache/tomcat/util/threads/ThreadPool$ControlRunnable.run()V(ThreadPool.
java:684)
INFO | jvm 1 | 2005/08/22 15:38:13 | at
java/lang/Thread.run()V(Unknown Source)
INFO | jvm 1 | 2005/08/22 15:38:13 | at
jrockit/vm/RNI.c2java()V(Native Method)
DEBUG | wrapper | 2005/08/22 15:38:13 | Pause reading child output to
share cycles.
INFO | jvm 1 | 2005/08/22 15:38:13 | -- end of trace
INFO | jvm 1 | 2005/08/22 15:38:13 |
INFO | jvm 1 | 2005/08/22 15:38:13 | ===== END OF THREAD DUMP
===============
INFO | jvm 1 | 2005/08/22 15:38:13 | WrapperStartStopApp: stopping.
Waiting for 6 threads to complete.
-----Original Message-----
From: wra...@li...
[mailto:wra...@li...] On Behalf Of Leif
Mortenson
Sent: Monday, August 22, 2005 3:27 PM
To: wra...@li...
Subject: Re: [Wrapper-user] Tomcat 5.5.9/JRockit won't shutdown cleanly
Brad,
Sorry, I forgot. Could you also set the following property and
rerun this test? It will
tell me what those 6 threads are.
wrapper.request_thread_dump_on_failed_jvm_exit=TRUE
Cheers,
Leif
|
