AnsweredAssumed Answered

Solved: Alfresco Com 3.2 on Win XP crashes

Question asked by georgs on Aug 4, 2009
Latest reply on Aug 4, 2009 by georgs
Hello everybody,
"Alfresco" is a great thing, but I ran into trouble with the installation:
I got it installed and it ran. Then I got problems with the port I used (8880 instead of default 8080)
because the "share" part did not work. I reconfigured win xp professional to free that port,
deinstalled and reinstalled alfresco.
But now it does not even start.
I used the packed installer with everything included: mysql, tomcat, java ….
Now here are the logs. They are telling me that the system is in read-only mode. This should not be
a license issue, since I use the community 3.2 version.
Does someone know a solution to the problem. Thanks in advance for any help.
alfresco.log:
10:56:19,546 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
10:56:19,578 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
10:56:19,578 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/C:/Alfresco/tomcat/shared/classes/alfresco-global.properties]
10:56:19,781 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:28,015 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
10:57:33,015 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] No changes were made to the schema.
10:57:41,687 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [default]
10:57:41,734 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:43,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [default] complete
10:57:44,500 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: C:\Alfresco\alf_data
10:57:44,734 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
10:57:45,640 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] No patches were required.
10:57:45,859 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Found 1 module(s).
10:57:45,968 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Starting module 'org.alfresco.module.vti' version 1.2.
10:57:46,484 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [default]
10:57:46,531 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:47,234 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]
10:57:47,265 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:48,421 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [managed, alfrescoNtlm1] complete
10:57:48,515 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [default] complete
10:57:48,515 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [default]
10:57:48,546 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:48,671 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [default] complete
10:57:48,671 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [default]
10:57:48,734 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:57:48,765 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [default] complete
10:57:48,828 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_07-b06; maximum heap size 506,313MB
10:57:48,828 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.2.0 (2056) schema 3000 - Originally installed version 3.2.0 (2056) schema 3000
10:57:50,078 INFO  [org.alfresco.module.vti.VtiServer] Vti server started successfully on port: 7070
10:58:28,328 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'wcm_deployment_receiver' subsystem, ID: [default]
10:58:28,359 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:58:28,562 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'wcm_deployment_receiver' subsystem, ID: [default] complete
10:58:33,046 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Refreshing org.alfresco.config.JBossEnabledWebApplicationContext@18e479b: display name [Root WebApplicationContext]; startup date [Tue Aug 04 10:58:33 CEST 2009]; root of context hierarchy
10:58:34,000 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Bean factory for application context [org.alfresco.config.JBossEnabledWebApplicationContext@18e479b]: org.springframework.beans.factory.support.DefaultListableBeanFactory@731ffa
10:58:38,093 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 24 Web Scripts (+0 failed), 26 URLs
10:58:38,156 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised Presentation Web Script Container (in 1694.2614ms)
10:58:38,531 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 42 Web Scripts (+0 failed), 44 URLs
10:58:38,562 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised WebFramework Web Script Container (in 391.65228ms)
10:58:38,703 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
10:58:46,812 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
11:01:57,265 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
11:01:58,140 ERROR [org.alfresco.repo.transaction.AlfrescoTransactionSupport] After completion (committed) listener exception:
   listener: org.alfresco.repo.security.person.PersonServiceImpl@1
org.alfresco.repo.security.permissions.AccessDeniedException: 07040002 Access Denied.  The system is currently in read-only mode.
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:275)
   at org.alfresco.repo.security.person.PersonServiceImpl.afterCommit(PersonServiceImpl.java:412)
   at org.alfresco.repo.transaction.AlfrescoTransactionSupport$TransactionSynchronizationImpl.afterCompletion(AlfrescoTransactionSupport.java:766)
   at org.springframework.transaction.support.TransactionSynchronizationUtils.invokeAfterCompletion(TransactionSynchronizationUtils.java:133)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.invokeAfterCompletion(AbstractPlatformTransactionManager.java:904)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.triggerAfterCompletion(AbstractPlatformTransactionManager.java:879)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:707)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:632)
   at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:314)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:116)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
   at $Proxy26.authenticateAsGuest(Unknown Source)
   at org.alfresco.repo.web.scripts.servlet.BasicHttpAuthenticatorFactory$BasicHttpAuthenticator.authenticate(BasicHttpAuthenticatorFactory.java:127)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:280)
   at org.alfresco.web.scripts.AbstractRuntime.executeScript(AbstractRuntime.java:262)
   at org.alfresco.web.scripts.AbstractRuntime.executeScript(AbstractRuntime.java:139)
   at org.alfresco.web.scripts.servlet.WebScriptServlet.service(WebScriptServlet.java:122)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:128)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:286)
   at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:845)
   at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:583)
   at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447)
   at java.lang.Thread.run(Thread.java:619)
