topic Re: Alfresco 3.2 community and Jboss 4.2.3 GA in Alfresco Archive

Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Mon, 26 Oct 2009 00:54:35 GMT

I have an Alfresco 2.1 installation (community) with no customizations working fine in JBoss 4.0.5GA with JDK 1.5.0_x on FC4 but I need to upgrade Alfresco 2.1 to 3.2. Alfresco is one of 4 applications in this JBoss. Here's what I did, following the instructions in the wiki (http://wiki.alfresco.com

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

varsenault — Mon, 26 Oct 2009 19:04:15 GMT

Hi,

We are upgrading from Alfresco 3.0 CE to 3.2r CE. We are getting the same error (you can find below the complete startup log). We are not using JBoss but Tomcat.

13:39:40,387 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
13:39:40,389 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
13:39:40,389 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/opt/Alfresco3/tomcat/shared/classes/alfresco-global.properties]
13:39:40,453 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:39:52,504 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
13:39:58,771 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-1967587147919756619.sql (Copied from classpath:alfresco/dbscripts/upgrade/2.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoSchemaUpdate-Person.sql).
13:40:03,795 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-260022686606658569.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-LockTables.sql).
13:40:03,968 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-4639442404432880570.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-ContentTables.sql).
13:40:04,074 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-6246947482225375331.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-PropertyValueTables.sql).
13:40:04,325 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-4298167824623912476.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-AuditTables.sql).
13:40:06,878 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-7245033492526359529.sql (Generated).
13:40:08,413 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-7924746508798668917.sql (Copied from classpath:alfresco/dbscripts/upgrade/3.2/org.hibernate.dialect.MySQLInnoDBDialect/remove-AVM-issuer.sql).
13:40:08,538 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-1560248564746840133.sql (Copied from classpath:alfresco/dbscripts/upgrade/3.2/org.hibernate.dialect.MySQLInnoDBDialect/modify-AVM-mimetype.sql).
13:40:08,569 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-Update-592195967571513656.sql (Copied from classpath:alfresco/dbscripts/upgrade/3.2/org.hibernate.dialect.MySQLInnoDBDialect/jbpm-upgrade.sql).
13:40:08,663 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] All executed statements:  /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-All_Statements-8964299163492627963.sql.
13:40:12,464 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Normalized schema (pre-bootstrap)  dumped to file /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-914843302716512497-Startup.xml.
13:40:12,465 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Normalized schema (post-bootstrap) dumped to file /opt/Alfresco3/tomcat/temp/Alfresco/AlfrescoSchema-MySQLInnoDBDialect-1054351381434015463.xml.
13:40:14,141 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent] Index recovery started: 116,667 transactions.
13:40:15,279 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [default]
13:40:15,315 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:40:15,634 ERROR [org.alfresco.repo.content.transform.RuntimeExecutableContentTransformerWorker] Failed to start a runtime executable content transformer: 
Execution result: 
   os:         Linux
   command:    [./bin/pdf2swf, -V]
   succeeded:  false
   exit code:  1
   out:        
   err:        Cannot run program "./bin/pdf2swf": java.io.IOException: error=2, No such file or directory
13:40:15,735 ERROR [org.alfresco.repo.content.transform.magick.AbstractImageMagickContentTransformerWorker] ImageMagickContentTransformerWorker not available: 09260000 Failed to perform ImageMagick transformation: 
Execution result: 
   os:         Linux
   command:    [./ImageMagick/bin/convert, /opt/Alfresco3/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_source_6679780443302676071.gif[0], /opt/Alfresco3/tomcat/temp/Alfresco/ImageMagickContentTransformerWorker_init_target_7508618755027088785.png]
   succeeded:  false
   exit code:  1
   out:        
   err:        Cannot run program "./ImageMagick/bin/convert": java.io.IOException: error=2, No such file or directory
