PDA

Archiv verlassen und diese Seite im Standarddesign anzeigen : Probleme mit catalina



Johny_D94
09.03.14, 22:17
Moinz zusammen

seit einiger Zeit versuche ich meinen Icescrum Server zum laufen zu bringen, habe aber noch ein Problem das ich auch nach stunden langem Probieren und herum googlen nicht lösen konnte :(

Meine Logs

catalina.out


Mrz 09, 2014 9:57:37 PM org.apache.coyote.AbstractProtocol init
Information: Initializing ProtocolHandler ["http-nio-8080"]
Mrz 09, 2014 9:57:37 PM org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
Information: Using a shared selector for servlet write/read
Mrz 09, 2014 9:57:37 PM org.apache.catalina.startup.Catalina load
Information: Initialization processed in 4002 ms
Mrz 09, 2014 9:57:37 PM org.apache.catalina.core.StandardService startInternal
Information: Starting service Catalina
Mrz 09, 2014 9:57:37 PM org.apache.catalina.core.StandardEngine startInternal
Information: Starting Servlet Engine: Apache Tomcat/7.0.35
Mrz 09, 2014 9:57:37 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/host-manager.xml
Mrz 09, 2014 9:57:40 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/manager.xml
Mrz 09, 2014 9:57:40 PM org.apache.catalina.startup.HostConfig deployWAR
Information: Deploying web application archive /var/lib/tomcat7/webapps/icescrum.war
Server Timezone : Europe/Zurich
log dir : logs
--------------------------------------------------------
Including configuration file specified on command line: /etc/icescrum/icescrum_config.groovy
(*) grails.config.locations = [file:/etc/icescrum/icescrum_config.groovy]
--------------------------------------------------------

Configuring Spring Security Core ...
... finished configuring Spring Security Core


Configuring Spring Security ACL ...
... finished configuring Spring Security ACL

Mrz 09, 2014 9:59:01 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Error listenerStart
Mrz 09, 2014 9:59:01 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Context [/icescrum] startup failed due to previous errors
Mrz 09, 2014 9:59:01 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
Schwerwiegend: The web application [/icescrum] registered the JDBC driver [org.hsqldb.jdbcDriver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
Mrz 09, 2014 9:59:01 PM org.apache.catalina.startup.HostConfig deployDirectory
Information: Deploying web application directory /var/lib/tomcat7/webapps/ROOT
Mrz 09, 2014 9:59:03 PM org.apache.coyote.AbstractProtocol start
Information: Starting ProtocolHandler ["http-nio-8080"]
Mrz 09, 2014 9:59:03 PM org.apache.catalina.startup.Catalina start
Information: Server startup in 86550 ms

catalina.2014-03-09.log

Mrz 09, 2014 9:57:37 PM org.apache.coyote.AbstractProtocol init
Information: Initializing ProtocolHandler ["http-nio-8080"]
Mrz 09, 2014 9:57:37 PM org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
Information: Using a shared selector for servlet write/read
Mrz 09, 2014 9:57:37 PM org.apache.catalina.startup.Catalina load
Information: Initialization processed in 4002 ms
Mrz 09, 2014 9:57:37 PM org.apache.catalina.core.StandardService startInternal
Information: Starting service Catalina
Mrz 09, 2014 9:57:37 PM org.apache.catalina.core.StandardEngine startInternal
Information: Starting Servlet Engine: Apache Tomcat/7.0.35
Mrz 09, 2014 9:57:37 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/host-manager.xml
Mrz 09, 2014 9:57:40 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/manager.xml
Mrz 09, 2014 9:57:40 PM org.apache.catalina.startup.HostConfig deployWAR
Information: Deploying web application archive /var/lib/tomcat7/webapps/icescrum.war
Mrz 09, 2014 9:59:01 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Error listenerStart
Mrz 09, 2014 9:59:01 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Context [/icescrum] startup failed due to previous errors
Mrz 09, 2014 9:59:01 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
Schwerwiegend: The web application [/icescrum] registered the JDBC driver [org.hsqldb.jdbcDriver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
Mrz 09, 2014 9:59:01 PM org.apache.catalina.startup.HostConfig deployDirectory
Information: Deploying web application directory /var/lib/tomcat7/webapps/ROOT
Mrz 09, 2014 9:59:03 PM org.apache.coyote.AbstractProtocol start
Information: Starting ProtocolHandler ["http-nio-8080"]
Mrz 09, 2014 9:59:03 PM org.apache.catalina.startup.Catalina start
Information: Server startup in 86550 ms


Leider weiss ich nicht wie ich bei der Fehlersuche vorgehen soll und währe froh um hinweise/tipps:D Nicht dass ich auf der faulen Haut ligen möchte, komme aber seit über 10 "arbeitsstunden" nicht weiter:rolleyes:

marce
10.03.14, 08:07
Schwerwiegend: Error listenerStart
deutet darauf hin, daß irgendwas mit der Netzwerkkonfiguration nicht stimmt - ggf. bereits vergebene Ports oder ähnliches.

Kann aber auch eine fehlerhafte Konfiguration im server.xml des Tomcat selbst sein.

Johny_D94
10.03.14, 17:58
deutet darauf hin, daß irgendwas mit der Netzwerkkonfiguration nicht stimmt - ggf. bereits vergebene Ports oder ähnliches.

Kann aber auch eine fehlerhafte Konfiguration im server.xml des Tomcat selbst sein.

Soweit bin ich auch schon. Aber ist dass nicht die Nadel im Heuhaufen suchen? Gibt es irgendwo einen genaueren Log als diesen?:confused:

Edit:
Ich habe vergessen in der konfiguration von Icescrum den debug einzuschalten. Wenn dieser eingeschaltet ist steht in catalina.out folgendes

Mrz 10, 2014 6:15:16 PM org.apache.coyote.AbstractProtocol init
Information: Initializing ProtocolHandler ["http-nio-8080"]
Mrz 10, 2014 6:15:16 PM org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
Information: Using a shared selector for servlet write/read
Mrz 10, 2014 6:15:16 PM org.apache.catalina.startup.Catalina load
Information: Initialization processed in 3141 ms
Mrz 10, 2014 6:15:16 PM org.apache.catalina.core.StandardService startInternal
Information: Starting service Catalina
Mrz 10, 2014 6:15:16 PM org.apache.catalina.core.StandardEngine startInternal
Information: Starting Servlet Engine: Apache Tomcat/7.0.35
Mrz 10, 2014 6:15:16 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/host-manager.xml
Mrz 10, 2014 6:15:20 PM org.apache.catalina.startup.HostConfig deployDescriptor
Information: Deploying configuration descriptor /etc/tomcat7/Catalina/localhost/manager.xml
Mrz 10, 2014 6:15:20 PM org.apache.catalina.startup.HostConfig deployWAR
Information: Deploying web application archive /var/lib/tomcat7/webapps/icescrum.war
Server Timezone : Europe/Zurich
log dir : logs
--------------------------------------------------------
Including configuration file specified on command line: /etc/icescrum/icescrum_config.groovy
(*) grails.config.locations = [file:/etc/icescrum/icescrum_config.groovy]
--------------------------------------------------------
2014-03-10 18:16:15,468 [localhost-startStop-1] INFO spring.BeanBuilder - [RuntimeConfiguration] Configuring data source for environment: PRODUCTION
2014-03-10 18:16:17,931 [localhost-startStop-1] DEBUG support.ApplicationSupport - Retrieving appID...
2014-03-10 18:16:17,951 [localhost-startStop-1] DEBUG support.ApplicationSupport - Retrieved appID: 865cfc3f-fcb3-f6c1-d4c5-65f1178d65ef

Configuring Spring Security Core ...
... finished configuring Spring Security Core


Configuring Spring Security ACL ...
... finished configuring Spring Security ACL

2014-03-10 18:16:28,140 [localhost-startStop-1] ERROR context.ContextLoader - Context initialization failed
org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'messageSource': Initialization of bean failed; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'transactionManager': Cannot resolve reference to bean 'sessionFactory' while setting bean property 'sessionFactory'; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'sessionFactory': Cannot resolve reference to bean 'hibernateProperties' while setting bean property 'hibernateProperties'; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'hibernateProperties': Cannot resolve reference to bean 'dialectDetector' while setting bean property 'properties' with key [hibernate.dialect]; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'dialectDetector': Invocation of init method failed; nested exception is org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
at java.util.concurrent.Executors$RunnableAdapter.cal l(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.jav a:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker( ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run (ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
Caused by: org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'transactionManager': Cannot resolve reference to bean 'sessionFactory' while setting bean property 'sessionFactory'; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'sessionFactory': Cannot resolve reference to bean 'hibernateProperties' while setting bean property 'hibernateProperties'; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'hibernateProperties': Cannot resolve reference to bean 'dialectDetector' while setting bean property 'properties' with key [hibernate.dialect]; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'dialectDetector': Invocation of init method failed; nested exception is org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
... 5 more
Caused by: org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'sessionFactory': Cannot resolve reference to bean 'hibernateProperties' while setting bean property 'hibernateProperties'; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'hibernateProperties': Cannot resolve reference to bean 'dialectDetector' while setting bean property 'properties' with key [hibernate.dialect]; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'dialectDetector': Invocation of init method failed; nested exception is org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
... 5 more
Caused by: org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'hibernateProperties': Cannot resolve reference to bean 'dialectDetector' while setting bean property 'properties' with key [hibernate.dialect]; nested exception is org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'dialectDetector': Invocation of init method failed; nested exception is org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
... 5 more
Caused by: org.springframework.beans.factory.BeanCreationExce ption: Error creating bean with name 'dialectDetector': Invocation of init method failed; nested exception is org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
... 5 more
Caused by: org.springframework.jdbc.support.MetaDataAccessExc eption: Error while extracting DatabaseMetaData; nested exception is java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
... 5 more
Caused by: java.sql.SQLException: Driver:org.hsqldb.jdbcDriver@69ab0291 returned null for URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
at com.sun.proxy.$Proxy19.getMetaData(Unknown Source)
... 5 more
Mrz 10, 2014 6:16:28 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Error listenerStart
Mrz 10, 2014 6:16:28 PM org.apache.catalina.core.StandardContext startInternal
Schwerwiegend: Context [/icescrum] startup failed due to previous errors
Mrz 10, 2014 6:16:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
Schwerwiegend: The web application [/icescrum] registered the JDBC driver [org.hsqldb.jdbcDriver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
Mrz 10, 2014 6:16:28 PM org.apache.catalina.startup.HostConfig deployDirectory
Information: Deploying web application directory /var/lib/tomcat7/webapps/ROOT
Mrz 10, 2014 6:16:29 PM org.apache.coyote.AbstractProtocol start
Information: Starting ProtocolHandler ["http-nio-8080"]
Mrz 10, 2014 6:16:29 PM org.apache.catalina.startup.Catalina start
Information: Server startup in 72465 ms

marce
10.03.14, 18:25
Man kann generell das Logging von Tomcat hochstellen - wo und wie müsste ich gerade selbst heraussuchen.
Grundlegend kannst Du aber z.B. mal die server.xml posten (vielleicht finden wir zusammen den Wurm) und auch mal mit nmap schauen, ob alle darin angegebenen Ports auch frei sind - auch die shutdown-Ports und alles andere, was da so gegeben ist per default...

Johny_D94
10.03.14, 18:39
Okeey...hier mal die Server.xml
Port 8080 ist offen


<?xml version='1.0' encoding='utf-8'?>
<!--
Licensed to the Apache Software Foundation (ASF) under one or more
contributor license agreements. See the NOTICE file distributed with
this work for additional information regarding copyright ownership.
The ASF licenses this file to You under the Apache License, Version 2.0
(the "License"); you may not use this file except in compliance with
the License. You may obtain a copy of the License at

http://www.apache.org/licenses/LICENSE-2.0

Unless required by applicable law or agreed to in writing, software
distributed under the License is distributed on an "AS IS" BASIS,
WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
See the License for the specific language governing permissions and
limitations under the License.
-->
<!-- Note: A "Server" is not itself a "Container", so you may not
define subcomponents such as "Valves" at this level.
Documentation at /docs/config/server.html
-->
<Server port="8005" shutdown="SHUTDOWN">
<!-- Security listener. Documentation at /docs/config/listeners.html
<Listener className="org.apache.catalina.security.SecurityListener" />
-->
<!--APR library loader. Documentation at /docs/apr.html -->
<!--
<Listener className="org.apache.catalina.core.AprLifecycleListener" SSLEngine="on" />
-->
<!--Initialize Jasper prior to webapps are loaded. Documentation at /docs/jasper-howto.html -->
<Listener className="org.apache.catalina.core.JasperListener" />
<!-- Prevent memory leaks due to use of particular java/javax APIs-->
<Listener className="org.apache.catalina.core.JreMemoryLeakPreventionLi stener" />
<Listener className="org.apache.catalina.mbeans.GlobalResourcesLifecycl eListener" />
<Listener className="org.apache.catalina.core.ThreadLocalLeakPrevention Listener" />

<!-- Global JNDI resources
Documentation at /docs/jndi-resources-howto.html
-->
<GlobalNamingResources>
<!-- Editable user database that can also be used by
UserDatabaseRealm to authenticate users
-->
<Resource name="UserDatabase" auth="Container"
type="org.apache.catalina.UserDatabase"
description="User database that can be updated and saved"
factory="org.apache.catalina.users.MemoryUserDatabaseFactor y"
pathname="conf/tomcat-users.xml" />
</GlobalNamingResources>

<!-- A "Service" is a collection of one or more "Connectors" that share
a single "Container" Note: A "Service" is not itself a "Container",
so you may not define subcomponents such as "Valves" at this level.
Documentation at /docs/config/service.html
-->
<Service name="Catalina">

<!--The connectors can use a shared executor, you can define one or more named thread pools-->
<!--
<Executor name="tomcatThreadPool" namePrefix="catalina-exec-"
maxThreads="150" minSpareThreads="4"/>
-->


<!-- A "Connector" represents an endpoint by which requests are received
and responses are returned. Documentation at :
Java HTTP Connector: /docs/config/http.html (blocking & non-blocking)
Java AJP Connector: /docs/config/ajp.html
APR (HTTP/AJP) Connector: /docs/apr.html
Define a non-SSL HTTP/1.1 Connector on port 8080
-->
<Connector port="8080"
protocol="org.apache.coyote.http11.Http11NioProtocol"
connectionTimeout="20000"
maxThreads="500"
URIEncoding="UTF-8"/>
<!-- A "Connector" using the shared thread pool-->
<!--
<Connector executor="tomcatThreadPool"
port="8080" protocol="HTTP/1.1"
connectionTimeout="20000"
redirectPort="8443" />
-->
<!-- Define a SSL HTTP/1.1 Connector on port 8443
This connector uses the JSSE configuration, when using APR, the
connector should be using the OpenSSL style configuration
described in the APR documentation -->
<!--
<Connector port="8443" protocol="HTTP/1.1" SSLEnabled="true"
maxThreads="150" scheme="https" secure="true"
clientAuth="false" sslProtocol="TLS" />
-->

<!-- Define an AJP 1.3 Connector on port 8009 -->
<!--
<Connector port="8009" protocol="AJP/1.3" redirectPort="8443" />
-->


<!-- An Engine represents the entry point (within Catalina) that processes
every request. The Engine implementation for Tomcat stand alone
analyzes the HTTP headers included with the request, and passes them
on to the appropriate Host (virtual host).
Documentation at /docs/config/engine.html -->

<!-- You should set jvmRoute to support load-balancing via AJP ie :
<Engine name="Catalina" defaultHost="localhost" jvmRoute="jvm1">
-->
<Engine name="Catalina" defaultHost="localhost">

<!--For clustering, please take a look at documentation at:
/docs/cluster-howto.html (simple how to)
/docs/config/cluster.html (reference documentation) -->
<!--
<Cluster className="org.apache.catalina.ha.tcp.SimpleTcpCluster"/>
-->

<!-- Use the LockOutRealm to prevent attempts to guess user passwords
via a brute-force attack -->
<Realm className="org.apache.catalina.realm.LockOutRealm">
<!-- This Realm uses the UserDatabase configured in the global JNDI
resources under the key "UserDatabase". Any edits
that are performed against this UserDatabase are immediately
available for use by the Realm. -->
<Realm className="org.apache.catalina.realm.UserDatabaseRealm"
resourceName="UserDatabase"/>
</Realm>

<Host name="localhost" appBase="webapps"
unpackWARs="true" autoDeploy="true">

<!-- SingleSignOn valve, share authentication between web applications
Documentation at: /docs/config/valve.html -->
<!--
<Valve className="org.apache.catalina.authenticator.SingleSignOn" />
-->

<!-- Access log processes all example.
Documentation at: /docs/config/valve.html
Note: The pattern used is equivalent to using pattern="common" -->
<Valve className="org.apache.catalina.valves.AccessLogValve" directory="logs"
prefix="localhost_access_log." suffix=".txt"
pattern="%h %l %u %t &quot;%r&quot; %s %b" />

</Host>
</Engine>
</Service>
</Server>

marce
10.03.14, 18:55
Auf den ersten Blick: und was ist mit 8005?

für den Rest müsste ich in einem Moment mit etwas mehr Muße ran - jetzt ist aber erst mal Sandmännchen angesagt...

Johny_D94
10.03.14, 20:56
Port 8005 wird noch von nichts anderem benutzt. Tomcat müsste sich den Port auch selber öffnen wie den Port 8080 wenn er ihn benutzt. Oder liege ich falsch?

marce
11.03.14, 06:58
Ah, gerade gesehen, daß Du oben noch was editiert hast:

/home/icescrum/icescrum/db/prodDba - gibt's das, kann der TomCat darauf zugreifen - und ist der notwendige Datenbanktreiber vorhanden?

Ich fürchte, an der Stelle bin ich dann raus - das müsste man wohl weiter direkt am System verfolgen und ggf. auch mal in der Java-Code reinschauen, was da so passiert.

Ggf. könnte es helfen, auch noch strace auf den Tomcat beim Start loszulassen - und dann versuchen herauszufinden, wo es denn klemmt. Ich würde vermuten, daß irgendwo Rechte fehlen oder ein jar-File nicht vorhanden ist, welches die App braucht - ggf. auch mal schauen, ob irgendwo außerhalb der server.xml noch weitere Ports definiert sind, die der Tomcat / die Applikation öffnen möchte.

Johny_D94
11.03.14, 18:15
Na ja...das file existiert :rolleyes:

jedoch ist
URL:jbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba
falsch.
es müsste heissen:
URL:jdbc:hsqldb:file:/home/icescrum/icescrum/db/prodDba

Läuft jetzt :D
Danke für alle Hinweise:)

marce
11.03.14, 19:11
ooops, ja solche Kleinigkeiten findet man in 100 Jahren oft nicht.

Mal gemütlich auf den Topf gehen hilft da auch oft.... :-)