11:01:58,828 ERROR [org.alfresco.repo.transaction.AlfrescoTransactionSupport] After completion (committed) listener exception:
   listener: org.alfresco.repo.security.person.PersonServiceImpl@1
org.alfresco.repo.security.permissions.AccessDeniedException: 07040003 Access Denied.  The system is currently in read-only mode.
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:275)
   at org.alfresco.repo.security.person.PersonServiceImpl.afterCommit(PersonServiceImpl.java:412)
   at org.alfresco.repo.transaction.AlfrescoTransactionSupport$TransactionSynchronizationImpl.afterCompletion(AlfrescoTransactionSupport.java:766)
   at org.springframework.transaction.support.TransactionSynchronizationUtils.invokeAfterCompletion(TransactionSynchronizationUtils.java:133)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.invokeAfterCompletion(AbstractPlatformTransactionManager.java:904)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.triggerAfterCompletion(AbstractPlatformTransactionManager.java:879)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:707)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:632)
   at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:314)
   at org.alfresco.util.transaction.SpringAwareUserTransaction.commit(SpringAwareUserTransaction.java:467)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:340)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:407)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:424)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:253)
   at org.alfresco.web.scripts.AbstractRuntime.executeScript(AbstractRuntime.java:262)
   at org.alfresco.web.scripts.AbstractRuntime.executeScript(AbstractRuntime.java:139)
   at org.alfresco.web.scripts.servlet.WebScriptServlet.service(WebScriptServlet.java:122)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:128)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:286)
   at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:845)
   at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:583)
   at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447)
   at java.lang.Thread.run(Thread.java:619)
11:01:59,062 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Closing org.alfresco.config.JBossEnabledWebApplicationContext@18e479b: display name [Root WebApplicationContext]; startup date [Tue Aug 04 10:58:33 CEST 2009]; root of context hierarchy
11:02:00,265 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'wcm_deployment_receiver' subsystem, ID: [default]
11:02:00,265 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'wcm_deployment_receiver' subsystem, ID: [default]
11:02:00,296 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'fileServers' subsystem, ID: [default]
11:02:02,312 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'fileServers' subsystem, ID: [default]
11:02:02,312 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'imap' subsystem, ID: [default]
11:02:02,312 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'imap' subsystem, ID: [default]
11:02:02,312 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'Synchronization' subsystem, ID: [default]
11:02:02,312 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'Synchronization' subsystem, ID: [default]
11:02:02,328 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'thirdparty' subsystem, ID: [default]
11:02:02,328 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'thirdparty' subsystem, ID: [default]
11:02:02,328 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]
11:02:02,343 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]

catalina.log
04-ago-2009 10:16:28 org.apache.coyote.http11.Http11Protocol init
INFO: Inicializando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:16:28 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2099 ms
04-ago-2009 10:16:28 org.apache.catalina.core.StandardService start
INFO: Arrancando servicio Catalina
04-ago-2009 10:16:28 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
04-ago-2009 10:16:35 org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
04-ago-2009 10:20:39 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo mobile.war de la aplicaci�n web
04-ago-2009 10:20:48 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo share.war de la aplicaci�n web
04-ago-2009 10:20:57 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo studio.war de la aplicaci�n web
04-ago-2009 10:24:10 org.apache.coyote.http11.Http11Protocol start
INFO: Arrancando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:24:11 org.apache.catalina.startup.Catalina start
INFO: Server startup in 462604 ms
04-ago-2009 10:24:11 org.apache.catalina.core.StandardServer await
GRAVE: StandardServer.await: create[8005]:
java.net.BindException: Address already in use: JVM_Bind
   at java.net.PlainSocketImpl.socketBind(Native Method)
   at java.net.PlainSocketImpl.bind(PlainSocketImpl.java:359)
   at java.net.ServerSocket.bind(ServerSocket.java:319)
   at java.net.ServerSocket.<init>(ServerSocket.java:185)
   at org.apache.catalina.core.StandardServer.await(StandardServer.java:373)
   at org.apache.catalina.startup.Catalina.await(Catalina.java:642)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:602)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