13:40:16,088 ERROR [org.alfresco.util.exec.RuntimeExecBootstrapBean] Bootstrap command failed: 
Execution result: 
   os:         Linux
   command:    [soffice, -accept=socket,host=localhost,port=8100;urp;StarOffice.ServiceManager, -env:UserInstallation=file:///data/alf_data/oouser, -nologo, -headless, -nofirststartwizard, -nocrashrep, -norestore]
   succeeded:  false
   exit code:  2
   out:        
   err:        Cannot run program "soffice": java.io.IOException: error=2, No such file or directory
13:40:16,141 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
13:40:16,141 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [default] complete
13:40:46,740 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    10 % complete.
13:41:09,081 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    20 % complete.
13:41:32,448 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    30 % complete.
13:41:56,509 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    40 % complete.
13:42:23,595 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    50 % complete.
13:42:50,551 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    60 % complete.
13:43:13,813 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    70 % complete.
13:45:09,389 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    80 % complete.
13:45:45,436 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    90 % complete.
13:46:12,756 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent]    100 % complete.
13:46:13,782 INFO  [org.alfresco.repo.node.index.FullIndexRecoveryComponent] Index recovery completed.
13:46:13,837 WARN  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Index for avm store investissementresponsable–rvendette is out of date
13:46:13,854 WARN  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Index for avm store investissementresponsable–rvendette–preview is out of date
13:46:13,864 WARN  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Index for avm store investissementresponsable–admin is out of date
13:46:13,877 WARN  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Index for avm store investissementresponsable–admin–preview is out of date
13:46:13,896 WARN  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Index for avm store investissementresponsable–preview is out of date
13:46:13,900 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent] Rebuilding indexes for 7 AVM Stores
13:46:13,900 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable–rvendette
13:46:13,903 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   10% complete
13:46:13,903 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable–rvendette–preview
13:46:13,905 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   20% complete
13:46:13,905 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable–admin
13:46:13,906 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   40% complete
13:46:13,906 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable–admin–preview
13:46:13,907 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   50% complete
13:46:13,907 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable
13:46:13,932 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]         Rebuilding index for snapshots 0 to 4
13:46:15,307 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   70% complete
13:46:15,307 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for investissementresponsable–preview
13:46:15,309 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   80% complete
13:46:15,309 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]     Rebuilding index for sitestore
13:46:15,327 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]         Rebuilding index for snapshots 0 to 1
13:46:15,350 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent]   Reindex   100% complete
13:46:15,350 INFO  [org.alfresco.repo.node.index.AVMFullIndexRecoveryComponent] Finished rebuilding indexes for AVM Stores
13:46:17,987 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /data/alf_data
13:46:17,999 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
13:46:18,108 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.redeploySubmitProcess5' (Re-deploy WCM Submit Process Definition.).
13:46:18,380 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.deploySubmitDirectProcess' (Deploy WCM Direct Submit Process Definition.).
13:46:18,461 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.zonedAuthorities' (Adds the remodelled cm:authority container to the spaces store).
13:46:18,926 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.resetWCMToGroupBasedPermissionsPatch' (Reset WCM to group based permissions.).
13:46:18,927 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Retrieved list of 7 AVM store descriptors in 0 secs
13:46:18,930 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Retrieved store types for 6 WCM stores in 0 secs
13:46:19,289 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Processed 1 WCM staging stores: 0 secs
13:46:19,349 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Nullified acls for 5 WCM sandbox stores: 0 secs
13:46:24,107 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Deleted dangling acls/aces across all stores in 4 secs
13:46:24,412 INFO  [org.alfresco.repo.admin.patch.impl.ResetWCMToGroupBasedPermissionsPatch] Processed 5 WCM sandbox stores: 0 secs
13:46:24,489 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.moveWCMToGroupBasedPermissionsPatch' (A placeholder patch; usually marks a superceded patch.).
13:46:24,492 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.wcmPostPermissionSnapshotPatch3' (Snapshot stores (after fixing ACLs so they are only set on the staging area store).).
13:46:24,494 ERROR [org.alfresco.repo.admin.patch.PatchExecuter] 09260002 com.ibatis.sqlmap.client.SqlMapException: There is no statement named select.AVMNodeEntitiesCountWhereNewInStore in this SqlMap.
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.getMappedStatement(SqlMapExecutorDelegate.java:231)
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.queryForObject(SqlMapExecutorDelegate.java:509)
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.queryForObject(SqlMapExecutorDelegate.java:493)
   at com.ibatis.sqlmap.engine.impl.SqlMapSessionImpl.queryForObject(SqlMapSessionImpl.java:106)
   at org.springframework.orm.ibatis.SqlMapClientTemplate$1.doInSqlMapClient(SqlMapClientTemplate.java:244)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.execute(SqlMapClientTemplate.java:194)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.queryForObject(SqlMapClientTemplate.java:242)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.queryForObject(SqlMapClientTemplate.java:236)
   at org.alfresco.repo.domain.patch.ibatis.PatchDAOImpl.getAVMNodeEntitiesCountWhereNewInStore(PatchDAOImpl.java:56)
   at org.alfresco.repo.domain.patch.AbstractPatchDAOImpl.getAVMNodesCountWhereNewInStore(AbstractPatchDAOImpl.java:44)
   at org.alfresco.repo.domain.hibernate.AclDaoComponentImpl.getNewInStore(AclDaoComponentImpl.java:2054)
   at org.alfresco.repo.admin.patch.impl.WCMPostPermissionSnapshotPatch.applyInternal(WCMPostPermissionSnapshotPatch.java:75)
   at org.alfresco.repo.admin.patch.AbstractPatch$1$1.execute(AbstractPatch.java:388)
   at org.alfresco.repo.admin.patch.AbstractPatch$1$1.execute(AbstractPatch.java:382)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:326)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:233)
   at org.alfresco.repo.admin.patch.AbstractPatch$1.doWork(AbstractPatch.java:414)
   at org.alfresco.repo.admin.patch.AbstractPatch$1.doWork(AbstractPatch.java:378)
   at org.alfresco.repo.security.authentication.AuthenticationUtil.runAs(AuthenticationUtil.java:503)
   at org.alfresco.repo.admin.patch.AbstractPatch.apply(AbstractPatch.java:418)
   at org.alfresco.repo.admin.patch.PatchServiceImpl.applyPatch(PatchServiceImpl.java:294)
   at org.alfresco.repo.admin.patch.PatchServiceImpl.access$200(PatchServiceImpl.java:56)
   at org.alfresco.repo.admin.patch.PatchServiceImpl$2.execute(PatchServiceImpl.java:231)
   at org.alfresco.repo.admin.patch.PatchServiceImpl$2.execute(PatchServiceImpl.java:229)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:326)
   at org.alfresco.repo.admin.patch.PatchServiceImpl.applyPatchAndDependencies(PatchServiceImpl.java:234)
   at org.alfresco.repo.admin.patch.PatchServiceImpl.applyPatchAndDependencies(PatchServiceImpl.java:219)
   at org.alfresco.repo.admin.patch.PatchServiceImpl.applyOutstandingPatches(PatchServiceImpl.java:168)
   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:304)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
   at $Proxy69.applyOutstandingPatches(Unknown Source)
   at org.alfresco.repo.admin.patch.PatchExecuter.applyOutstandingPatches(PatchExecuter.java:89)
   at org.alfresco.repo.admin.patch.PatchExecuter.onBootstrap(PatchExecuter.java:132)
   at org.alfresco.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:62)
   at org.springframework.context.event.SimpleApplicationEventMulticaster$1.run(SimpleApplicationEventMulticaster.java:77)
   at org.springframework.core.task.SyncTaskExecutor.execute(SyncTaskExecutor.java:49)
   at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:75)
   at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:246)
   at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:617)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:355)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:246)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:189)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:49)
   at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:69)
   at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3843)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4342)
   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:525)
   at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:627)
   at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488)
   at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1149)
   at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311)
   at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:117)
   at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
   at org.apache.catalina.core.StandardHost.start(StandardHost.java:719)
   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:516)
   at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:578)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)

