Details

      Description

      Performing backup creation on Platform 3.5.2 we face with Lucene exception thrown from JCR indexer internals.
      There is full log of backup operation:

      2012-04-04 11:02:32,420 [http-8080-9] INFO  org.exoplatform.platform.organization.integration.OrganizationIntegrationService - Invoke root user profile synchronization.
      2012-04-04 11:02:34,181 [http-8080-9] INFO  org.exoplatform.platform.gadget.services.LoginHistory.LoginHistoryListener - User root logged in.
      2012-04-04 11:02:44,131 [Index Merger portal-as1-pc-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,135 [as1@pc-system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/pc-system_portal
      2012-04-04 11:02:44,145 [Index Merger portal-as1-portal-work] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,146 [Index Merger portal-as1-portal-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,150 [Index Merger portal-as1-wcm-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,154 [as1@wcm-system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/wcm-system_portal
      2012-04-04 11:02:44,155 [Index Merger portal-as1-backup] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,160 [as1@backup-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/backup_portal
      2012-04-04 11:02:44,178 [Index Merger portal-as1-knowledge] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,195 [Index Merger portal-as1-social] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,198 [Index Merger portal-as1-collaboration] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,198 [Index Merger portal-as1-dev-monit] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,201 [as1@dev-monit-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dev-monit_portal
      2012-04-04 11:02:44,211 [as1@social-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/social_portal
      2012-04-04 11:02:44,212 [Index Merger portal-as1-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,212 [Index Merger portal-as1-dms-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,218 [as1@dms-system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dms-system_portal
      2012-04-04 11:02:44,233 [as1@portal-work-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-work_portal
      2012-04-04 11:02:44,241 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal_system
      2012-04-04 11:02:44,246 [Index Merger portal-as1-system] INFO  exo.jcr.component.core.IndexMerger - IndexMerger terminated
      2012-04-04 11:02:44,252 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal
      2012-04-04 11:02:44,292 [as1@knowledge-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/knowledge_portal
      2012-04-04 11:02:44,311 [as1@collaboration-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/collaboration_portal
      2012-04-04 11:02:44,311 [as1@portal-system-0] INFO  exo.jcr.component.core.SearchIndex - Index closed: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-system_portal
      2012-04-04 11:02:44,709 [as1@pc-system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/pc-system_portal
      2012-04-04 11:02:44,718 [as1@wcm-system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/wcm-system_portal
      2012-04-04 11:02:44,726 [as1@pc-system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/pc-system_portal Version: 4
      2012-04-04 11:02:44,742 [as1@wcm-system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/wcm-system_portal Version: 4
      2012-04-04 11:02:45,230 [as1@backup-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/backup_portal
      2012-04-04 11:02:45,251 [as1@backup-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/backup_portal Version: 4
      2012-04-04 11:02:46,628 [as1@knowledge-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/knowledge_portal
      2012-04-04 11:02:46,693 [as1@knowledge-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/knowledge_portal Version: 4
      2012-04-04 11:02:47,161 [as1@portal-work-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-work_portal
      2012-04-04 11:02:47,193 [as1@portal-work-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-work_portal Version: 4
      2012-04-04 11:02:48,440 [as1@dev-monit-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dev-monit_portal
      2012-04-04 11:02:48,455 [as1@dev-monit-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dev-monit_portal Version: 4
      2012-04-04 11:02:49,303 [as1@social-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/social_portal
      2012-04-04 11:02:49,360 [as1@social-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/social_portal Version: 4
      2012-04-04 11:02:53,719 [as1@dms-system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dms-system_portal
      2012-04-04 11:02:53,746 [as1@dms-system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/dms-system_portal Version: 4
      2012-04-04 11:02:57,245 [as1@collaboration-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/collaboration_portal
      2012-04-04 11:02:57,313 [as1@collaboration-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/collaboration_portal Version: 4
      2012-04-04 11:02:57,341 [DefaultQuartzScheduler_Worker-1] ERROR  org.exoplatform.services.wcm.extensions.scheduler.impl.ChangeStateCronJobImpl - error when changing the state of the content : this Directory is closed
      org.apache.lucene.store.AlreadyClosedException: this Directory is closed
      	at org.apache.lucene.store.Directory.ensureOpen(Directory.java:255) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.apache.lucene.store.FSDirectory.listAll(FSDirectory.java:542) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.apache.lucene.index.SegmentInfos$FindSegmentsFile.run(SegmentInfos.java:564) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.apache.lucene.index.DirectoryReader.open(DirectoryReader.java:73) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.apache.lucene.index.IndexReader.open(IndexReader.java:476) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.apache.lucene.index.IndexReader.open(IndexReader.java:403) ~[lucene-core-2.9.4.jar:2.9.4 1039909 - 2010-11-28 19:08:14]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.AbstractIndex.getIndexReader(AbstractIndex.java:248) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.AbstractIndex.getReadOnlyIndexReader(AbstractIndex.java:268) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.MultiIndex$6.run(MultiIndex.java:1308) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.MultiIndex$6.run(MultiIndex.java:1268) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at java.security.AccessController.doPrivileged(Native Method) ~[na:1.6.0_30]
      	at org.exoplatform.commons.utils.SecurityHelper.doPrivilegedExceptionAction(SecurityHelper.java:307) ~[exo.kernel.commons-2.3.6-GA.jar:2.3.6-GA]
      	at org.exoplatform.commons.utils.SecurityHelper.doPrivilegedIOExceptionAction(SecurityHelper.java:58) ~[exo.kernel.commons-2.3.6-GA.jar:2.3.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.MultiIndex.getIndexReader(MultiIndex.java:1267) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.MultiIndex.getIndexReader(MultiIndex.java:1251) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.SearchIndex.getIndexReader(SearchIndex.java:1548) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.SearchIndex.executeQuery(SearchIndex.java:1298) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.SingleColumnQueryResult.executeQuery(SingleColumnQueryResult.java:68) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.QueryResultImpl.getResults(QueryResultImpl.java:323) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.SingleColumnQueryResult.<init>(SingleColumnQueryResult.java:59) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.lucene.QueryImpl.execute(QueryImpl.java:143) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.jcr.impl.core.query.QueryImpl.execute(QueryImpl.java:188) ~[exo.jcr.component.core-1.14.6-GA.jar:1.14.6-GA]
      	at org.exoplatform.services.wcm.extensions.scheduler.impl.ChangeStateCronJobImpl.execute(ChangeStateCronJobImpl.java:104) ~[exo-ecms-ext-authoring-services-2.3.6.jar:2.3.6]
      	at org.quartz.core.JobRunShell.run(JobRunShell.java:203) ~[quartz-1.5.2.jar:1.5.2]
      	at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:520) ~[quartz-1.5.2.jar:1.5.2]
      2012-04-04 11:02:58,037 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal_system
      2012-04-04 11:02:58,177 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal_system Version: 4
      2012-04-04 11:02:58,179 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal
      2012-04-04 11:02:58,210 [as1@system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/system_portal Version: 4
      2012-04-04 11:02:59,264 [as1@portal-system-0] INFO  exo.jcr.component.core.SearchIndex - path=/eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-system_portal
      2012-04-04 11:02:59,371 [as1@portal-system-0] INFO  exo.jcr.component.core.SearchIndex - Index initialized: /eXo/cloud-workspaces/1.0.2/app-server-tomcat/bin/../gatein/data/jcr/as1/index/portal-system_portal Version: 4
      2012-04-04 11:03:02,119 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_pc-system-20120404_110243/as1_pc-system-20120404_110243.0
      2012-04-04 11:03:02,124 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_portal-work-20120404_110243/as1_portal-work-20120404_110243.0
      2012-04-04 11:03:02,128 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_portal-system-20120404_110243/as1_portal-system-20120404_110243.0
      2012-04-04 11:03:02,132 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_knowledge-20120404_110244/as1_knowledge-20120404_110244.0
      2012-04-04 11:03:02,135 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_wcm-system-20120404_110244/as1_wcm-system-20120404_110244.0
      2012-04-04 11:03:02,138 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_social-20120404_110244/as1_social-20120404_110244.0
      2012-04-04 11:03:02,141 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_backup-20120404_110243/as1_backup-20120404_110244.0
      2012-04-04 11:03:02,143 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_collaboration-20120404_110243/as1_collaboration-20120404_110243.0
      2012-04-04 11:03:02,146 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_dev-monit-20120404_110244/as1_dev-monit-20120404_110244.0
      2012-04-04 11:03:02,148 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_system-20120404_110243/as1_system-20120404_110243.0
      2012-04-04 11:03:02,151 [RepositoryBackupAutoStopper portal] INFO  exo.jcr.component.ext.FullBackupJob - Stop requested /eXo/cloud-workspaces/1.0.2/app-server-tomcat/gatein/backup/backup_portal/repository_as1_backup_1333526563808/as1_dms-system-20120404_110244/as1_dms-system-20120404_110244.0
      

        Gliffy Diagrams

          Attachments

            Activity

              People

              • Assignee:
                areshetnyak Alex Reshetnyak
                Reporter:
                pnedonosko Peter Nedonosko
              • Votes:
                0 Vote for this issue
                Watchers:
                3 Start watching this issue

                Dates

                • Created:
                  Updated:
                  Resolved:

                  Time Tracking

                  Estimated:
                  Original Estimate - 1 day Original Estimate - 1 day
                  1d
                  Remaining:
                  Remaining Estimate - 0 minutes
                  0m
                  Logged:
                  Time Spent - 2 days, 1 hour
                  2d 1h