AnsweredAssumed Answered

[Résolu] 'Error during run with lock' après exec. projet SVN

Question asked by showky on May 5, 2009
Latest reply on Dec 11, 2009 by soundscape
Bonjour !
j'ai déjà posté le problème sur le forum anglais dans la même section hier mais je pense qu'un peu d'aide du côté Français sera la bienvenue aussi (d'autant que je n'ai pas eu de réponse et que c'est un tantinet urgent ^^')

Donc voila, j'ai installé la version Alfresco-Labs 3Stable Full 3.0.0 build 1526. J'ai installé via l'exécutable téléchargeable. Jusqu'à présent je développais grâce au SDK (3 Stable), tout fonctionnait bien.

J'ai installé récemment la version SVN du kit du développement, j'ai suivis les instructions, etc, et tout semble être bien installé et importé dans Eclipse. Il se passe alors quelque chose de bizarre quand je lance le projet SDK FirstClientFoundation : lorsque je le runnais avec le SDK, j'avais la sortie console (dans Eclipse) suivante :

17:43:22,093  INFO  [config.xml.XMLConfigService$PropertyConfigurer] Loading properties file from class path resource [alfresco/file-servers.properties]
17:43:24,859  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
17:43:25,531  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
17:43:27,109 User:System INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: C:\Alfresco\alf_data
17:43:27,140 User:System INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
17:43:27,296 User:System INFO  [admin.patch.PatchExecuter] No patches were required.
17:43:27,296 User:System INFO  [repo.module.ModuleServiceImpl] Found 0 module(s).
17:43:27,343 User:System WARN  [repo.module.ModuleServiceImpl] A previously-installed module 'org.alfresco.module.vti' (version 1.0) is not present in your distribution.
17:43:28,562 User:System WARN  [alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
17:43:28,609 User:System INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_13-b03; maximum heap size 1016,125MB
17:43:28,609 User:System INFO  [service.descriptor.DescriptorService] Alfresco started (Labs): Current version 3.0.0 (Stable 1526) schema 1002 - Installed version 3.0.0 (Stable 1526) schema 1002

Si je relance Alfresco, tout est OK.

Lorsque j'exécute pour la première fois le même projet, provenant de la version SVN :

17:47:22,593  INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
17:47:23,343  INFO  [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/hibernate-cfg.properties]
17:47:35,828  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
17:47:36,937  INFO  [domain.schema.SchemaBootstrap] Executing database script C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-8669142084738288324.sql (Copied from classpath:alfresco/dbscripts/upgrade/2.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoSchemaUpdate-Person.sql).
17:47:37,046  INFO  [domain.schema.SchemaBootstrap] Executing database script C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-7615510242104074000.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-LockTables.sql).
17:47:37,921  INFO  [domain.schema.SchemaBootstrap] Executing database script C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-2701564815722804772.sql (Copied from classpath:alfresco/dbscripts/upgrade/3.2/org.hibernate.dialect.MySQLInnoDBDialect/remove-AVM-issuer.sql).
17:47:38,375  INFO  [domain.schema.SchemaBootstrap] All executed statements:  C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-All_Statements-4931947912673377590.sql.
17:47:39,125  INFO  [domain.schema.SchemaBootstrap] Normalized schema (pre-bootstrap)  dumped to file C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-814643589718943040-Startup.xml.
17:47:39,125  INFO  [domain.schema.SchemaBootstrap] Normalized schema (post-bootstrap) dumped to file C:\DOCUME~1\bedeaub\LOCALS~1\Temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-3203957614568981738.xml.
17:47:41,093 User:System INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
17:47:42,656 User:System INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: c:\alfresco\alf_data
17:47:42,703 User:System INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
17:47:43,218 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.redeploySubmitProcess5' (Re-deploy WCM Submit Process Definition.).
17:47:43,578 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.deploySubmitDirectProcess' (Deploy WCM Direct Submit Process Definition.).
17:47:43,687 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.moveWCMToGroupBasedPermissionsPatch' (Move WCM to group based permissions.).
17:47:43,734 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.wcmPostPermissionSnapshotPatch2' (Snapshot stores (after fixing ACLs so they are only set on the staging area store).).
17:47:43,984 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.redeploySubmitProcess6' (Re-deploy WCM Submit Process Definition.).
17:47:44,343 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.redeploySubmitProcess7' (Re-deploy WCM Submit Process Definition.).
17:47:44,625 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.migrateVersionStoreUpdateCounter' (Update internal version2Store counter (if needed).).
17:47:44,703 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.webSiteAddModerated' (Changing Web Site visibility from a boolean to enum.).
17:47:44,750 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.invitationMigration' (Migrate invitations from old invite service to invitation service).
17:47:44,750 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.mtShareExistingTenants' (Update existing tenants for MT Share.).
17:47:44,906 User:System INFO  [admin.patch.PatchExecuter]    Applying patch 'patch.redeployInvitationProcess' (Re-deploy Invitation Process Definitions.).
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.db-V2.2-Person-2
RESULT:
Script completed
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.db-V3.2-LockTables
RESULT:
Script completed
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.db-V3.2-Remove-AVM-Issuer
RESULT:
Script completed
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.deploySubmitDirectProcess
RESULT:
Re-deployed 1 workflows.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.migrateVersionStoreUpdateCounter
RESULT:
Update internal version2Store counter (if needed): oldV1count=0,oldV2count=0,newV2count=0
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.moveWCMToGroupBasedPermissionsPatch
RESULT:
WCM moved to group based permissions.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.mtShareExistingTenants
RESULT:
Patch applied, although no changes made since MT is not enabled.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.redeployInvitationProcess
RESULT:
Re-deployed 2 workflows.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.redeploySubmitProcess5
RESULT:
Re-deployed 1 workflows.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.redeploySubmitProcess6
RESULT:
Re-deployed 2 workflows.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.redeploySubmitProcess7
RESULT:
Re-deployed 2 workflows.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.wcmPostPermissionSnapshotPatch2
RESULT:
Snapshot complete after WCM ACL changes.
=====================================
17:47:45,062 User:System INFO  [admin.patch.PatchExecuter]
=== Applied patch                 ===
ID: patch.webSiteAddModerated
RESULT:
Changed Web Site visibility.
=====================================
17:47:45,062 User:System INFO  [repo.module.ModuleServiceImpl] Found 0 module(s).
17:47:45,187 User:System WARN  [repo.module.ModuleServiceImpl] A previously-installed module 'org.alfresco.module.vti' (version 1.0) is not present in your distribution.
17:47:45,234 User:System INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
17:47:45,531 User:System INFO  [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
17:47:45,906 User:System INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_13-b03; maximum heap size 1016,125MB
17:47:45,906 User:System INFO  [service.descriptor.DescriptorService] Alfresco started (Labs): Current version 3.2.0 (_Preview2_dev @build-number@) schema 2011 - Installed version 3.0.0 (Stable 1526) schema 1002

Là déjà je me dit que les patchs appliqués, c'est bizarre….Et lorsque je relance Alfresco :

17:49:31,125 INFO  [org.alfresco.config.xml.XMLConfigService$PropertyConfigurer] Loading properties file from class path resource [alfresco/file-servers.properties]
17:49:39,468 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
17:49:40,296 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Exécution du script de base de données C:\Alfresco\tomcat\temp\Alfresco\AlfrescoSchemaUpdate-org.hibernate.dialect.MySQLInnoDBDialect-8420358068760992259.sql (généré)
17:49:40,375 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Tous les instructions exécutées sont journalisées dans le fichier C:\Alfresco\tomcat\temp\Alfresco\AlfrescoSchemaUpdate-All_Statements-3766312784026750636.sql.
17:49:40,703 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
java.lang.RuntimeException: Error during run with lock.
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.doWithFileLock(IndexInfo.java:2251)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.<init>(IndexInfo.java:557)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.getIndexInfo(IndexInfo.java:351)
   at org.alfresco.repo.search.impl.lucene.AbstractLuceneBase.initialise(AbstractLuceneBase.java:106)
   at org.alfresco.repo.search.impl.lucene.ADMLuceneSearcherImpl.getSearcher(ADMLuceneSearcherImpl.java:129)
   at org.alfresco.repo.search.impl.lucene.ADMLuceneIndexerAndSearcherFactory.getSearcher(ADMLuceneIndexerAndSearcherFactory.java:116)
   at org.alfresco.repo.search.impl.lucene.AbstractLuceneIndexerAndSearcherFactory.getSearcher(AbstractLuceneIndexerAndSearcherFactory.java:463)
   at org.alfresco.repo.search.impl.lucene.AbstractLuceneIndexerAndSearcherFactory.getSearcher(AbstractLuceneIndexerAndSearcherFactory.java:87)
   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.alfresco.repo.service.StoreRedirectorProxyFactory$RedirectorInvocationHandler.invoke(StoreRedirectorProxyFactory.java:221)
   at $Proxy27.getSearcher(Unknown Source)
   at org.alfresco.repo.search.SearcherComponent.selectNodes(SearcherComponent.java:107)
   at org.alfresco.repo.search.AbstractSearcherComponent.selectNodes(AbstractSearcherComponent.java:77)
   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:296)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:177)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:144)
   at net.sf.acegisecurity.intercept.method.aopalliance.MethodSecurityInterceptor.invoke(MethodSecurityInterceptor.java:80)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:166)
   at org.alfresco.repo.security.permissions.impl.ExceptionTranslatorMethodInterceptor.invoke(ExceptionTranslatorMethodInterceptor.java:49)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:166)
   at org.alfresco.repo.audit.AuditComponentImpl.audit(AuditComponentImpl.java:275)
   at org.alfresco.repo.audit.AuditMethodInterceptor.invoke(AuditMethodInterceptor.java:69)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:166)
   at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:107)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:166)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
   at $Proxy20.selectNodes(Unknown Source)
   at org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap.initDictionary(DictionaryRepositoryBootstrap.java:242)
   at org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap$1.execute(DictionaryRepositoryBootstrap.java:207)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:320)
   at org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap.init(DictionaryRepositoryBootstrap.java:203)
   at org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap$2.doWork(DictionaryRepositoryBootstrap.java:395)
   at org.alfresco.repo.security.authentication.AuthenticationUtil.runAs(AuthenticationUtil.java:437)
   at org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap.onBootstrap(DictionaryRepositoryBootstrap.java:391)
   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.refresh(AbstractApplicationContext.java:355)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:244)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:187)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:49)
   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.deployWAR(HostConfig.java:830)
   at org.apache.catalina.startup.HostConfig.deployWARs(HostConfig.java:719)
   at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:490)
   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)