13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V2.2-Person-3
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-AuditTables
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-ContentTables
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-LockTables
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-Modify-AVM-MimeType
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-PropertyValueTables
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-Remove-AVM-Issuer
RESULT: 
Script completed
=====================================
13:46:24,503 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-Upgrade-JBPM
RESULT: 
Script completed
=====================================
13:46:24,504 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.deploySubmitDirectProcess
RESULT: 
Re-deployed 1 workflows. 
=====================================
13:46:24,504 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.moveWCMToGroupBasedPermissionsPatch
RESULT: 
No-op patch
=====================================
13:46:24,504 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.redeploySubmitProcess5
RESULT: 
Re-deployed 1 workflows. 
=====================================
13:46:24,504 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.resetWCMToGroupBasedPermissionsPatch
RESULT: 
WCM reset to group based permissions.
=====================================
13:46:24,504 ERROR [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Failed to apply patch         === 
ID: patch.wcmPostPermissionSnapshotPatch3
RESULT: 
09260002 com.ibatis.sqlmap.client.SqlMapException: There is no statement named select.AVMNodeEntitiesCountWhereNewInStore in this SqlMap.
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.getMappedStatement(SqlMapExecutorDelegate.java:231)
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.queryForObject(SqlMapExecutorDelegate.java:509)
   at com.ibatis.sqlmap.engine.impl.SqlMapExecutorDelegate.queryForObject(SqlMapExecutorDelegate.java:493)
   at com.ibatis.sqlmap.engine.impl.SqlMapSessionImpl.queryForObject(SqlMapSessionImpl.java:106)
   at org.springframework.orm.ibatis.SqlMapClientTemplate$1.doInSqlMapClient(SqlMapClientTemplate.java:244)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.execute(SqlMapClientTemplate.java:194)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.queryForObject(SqlMapClientTemplate.java:242)
   at org.springframework.orm.ibatis.SqlMapClientTemplate.queryForObject(SqlMapClientTemplate.java:236)
   at org.alfresco.repo.domain.patch.ibatis.PatchDAOImpl.getAVMNo…
=====================================
13:46:24,504 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.zonedAuthorities
RESULT: 
Imported view into bootstrap location: /sys:system (workspace://SpacesStore/0094cf97-3f9d-11dc-a403-cbe9c48b606f)
=====================================
13:46:24,505 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.alfresco.error.AlfrescoRuntimeException: 09260003 Not all patches could be applied
   at org.alfresco.repo.admin.patch.PatchExecuter.applyOutstandingPatches(PatchExecuter.java:124)
   at org.alfresco.repo.admin.patch.PatchExecuter.onBootstrap(PatchExecuter.java:132)
   at org.alfresco.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:62)
   at org.springframework.context.event.SimpleApplicationEventMulticaster$1.run(SimpleApplicationEventMulticaster.java:77)
   at org.springframework.core.task.SyncTaskExecutor.execute(SyncTaskExecutor.java:49)
   at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:75)
   at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:246)
   at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:617)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:355)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:246)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:189)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:49)
   at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:69)
   at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3843)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4342)
   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:525)
   at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:627)
   at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488)
   at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1149)
   at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311)
   at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:117)
   at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
   at org.apache.catalina.core.StandardHost.start(StandardHost.java:719)
   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:516)
   at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:578)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
