Alfresco War only Installation

[djpme]

I'm installing the Alfresco non-bundled war file.  Tomcat is sucessully running on its own but when I do try to access http://localhost:8080/alfresco I get an error saying: "HTTP Status 404 - /alfresco/ The requested resource (/alfresco/) is not available.

The Tomcat Manager shows alfresco in the list of applications and it appears to be started.  Any ideas on how to troubleshoot this?

[mrogers]

You need to look in the log files for tomcat and most importantly alfresco.log.

[djpme]

You need to look in the log files for tomcat and most importantly alfresco.log.

I checked alfresco.log and saw no glaring signs errors…here it is:

10:48:02,214 INFO [org.alfresco.web.site.FrameworkHelper] Sucessfully Initialized Web Framework 
10:55:43,686 INFO [org.alfresco.web.site.FrameworkHelper] Sucessfully Initialized Web Framework 
11:05:06,362 INFO [org.alfresco.web.site.FrameworkHelper] Sucessfully Initialized Web Framework 
11:11:02,813 INFO [org.alfresco.web.site.FrameworkHelper] Sucessfully Initialized Web Framework 
‍‍‍‍‍‍

There are severe errors in the tomcat log (catalina.2004-4-21.log).  Can someone help me reason these out?  Again, tomcat appears to be working just fine…I can access localhost:8080, I can even pull up the login page to the Alfresco share site, but the main aflresco page (localhost:8080/alfresco) I cannot pull up.   

INFO: Deploying web application archive alfresco.war
Apr 21, 2009 2:38:09 PM org.apache.coyote.http11.Http11Protocol start
SEVERE: Error starting endpoint
java.net.BindException: Address already in use<null>:8080
        at org.apache.tomcat.util.net.JIoEndpoint.init(JIoEndpoint.java:502)
        at org.apache.tomcat.util.net.JIoEndpoint.start(JIoEndpoint.java:519)
        at org.apache.coyote.http11.Http11Protocol.start(Http11Protocol.java:203)
        at org.apache.catalina.connector.Connector.start(Connector.java:1131)
        at org.apache.catalina.core.StandardService.start(StandardService.java:531)
        at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
        at org.apache.catalina.startup.Catalina.start(Catalina.java:578)
        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)
Apr 21, 2009 2:38:09 PM org.apache.catalina.startup.Catalina start
SEVERE: Catalina.start:
LifecycleException:  service.getName(): "Catalina";  Protocol handler start failed: java.net.BindException: Address already in use<null>:8080
        at org.apache.catalina.connector.Connector.start(Connector.java:1138)
        at org.apache.catalina.core.StandardService.start(StandardService.java:531)
        at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
        at org.apache.catalina.startup.Catalina.start(Catalina.java:578)
        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)
Apr 21, 2009 2:38:09 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 2181 ms
Apr 21, 2009 2:38:09 PM org.apache.catalina.core.StandardServer await
SEVERE: StandardServer.await: create[8005]:
java.net.BindException: Address already in use
        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)
Apr 21, 2009 2:38:09 PM org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:38:09 PM org.apache.catalina.connector.Connector pause
SEVERE: Protocol handler pause failed
java.lang.NullPointerException
        at org.apache.jk.server.JkMain.pause(JkMain.java:679)
        at org.apache.jk.server.JkCoyoteHandler.pause(JkCoyoteHandler.java:153)
        at org.apache.catalina.connector.Connector.pause(Connector.java:1073)
        at org.apache.catalina.core.StandardService.stop(StandardService.java:563)
        at org.apache.catalina.core.StandardServer.stop(StandardServer.java:744)
        at org.apache.catalina.startup.Catalina.stop(Catalina.java:628)
        at org.apache.catalina.startup.Catalina$CatalinaShutdownHook.run(Catalina.java:671)