04-ago-2009 10:24:11 org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
04-ago-2009 10:24:12 org.apache.catalina.core.StandardService stop
INFO: Parando servicio Catalina
04-ago-2009 10:24:26 org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
04-ago-2009 10:25:58 org.apache.coyote.http11.Http11Protocol init
INFO: Inicializando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:25:58 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1538 ms
04-ago-2009 10:25:58 org.apache.catalina.core.StandardService start
INFO: Arrancando servicio Catalina
04-ago-2009 10:25:58 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
04-ago-2009 10:26:03 org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
04-ago-2009 10:28:30 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo mobile.war de la aplicaci�n web
04-ago-2009 10:28:39 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo share.war de la aplicaci�n web
04-ago-2009 10:28:47 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo studio.war de la aplicaci�n web
04-ago-2009 10:30:17 org.apache.coyote.http11.Http11Protocol init
INFO: Inicializando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:30:17 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1578 ms
04-ago-2009 10:30:17 org.apache.catalina.core.StandardService start
INFO: Arrancando servicio Catalina
04-ago-2009 10:30:17 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
04-ago-2009 10:30:23 org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
04-ago-2009 10:32:45 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo mobile.war de la aplicaci�n web
04-ago-2009 10:32:53 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo share.war de la aplicaci�n web
04-ago-2009 10:33:01 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo studio.war de la aplicaci�n web
04-ago-2009 10:36:12 org.apache.coyote.http11.Http11Protocol start
INFO: Arrancando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:36:12 org.apache.catalina.startup.Catalina start
INFO: Server startup in 354480 ms
04-ago-2009 10:36:12 org.apache.catalina.core.StandardServer await
GRAVE: StandardServer.await: create[8005]:
java.net.BindException: Address already in use: JVM_Bind
   at java.net.PlainSocketImpl.socketBind(Native Method)
   at java.net.PlainSocketImpl.bind(PlainSocketImpl.java:359)
   at java.net.ServerSocket.bind(ServerSocket.java:319)
   at java.net.ServerSocket.<init>(ServerSocket.java:185)
   at org.apache.catalina.core.StandardServer.await(StandardServer.java:373)
   at org.apache.catalina.startup.Catalina.await(Catalina.java:642)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:602)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
04-ago-2009 10:36:12 org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
04-ago-2009 10:36:13 org.apache.catalina.core.StandardService stop
INFO: Parando servicio Catalina
04-ago-2009 10:36:22 org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
04-ago-2009 10:55:55 org.apache.coyote.http11.Http11Protocol init
INFO: Inicializando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 10:55:55 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1718 ms
04-ago-2009 10:55:55 org.apache.catalina.core.StandardService start
INFO: Arrancando servicio Catalina
04-ago-2009 10:55:55 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
04-ago-2009 10:56:01 org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
04-ago-2009 10:58:30 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo mobile.war de la aplicaci�n web
04-ago-2009 10:58:38 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo share.war de la aplicaci�n web
04-ago-2009 10:58:46 org.apache.catalina.startup.HostConfig deployWAR
INFO: Despliegue del archivo studio.war de la aplicaci�n web
04-ago-2009 11:01:57 org.apache.coyote.http11.Http11Protocol start
INFO: Arrancando Coyote HTTP/1.1 en puerto http-8080
04-ago-2009 11:01:57 org.apache.catalina.startup.Catalina start
INFO: Server startup in 362266 ms
04-ago-2009 11:01:58 org.apache.catalina.core.StandardServer await
GRAVE: StandardServer.await: create[8005]:
java.net.BindException: Address already in use: JVM_Bind
   at java.net.PlainSocketImpl.socketBind(Native Method)
   at java.net.PlainSocketImpl.bind(PlainSocketImpl.java:359)
   at java.net.ServerSocket.bind(ServerSocket.java:319)
   at java.net.ServerSocket.<init>(ServerSocket.java:185)
   at org.apache.catalina.core.StandardServer.await(StandardServer.java:373)
   at org.apache.catalina.startup.Catalina.await(Catalina.java:642)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:602)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
