JVM Heap size

[onyme]

Bonjour,

Je suis en test sur la 3.4a déployée de manière standard sans modification (VMware - OS de la VM : Open Suse 10.2).
Alfresco se déploie bien la première fois et lors d'un reboot de la machine j'ai un symptôme de dépassement de heap size :

2 nov. 2010 12:44:41 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: /opt/alfresco/alf/java/jre/lib/i386/client:/opt/alfresco/alf/java/jre/lib/i386:/opt/alfresco/alf/java/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
2 nov. 2010 12:44:42 org.apache.coyote.http11.Http11Protocol init
INFO: Initialisation de Coyote HTTP/1.1 sur http-8080
2 nov. 2010 12:44:42 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2281 ms
2 nov. 2010 12:44:42 org.apache.catalina.core.StandardService start
INFO: Démarrage du service Catalina
2 nov. 2010 12:44:42 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
2 nov. 2010 12:44:42 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration alfresco.xml
2 nov. 2010 12:44:45 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.
12:44:59,479  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
12:44:59,488  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
12:44:59,491  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
12:44:59,492  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
12:44:59,492  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
12:44:59,672  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:45:46,382  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
12:45:46,382  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
12:46:16,797  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
12:46:17,928  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
12:46:18,161  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
12:46:18,195  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:18,228  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
12:46:22,896  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
12:46:22,919  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:23,171  ERROR [transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 10020000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/alf/common/bin/convert, /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_4554777110733567.gif[0], /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_4986000329671286938.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_4554777110733567.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfresco/
12:46:23,171  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
12:46:23,171  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
12:46:23,171  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:24,003  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
12:46:25,921  INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf/alf_data
12:46:26,090  INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
12:46:27,587  INFO  [admin.patch.PatchExecuter] No patches were required.
12:46:27,601 User:System INFO  [repo.module.ModuleServiceImpl] Found 1 module(s).
12:46:27,754 User:System INFO  [repo.module.ModuleServiceImpl] Starting module 'org.alfresco.module.vti' version 1.2.
12:46:27,788  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
12:46:27,922  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:30,755  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
12:46:30,889  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:31,336  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
12:46:31,964  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
12:46:31,964  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
12:46:31,987  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:32,185  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
12:46:32,185  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
12:46:32,297  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:32,570  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
12:46:32,571  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
12:46:32,593  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:32,869  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]
12:46:32,870  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
12:46:32,890  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
12:46:32,890  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
12:46:32,925  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:35,168  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
12:46:35,195  INFO  [repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
12:46:35,312  INFO  [repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
12:46:35,312  INFO  [repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
12:46:35,312  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
12:46:35,334  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:35,580  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
12:46:35,756  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 247,500MB
12:46:35,756  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 247,500MB is less than recommended 512MB
12:46:35,757  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
12:46:35,758  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
12:46:35,874  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:46:35,881  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
12:46:37,555  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
12:46:44,987 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 4898.1523ms)
12:46:44,988  ERROR [web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: 10020001 Exception in Transaction.
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:410)
   at org.alfresco.repo.web.scripts.RepoStore$3.doWork(RepoStore.java:389)
   at org.alfresco.repo.web.scripts.RepoStore$3.doWork(RepoStore.java:386)
   at org.alfresco.repo.security.authentication.AuthenticationUtil.runAs(AuthenticationUtil.java:508)
   at org.alfresco.repo.web.scripts.RepoStore.getDocumentPaths(RepoStore.java:385)
   at org.springframework.extensions.webscripts.DeclarativeRegistry.initWebScripts(DeclarativeRegistry.java:288)
   at org.springframework.extensions.webscripts.DeclarativeRegistry.reset(DeclarativeRegistry.java:178)
   at org.springframework.extensions.webscripts.AbstractRuntimeContainer.reset(AbstractRuntimeContainer.java:226)
   at org.alfresco.repo.web.scripts.RepositoryContainer.init(RepositoryContainer.java:573)
   at org.alfresco.repo.web.scripts.RepositoryContainer.reset(RepositoryContainer.java:547)
   at org.alfresco.repo.web.scripts.RepositoryContainer$4.doWork(RepositoryContainer.java:501)
   at org.alfresco.repo.security.authentication.AuthenticationUtil.runAs(AuthenticationUtil.java:508)
   at org.alfresco.repo.web.scripts.RepositoryContainer.onApplicationEvent(RepositoryContainer.java:505)
   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)
Caused by: java.lang.OutOfMemoryError: PermGen space
   at java.lang.ClassLoader.defineClass1(Native Method)
   at java.lang.ClassLoader.defineClassCond(ClassLoader.java:632)
   at java.lang.ClassLoader.defineClass(ClassLoader.java:616)
   at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:141)
   at org.apache.catalina.loader.WebappClassLoader.findClassInternal(WebappClassLoader.java:2527)
   at org.apache.catalina.loader.WebappClassLoader.findClass(WebappClassLoader.java:1010)
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1483)
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1361)
   at org.apache.lucene.queryParser.QueryParser.newWildcardQuery(QueryParser.java:771)
   at org.alfresco.repo.search.impl.lucene.LuceneQueryParser.newWildcardQuery(LuceneQueryParser.java:3392)
   at org.apache.lucene.queryParser.QueryParser.getWildcardQuery(QueryParser.java:889)
   at org.alfresco.repo.search.impl.lucene.LuceneQueryParser.getWildcardQuery(LuceneQueryParser.java:3239)
   at org.alfresco.repo.search.impl.lucene.LuceneQueryParser.getWildcardQuery(LuceneQueryParser.java:3161)
   at org.apache.lucene.queryParser.QueryParser.Term(QueryParser.java:1309)
   at org.apache.lucene.queryParser.QueryParser.Clause(QueryParser.java:1211)
   at org.apache.lucene.queryParser.QueryParser.Query(QueryParser.java:1168)
   at org.apache.lucene.queryParser.QueryParser.TopLevelQuery(QueryParser.java:1128)
   at org.apache.lucene.queryParser.QueryParser.parse(QueryParser.java:170)
   at org.alfresco.repo.search.impl.lucene.LuceneQueryParser.parse(LuceneQueryParser.java:308)
   at org.alfresco.repo.search.impl.lucene.ADMLuceneSearcherImpl.query(ADMLuceneSearcherImpl.java:287)
   at org.alfresco.repo.search.impl.lucene.ADMLuceneSearcherImpl.query(ADMLuceneSearcherImpl.java:241)
   at org.alfresco.repo.search.SearcherComponent.query(SearcherComponent.java:67)
   at org.alfresco.repo.search.AbstractSearcherComponent.query(AbstractSearcherComponent.java:53)
   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.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
   at net.sf.acegisecurity.intercept.method.aopalliance.MethodSecurityInterceptor.invoke(MethodSecurityInterceptor.java:80)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