Caused by: java.io.IOException: Unknown format version: -7
   at org.apache.lucene.index.SegmentInfos.read(SegmentInfos.java:195)
   at org.apache.lucene.index.IndexReader$1.doBody(IndexReader.java:152)
   at org.apache.lucene.index.SegmentInfos$FindSegmentsFile.run(SegmentInfos.java:579)
   at org.apache.lucene.index.IndexReader.open(IndexReader.java:147)
   at org.apache.lucene.index.IndexReader.open(IndexReader.java:142)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.buildReferenceCountingIndexReader(IndexInfo.java:1927)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.access$1200(IndexInfo.java:127)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo$2.doWork(IndexInfo.java:618)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.doWithFileLock(IndexInfo.java:2320)
   at org.alfresco.repo.search.impl.lucene.index.IndexInfo.doWithFileLock(IndexInfo.java:2240)
   … 73 more
17:49:44,656 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
17:49:46,703 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 67 Web Scripts (+0 failed), 71 URLs
17:49:46,718 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised Presentation Web Script Container (in 355.64462ms)
17:50:47,750 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 101 Web Scripts (+0 failed), 105 URLs
17:50:47,750 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised WebFramework Web Script Container (in 61023.312ms)
17:50:47,796 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework

Et là… c'est le drame…Car pour tout faire rentrer dans l'ordre, je suis obligé de delete le répertoire alf_data, de drop la database, de la recréer, puis de relancer Alfresco….
J'ai essayé de reconstruire les index (en mode FULL) mais rien n'y fait…

C'est assez gênant !

Je note cependant la dernière ligne dans la console en sorti du projet SVN :

17:47:45,906 User:System INFO  [service.descriptor.DescriptorService] Alfresco started (Labs): Current version 3.2.0 (_Preview2_dev @build-number@) schema 2011 - Installed version 3.0.0 (Stable 1526) schema 1002

Ok, je crois savoir que j'ai patché Alfresco en 3.2.0 mais que j'ai toujours une version 3.0.0…

Quelqu'un aurait-il une idée de piste pour résoudre tout ça ? Installer la version 3.2.0 ? ou pas ? Merci beaucoup !

Outcomes