04-ago-2009 11:01:58 org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
04-ago-2009 11:01:59 org.apache.catalina.core.StandardService stop
INFO: Parando servicio Catalina
04-ago-2009 11:02:08 org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080

and finally localhost.log
04-ago-2009 10:16:40 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:20:41 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:20:50 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:20:59 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.utils.Log DEBUG: logLevel set to DEBUG
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: confPath set to /WEB-INF/urlrewrite.xml
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML builder factory is: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML Parser: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: about to parse conf
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.ConfHandler DEBUG: Resolving to DTD /org/tuckey/web/filters/urlrewrite/dtds/urlrewrite3.2.dtd
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: now initialising conf
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: conf status true
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: inited with 0 rules
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: conf is ok
04-ago-2009 10:24:09 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
04-ago-2009 10:24:10 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextInitialized()
04-ago-2009 10:24:10 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextInitialized()
04-ago-2009 10:24:12 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:24:13 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:24:14 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextDestroyed()
04-ago-2009 10:24:14 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextDestroyed()
04-ago-2009 10:24:14 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:24:17 org.apache.catalina.core.ApplicationContext log
INFO: Shutting down Log4J
04-ago-2009 10:24:26 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
04-ago-2009 10:24:26 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:26:07 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:28:33 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:28:41 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:28:49 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:30:27 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:32:47 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:32:54 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:33:02 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.utils.Log DEBUG: logLevel set to DEBUG
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: confPath set to /WEB-INF/urlrewrite.xml
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML builder factory is: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML Parser: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: about to parse conf
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.ConfHandler DEBUG: Resolving to DTD /org/tuckey/web/filters/urlrewrite/dtds/urlrewrite3.2.dtd
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: now initialising conf
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: conf status true
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: inited with 0 rules
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: conf is ok
04-ago-2009 10:36:11 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
04-ago-2009 10:36:12 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextInitialized()
04-ago-2009 10:36:12 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextInitialized()
04-ago-2009 10:36:13 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:36:13 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:36:14 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextDestroyed()
04-ago-2009 10:36:14 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextDestroyed()
04-ago-2009 10:36:14 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:36:16 org.apache.catalina.core.ApplicationContext log
INFO: Shutting down Log4J
04-ago-2009 10:36:21 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
04-ago-2009 10:36:21 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 10:56:06 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:58:32 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:58:40 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 10:58:47 org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.utils.Log DEBUG: logLevel set to DEBUG
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: confPath set to /WEB-INF/urlrewrite.xml
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML builder factory is: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderFactoryImpl
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: XML Parser: com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: about to parse conf
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.ConfHandler DEBUG: Resolving to DTD /org/tuckey/web/filters/urlrewrite/dtds/urlrewrite3.2.dtd
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: now initialising conf
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.Conf DEBUG: conf status true
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: inited with 0 rules
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter DEBUG: conf is ok
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextInitialized()
04-ago-2009 11:01:57 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextInitialized()
04-ago-2009 11:01:59 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 11:01:59 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 11:02:00 org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextDestroyed()
04-ago-2009 11:02:00 org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextDestroyed()
04-ago-2009 11:02:00 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
04-ago-2009 11:02:02 org.apache.catalina.core.ApplicationContext log
INFO: Shutting down Log4J
04-ago-2009 11:02:07 org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
04-ago-2009 11:02:07 org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext

Outcomes