Error when starting Alfresco

yogeshkumar — Wed, 01 Dec 2010 09:49:09 GMT

I have install two alfresco in my sytemIf i start the 1st one its starting properly parallely if i start the second one i am getting some error like15:15:06,516 INFO [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]15:15:0

Re: Error when starting Alfresco

mrogers — Wed, 01 Dec 2010 09:58:39 GMT

Is the red bit in the right place in the log file

You are probably trying to run two instances of IMAP or FTP on the same port, the second one will fail. Turn off imap or FTP for one of your servers or run each server on it's own IP address and or range of ports .

Re: Error when starting Alfresco

pankaj_p_mishra — Wed, 08 Dec 2010 10:51:02 GMT

I am stocked with a very little problem with alfresco…
actually,i configured alfresco with ubuntu and try to run on it.But when i started alfresco with alf_start.sh script ,and read log file i find that there is something missing because catalina.out file displaye some error message…
PORT ALREADY IN USE…like that.
i killed that process and try to run it again it shows same message again and again …
here i put actual code of catalina.out


CompilerOracle: exclude org/apache/lucene/index/IndexReader$1.doBody
CompilerOracle: exclude org/alfresco/repo/search/impl/lucene/index/IndexInfo$Merger.mergeIndexes
CompilerOracle: exclude org/alfresco/repo/search/impl/lucene/index/IndexInfo$Merger.mergeDeletions
8 Dec, 2010 11:38:38 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: /usr/lib/jvm/java-6-sun-1.6.0.22/jre/lib/amd64/server:/usr/lib/jvm/java-6-sun-1.6.0.22/jre/lib/amd64:/usr/lib/jvm/java-6-sun-1.6.0.22/jre/../lib/amd64:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
8 Dec, 2010 11:38:38 AM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
8 Dec, 2010 11:38:38 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 540 ms
8 Dec, 2010 11:38:38 AM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
8 Dec, 2010 11:38:38 AM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.29
8 Dec, 2010 11:38:38 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor manager.xml
8 Dec, 2010 11:38:39 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor alfresco.xml
8 Dec, 2010 11:38:39 AM 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.
11:38:44,912  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
11:38:44,941  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
11:38:44,942  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/usr/local/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
11:38:44,942  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/usr/local/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
11:38:45,003  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
11:38:57,194  ERROR [web.context.ContextLoader] Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'registry' defined in class path resource [alfresco/core-services-context.xml]: Invocation of init method failed; nested exception is java.rmi.server.ExportException: [b][color=#FF0000]Port already in use: 50500; nested exception is:[/color][/b] 
   java.net.BindException: Address already in use
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1401)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:512)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:450)
   at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:290)
   at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
   at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:287)
   at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:189)
   at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:280)
   at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:189)
   at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:557)
   at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:842)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:416)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:261)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:192)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:47)
   at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:63)
   at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4135)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4630)
   at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
   at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
   at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
   at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:637)
   at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:563)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:498)
   at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
   at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
   at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
   at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
   at org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
   at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
   at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:445)
   at org.apache.catalina.core.StandardService.start(StandardService.java:519)
   at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
   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:289)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
Caused by: java.rmi.server.ExportException: Port already in use: 50500; nested exception is: 
   java.net.BindException: Address already in use
   at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:310)
   at sun.rmi.transport.tcp.TCPTransport.exportObject(TCPTransport.java:218)
   at sun.rmi.transport.tcp.TCPEndpoint.exportObject(TCPEndpoint.java:393)
   at sun.rmi.transport.LiveRef.exportObject(LiveRef.java:129)
   at sun.rmi.server.UnicastServerRef.exportObject(UnicastServerRef.java:190)
   at sun.rmi.registry.RegistryImpl.setup(RegistryImpl.java:92)
   at sun.rmi.registry.RegistryImpl.<init>(RegistryImpl.java:78)
   at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:186)
   at org.springframework.remoting.rmi.RmiRegistryFactoryBean.getRegistry(RmiRegistryFactoryBean.java:267)
   at org.springframework.remoting.rmi.RmiRegistryFactoryBean.getRegistry(RmiRegistryFactoryBean.java:236)
   at org.springframework.remoting.rmi.RmiRegistryFactoryBean.getRegistry(RmiRegistryFactoryBean.java:193)
   at org.springframework.remoting.rmi.RmiRegistryFactoryBean.afterPropertiesSet(RmiRegistryFactoryBean.java:164)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1460)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1398)
   … 39 more
Caused by: java.net.BindException: Address already in use
   at java.net.PlainSocketImpl.socketBind(Native Method)
   at java.net.PlainSocketImpl.bind(PlainSocketImpl.java:365)
   at java.net.ServerSocket.bind(ServerSocket.java:319)
   at java.net.ServerSocket.<init>(ServerSocket.java:185)
   at java.net.ServerSocket.<init>(ServerSocket.java:97)
   at sun.rmi.transport.proxy.RMIDirectSocketFactory.createServerSocket(RMIDirectSocketFactory.java:27)
   at sun.rmi.transport.proxy.RMIMasterSocketFactory.createServerSocket(RMIMasterSocketFactory.java:333)
   at sun.rmi.transport.tcp.TCPEndpoint.newServerSocket(TCPEndpoint.java:649)
   at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:299)
   … 52 more
