topic can´t start alfresco, mysql could not be started in Alfresco Archive

can´t start alfresco, mysql could not be started

disident — Wed, 18 Jan 2012 20:28:58 GMT

hola a todosles cuento, hace mas de 2 semanas que estoy investigando alfresco, al instalarlo en windows 2003 server no tuve ningun problema, pero mi jefe me lo pide en ubuntu, despues de muchos intentos lo hice correr en ubuntu 10.04 server, con esta pagina http://sysadminnotebook.blogspot.com/2011/

Re: can´t start alfresco, mysql could not be started

cristinamr — Wed, 18 Jan 2012 21:26:27 GMT

Buenas.

Segun lo que nos has pasado, el problema lo tienes en la BBDD:

120116  8:57:58 [ERROR] Can't start server: Bind on TCP/IP port: Address already in use
120116  8:57:58 [ERROR] Do you already have another mysqld server running on port: 3306 ?‍‍

Me da que tienes ocupado el puerto 3306 que necesita el servicio de alfresco para arrancar el mysql.

¿Podrías hacer un grep y mirar qué procesos corren en tu máquina? Porque el alfresco lo tienes bien instalado.

Un saludo.

Re: can´t start alfresco, mysql could not be started

disident — Thu, 19 Jan 2012 12:48:22 GMT

ok, les cuento lo q hice, reinicie la makina, borre el archivo catalina.pid, el alfresco.log y el mysql.log, pare el servicio mysql con

service mysql stop‍

hasta ahi todo bien, luego le di un

./alfresco.sh start‍

con eso me salio esto


120119 11:15:53 mysqld_safe Logging to '/opt/alfresco/mysql/data/mysqld.log'
120119 11:15:53 mysqld_safe Starting mysqld.bin daemon with databases from '/opt/alfresco/mysql/data
120119 11:15:53 mysqld_safe mysqld from pid file /opt/alfresco/mysql/data/alfresco.pid ended
/opt/alfresco/mysql/scripts/ctl.sh : mysql started at port 3306
Using CATALINA_BASE:          /opt/alfresco/tomcat
Using CATALINA_HOME:          /opt/alfresco/tomcat
Using CATALINA_TMPDIR:        /opt/alfresco/tomcat/temp
Using JRE_HOME:               /opt/alfresco/java
Using CLASSPATH:              /opt/alfresco/tomcat/bin/bootstrap.jar
/opt/alfresco/tomcat/scripts/ctl.sh : tomcat started
‍‍‍‍‍‍‍‍‍‍‍‍

con eso se supone q esta bien, ahora con mi_ip:8080/alfresco me sale lo siguiente


Estado HTTP 404 -

type Informe de estado

mensaje

descripción El recurso requerido () no está disponible.
Apache Tomcat/6.0.26
‍‍‍‍‍‍‍‍‍‍

y si me meto en mi_ip:8080/share
me sale la pantalla del login del share, pero cuando me trato de loguear me

The remote server may be unavailable or your authentication details have not been recognized.
‍‍

yo creo q es problema del mysql, pero con algo mas 😕 porfavor, ayuyenme, o tambien estaria bien, una guia para instalar el alfresco 4 en ubuntu 11.10 server de 32 bits… o algo asi. xD

les adjunto el nuevo log del alfresco y de mysqld
este es el alfresco.log