2 nov. 2010 12:46:45 org.apache.catalina.core.StandardContext start
GRAVE: Error listenerStart
2 nov. 2010 12:46:45 org.apache.catalina.core.StandardContext start
GRAVE: Erreur de démarrage du contexte [/alfresco] suite aux erreurs précédentes
2 nov. 2010 12:46:45 org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
GRAVE: A web application 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.
2 nov. 2010 12:46:45 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
2 nov. 2010 12:46:45 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

j'ai en particulier :

12:46:35,756  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 247,500MB
12:46:35,756  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 247,500MB is less than recommended 512MB
‍‍‍

Pour accroitre le heap size j'ai modifié les paramètres du fichier /tomcat/scripts/ctl.sh comme suit

start_tomcat() {
    export JAVA_OPTS="-XX:MaxPermSize=512m -Xms512m -Xmx512m"
    export JAVA_HOME=$JRE_HOME
    $TOMCAT_BINDIR/startup.sh 
‍‍‍‍‍

Or cette modification ne provoque pas l'accroissement attendu.
le document  http://wiki.alfresco.com/wiki/JVM_Tuning ne semble pas indiquer d'autres possibilités.

Pour info les paramètres d'exécution de JRE sont

-Xmx512m‍

Merci bien de votre coopération.

[bertrandf]

Bonjour,

Vous avez quoi comme valeurs dans le fichier alfresco.sh ?

Cordialement.

[onyme]

Bonjour,

Je n'ai rien de particulier sur ce sujet dans alfresco.sh hormis un renvoi vers les script TOMCAT :

INSTALLDIR=/opt/alfresco/alf

if [ -r "$INSTALLDIR/scripts/setenv.sh" ]; then
. "$INSTALLDIR/scripts/setenv.sh"
fi

ERROR=0
MYSQL_SCRIPT=$INSTALLDIR/mysql/scripts/ctl.sh
INGRES_SCRIPT=$INSTALLDIR/ingres/scripts/ctl.sh
APACHE_SCRIPT=$INSTALLDIR/apache2/scripts/ctl.sh
HYPERSONIC_SCRIPT=$INSTALLDIR/hypersonic/scripts/ctl.sh
TOMCAT_SCRIPT=$INSTALLDIR/tomcat/scripts/ctl.sh
….
if test -x $TOMCAT_SCRIPT; then
            $TOMCAT_SCRIPT start  
            TOMCAT_ERROR=$?
        fi
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

En revanche dans setenv.sh j'ai :

##### JAVA ENV #####
JAVA_HOME=/opt/alfresco/alf/java
export JAVA_HOME


JAVA_BINDIR=/opt/alfresco/alf/java/bin
export JAVA_BINDIR
JAVA_ROOT=/opt/alfresco/alf/java
export JAVA_ROOT
JRE_HOME=/opt/alfresco/alf/java/jre
export JRE_HOME
‍‍‍‍‍‍‍‍‍‍‍‍

Bien cordialement.

[jeanjot]

Bonjour

Votre problème ne vient pas de la JVM, d'ailleurs il vous est signalé plus tôt un WARNING :

12:46:35,756  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 247,500MB
12:46:35,756  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 247,500MB is less than recommended 512MB
‍‍‍

Par contre plus loin vous avez lz message suivant :

12:46:44,988  ERROR [web.context.ContextLoader] Context initialization failed‍

qui lui représente un problème de connexion à la base de données …

Et là vous avez un vrai problème …

[jayjayecl]

Bonjour,

le problème, en observant la trace de logs, est un

Caused by: java.lang.OutOfMemoryError: PermGen space

Un recherche rapide sur les forums anglais et français vous donnera quelques pistes de résolution, en jouant en effet sur les paramètres de la mémoire au démarrage.
Si jamais vous ne pouviez solutionner le problème avec les indices que vous récolterez alors, n'hésitez pas à poster un nouveau message ici en nous décrivant vos différentes tentatives.

Bonne chance

[jeanjot]

Bonsoir

Lors du premier arrêt du serveur alfresco, êtes vous sur que l'ensemble des services était bien stoppé. Notamment la processus java.

Je vois en effet le problème suivant, vis à vis de la base de données :

GRAVE: A web application 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.‍

Vous utilisez PostGresql ?

[onyme]

Bonsoir,

j'ai déployé Alfresco à partir du module : "alfresco-community-3.4.a-installer-linux-x32.bin" en suivant les options les plus standards afin d'avoir le moins de problèmes  (alfresco, share, sharepoint seulement). Donc c'est MySQL qui est installé par défaut et non PostGresql. J'ai remarqué aussi ce point qui est étonnant.
En fait je n'ai pas arrêté le serveur Alfresco, mais j'ai procédé à un arrêt de machine complet. En principe (enfin je pense…) openSuse arrête tous les services 1 à 1 avant le stop complet et ne les coupent pas brutalement.
Fondamentalement ce qui me surprend, ce sont ces problèmes avec la 3.4a (mémoire, PostGresql, un autre avec imagemagick), avec une installation standard sur une machine sur laquelle une 3.1 fonctionne sans trop de soucis. Je reconnais que l'installeur apporte beaucoup d'améliorations, mais qu'il est peut être encore un peu jeune.
Bien cordialement.

[jeanjot]

Bonsoir

êtes-vous sur de ne pas avoir lors de l'installation coché la case de mise en service d'Alfresco. Si oui, cela veut dire qu'il se lance au démarrage de vote machine, sans vous demander votre avis …

Pour information, j'ai le même problème avec imageMagick.

Je n'ai pas encore eu le temps d'investiguer.
Je constate que je n'ai pas de vignette sur mes fichiers dans Alfresco share.
Par contre, j'ai bien la preview de mes fichiers dans la vue détaillée dans alfresco share.

A suivre.

De tout façon je ferais un nouveau post pour ne pas mélanger les problèmes …

[onyme]

Bonjour,

Suite des tests. Les différents tests réalisés pour changer la heap size n'ont pas fonctionné. Suite au dernier post de jeanjot, pour être certain qu'Alfresco ne démarre sans me demander mon avis, réinstallation avec l'option "non" pour la mise en place des services.
La heap size est à 494 Mo proche des 512 recommandé et cela fonctionne.
Néanmoins ci dessous les essais réalisés et  catalina.out (partiel) correspondant :

1) Installation à partir de 0 et démarrage d'Alfresco en fin d'installation (12h40)
2) Arrêt d'Alfresco par la commande sh alfresco.sh stop (13h34)
3) Démarrage d'Alfresco poar la commande  sh alfresco.sh start (13h47) les quelques fonctionnalités testées sont ok.
4) Arrêt d'alfresco comme 2 et reboot de la VM (13h53)
5) Alfresco est déjà démarré. Etonnant car à l'install j'ai coché non. (13h57) et essais (volontaire) de sh alfresco.sh start. Le tout fonctionne ce qui est suprenant quand on voit le Catalina.out
6) essais de restart par  sh alfresco.sh restart (14h13) tout semble ok.