13:46:27,025 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
13:46:28,533 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

And if we restart Alfresco, we get this :

org.alfresco.error.AlfrescoRuntimeException: 09260002 The store 'avm://investissementresponsable' has a duplicate root node entry.
   at org.alfresco.repo.admin.ConfigurationChecker.check(ConfigurationChecker.java:268)
   at org.alfresco.repo.admin.ConfigurationChecker.access$000(ConfigurationChecker.java:72)
   at org.alfresco.repo.admin.ConfigurationChecker$1.execute(ConfigurationChecker.java:178)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:326)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:252)
   at org.alfresco.repo.admin.ConfigurationChecker.onBootstrap(ConfigurationChecker.java:182)
   at org.alfresco.util.AbstractLifecycleBean.onApplicationEvent(AbstractLifecycleBean.java:62)
   at org.springframework.context.event.SimpleApplicationEventMulticaster$1.run(SimpleApplicationEventMulticaster.java:77)
   at org.springframework.core.task.SyncTaskExecutor.execute(SyncTaskExecutor.java:49)
   at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:75)
   at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:246)
   at org.springframework.context.support.AbstractApplicationContext.finishRefresh(AbstractApplicationContext.java:617)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:355)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:246)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:189)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:49)
   at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:69)
   at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3843)
   at org.apache.catalina.core.StandardContext.start(StandardContext.java:4342)
   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:525)
   at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:627)
   at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:553)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:488)
   at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1149)
   at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:311)
   at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:117)
   at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
   at org.apache.catalina.core.StandardHost.start(StandardHost.java:719)
   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:516)
   at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
   at org.apache.catalina.startup.Catalina.start(Catalina.java:578)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:597)
   at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:288)
   at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:413)
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