09:21:12,288 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
09:21:12,315 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
09:21:12,322 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
09:21:12,327 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_wcmquickstart/alfresco-global.properties]
09:21:12,332 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_dod5015/alfresco-global.properties]
09:21:12,337 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco-global.properties]
09:21:12,442 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:12,535 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:12,569 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:12,630 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:12,631 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:29,488 WARN  [org.springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'serviceBeans' being accessed! Ambiguous write methods found next to actually used [public void org.apache.cxf.jaxrs.JAXRSServerFactoryBean.setServiceBeans(java.util.List)]: [public void org.apache.cxf.jaxrs.JAXRSServerFactoryBean.setServiceBeans(java.lang.Object[])]
09:21:30,907 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
09:21:30,909 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
09:21:35,105 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
09:21:35,660 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] No changes were made to the schema.
09:21:35,718 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
09:21:35,740 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:35,741 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:35,742 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:35,743 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:35,743 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:35,901 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
09:21:37,605 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
09:21:37,644 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:37,644 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:37,646 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:37,646 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:37,647 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:38,051 ERROR [org.alfresco.repo.content.transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 00190000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/common/bin/convert, /opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_8080892403720128609.gif[0], /opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_542575958169196605.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_8080892403720128609.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfresco/t
09:21:38,159 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
09:21:38,159 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
09:21:38,181 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:38,182 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:38,182 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:38,183 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:38,183 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:38,522 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
09:21:38,538 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
09:21:42,202 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf_data
09:21:43,243 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: 00190001 The store 'avm://sitestore' has a duplicate root node entry.
   at org.alfresco.repo.admin.ConfigurationChecker.check(ConfigurationChecker.java:288)
   at org.alfresco.repo.admin.ConfigurationChecker.access$000(ConfigurationChecker.java:68)
   at org.alfresco.repo.admin.ConfigurationChecker$1.execute(ConfigurationChecker.java:180)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:377)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:270)
   at org.alfresco.repo.admin.ConfigurationChecker.onBootstrap(ConfigurationChecker.java:184)
   at org.springframework.extensions.surf.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:56)
   at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:97)
   at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEvent(SafeApplicationEventMulticaster.java:78)
   at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:294)
   at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:858)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:419)
   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:3972)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
   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:443)
   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)
09:21:54,464 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 302 Web Scripts (+0 failed), 310 URLs
09:21:54,465 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
09:21:54,466 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
09:21:54,661 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 1788.7124ms)
09:21:54,729 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,800 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
09:21:54,861 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,864 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
09:21:54,952 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,956 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

y el mysqld.log

120119 08:58:14 mysqld_safe mysqld from pid file /opt/alfresco/mysql/data/alfresco.pid ended
120119 09:09:55 mysqld_safe Starting mysqld.bin daemon with databases from /opt/alfresco/mysql/data
120119  9:09:55  InnoDB: Started; log sequence number 0 3411468
120119  9:09:55 [Note] Event Scheduler: Loaded 0 events
120119  9:09:55 [Note] /opt/alfresco/mysql/bin/mysqld.bin: ready for connections.
Version: '5.1.30'  socket: '/opt/alfresco/mysql/tmp/mysql.sock'  port: 3306  MySQL Community Server (GPL)
120119  9:10:24 [Note] /opt/alfresco/mysql/bin/mysqld.bin: Normal shutdown

120119  9:10:24 [Note] Event Scheduler: Purging the queue. 0 events
120119  9:10:24  InnoDB: Starting shutdown…
120119  9:10:25  InnoDB: Shutdown completed; log sequence number 0 3411468
120119  9:10:25 [Note] /opt/alfresco/mysql/bin/mysqld.bin: Shutdown complete

120119 09:10:25 mysqld_safe mysqld from pid file /opt/alfresco/mysql/data/alfresco.pid ended
120119 09:13:11 mysqld_safe Starting mysqld.bin daemon with databases from /opt/alfresco/mysql/data
120119  9:13:11  InnoDB: Started; log sequence number 0 3411468
120119  9:13:11 [Note] Event Scheduler: Loaded 0 events
120119  9:13:11 [Note] /opt/alfresco/mysql/bin/mysqld.bin: ready for connections.
Version: '5.1.30'  socket: '/opt/alfresco/mysql/tmp/mysql.sock'  port: 3306  MySQL Community Server (GPL)
120119  9:20:00 [Note] /opt/alfresco/mysql/bin/mysqld.bin: Normal shutdown

120119  9:20:00 [Note] Event Scheduler: Purging the queue. 0 events
120119  9:20:00  InnoDB: Starting shutdown…
120119  9:20:01  InnoDB: Shutdown completed; log sequence number 0 3411468
120119  9:20:01 [Note] /opt/alfresco/mysql/bin/mysqld.bin: Shutdown complete

