Some Eclipse Foundation services are deprecated, or will be soon. Please ensure you've read this important communication.

Bug 352212

Summary:	System.err messages coming out of the log from Tomcat during startup, installing bundles and shutdown
Product:	[RT] Virgo	Reporter:	Chris Frost <eclipse>
Component:	runtime	Assignee:	Glyn Normington <glyn.normington>
Status:	CLOSED NOT_ECLIPSE	QA Contact:
Severity:	normal
Priority:	P3	CC:	glyn.normington, milesg78
Version:	3.0.0.M06
Target Milestone:	3.0.0.RC1
Hardware:	PC
OS:	Mac OS X - Carbon (unsup.)
Whiteboard:

Description Chris Frost

2011-07-15 09:46:25 EDT

To recreate,
1. take a fresh build or web-server and start it.
2. Stop it and look in the logs, about 380 lines in.

Startup:
system-artifacts             org.eclipse.gemini.web.tomcat.internal.TomcatConfigLocator        Configuring Tomcat from file 'config/tomcat-server.xml' 
system-artifacts             System.err                                                        Jul 15, 2011 12:37:09 PM org.apache.catalina.core.AprLifecycleListener init 
system-artifacts             System.err                                                        INFO: The APR based Apache Tomcat Native library which allows optimal performance 
system-artifacts             System.err                                                        Jul 15, 2011 12:37:09 PM org.apache.coyote.AbstractProtocolHandler init 
system-artifacts             System.err                                                        INFO: Initializing ProtocolHandler ["http-bio-8080"] 
system-artifacts             System.err                                                        Jul 15, 2011 12:37:09 PM org.apache.coyote.AbstractProtocolHandler init 
system-artifacts             System.err                                                        INFO: Initializing ProtocolHandler ["http-bio-8443"] 
system-artifacts             System.err                                                        Jul 15, 2011 12:37:09 PM org.apache.coyote.AbstractProtocolHandler init 
system-artifacts             System.err                                                        INFO: Initializing ProtocolHandler ["ajp-bio-8009"] 


Deploying:
"http-bio-8080"-exec-3       System.err                                                        Jul 15, 2011 12:37:38 PM org.apache.catalina.core.ApplicationContext log
"http-bio-8080"-exec-3       System.err                                                        INFO: Initializing Spring FrameworkServlet 'splash' 


Shutdown:
 System Bundle Shutdown       org.eclipse.virgo.medic.eventlog.default                         TC0002I Stopping Tomcat. 
 System Bundle Shutdown       System.err                                                        Jul 15, 2011 12:37:54 PM org.apache.coyote.AbstractProtocolHandler pause 
 System Bundle Shutdown       System.err                                                        INFO: Pausing ProtocolHandler ["http-bio-8080"] 
 System Bundle Shutdown       System.err                                                        Jul 15, 2011 12:37:55 PM org.apache.coyote.AbstractProtocolHandler pause 
 System Bundle Shutdown       System.err                                                        INFO: Pausing ProtocolHandler ["http-bio-8443"] 
 System Bundle Shutdown       System.err                                                        Jul 15, 2011 12:37:56 PM org.apache.coyote.AbstractProtocolHandler pause 
 System Bundle Shutdown       System.err                                                        INFO: Pausing ProtocolHandler ["ajp-bio-8009"] 
 System Bundle Shutdown       System.err                                                        Jul 15, 2011 12:37:57 PM org.apache.catalina.core.StandardService stopInternal 
 System Bundle Shutdown       System.err                                                        INFO: Stopping service Catalina 
 System Bundle Shutdown       System.err                                                        Jul 15, 2011 12:37:57 PM org.apache.catalina.core.ApplicationContext log 
 System Bundle Shutdown       System.err                                                        INFO: Destroying Spring FrameworkServlet 'splash'

Comment 1 Glyn Normington

2011-07-19 07:17:34 EDT

See also bug 351533 which the fix to this bug may help.

Comment 2 Glyn Normington

2011-07-19 12:02:14 EDT

I checked the behaviour of Virgo 2.1.0.RELEASE and this also includes corresponding log entries such as:

[2011-07-19 16:11:17.745] system-artifacts             System.err              
                                         INFO: The APR based Apache Tomcat
Native library which allows optimal performance in production environments was
not found on the java.library.path:
.:/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java

So closing this bug as working as designed. I will however check with a Tomcat expert to make sure Tomcat really is intending to write to System.err.

Comment 3 Glyn Normington

2011-07-20 09:12:17 EDT

The Tomcat behaviour is actually a behaviour of the JUL ConsoleHandler ([1]) which directs all log records to System.err, regardless of their level.

[1] http://download.oracle.com/javase/6/docs/api/java/util/logging/ConsoleHandler.html