Catalina.out

3 nov. 2010 12:40:49 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: /opt/alfresco/alf/java/jre/lib/i386/client:/opt/alfresco/alf/java/jre/lib/i386:/opt/alfresco/alf/java/jre/../lib/i386:/opt/alfresco/alf/mysql/lib:/opt/alfresco/alf/common/lib::/usr/java/packages/lib/i386:/lib:/usr/lib
3 nov. 2010 12:40:49 org.apache.coyote.http11.Http11Protocol init
INFO: Initialisation de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 12:40:49 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1536 ms
3 nov. 2010 12:40:49 org.apache.catalina.core.StandardService start
INFO: Démarrage du service Catalina
3 nov. 2010 12:40:49 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
3 nov. 2010 12:40:49 org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive share.war de l'application web
12:41:10,767  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 256 Web Scripts (+0 failed), 264 URLs
12:41:10,767  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
12:41:10,767  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
12:41:10,767  INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 3802.0645ms)
12:41:10,767  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
12:41:10,767  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
12:41:11,200  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
12:41:11,214  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
12:41:11,492  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
12:41:11,506  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 12:41:14 org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive alfresco.war de l'application web
3 nov. 2010 12:41:28 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.
12:41:43,385  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
12:41:43,385  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
12:41:43,385  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
12:41:43,385  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
12:41:43,385  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
12:41:43,385  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:42:21,776  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
12:42:21,779  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
12:42:30,055  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
12:42:30,479  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-6588167165108876494.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-RepoTables.sql).
12:42:31,210  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-2308594682472029147.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-LockTables.sql).
12:42:31,210  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-4257121862562394673.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-ContentTables.sql).
12:42:31,210  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-2261763448403219178.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-PropertyValueTables.sql).
12:42:31,210  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-4356414439858773403.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-AuditTables.sql).
12:42:31,210  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-748632906532756816.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-AvmTables.sql).
12:42:32,477  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-9127966446162329168.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-ActivityTables.sql).
12:42:32,477  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-8422992934852329587.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoCreate-UsageTables.sql).
12:42:32,477  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-8608063268596566578.sql (Generated).
12:42:33,052  INFO  [domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-3257166049945179291.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-JBPM-Extra.sql).
12:42:33,052  INFO  [domain.schema.SchemaBootstrap] All executed statements:  /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-All_Statements-8094502995515107082.sql.
12:42:33,140  INFO  [domain.schema.SchemaBootstrap] Normalized schema dumped to file /opt/alfresco/alf/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-4605649376428705121.xml.
12:42:33,184  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
12:42:33,248  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:42:33,277  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
12:42:33,733 User:System WARN  [repo.dictionary.DictionaryRepositoryBootstrap] StoreRef 'workspace://SpacesStore' does not exist
12:42:36,527 User:System INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
12:42:36,545 User:System INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:42:37,516 User:System ERROR [transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 10030000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/alf/common/bin/convert, /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_3059273852289215511.gif[0], /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_2053084523095370058.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_3059273852289215511.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfres
12:42:37,516 User:System INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
12:42:37,516 User:System INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
12:42:37,516 User:System INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:42:38,439 User:System INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
12:43:00,808  INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf/alf_data
12:43:00,808  INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
12:43:02,055  WARN  [admin.patch.PatchExecuter] Patch description is not available: Patch[ id=patch.updateMimetypes2, description=patch.updateMimetypes2.description, fixesFromSchema=0, fixesToSchema=4110, targetSchema=4111]
12:43:02,070  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.4-UsageTables
RESULT: 
Script completed
=====================================
12:43:02,070  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.0-ActivityTables
RESULT: 
Script completed
=====================================
12:43:02,070  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-LockTables
RESULT: 
Script completed
=====================================
12:43:02,070  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-ContentTables
RESULT: 
Script completed
=====================================
12:43:02,071  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-PropertyValueTables
RESULT: 
Script completed
=====================================
12:43:02,071  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-AvmTables
RESULT: 
Script completed
=====================================
12:43:02,071  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-AuditTables
RESULT: 
Script completed
=====================================
12:43:02,071  INFO  [admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.3-JBPM-Extra
RESULT: 
Script completed
=====================================
12:43:02,086 User:System INFO  [repo.module.ModuleServiceImpl] Found 1 module(s).
12:43:02,120 User:System INFO  [repo.module.ModuleServiceImpl] Installing module 'org.alfresco.module.vti' version 1.2.
12:43:02,223  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
12:43:02,251  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:03,001  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
12:43:03,163  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:03,316  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
12:43:03,648  ERROR [org.alfresco.fileserver] Failed to get local domain/workgroup name, using default of WORKGROUP
12:43:03,648  ERROR [org.alfresco.fileserver] (This may be due to firewall settings or incorrect <broadcast> setting)
12:43:04,164  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
12:43:04,164  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
12:43:04,181  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:04,357  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
12:43:04,360  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
12:43:04,374  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:04,443  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
12:43:04,444  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
12:43:04,461  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:04,616  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]
12:43:04,616  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
12:43:04,634  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
12:43:04,635  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
12:43:04,659  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:05,173  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
12:43:06,728  INFO  [repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
12:43:06,735  INFO  [repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
12:43:06,736  INFO  [repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
12:43:06,736  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
12:43:06,750  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:06,883  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
12:43:07,041  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 494,938MB
12:43:07,041  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 494,938MB is less than recommended 512MB
12:43:07,041  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
12:43:07,044  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
12:43:07,056  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
12:43:07,064  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
12:43:12,029  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
12:43:26,679 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 370 Web Scripts (+0 failed), 611 URLs
12:43:26,679 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
12:43:26,679 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
12:43:26,681 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 14394.061ms)
12:43:26,682  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
12:43:26,684  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 12:43:29 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire host-manager de l'application web
3 nov. 2010 12:43:30 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire docs de l'application web
3 nov. 2010 12:43:30 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire manager de l'application web
3 nov. 2010 12:43:30 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire examples de l'application web
3 nov. 2010 12:43:31 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire ROOT de l'application web
3 nov. 2010 12:43:31 org.apache.coyote.http11.Http11Protocol start
INFO: Démarrage de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 12:43:33 org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
3 nov. 2010 12:43:33 org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/159  config=null
3 nov. 2010 12:43:33 org.apache.catalina.startup.Catalina start
INFO: Server startup in 163822 ms
3 nov. 2010 13:34:41 org.apache.coyote.http11.Http11Protocol pause
INFO: Suspension de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 13:34:42 org.apache.catalina.core.StandardService stop
INFO: Arrêt du service Catalina
13:34:43,671  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'googledocs' subsystem, ID: [googledocs, default]
13:34:43,672  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'googledocs' subsystem, ID: [googledocs, default]
13:34:43,672  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'email' subsystem, ID: [email, inbound]
13:34:43,673  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'email' subsystem, ID: [email, inbound]
13:34:43,875  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Replication' subsystem, ID: [Replication, default]
13:34:43,875  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Replication' subsystem, ID: [Replication, default]
13:34:43,886  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
13:34:43,886  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
13:34:43,887  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'fileServers' subsystem, ID: [fileServers, default]
13:34:44,666  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'fileServers' subsystem, ID: [fileServers, default]
13:34:44,666  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:34:44,671  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:34:44,671  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'email' subsystem, ID: [email, outbound]
13:34:44,672  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'email' subsystem, ID: [email, outbound]
13:34:44,672  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'imap' subsystem, ID: [imap, default]
13:34:44,672  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'imap' subsystem, ID: [imap, default]
13:34:44,697  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
13:34:44,697  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
13:34:44,714  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:34:44,715  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:34:44,715  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
13:34:44,715  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
GRAVE: A web application 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.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesStopTimerThread
GRAVE: A web application appears to have started a TimerThread named [Timer-1] via the java.util.Timer API but has failed to stop it. To prevent a memory leak, the timer (and hence the associated thread) has been forcibly cancelled. 
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [process reaper] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [Thread-19] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [Thread-20] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [AlfJLANWorker1] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [AlfJLANWorker2] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
…
GRAVE: A web application appears to have started a thread named [TimedRequestProcessor] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [indexThread1] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [indexThread2] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
…
3 nov. 2010 13:34:44 org.apache.catalina.loader.WebappClassLoader clearThreadLocalMap
GRAVE: A web application created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@50c6dd]) and a value of type [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory.ReferenceCountingReadOnlyIndexReader] (value [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@ed9837]) but failed to remove it when the web application was stopped. To prevent a memory leak, the ThreadLocal has been forcibly removed.
…
…
3 nov. 2010 13:34:50 org.apache.coyote.http11.Http11Protocol destroy
INFO: Arrêt de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 13:47:35 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: /opt/alfresco/alf/java/jre/lib/i386/client:/opt/alfresco/alf/java/jre/lib/i386:/opt/alfresco/alf/java/jre/../lib/i386:/opt/alfresco/alf/mysql/lib:/opt/alfresco/alf/common/lib::/usr/java/packages/lib/i386:/lib:/usr/lib
3 nov. 2010 13:47:36 org.apache.coyote.http11.Http11Protocol init
INFO: Initialisation de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 13:47:36 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1918 ms
3 nov. 2010 13:47:36 org.apache.catalina.core.StandardService start
INFO: Démarrage du service Catalina
3 nov. 2010 13:47:36 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
3 nov. 2010 13:47:36 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration alfresco.xml
3 nov. 2010 13:47:38 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.
13:47:47,810  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
13:47:47,820  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
13:47:47,821  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
13:47:47,822  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
13:47:47,823  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
13:47:48,694  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:13,573  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
13:48:13,582  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
13:48:24,273  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
13:48:24,273  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
13:48:24,297  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
13:48:24,346  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:24,385  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
13:48:28,460  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
13:48:28,480  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:29,444  ERROR [transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 10030000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/alf/common/bin/convert, /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_7600290199984657570.gif[0], /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_1818164675628334960.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_7600290199984657570.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfres
13:48:29,461  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
13:48:29,464  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:48:29,532  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:30,585  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
13:48:31,942  INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf/alf_data
13:48:31,991  INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
13:48:33,464  INFO  [admin.patch.PatchExecuter] No patches were required.
13:48:33,504 User:System INFO  [repo.module.ModuleServiceImpl] Found 1 module(s).
13:48:33,805 User:System INFO  [repo.module.ModuleServiceImpl] Starting module 'org.alfresco.module.vti' version 1.2.
13:48:33,904  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
13:48:34,016  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:36,594  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:48:36,658  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:37,041  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
13:48:37,071  ERROR [org.alfresco.fileserver] Failed to get local domain/workgroup name, using default of WORKGROUP
13:48:37,071  ERROR [org.alfresco.fileserver] (This may be due to firewall settings or incorrect <broadcast> setting)
13:48:37,359  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
13:48:37,360  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
13:48:37,381  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:37,479  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
13:48:37,479  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
13:48:37,498  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:37,568  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
13:48:37,568  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
13:48:37,587  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:37,744  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]
13:48:37,744  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
13:48:37,764  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
13:48:37,764  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
13:48:37,793  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:38,293  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
13:48:38,320  INFO  [repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
13:48:38,333  INFO  [repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
13:48:38,333  INFO  [repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
13:48:38,334  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
13:48:38,350  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:38,500  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
13:48:38,647  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 494,938MB
13:48:38,647  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 494,938MB is less than recommended 512MB
13:48:38,648  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
13:48:38,649  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
13:48:38,661  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:48:38,668  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
13:48:46,287  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
13:49:00,363 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 370 Web Scripts (+0 failed), 611 URLs
13:49:00,363 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
13:49:00,363 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
13:49:00,363 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 13822.522ms)
13:49:00,363  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
13:49:00,363  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 13:49:03 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration manager.xml
3 nov. 2010 13:49:03 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration host-manager.xml
3 nov. 2010 13:49:03 org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive share.war de l'application web
13:49:15,141  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 256 Web Scripts (+0 failed), 264 URLs
13:49:15,143  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
13:49:15,143  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
13:49:15,259  INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 3033.3452ms)
13:49:15,356  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
13:49:15,630  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
13:49:15,784  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
13:49:15,795  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
13:49:16,099  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
13:49:16,106  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 13:49:19 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire docs de l'application web
3 nov. 2010 13:49:19 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire examples de l'application web
3 nov. 2010 13:49:19 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire ROOT de l'application web
3 nov. 2010 13:49:19 org.apache.coyote.http11.Http11Protocol start
INFO: Démarrage de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 13:49:19 org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
3 nov. 2010 13:49:19 org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/34  config=null
3 nov. 2010 13:49:19 org.apache.catalina.startup.Catalina start
INFO: Server startup in 103480 ms
3 nov. 2010 13:53:16 org.apache.coyote.http11.Http11Protocol pause
INFO: Suspension de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 13:53:17 org.apache.catalina.core.StandardService stop
INFO: Arrêt du service Catalina
13:53:18,590  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'googledocs' subsystem, ID: [googledocs, default]
13:53:18,590  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'googledocs' subsystem, ID: [googledocs, default]
13:53:18,590  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'email' subsystem, ID: [email, inbound]
13:53:18,591  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'email' subsystem, ID: [email, inbound]
13:53:18,660  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Replication' subsystem, ID: [Replication, default]
13:53:18,661  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Replication' subsystem, ID: [Replication, default]
13:53:18,670  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
13:53:18,671  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
13:53:18,671  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'fileServers' subsystem, ID: [fileServers, default]
13:53:19,302  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'fileServers' subsystem, ID: [fileServers, default]
13:53:19,303  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:53:19,310  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:53:19,310  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'email' subsystem, ID: [email, outbound]
13:53:19,311  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'email' subsystem, ID: [email, outbound]
13:53:19,311  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'imap' subsystem, ID: [imap, default]
13:53:19,311  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'imap' subsystem, ID: [imap, default]
13:53:19,333  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
13:53:19,333  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
13:53:19,344  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:53:19,345  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:53:19,345  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
13:53:19,345  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application 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.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesStopTimerThread
GRAVE: A web application appears to have started a TimerThread named [Timer-0] via the java.util.Timer API but has failed to stop it. To prevent a memory leak, the timer (and hence the associated thread) has been forcibly cancelled. 
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesStopTimerThread
GRAVE: A web application appears to have started a TimerThread named [Timer-1] via the java.util.Timer API but has failed to stop it. To prevent a memory leak, the timer (and hence the associated thread) has been forcibly cancelled. 
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [process reaper] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [Thread-19] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
GRAVE: A web application appears to have started a thread named [Thread-20] but has failed to stop it. This is very likely to create a memory leak.
3 nov. 2010 13:53:19 org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
…
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /opt/alfresco/alf/java/jre/lib/i386/client:/opt/alfresco/alf/java/jre/lib/i386:/opt/alfresco/alf/java/jre/../lib/i386:/opt/alfresco/alf/mysql/lib:/opt/alfresco/alf/common/lib::/usr/java/packages/lib/i386:/lib:/usr/lib
Nov 3, 2010 1:57:24 PM org.apache.coyote.http11.Http11Protocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
Nov 3, 2010 1:57:24 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 5708 ms
Nov 3, 2010 1:57:24 PM org.apache.coyote.http11.Http11Protocol init
SEVERE: Error initializing endpoint
java.net.BindException: Address already in use <null>:8080
   at org.apache.tomcat.util.net.JIoEndpoint.init(JIoEndpoint.java:549)
   at org.apache.coyote.http11.Http11Protocol.init(Http11Protocol.java:176)
   at org.apache.catalina.connector.Connector.initialize(Connector.java:1014)
   at org.apache.catalina.core.StandardService.initialize(StandardService.java:680)
   at org.apache.catalina.core.StandardServer.initialize(StandardServer.java:795)
   at org.apache.catalina.startup.Catalina.load(Catalina.java:524)
   at org.apache.catalina.startup.Catalina.load(Catalina.java:548)
   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.load(Bootstrap.java:261)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
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:141)
   at org.apache.tomcat.util.net.DefaultServerSocketFactory.createSocket(DefaultServerSocketFactory.java:50)
   at org.apache.tomcat.util.net.JIoEndpoint.init(JIoEndpoint.java:538)
   … 12 more
Nov 3, 2010 1:57:24 PM org.apache.catalina.startup.Catalina load
SEVERE: Catalina.start
LifecycleException:  Protocol handler initialization failed: java.net.BindException: Address already in use <null>:8080
   at org.apache.catalina.connector.Connector.initialize(Connector.java:1016)
   at org.apache.catalina.core.StandardService.initialize(StandardService.java:680)
   at org.apache.catalina.core.StandardServer.initialize(StandardServer.java:795)
   at org.apache.catalina.startup.Catalina.load(Catalina.java:524)
   at org.apache.catalina.startup.Catalina.load(Catalina.java:548)
   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.load(Bootstrap.java:261)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
Nov 3, 2010 1:57:24 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 5784 ms
Nov 3, 2010 1:57:24 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Nov 3, 2010 1:57:24 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
Nov 3, 2010 1:57:24 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor alfresco.xml
Nov 3, 2010 1:57:24 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Nov 3, 2010 1:57:24 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
Nov 3, 2010 1:57:24 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor alfresco.xml
Nov 3, 2010 1:57:36 PM 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.
Nov 3, 2010 1:57:36 PM 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.
13:57:59,313  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
13:57:59,343  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
13:57:59,372  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
13:57:59,394  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
13:57:59,395  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
13:58:00,121  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:29,119  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
13:58:29,127  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
13:58:29,129  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
13:58:29,130  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
13:58:29,130  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
13:58:29,443  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:21,685  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
13:59:21,689  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
java.net.UnknownHostException: basename
   at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:177)
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:366)
   at java.net.Socket.connect(Socket.java:525)
   at java.net.Socket.connect(Socket.java:475)
   at sun.net.NetworkClient.doConnect(NetworkClient.java:163)
   at sun.net.NetworkClient.openServer(NetworkClient.java:118)
   at sun.net.ftp.FtpClient.openServer(FtpClient.java:488)
   at sun.net.ftp.FtpClient.openServer(FtpClient.java:475)
   at sun.net.www.protocol.ftp.FtpURLConnection.connect(FtpURLConnection.java:270)
   at sun.net.www.protocol.ftp.FtpURLConnection.getInputStream(FtpURLConnection.java:352)
   at java.net.URL.openStream(URL.java:1010)
   at org.apache.xml.resolver.Catalog.parseCatalogFile(Unknown Source)
   at org.apache.xml.resolver.Catalog.parsePendingCatalogs(Unknown Source)
   at org.apache.xml.resolver.Catalog.parseCatalog(Unknown Source)
   at org.apache.xml.resolver.Catalog.loadSystemCatalogs(Unknown Source)
   at org.apache.xml.resolver.CatalogManager.getPrivateCatalog(Unknown Source)
   at org.apache.xml.resolver.CatalogManager.getCatalog(Unknown Source)
   at org.apache.xml.resolver.tools.CatalogResolver.initializeCatalogs(Unknown Source)
   at org.apache.xml.resolver.tools.CatalogResolver.<init>(Unknown Source)
   at org.apache.cxf.catalog.OASISCatalogManager.getResolver(OASISCatalogManager.java:69)
   at org.apache.cxf.catalog.OASISCatalogManager.<init>(OASISCatalogManager.java:58)
   at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
   at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
   at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
   at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
   at org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:126)
   at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:72)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:938)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:890)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:479)
   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)