120119 09:20:01 mysqld_safe mysqld from pid file /opt/alfresco/mysql/data/alfresco.pid ended
120119 09:20:47 mysqld_safe Starting mysqld.bin daemon with databases from /opt/alfresco/mysql/data
120119  9:20:47  InnoDB: Started; log sequence number 0 3411468
120119  9:20:47 [Note] Event Scheduler: Loaded 0 events
120119  9:20:47 [Note] /opt/alfresco/mysql/bin/mysqld.bin: ready for connections.
Version: '5.1.30'  socket: '/opt/alfresco/mysql/tmp/mysql.sock'  port: 3306  MySQL Community Server (GPL)
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

gracias por la respuesta tan pronta Cristina.

y me podrias decir como hacer ese grep con los procesos, porfavor ^^

Re: can´t start alfresco, mysql could not be started

cristinamr — Thu, 19 Jan 2012 13:06:28 GMT

Ahora aparentemente Mysql está bien pero si te fijas en el log de alfresco tienes esto:

09:21:43,243 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: 00190001 The store 'avm://sitestore' has a duplicate root node entry.‍‍

O sea que el problema ahora lo tienes en la instalación. Me da que se debió queda mal instalado o con basurilla de las anteriores veces que intentaste arrancar.

Intenta hacer esta prueba:

- Paralo todo.
- De tu alfresco borra TODO el contenido de lo siguiente:
alfresco/alf_data/*
alfresco/tomcat/work/*
alfresco/tomcat/temp/*

- Además borra las siguientes carpetas (con todo lo que tengan dentro):
alfresco/tomcat/webapps/alfresco
alfresco/tomcat/webapps/share
alfresco/tomcat/webapps/wcmwqs
alfresco/tomcat/webapps/awe

- Prueba a arrancar a ver que tal.

Con esto borramos todo el contexto que hubiera en alfresco, es decir, que si anteriormente no te arrancó correctamente y dejó "basurilla" con este proceso eliminamos cualquier "resto".

Comentanos.

Un saludo.

Edito:
El ps es: ps -fea |grep nombre_proceso En el caso de Alfresco sería ps -fea |grep tomcat o ps -fea |grep mysql y ya verías si está arrancando y qué número de proceso tiene (PID).
Una vez usado el ps -fea, puedes usar el comando netstat de linux para ver si tienes un puerto determinado "pillado" por otro proceso. Creo recordar que era algo como netstat -tupa |grep PID donde PID es el número del proceso que hayas consultado con el ps -fea 😃

Re: can´t start alfresco, mysql could not be started

disident — Thu, 19 Jan 2012 13:38:03 GMT

nada u_u
borre todo eso me sale


120119 10:33:53 mysqld_safe Logging to '/opt/alfresco/mysql/data/mysqld.log'
120119 10:33:53 mysqld_safe Starting mysqld.bin daemon with databases from '/opt/alfresco/mysql/data
/opt/alfresco/mysql/scripts/ctl.sh : mysql started at port 3306
Using CATALINA_BASE:          /opt/alfresco/tomcat
Using CATALINA_HOME:          /opt/alfresco/tomcat
Using CATALINA_TMPDIR:        /opt/alfresco/tomcat/temp
Using JRE_HOME:               /opt/alfresco/java
Using CLASSPATH:              /opt/alfresco/tomcat/bin/bootstrap.jar
/opt/alfresco/tomcat/scripts/ctl.sh : tomcat started‍‍‍‍‍‍‍‍‍‍

pero nada u.u

hay alguna forma de instalarlo en Ubuntu 11.10 server de 32 bits, esto ya no me esta gustando,

Re: can´t start alfresco, mysql could not be started

cristinamr — Thu, 19 Jan 2012 14:06:43 GMT

Muestrame el alfresco.log o el catalina.out por favor.

Re: can´t start alfresco, mysql could not be started

disident — Thu, 19 Jan 2012 15:55:45 GMT

09:21:12,288 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
09:21:12,315 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
09:21:12,322 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
09:21:12,327 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_wcmquickstart/alfresco-global.properties]
09:21:12,332 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_dod5015/alfresco-global.properties]
09:21:12,337 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco-global.properties]
09:21:12,442 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:12,535 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:12,569 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:12,630 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:12,631 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:29,488 WARN  [org.springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'serviceBeans' being accessed! Ambiguous write methods found next to actually used [public void org.apache.cxf.jaxrs.JAXRSServerFactoryBean.setServiceBeans(java.util.List)]: [public void org.apache.cxf.jaxrs.JAXRSServerFactoryBean.setServiceBeans(java.lang.Object[])]
09:21:30,907 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
09:21:30,909 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
09:21:35,105 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
09:21:35,660 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] No changes were made to the schema.
09:21:35,718 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
09:21:35,740 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:35,741 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:35,742 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:35,743 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:35,743 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:35,901 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
09:21:37,605 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
09:21:37,644 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:37,644 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:37,646 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:37,646 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:37,647 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:38,051 ERROR [org.alfresco.repo.content.transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 00190000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/common/bin/convert, /opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_8080892403720128609.gif[0], /opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_542575958169196605.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_8080892403720128609.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfresco/t
09:21:38,159 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
09:21:38,159 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
09:21:38,181 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
09:21:38,182 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
09:21:38,182 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
09:21:38,183 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
09:21:38,183 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
09:21:38,522 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
09:21:38,538 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
09:21:42,202 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf_data
09:21:43,243 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: 00190001 The store 'avm://sitestore' has a duplicate root node entry.
   at org.alfresco.repo.admin.ConfigurationChecker.check(ConfigurationChecker.java:288)
   at org.alfresco.repo.admin.ConfigurationChecker.access$000(ConfigurationChecker.java:68)
   at org.alfresco.repo.admin.ConfigurationChecker$1.execute(ConfigurationChecker.java:180)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:377)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:270)
   at org.alfresco.repo.admin.ConfigurationChecker.onBootstrap(ConfigurationChecker.java:184)
   at org.springframework.extensions.surf.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:56)
   at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:97)
   at org.alfresco.repo.management.SafeApplicationEventMulticaster.multicastEvent(SafeApplicationEventMulticaster.java:78)
   at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:294)
   at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:858)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:419)
   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:3972)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
   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:443)
   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)
09:21:54,464 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 302 Web Scripts (+0 failed), 310 URLs
09:21:54,465 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
09:21:54,466 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
09:21:54,661 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 1788.7124ms)
09:21:54,729 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,800 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
09:21:54,861 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,864 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
09:21:54,952 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
09:21:54,956 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:32:05,459 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 302 Web Scripts (+0 failed), 310 URLs
10:32:05,460 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
10:32:05,460 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
10:32:05,614 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 1221.7771ms)
10:32:05,664 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:32:05,724 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:32:05,783 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:32:05,786 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:32:05,850 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:32:05,853 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:32:17,475 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
10:32:17,477 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
10:32:17,477 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
10:32:17,477 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_wcmquickstart/alfresco-global.properties]
10:32:17,477 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_dod5015/alfresco-global.properties]
10:32:17,477 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco-global.properties]
10:32:17,504 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:32:17,588 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
10:32:17,608 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
10:32:17,645 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
10:32:17,646 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
10:32:28,816 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'avmRemoteService' defined in class path resource [alfresco/remote-services-context.xml]: Invocation of init method failed; nested exception is java.rmi.server.ExportException: Port already in use: 50500; nested exception is: 
   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.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:3972)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
   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.deployWAR(HostConfig.java:905)
   at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:740)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:500)
   at org.apache.catalina.startup.HostConfig.check(HostConfig.java:1345)
   at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:303)
   at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
   at org.apache.catalina.core.ContainerBase.backgroundProcess(ContainerBase.java:1337)
   at org.apache.catalina.core.ContainerBase$ContainerBackgroundProcessor.processChildren(ContainerBase.java:1601)
   at org.apache.catalina.core.ContainerBase$ContainerBackgroundProcessor.processChildren(ContainerBase.java:1610)
   at org.apache.catalina.core.ContainerBase$ContainerBackgroundProcessor.run(ContainerBase.java:1590)
   at java.lang.Thread.run(Thread.java:619)
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:68)
   at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:222)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:366)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:331)
   at org.springframework.remoting.rmi.RmiServiceExporter.prepare(RmiServiceExporter.java:264)
   at org.springframework.remoting.rmi.RmiServiceExporter.afterPropertiesSet(RmiServiceExporter.java:227)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1460)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1398)
   … 29 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 org.alfresco.util.remote.server.socket.HostConfigurableSocketFactory.createServerSocket(HostConfigurableSocketFactory.java:88)
   at sun.rmi.transport.tcp.TCPEndpoint.newServerSocket(TCPEndpoint.java:649)
   at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:299)
   … 42 more
10:33:55,625 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
10:33:55,628 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
10:33:55,628 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
10:33:55,628 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_wcmquickstart/alfresco-global.properties]
10:33:55,628 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/org_alfresco_module_dod5015/alfresco-global.properties]
10:33:55,628 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco-global.properties]
10:33:55,695 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:33:55,790 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]
10:33:55,816 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]
10:33:55,862 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/module/org.alfresco.module.vti/context/vti.properties]
10:33:55,862 INFO  [org.alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from URL [file:/opt/alfresco/tomcat/shared/classes/alfresco/extension/custom-vti.properties]
10:34:09,688 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'avmRemoteService' defined in class path resource [alfresco/remote-services-context.xml]: Invocation of init method failed; nested exception is java.rmi.server.ExportException: Port already in use: 50500; nested exception is: 
   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.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:3972)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
   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:443)
   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:68)
   at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:222)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:366)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:331)
   at org.springframework.remoting.rmi.RmiServiceExporter.prepare(RmiServiceExporter.java:264)
   at org.springframework.remoting.rmi.RmiServiceExporter.afterPropertiesSet(RmiServiceExporter.java:227)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1460)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1398)
   … 37 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 org.alfresco.util.remote.server.socket.HostConfigurableSocketFactory.createServerSocket(HostConfigurableSocketFactory.java:88)
   at sun.rmi.transport.tcp.TCPEndpoint.newServerSocket(TCPEndpoint.java:649)
   at sun.rmi.transport.tcp.TCPTransport.listen(TCPTransport.java:299)
   … 50 more
10:34:18,502 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 302 Web Scripts (+0 failed), 310 URLs
10:34:18,503 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
10:34:18,504 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
10:34:18,680 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 1511.9634ms)
10:34:18,800 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:34:18,941 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:34:19,092 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:34:19,096 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
10:34:19,220 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:34:19,223 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

Re: can´t start alfresco, mysql could not be started

cristinamr — Thu, 19 Jan 2012 18:49:23 GMT

El puerto que necesita alfresco estaba en uso:

Caused by: java.rmi.server.ExportException: Port already in use: 50500; nested exception is:
   java.net.BindException: Address already in use‍‍

Antes de arrancar, excepciorate de que los puertos que necesitas no están cogidos! (Para alfresco el 8080 y mysql 3306)

Es que sino no te va a funcionar nunca

Re: can´t start alfresco, mysql could not be started

disident — Thu, 19 Jan 2012 18:58:14 GMT

=(
para lo del mysql lo he cerrado, con un

service mysql stop

pero lo del alfresco??

como lo podria cerrar?
con un
./alfresco.sh stop??
ya lo he hecho pero sigue asi

de antemano muchas gracias 😕

Re: can´t start alfresco, mysql could not be started

cristinamr — Thu, 19 Jan 2012 19:12:56 GMT

A ver, no es eso.

Por partes, para parar alfresco o mysql es como lo has hecho. Pero te comentaba que cuando vayas a arrancarlo compruenes que en tu máquina no hay otra aplicacion que use los puertos que necesitas (el 8080 para alfresco y el 3306 para myql). Me da que el problema aquí es que no tienes controlado la parte de linux y al haber intentado arrancar alfresco se no se te monta correctamente (vamos, que el problema aparentemente se origina porque cuando arrancas los puertos están cogidos y alfresco carga mal los achivos cuando se arranca).

Para ver los puertos que tienes abiertos.

Y una guía de comandos para linux.

Intenta parar por completo, si ves que no puedes reinicia, haz un ps -fea para comprobar que tomcat no se está ejecutando ni mysql, y arranca ambos procesos.

Si esto sigue sin funcionar, tendrás que vovler a hacer "la limpieza" e intentar arrancarlo a ver si conseguimos que arranque sin los puertos cogidos.. Creo que eso debería funcionarte.

Un saludo.

Re: can´t start alfresco, mysql could not be started

cristinamr — Fri, 20 Jan 2012 09:19:08 GMT

Hey, acabo de encontrar un tuto. Ojealo a ver si te sirve.

Un saludo.

Re: can´t start alfresco, mysql could not be started

disident — Fri, 20 Jan 2012 14:28:43 GMT

muchas gracias por el tutorial Cristina, voi a ver si me corre bien con el 11.10 con la version 4 de alfresco community ahi te cuento como me fue
saludos.

y muchas gracias por todo
edito:

vi q muchos tenian mi mismo problema con esa instalacion, mi makina soporta 64bits, es recomendable instalar ubuntu 11.10 server x64, e instalar alfresco 4.* con el wizard??

como lo tienes instalado tu??
te dio muchos problemas, o es mas facil en 64 bits??

Re: can´t start alfresco, mysql could not be started

cristinamr — Sat, 21 Jan 2012 17:10:28 GMT

Yo tengo un virtualbox de 64 (mi máquina lo es) y un ubuntu 11.10 intalado y funciona a la primera. Eso sí, en mi caso la BBDD la saco a mysql. Pruebalo, a lo mejor es eso :?

Re: can´t start alfresco, mysql could not be started

disident — Thu, 26 Jan 2012 19:52:26 GMT

Mi solucion fue, instalar Alfresco 4.0.c en ubuntu 11.10 server de 64 bits, con todas las opciones por defecto, y con el auto instalable.
con eso no me dio mas problemas..
al final nunca supe q era lo q tenia el anterior

Re: can´t start alfresco, mysql could not be started

hepale — Sat, 28 Jan 2012 05:48:55 GMT

Me suena que tiene que ver con tu configuración del pool de conexiones.

Re: can´t start alfresco, mysql could not be started

darkmstr — Wed, 01 Aug 2012 16:35:46 GMT

Perdon por revivir tema viejo pero probe con tu solucion Cristina de borrar todo lo de esas carpetas, cambien el index a lucene con FULL en recovery y me aparece :

Aug 1, 2012 11:33:13 AM org.apache.catalina.startup.Catalina start
SEVERE: Catalina.start:
LifecycleException:  service.getName(): "Catalina";  Protocol handler start failed: java.io.FileNotFoundException: /opt/alfresco4/alf_data/keystore/ssl.keystore (No such file or directory)
        at org.apache.catalina.connector.Connector.start(Connector.java:1094)
        at org.apache.catalina.core.StandardService.start(StandardService.java:534)
        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)
Aug 1, 2012 11:33:13 AM org.apache.catalina.startup.Catalina start
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

Re: can´t start alfresco, mysql could not be started

cristinamr — Wed, 01 Aug 2012 16:58:49 GMT

Francisco.Rojas, peganos el log completo desde que arrancas, tanto el catalina.out como el alfresco.log a ver si encontramos qué ocurre :wink:

Re: can´t start alfresco, mysql could not be started

darkmstr — Mon, 06 Aug 2012 21:56:17 GMT

jeje el error no era de SOLR ni de Lucene, el problema era de DNS, ya lo solucione muchas gracias