8 Dec, 2010 11:38:57 AM org.apache.catalina.core.StandardContext start
SEVERE: Error listenerStart
8 Dec, 2010 11:38:57 AM org.apache.catalina.core.StandardContext start
SEVERE: Context [/alfresco] startup failed due to previous errors
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
SEVERE: The web application [/alfresco] registered the JBDC driver [org.postgresql.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-1] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-2] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-3] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-4] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-5] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-6] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-7] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-8] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-9] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
SEVERE: The web application [/alfresco] appears to have started a thread named [DefaultScheduler_Worker-10] but has failed to stop it. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearThreadLocalMap
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@7d25e791]) and a value of type [org.apache.cxf.bus.CXFBusImpl] (value [org.apache.cxf.bus.CXFBusImpl@438620c7]) but failed to remove it when the web application was stopped. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearThreadLocalMap
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [null] (value [com.sun.xml.bind.v2.ClassFactory$1@53edb8c6]) and a value of type [java.util.WeakHashMap] (value [{class org.alfresco.repo.audit.model._3.RecordValue=java.lang.ref.WeakReference@10260657, class org.alfresco.repo.audit.model._3.Audit=java.lang.ref.WeakReference@306a4209, class org.alfresco.repo.audit.model._3.AuditPath=java.lang.ref.WeakReference@101575b4, class java.util.ArrayList=java.lang.ref.WeakReference@70e284ab, class org.alfresco.repo.audit.model._3.PathMap=java.lang.ref.WeakReference@27743073, class org.alfresco.repo.audit.model._3.PathMappings=java.lang.ref.WeakReference@3d18e241, class org.alfresco.repo.audit.model._3.DataExtractors=java.lang.ref.WeakReference@2cae38bd, class org.alfresco.repo.audit.model._3.GenerateValue=java.lang.ref.WeakReference@620f1735, class org.alfresco.repo.audit.model._3.DataGenerators=java.lang.ref.WeakReference@4cbccade, class org.alfresco.repo.audit.model._3.Application=java.lang.ref.WeakReference@7eaadc2d, class org.alfresco.repo.audit.model._3.DataGenerator=java.lang.ref.WeakReference@35d4f53, class org.alfresco.repo.audit.model._3.DataExtractor=java.lang.ref.WeakReference@6302d3de}]) but failed to remove it when the web application was stopped. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearThreadLocalMap
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@4ea3c69a]) and a value of type [org.alfresco.util.CachingDateFormat] (value [yyyy-MM-dd]) but failed to remove it when the web application was stopped. This is very likely to create a memory leak.
8 Dec, 2010 11:38:57 AM org.apache.catalina.loader.WebappClassLoader clearThreadLocalMap
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [null] (value [com.sun.xml.bind.v2.runtime.Coordinator$1@6243d0cb]) and a value of type [com.sun.xml.bind.v2.runtime.Coordinator[]] (value [[Lcom.sun.xml.bind.v2.runtime.Coordinator;@5240f1d3]) but failed to remove it when the web application was stopped. This is very likely to create a memory leak.
log4j:ERROR LogMananger.repositorySelector was null likely due to error in class reloading, using NOPLoggerRepository.
8 Dec, 2010 11:38:58 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor host-manager.xml
8 Dec, 2010 11:38:58 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive share.war
11:39:02,886  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 227 Web Scripts (+0 failed), 235 URLs
11:39:02,888  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
11:39:02,888  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
11:39:02,970  INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 1321.6312ms)
11:39:03,031  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
11:39:03,121  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
11:39:03,176  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
11:39:03,180  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
11:39:03,276  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
11:39:03,281  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
8 Dec, 2010 11:39:04 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory examples
8 Dec, 2010 11:39:04 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory docs
8 Dec, 2010 11:39:04 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory ROOT
8 Dec, 2010 11:39:04 AM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
8 Dec, 2010 11:39:04 AM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
8 Dec, 2010 11:39:04 AM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/26  config=null
8 Dec, 2010 11:39:04 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 25821 ms
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

Awaiting for your valuable response…
Thanks

Re: Error when starting Alfresco

muralie39 — Mon, 17 Jan 2011 07:44:37 GMT

Use the following properties in the alfrescoglobal.properties file:

avm.rmi.service.port=0
avmsync.rmi.service.port=0
attribute.rmi.service.port=0
authentication.rmi.service.port=0
repo.rmi.service.port=0
action.rmi.service.port=0
deployment.rmi.service.port=0

the 0 shows that, it will take the random port number… check out any error?

Re: Error when starting Alfresco

mrogers — Mon, 17 Jan 2011 09:36:34 GMT

Actually the 50500 port is controled via the alfresco.rmi.services.port property.

Being unable to bind will be caused by one of three things.
a) There's an instance of alfresco already running which is using that port.
b) There's another program using that port.
c) A previous instance of alfresco has failed to shut down.

topic Re: Error when starting Alfresco in Alfresco Archive

Error when starting Alfresco

Re: Error when starting Alfresco

Re: Error when starting Alfresco

Re: Error when starting Alfresco

Re: Error when starting Alfresco