13:59:33,233  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
13:59:34,642  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
13:59:34,862  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
13:59:34,883  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:34,907  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
13:59:38,663  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
13:59:38,701  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:40,138  ERROR [transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 10030000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/alf/common/bin/convert, /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_5560920479548476890.gif[0], /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_8218567698054644601.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_5560920479548476890.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfres
13:59:40,138  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
13:59:40,138  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
13:59:40,138  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:41,052  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
13:59:42,258  INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf/alf_data
13:59:43,496  INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
13:59:45,099  INFO  [admin.patch.PatchExecuter] No patches were required.
13:59:45,170 User:System INFO  [repo.module.ModuleServiceImpl] Found 1 module(s).
13:59:45,423 User:System INFO  [repo.module.ModuleServiceImpl] Starting module 'org.alfresco.module.vti' version 1.2.
13:59:45,506  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
13:59:45,815  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:47,868  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
13:59:48,044  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:48,807  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
13:59:48,876  ERROR [org.alfresco.fileserver] Failed to get local domain/workgroup name, using default of WORKGROUP
13:59:48,876  ERROR [org.alfresco.fileserver] (This may be due to firewall settings or incorrect <broadcast> setting)
13:59:49,029  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
13:59:49,029  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
13:59:49,158  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:49,193  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
13:59:49,193  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
13:59:49,193  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:49,267  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
13:59:49,268  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
13:59:49,293  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:49,446  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]
13:59:49,447  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
13:59:49,470  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
13:59:49,471  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
13:59:49,536  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:50,766  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
13:59:50,835  INFO  [repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
13:59:50,866  INFO  [repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
13:59:50,866  INFO  [repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
13:59:50,866  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
13:59:50,954  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:51,226  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
13:59:51,439  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 494.938MB
13:59:51,439  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 494.938MB is less than recommended 512MB
13:59:51,440  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
13:59:51,446  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
13:59:51,574  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:59:51,596  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
13:59:52,929  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
14:00:07,940 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 370 Web Scripts (+0 failed), 611 URLs
14:00:07,940 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
14:00:07,940 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
14:00:07,940 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 14066.597ms)
14:00:07,940  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:00:07,940  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
Nov 3, 2010 2:00:09 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor manager.xml
Nov 3, 2010 2:00:09 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor host-manager.xml
Nov 3, 2010 2:00:09 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive share.war
14:00:21,034  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 256 Web Scripts (+0 failed), 264 URLs
14:00:21,039  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
14:00:21,039  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
14:00:21,350  INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 2823.292ms)
14:00:21,580  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:00:21,976  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
14:00:22,440  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:00:22,459  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
14:00:22,845  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:00:22,854  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
Nov 3, 2010 2:00:25 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory docs
Nov 3, 2010 2:00:25 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory examples
Nov 3, 2010 2:00:25 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory ROOT
Nov 3, 2010 2:00:25 PM org.apache.coyote.http11.Http11Protocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
Nov 3, 2010 2:00:25 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
Nov 3, 2010 2:00:25 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/46  config=null
Nov 3, 2010 2:00:25 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 181811 ms
Nov 3, 2010 2:13:48 PM org.apache.coyote.http11.Http11Protocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
Nov 3, 2010 2:13:49 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
14:13:52,822  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'googledocs' subsystem, ID: [googledocs, default]
14:13:52,822  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'googledocs' subsystem, ID: [googledocs, default]
14:13:52,822  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'email' subsystem, ID: [email, inbound]
14:13:52,824  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'email' subsystem, ID: [email, inbound]
14:13:53,017  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Replication' subsystem, ID: [Replication, default]
14:13:53,020  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Replication' subsystem, ID: [Replication, default]
14:13:53,020  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
14:13:53,020  INFO  [management.subsystems.ChildApplicationContextFactory] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
14:13:53,020  INFO  [management.subsystems.ChildApplicationContextFactory] Stopping 'fileServers' subsystem, ID: [fileServers, default]
3 nov. 2010 14:16:11 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: /opt/alfresco/alf/java/jre/lib/i386/client:/opt/alfresco/alf/java/jre/lib/i386:/opt/alfresco/alf/java/jre/../lib/i386:/opt/alfresco/alf/mysql/lib:/opt/alfresco/alf/common/lib::/usr/java/packages/lib/i386:/lib:/usr/lib
3 nov. 2010 14:16:12 org.apache.coyote.http11.Http11Protocol init
INFO: Initialisation de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 14:16:12 org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1265 ms
3 nov. 2010 14:16:12 org.apache.catalina.core.StandardService start
INFO: Démarrage du service Catalina
3 nov. 2010 14:16:12 org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/6.0.26
3 nov. 2010 14:16:12 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration alfresco.xml
3 nov. 2010 14:16:15 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.
14:16:23,066  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
14:16:23,069  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
14:16:23,069  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/test/alfresco-global.properties]
14:16:23,070  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [/opt/alfresco/alf/tomcat/webapps/alfresco/WEB-INF/classes/alfresco/module/tests/alfresco-global.properties]
14:16:23,070  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties]
14:16:23,411  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:16:54,753  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
14:16:54,757  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
14:17:09,378  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
14:17:09,798  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
14:17:09,892  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
14:17:09,908  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:09,921  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
14:17:13,602  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
14:17:13,618  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:14,676  ERROR [transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 10030000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [/opt/alfresco/alf/common/bin/convert, /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_5278259134269785826.gif[0], /opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_9191755664799581794.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        .convert.bin: no decode delegate for this image format `/opt/alfresco/alf/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_5278259134269785826.gif' @ constitute.c/ReadImage/526.
.convert.bin: missing an image filename `/opt/alfres
14:17:14,690  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
14:17:14,690  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
14:17:14,712  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:16,229  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
14:17:17,502  INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf/alf_data
14:17:17,653  INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
14:17:19,291  INFO  [admin.patch.PatchExecuter] No patches were required.
14:17:19,306 User:System INFO  [repo.module.ModuleServiceImpl] Found 1 module(s).
14:17:19,363 User:System INFO  [repo.module.ModuleServiceImpl] Starting module 'org.alfresco.module.vti' version 1.2.
14:17:19,396  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
14:17:19,428  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:21,265  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
14:17:21,292  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:21,564  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
14:17:21,592  ERROR [org.alfresco.fileserver] Failed to get local domain/workgroup name, using default of WORKGROUP
14:17:21,592  ERROR [org.alfresco.fileserver] (This may be due to firewall settings or incorrect <broadcast> setting)
14:17:21,753  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
14:17:21,753  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
14:17:21,770  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:21,958  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
14:17:21,959  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
14:17:21,976  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:22,060  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
14:17:22,060  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
14:17:22,086  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:22,160  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]
14:17:22,160  WARN  [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]
14:17:22,183  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
14:17:22,183  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
14:17:22,218  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:23,251  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
14:17:23,339  INFO  [repo.usage.UserUsageTrackingComponent] Enabled - calculate missing user usages …
14:17:23,463  INFO  [repo.usage.UserUsageTrackingComponent] Found 0 users to recalculate
14:17:23,463  INFO  [repo.usage.UserUsageTrackingComponent] … calculated missing usages for 0 users
14:17:23,464  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
14:17:23,507  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:23,763  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
14:17:23,999  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 494,938MB
14:17:24,000  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 494,938MB is less than recommended 512MB
14:17:24,000  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
14:17:24,001  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
14:17:24,016  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
14:17:24,024  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
14:17:24,557  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
14:17:42,189 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 370 Web Scripts (+0 failed), 611 URLs
14:17:42,189 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
14:17:42,189 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
14:17:42,197 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 17307.816ms)
14:17:42,198  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:17:42,199  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 14:17:44 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration manager.xml
3 nov. 2010 14:17:44 org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration host-manager.xml
3 nov. 2010 14:17:44 org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive share.war de l'application web
14:17:55,515  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 256 Web Scripts (+0 failed), 264 URLs
14:17:55,517  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
14:17:55,517  INFO  [extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
14:17:55,637  INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 3436.4878ms)
14:17:55,800  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:17:55,800  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
14:17:55,908  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:17:55,908  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
14:17:55,992  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
14:17:55,992  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
3 nov. 2010 14:17:59 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire docs de l'application web
3 nov. 2010 14:17:59 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire examples de l'application web
3 nov. 2010 14:18:00 org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire ROOT de l'application web
3 nov. 2010 14:18:00 org.apache.coyote.http11.Http11Protocol start
INFO: Démarrage de Coyote HTTP/1.1 sur http-8080
3 nov. 2010 14:18:00 org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
3 nov. 2010 14:18:01 org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/603  config=null
3 nov. 2010 14:18:01 org.apache.catalina.startup.Catalina start
INFO: Server startup in 108888 ms
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