If we could find an answer to this. That would be great to say the least!

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

vizir — Tue, 27 Oct 2009 19:40:14 GMT

Hi,

I'm migrating from Alfresco 2.1 HSQLDB to Alfresco 3.2 Mysql (on tomcat) and after a long long time trying to make it work I finally get into one of the last steps.

But when I tried to make a full index recovery (after all the scripts to migrate the DB worked apparently fine) I get this error :

20:26:41,946 User:System INFO  [admin.patch.PatchExecuter]      Applying patch 'patch.wcmPostPermissionSnapshotPatch3' (Snapshot stores (after fixing ACLs so they are only set on the staging area store).).
20:26:41,948 User:System ERROR [admin.patch.PatchExecuter] 09270001 com.ibatis.sqlmap.client.SqlMapException: There is no statement named select.AVMNodeEntitiesCountWhereNewInStore in this SqlMap.
‍‍‍

Any clue about this problem would be welcome

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Mon, 09 Nov 2009 02:05:32 GMT

I thought it might help to upgrade in steps. What I did so far is to take my previous 2.1 installation to 3.0 Stable which worked applying the procedure I listed above. I've seem similar problems to mine in the forum but so far no solution. I suppose that few people run into this situation. Does anybody know how to solve the problem of getting from 3.0 (or 2.1) to 3.2?

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

dward — Mon, 09 Nov 2009 14:02:32 GMT

Alfresco 3.2 is not supported on HSQLDB and there is no upgrade path for HSQLDB. If you have an enterprise license, please contact support for further information.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Tue, 10 Nov 2009 02:51:14 GMT

I'm using MySql as can be seen in the original post. The part about HSQLDB came in from another person that posted a similar problem in this thread. It would be great if you could post what could be the origin of this problem or where to look for a solution.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

dward — Tue, 10 Nov 2009 08:47:09 GMT

Do you have a strange setting for the hibernate.dialect property? Please make sure hibernate.dialect isn't set in any of your properties files and let the system auto-detect it.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Tue, 10 Nov 2009 23:58:30 GMT

Thanks for the idea. I have a custom-hibernate-dialect.properties file where the only uncommented line is:

hibernate.dialect=org.hibernate.dialect.MySQLInnoDBDialect

Do you mean that I should comment this line?

In custom-repository.properties I have this line for the database connection:

db.driver=org.gjt.mm.mysql.Driver
db.url=jdbc:mysql://localhost/alfresco

My custom-repository-context.xml has this part:


    <bean id="hibernateConfigProperties" class="org.springframework.beans.factory.config.PropertiesFactoryBean">
        <property name="locations">
            <list>
                <value>classpath:alfresco/domain/hibernate-cfg.properties</value>

                <!– Override hibernate dialect –>
                <value>classpath:alfresco/extension/custom-hibernate-dialect.properties</value>
            </list>
        </property>
    </bean>
‍‍‍‍‍‍‍‍‍‍‍‍

I assume that I should also remove this override. Is this so?

I haven't changed anything in the war file.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

dward — Wed, 11 Nov 2009 11:35:43 GMT

