Jazz Forum Welcome to the Jazz Community Forum Connect and collaborate with IBM Engineering experts and users

Can these logs tell me whether my Tomcat is crashing or being shut down?

Questions
Tags
Users
Badges
Andrew Trobec
(497●13●144●139) Feb 21 '14, 5:48 a.m.
Hello,

I am troubleshooting some catalina logs to determine whether my CLM server is crashing or whether it is being brought down intentionally by an admin or some rogue process.  Here are 4 different log extracts where the server restarts.  Can somebody help me figure out what's going on?

Extract 1

Feb 10, 2014 10:21:01 AM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop: 
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:393)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:254)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:241)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:556)
at java.net.Socket.connect(Socket.java:504)
at java.net.Socket.<init>(Socket.java:412)
at java.net.Socket.<init>(Socket.java:226)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
Feb 10, 2014 10:21:08 AM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path:<removed>
Feb 10, 2014 10:21:09 AM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
Feb 10, 2014 10:21:10 AM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
Feb 10, 2014 10:21:10 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2564 ms
Feb 10, 2014 10:21:10 AM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Feb 10, 2014 10:21:10 AM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.33
Feb 10, 2014 10:21:10 AM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Feb 10, 2014 10:22:09 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive clmhelp.war
Feb 10, 2014 10:22:16 AM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Feb 10, 2014 10:22:16 AM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
Feb 10, 2014 10:22:16 AM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Feb 10, 2014 10:22:16 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 66349 ms

Extract 2

Feb 11, 2014 7:08:11 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
Feb 11, 2014 7:17:59 PM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop: 
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:393)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:254)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:241)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:556)
at java.net.Socket.connect(Socket.java:504)
at java.net.Socket.<init>(Socket.java:412)
at java.net.Socket.<init>(Socket.java:226)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
Feb 11, 2014 7:18:08 PM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path:<removed>
Feb 11, 2014 7:18:08 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
Feb 11, 2014 7:18:10 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
Feb 11, 2014 7:18:10 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2314 ms
Feb 11, 2014 7:18:10 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Feb 11, 2014 7:18:10 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.33
Feb 11, 2014 7:18:10 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Feb 11, 2014 7:19:23 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive clmhelp.war
Feb 11, 2014 7:19:31 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Feb 11, 2014 7:19:31 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
Feb 11, 2014 7:19:31 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Feb 11, 2014 7:19:31 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 81296 ms

Extract 3

Feb 14, 2014 2:07:08 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
Feb 14, 2014 2:07:08 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9443
Feb 14, 2014 2:07:09 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Feb 14, 2014 2:12:21 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9080
Feb 14, 2014 2:12:21 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9443
Feb 14, 2014 2:13:12 PM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop: 
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:393)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:254)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:241)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:556)
at java.net.Socket.connect(Socket.java:504)
at java.net.Socket.<init>(Socket.java:412)
at java.net.Socket.<init>(Socket.java:226)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
Feb 14, 2014 4:32:29 PM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path:<removed>
Feb 14, 2014 4:32:29 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:32:30 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:32:30 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1626 ms
Feb 14, 2014 4:32:30 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Feb 14, 2014 4:32:30 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.33
Feb 14, 2014 4:32:30 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Feb 14, 2014 4:32:56 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive clmhelp.war
Feb 14, 2014 4:33:01 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:33:01 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:33:01 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Feb 14, 2014 4:33:01 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 30344 ms
Feb 14, 2014 4:33:22 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:33:22 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:33:23 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Feb 14, 2014 4:33:26 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:33:26 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:33:35 PM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path:<removed>
Feb 14, 2014 4:33:35 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:33:36 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:33:36 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1579 ms
Feb 14, 2014 4:33:36 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Feb 14, 2014 4:33:36 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.33
Feb 14, 2014 4:33:36 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Feb 14, 2014 4:34:02 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive clmhelp.war
Feb 14, 2014 4:34:06 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Feb 14, 2014 4:34:06 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
Feb 14, 2014 4:34:06 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Feb 14, 2014 4:34:06 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 29774 ms

Extract 4

Feb 18, 2014 10:28:51 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-9080
Feb 18, 2014 11:38:32 PM org.apache.catalina.startup.Catalina stopServer
SEVERE: Catalina.stop: 
java.net.ConnectException: Connection refused: connect
at java.net.PlainSocketImpl.socketConnect(Native Method)
at java.net.PlainSocketImpl.doConnect(PlainSocketImpl.java:393)
at java.net.PlainSocketImpl.connectToAddress(PlainSocketImpl.java:254)
at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:241)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:389)
at java.net.Socket.connect(Socket.java:556)
at java.net.Socket.connect(Socket.java:504)
at java.net.Socket.<init>(Socket.java:412)
at java.net.Socket.<init>(Socket.java:226)
at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:395)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:618)
at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:344)
at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:435)
Feb 18, 2014 11:38:40 PM org.apache.catalina.core.AprLifecycleListener init
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path:<removed>
Feb 18, 2014 11:38:40 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9080
Feb 18, 2014 11:38:42 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-9443
Feb 18, 2014 11:38:42 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2455 ms
Feb 18, 2014 11:38:42 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Feb 18, 2014 11:38:42 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.33
Feb 18, 2014 11:38:42 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Feb 18, 2014 11:40:20 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive clmhelp.war
Feb 18, 2014 11:40:29 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9080
Feb 18, 2014 11:40:29 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-9443
Feb 18, 2014 11:40:29 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Feb 18, 2014 11:40:30 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 107714 ms

As you can see, there is sometimes a pause a few minutes before the server is stopped and restarted.  The fact that the server starts almost immediately leads me to believe that there is some sort of restart being scheduled.

I don't expect a definitive solution, but maybe somebody has had a similart occurance and point to something that might be causing the problem (scheduled tasks or similar)

Thanks!

Andrew

0 votes

1 answer
10,335 views
0 votes

One answer

Permanent link
Ralph Schoon
FORUM ADMINISTRATOR / FORUM MODERATOR / JAZZ DEVELOPER (64.3k●3●36●48) Feb 21 '14, 6:58 a.m.
Andrew, if I request a shutdown, my catalina logs in Tomcat/logs show:
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.

1 vote

Comments
Andrew Trobec
Feb 21 '14, 7:09 a.m.

Hello Ralph,


Thanks for your input.  When you request a shutdown, are you doing it via windows service or the Jazz Team Server batch files?

Regards,

Andrew

Ralph Schoon
FORUM ADMINISTRATOR / FORUM MODERATOR / JAZZ DEVELOPER Feb 21 '14, 7:39 a.m.

As I usually run demo/development/test systems I start them with the batch files.
If you run a service, the service logs should tell you when the service was shut down.

Your answer

Register or log in to post your answer.

Dashboards and work items are no longer publicly available, so some links may be invalid. We now provide similar information through other means. Learn more here.

Ask a question
Guidelines
FAQ
Search context
Follow this question

By Email: 

Once you sign in you will be able to subscribe for any updates here.

By RSS:

Answers
Answers and Comments
Question details

Question asked: Feb 21 '14, 5:48 a.m.

Question was seen: 10,335 times

Last updated: Feb 21 '14, 7:39 a.m.

Confirmation Cancel Confirm