Je propose de cloturer ce post. Il reste néanmoins 2 questions :
1) Incapacité à monter le heap size
2) Pourquoi Alfresco redémarre seul après un reboot avec normalement les services à "non". 
+ quelques autres points qui feront l'objet d'autre post.

Merci à tous.

[onyme]

Bonjour,

Alors que je croyais le problème résolu, je repris les tests. Lors d'un redémarrage de la VM, Alfresco a présenté  les mêmes symptômes que précédemment.  De manière très surprenante il semblerait que la heap size a changée :

10:16:31,203  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
10:16:31,248  INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_18-b07; maximum heap size 247,500MB
10:16:31,248  WARN  [service.descriptor.DescriptorService] Alfresco JVM - WARNING - maximum heap size 247,500MB is less than recommended 512MB
10:16:31,249  INFO  [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (a 3169) schema 4111 - Originally installed version 3.4.0 (a 3169) schema 4111
10:16:31,250  INFO  [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
10:16:31,264  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
10:16:31,272  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
10:16:32,873  INFO  [module.vti.VtiServer] Vti server started successfully on port: 7070
10:16:58,243 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 370 Web Scripts (+0 failed), 611 URLs
10:16:58,243 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
10:16:58,244 User:System INFO  [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
10:16:58,248 User:System INFO  [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 24910.506ms)
10:16:58,249  INFO  [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
10:16:58,253  INFO  [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
java.lang.reflect.InvocationTargetException
   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)
Exception in thread "main" java.lang.OutOfMemoryError: PermGen space
Java HotSpot(TM) Client VM warning: Exception java.lang.OutOfMemoryError occurred dispatching signal SIGTERM to handler- the VM may need to be forcibly terminated
Exception in thread "DefaultScheduler_Worker-5" java.lang.OutOfMemoryError: PermGen space
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

.

Sur le panel control de Java les paramètre du JRE sont : -Xmx512m

Dans le fichier /opt/alfresco/alf/tomcat/scripts/ctl.sh le paramétrage est le suivant :

export JAVA_OPTS="-XX:MaxPermSize=512m -Xms512m -Xmx512m"
    export JAVA_HOME=$JRE_HOME
    $TOMCAT_BINDIR/startup.sh 
‍‍‍‍

Ayant vu sur le forum (EN) que le paramétrage JAVA_OPTS peut être mis sur le /opt/alfresco/alf/tomcat/shared/classes/alfresco-global.properties j'ai fait l'essai qui est vain.

Bien cordialement.