Please remove your repository-properties and hibernateConfigProperties bean definitions from custom-repository-context.xml and try putting all your custom property settings in jboss/server/default/conf/alfresco-global.properties. This is the new way of setting custom properties. Don't know why it's not working the old way though.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Thu, 12 Nov 2009 17:10:22 GMT

Ok, thanks a lot. I'll give this a try and post back.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

kbonnet — Thu, 12 Nov 2009 20:47:11 GMT

I'm upgrading from 3.0.0 CE to 3.2r and running into this same error. I dont have any extensions yet; all config coming from alfresco-global.properties.

Any clues?

Koen

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

kbonnet — Thu, 12 Nov 2009 20:57:02 GMT

Hey People,

A workaround for this bug has been posted on JIRA:

https://issues.alfresco.com/jira/browse/ALFCOM-3611

It worked for me at least, running on CentOS 5.3, JDK6, Tomcat6, Alfresco 3.2R.

Good luck!

Koen

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Fri, 13 Nov 2009 03:31:44 GMT

I tried it with the workaround in JIRA and that error went away. Thanks a lot!

I now have a different problem. My index recovery mode was set o VALIDATE and during deploymet of alfresco.war (3.2r) I go the

Context initialization failed java.lang.RuntimeException: Error during run with lock.

problem. I think I solved that one by setting -Xss1024k in my JAVA_OPTS by following some threads in the forum. I also set the reindex option to FULL. When I start again it seems to run pretty well and Alfresco is deployed. But I see this in the log:


8,907 INFO  [STDOUT] 00:56:18,907  INFO  [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [default]
5,937 INFO  [STDOUT] 00:57:15,937 User:System INFO  [node.index.FullIndexRecoveryComponent]   50 % complete.
5,995 INFO  [STDOUT] 00:57:15,995 User:System INFO  [node.index.FullIndexRecoveryComponent]   60 % complete.
6,098 INFO  [STDOUT] 00:57:16,001 User:System INFO  [node.index.FullIndexRecoveryComponent]   70 % complete.
6,099 INFO  [STDOUT] 00:57:16,099 User:System INFO  [node.index.FullIndexRecoveryComponent]   80 % complete.
3,283 INFO  [STDOUT] 00:57:33,261  ERROR [index.AbstractReindexComponent.threads] Reindexer    17 failed with error: Error during run with lock.
3,350 INFO  [STDOUT] 00:57:33,318  ERROR [index.AbstractReindexComponent.threads] Reindexer    18 failed with error: Error during run with lock.
3,352 INFO  [STDOUT] 00:57:33,352  ERROR [index.AbstractReindexComponent.threads] Reindexer    19 failed with error: Error during run with lock.
3,353 INFO  [STDOUT] 00:57:33,353  ERROR [index.AbstractReindexComponent.threads] Reindexer    20 failed with error: Error during run with lock.
3,853 INFO  [STDOUT] 00:57:33,853 User:System INFO  [node.index.FullIndexRecoveryComponent]   90 % complete.
3,862 INFO  [STDOUT] 00:57:33,862 User:System INFO  [node.index.FullIndexRecoveryComponent]   100 % complete.
9,795 INFO  [STDOUT] 00:57:39,795  ERROR [index.AbstractReindexComponent.threads] Reindexer    23 failed with error: Error during run with lock.
9,863 INFO  [STDOUT] 00:57:39,863  ERROR [index.AbstractReindexComponent.threads] Reindexer    24 failed with error: Error during run with lock.
0,031 INFO  [STDOUT] 00:57:40,031 User:System INFO  [node.index.FullIndexRecoveryComponent] Index recovery completed.
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

To me it looks like reindexing is still failing. I then tried it again with -Xss2048k just in case but there was no change.

Does anybody know how to correct that one?

Thanks.

Re: Alfresco 3.2 community and Jboss 4.2.3 GA

konsultex — Wed, 30 Dec 2009 00:27:17 GMT

I finally solved the problem with the indexes together with another one I had. It's not really related to the original problem but I think all these threads should be closed, so in case anyone has a similar problem, here's what I did:

http://forums.alfresco.com/en/viewtopic.php?f=8&t=23755&p=78599#p78599