Apr 21, 2009 2:38:10 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Apr 21, 2009 2:38:10 PM org.apache.catalina.connector.MapperListener destroy
WARNING: Error unregistering MBeanServerDelegate
java.lang.NullPointerException
        at org.apache.catalina.connector.MapperListener.destroy(MapperListener.java:165)
        at org.apache.catalina.connector.Connector.stop(Connector.java:1179)
        at org.apache.catalina.core.StandardService.stop(StandardService.java:593)
        at org.apache.catalina.core.StandardServer.stop(StandardServer.java:744)
        at org.apache.catalina.startup.Catalina.stop(Catalina.java:628)
        at org.apache.catalina.startup.Catalina$CatalinaShutdownHook.run(Catalina.java:671)
Apr 21, 2009 2:38:10 PM org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:38:10 PM org.apache.catalina.connector.Connector stop
SEVERE: Coyote connector has not been started
Apr 21, 2009 2:40:10 PM org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:40:11 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Apr 21, 2009 2:40:11 PM org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:40:55 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: /usr/java/jdk1.6.0_05/jre/lib/amd64/server:/usr/java/jdk1.6.0_05/jre/lib/amd64:/usr/java/jdk1.6.0_05/jre/../lib/amd64:/usr/java/packages/lib/amd64:/lib:/usr/lib
Apr 21, 2009 2:40:55 PM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:40:55 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 348 ms
Apr 21, 2009 2:40:55 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Apr 21, 2009 2:40:55 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
Apr 21, 2009 2:40:55 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive share.war
Apr 21, 2009 2:40:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive alfresco.war
Apr 21, 2009 2:40:57 PM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
Apr 21, 2009 2:40:57 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
Apr 21, 2009 2:40:57 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/13  config=null
Apr 21, 2009 2:40:57 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 2247 ms
Apr 21, 2009 6:00:19 PM org.apache.catalina.core.StandardContext stop
INFO: Container org.apache.catalina.core.ContainerBase.[Catalina].[localhost].[/alfresco] has not been started
Apr 21, 2009 6:11:57 PM org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
Apr 21, 2009 6:11:58 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Apr 21, 2009 6:11:59 PM org.apache.coyote.http11.Http11Protocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
Apr 21, 2009 6:20:19 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: /usr/java/jdk1.6.0_05/jre/lib/amd64/server:/usr/java/jdk1.6.0_05/jre/lib/amd64:/usr/java/jdk1.6.0_05/jre/../lib/amd64:/usr/java/packages/lib/amd64:/lib:/usr/lib
Apr 21, 2009 6:20:19 PM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
Apr 21, 2009 6:20:19 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 305 ms
Apr 21, 2009 6:20:19 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Apr 21, 2009 6:20:19 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.18
Apr 21, 2009 6:20:19 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive share.war
Apr 21, 2009 6:20:21 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive alfresco.war
Apr 21, 2009 6:20:21 PM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
Apr 21, 2009 6:20:21 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
Apr 21, 2009 6:20:21 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/13  config=null
Apr 21, 2009 6:20:21 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 2257 ms

‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

[amenel]

The bindException for port 8080 means that an application is already listening on that port. On my Windows installations, it happened under one of these circumstances:
- you have a previously launched instance of Tomcat that is still running while you think you closed it (in my case, I was using a virtual desktop manager). Check your process list, you should see either Tomcat or Java. Kill all such named processes and try a new launch.
- you closed the console instead of using "alf_stop.bat" or "shutdown.bat", but your Alfresco installation had started an OpenOffice instance that is still running since the closing of Alfresco did not occur in the "normal" way. If so, you won't see any Java or Tomcat (or any name you would recognize) in the process list. However, killing the soffice.exe process will (miraculously ?) release the port. Unless you are in production and/or need the content transformations provided by OpenOffice, I recommend  not installing it.
- you have Skype started… This f*** program has the stupid habit of binding to standard ports (80, 443). It never did bind to 8080 on my system but who knows what this should-have-been-better-thought piece of software does.
- another program is listening on the port. Enter "netstat -b" in a console with admin privilege to unveil the culprit.