cancel
Showing results for 
Search instead for 
Did you mean: 

Problème de récupération des documents pour un utilisateur

cedric2microtec
Champ in-the-making
Champ in-the-making
Bonjour à tous,

Je rencontre un problème lors de la récupération des documents d'un utilisateur Alfresco (un seul).

Le message qui apparaît est le suivant :

error on dispatched method [getNodeByUUID] threw exception [javax.jcr.ItemNotFoundException]
Heure de l'incident : Thu Nov 26 11:11:05 CET 2015

   org.alfresco.thread.DispatchException: error on dispatched method [getNodeByUUID] threw exception [javax.jcr.ItemNotFoundException]
   at org.alfresco.thread.WorkerThreadManager.execute(WorkerThreadManager.java:115)
   at org.alfresco.thread.ThreadBoundInvocationHandler.invoke(ThreadBoundInvocationHandler.java:270)
   at $Proxy96.getNodeByUUID(Unknown Source)
   at org.apache.jackrabbit.rmi.server.ServerSession.getNodeByUUID(ServerSession.java:162)
   at sun.reflect.GeneratedMethodAccessor7347.invoke(Unknown Source)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:294)
   at sun.rmi.transport.Transport$1.run(Transport.java:153)
   at java.security.AccessController.doPrivileged(Native Method)
   at sun.rmi.transport.Transport.serviceCall(Transport.java:149)
   at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:466)
   at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:707)
   at java.lang.Thread.run(Thread.java:595)

   

   javax.servlet.ServletException: Error calling action method of component with id navigation:fNav1:boutonCommunication
   at javax.faces.webapp.FacesServlet.service(FacesServlet.java:154)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at org.ajax4jsf.webapp.BaseXMLFilter.doXmlFilter(BaseXMLFilter.java:141)
   at org.ajax4jsf.webapp.BaseFilter.doFilter(BaseFilter.java:281)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at fr.armort.commun.web.filter.HtmlToPdfFilter.doFilter(HtmlToPdfFilter.java:72)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at org.apache.myfaces.webapp.filter.ExtensionsFilter.doFilter(ExtensionsFilter.java:147)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at fr.armort.commun.tools.registry.ServiceRegistryFilter.doFilter(ServiceRegistryFilter.java:39)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at fr.armort.commun.web.filter.CharacterEncodingFilter.doFilter(CharacterEncodingFilter.java:44)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:210)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:174)
   at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:525)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:151)
   at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:200)
   at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:283)
   at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:773)
   at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:703)
   at org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:895)
   at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:685)
   at java.lang.Thread.run(Thread.java:595)

Je n'ai rien trouvé à propos de ce message et espère que vous pourrez m'aider à résoudre ce problème.

Cordialement
2 REPLIES 2

cedric2microtec
Champ in-the-making
Champ in-the-making
14:01:08,947 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:08,948 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:08,948 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:08,948 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:08,948 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:08,948 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:08,950 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:08,950 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:08,950 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,038 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,039 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,039 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,040 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,040 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,040 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,041 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,041 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,041 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,094 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 8.0E-4 ms
14:01:09,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,097 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,153 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,154 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,154 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,154 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,154 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,154 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,156 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,156 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,156 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,248 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,249 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,249 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,249 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,249 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,249 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,338 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,340 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,340 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,340 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,341 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,341 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,342 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,342 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,342 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,394 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,396 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,396 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,396 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,396 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,396 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,499 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,500 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,500 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:09,500 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,501 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,501 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,502 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,502 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,502 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,551 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,569 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,570 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:09,570 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,570 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,570 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,571 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,571 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,571 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,664 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:09,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,667 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,711 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,712 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:09,712 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:09,712 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,713 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,713 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:09,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,817 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,818 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,818 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:09,818 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,818 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,818 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,819 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,819 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,819 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,850 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,851 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:09,851 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:09,851 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,851 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,851 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:09,863 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,863 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,863 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,886 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:09,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,908 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,909 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:09,909 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:09,909 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,909 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,909 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:09,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,938 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,938 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,938 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,939 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,962 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:09,963 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,964 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,964 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,984 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:09,985 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,986 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:09,986 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,021 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,022 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,022 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:10,022 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,022 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,022 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,023 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,023 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,023 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,057 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,058 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,058 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:10,058 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,058 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,058 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,059 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,059 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,059 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,075 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:10,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,096 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:10,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,098 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,099 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,099 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,099 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,099 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,120 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,121 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,169 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,170 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,186 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,187 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,187 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,187 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,217 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:10,218 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,218 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,218 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,236 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,236 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 2.0E-4 ms
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,237 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,253 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:10,254 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,254 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,254 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,281 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:10,282 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,282 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,282 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,301 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,302 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:10,302 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:10,302 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,302 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,302 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:10,303 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,303 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,303 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,573 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,574 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,574 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 0.0010 ms
14:01:10,574 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,577 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,577 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,577 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,711 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,711 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 0.0010 ms
14:01:10,711 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,711 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,712 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,714 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,825 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,826 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,826 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 7.0E-4 ms
14:01:10,826 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,826 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,826 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,827 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,827 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:10,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,868 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,868 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,868 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:10,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,910 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,911 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,912 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,912 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,912 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,965 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,966 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,966 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:10,966 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,966 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,966 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,967 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,967 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,967 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,995 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:10,996 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:10,996 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:10,996 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,996 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:10,996 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:10,997 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,997 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:10,997 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,029 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,030 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,030 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:11,030 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,030 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,030 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,031 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,031 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,031 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,061 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,062 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,062 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,062 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,062 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,062 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,063 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,063 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,063 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,092 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,093 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,093 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 6.0E-4 ms
14:01:11,093 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,093 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,093 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,094 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,094 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,094 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,124 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,125 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,125 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,125 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,148 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,149 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,149 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,149 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,149 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,149 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,150 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,150 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,150 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,172 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,173 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,173 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:11,173 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,173 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,173 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,174 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,174 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,174 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,230 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,231 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,231 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,231 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,231 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,231 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,232 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,232 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,232 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,250 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,251 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,252 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,269 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,270 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,271 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,292 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,293 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,293 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,293 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,293 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,293 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,294 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,294 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,294 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,332 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,333 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,333 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,333 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,352 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,353 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,353 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,353 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,353 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,353 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,354 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,354 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,354 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,415 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,415 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,415 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,416 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,439 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,440 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,440 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,440 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,461 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,462 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,462 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:11,462 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,462 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,462 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,463 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,463 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,463 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,514 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,515 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,515 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:11,515 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,515 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,515 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,516 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,516 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,517 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,589 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,620 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,620 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,620 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,649 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,649 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,649 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,675 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,675 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:11,676 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:11,676 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,676 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,676 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:11,677 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,677 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,677 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,739 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,740 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,740 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:11,740 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,740 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,740 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,741 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,741 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,741 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,774 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,775 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,775 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:11,775 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,775 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,775 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,776 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,776 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,776 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,802 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,807 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,807 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,807 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,865 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 6.0E-4 ms
14:01:11,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,866 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,867 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,920 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,921 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,921 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 6.0E-4 ms
14:01:11,921 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,921 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,921 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,922 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,922 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,922 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,955 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,956 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,956 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:11,956 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,956 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,956 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,957 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,957 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,957 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,982 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:11,983 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:11,983 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:11,983 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,983 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:11,983 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:11,984 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,984 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:11,984 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,019 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,020 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,020 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:12,020 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,020 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,020 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,021 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,021 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,021 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 6.0E-4 ms
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,051 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,052 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,052 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,052 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,078 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:12,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,079 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,080 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,080 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,080 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,110 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,111 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,111 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:12,111 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,111 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,111 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,112 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,112 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,112 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,177 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,178 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,178 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 6.0E-4 ms
14:01:12,178 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,178 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,178 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,179 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,179 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,179 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,240 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,241 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,241 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,241 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 5.0E-4 ms
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,313 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,314 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,314 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,314 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,336 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,337 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,337 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:12,337 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,337 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,337 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,338 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,338 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,338 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,355 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,356 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,356 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:12,356 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,356 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,356 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,357 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,357 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,357 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,378 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:12,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,379 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,380 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,397 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,398 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,418 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,419 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,419 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,419 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 4.0E-4 ms
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,447 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,448 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,448 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,448 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,466 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,467 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,467 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,467 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,482 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,483 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,483 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,496 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,496 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,497 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-1
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-1 -  in 3.0E-4 ms
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,511 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-1
14:01:12,512 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,512 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,512 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-1: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,529 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,530 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,530 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,530 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,545 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,546 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,546 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,546 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,560 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,561 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,561 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,561 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,575 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,576 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,576 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,576 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,590 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,591 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,604 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,604 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,604 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,604 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,605 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,605 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,605 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,605 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,605 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,618 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,619 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,619 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,619 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,632 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,633 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,633 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,633 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,650 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,651 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,665 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,666 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 2.0E-4 ms
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,679 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,680 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,680 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,680 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,696 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,697 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,697 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,697 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,709 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,710 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,743 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,744 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,744 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,744 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 3.0E-4 ms
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,793 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:12,794 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,794 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,794 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 4.0E-4 ms
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,809 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,810 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,810 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,810 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,837 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,837 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,837 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 4.0E-4 ms
14:01:12,837 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,837 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,841 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,841 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,841 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,841 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,854 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,855 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,855 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,855 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,883 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,884 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 3.0E-4 ms
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:12,898 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:12,899 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,899 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:12,899 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,201 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,202 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,203 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 0.0012 ms
14:01:13,203 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,203 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,203 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,205 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,205 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,205 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,357 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,358 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,358 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 0.0011 ms
14:01:13,358 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,358 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,358 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,360 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,360 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,360 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,446 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,448 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,449 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 0.0011 ms
14:01:13,449 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,449 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,449 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,486 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,486 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,486 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,548 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,549 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,549 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 9.0E-4 ms
14:01:13,549 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,549 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,549 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,551 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,551 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,551 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,585 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,585 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,585 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 7.0E-4 ms
14:01:13,586 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,586 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,586 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,587 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,587 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,587 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,646 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,647 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,647 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 6.0E-4 ms
14:01:13,647 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,647 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,647 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,648 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,672 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,673 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,673 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 5.0E-4 ms
14:01:13,673 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,673 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,673 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,674 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,674 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,674 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,731 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,732 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,732 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,732 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,763 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,764 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,764 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:13,764 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,764 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,764 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,765 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,765 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,765 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,783 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,784 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,784 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:13,784 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,784 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,784 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,785 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,785 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,785 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,805 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,805 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,806 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,828 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,829 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,829 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,829 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,848 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,849 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,849 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 4.0E-4 ms
14:01:13,849 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,849 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,849 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,850 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,850 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,850 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,868 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 4.0E-4 ms
14:01:13,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,869 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,870 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,887 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-3
14:01:13,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-3 -  in 4.0E-4 ms
14:01:13,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,888 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-3
14:01:13,889 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,889 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,889 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-3: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Got /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore org.alfresco.repo.search.impl.lucene.index.IndexInfo@3fa87a for /opt/alfresco/alf_data/lucene-indexes/user/alfrescoUserStore
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Waiting for READ lock  - pool-1-thread-2
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] …GOT READ LOCK  - pool-1-thread-2 -  in 5.0E-4 ms
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - increment - ref count is 1        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] Main index reader references = 1
14:01:13,906 DEBUG [org.alfresco.repo.search.impl.lucene.index.IndexInfo] RELEASED READ LOCK  - pool-1-thread-2
14:01:13,907 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader closing        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,907 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader - decrement - ref count is 0        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,907 DEBUG [org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader] pool-1-thread-2: Reader MainReader still open …. ref = 0 invalidForReuse = false        … org.alfresco.repo.search.impl.lucene.index.ReferenceCountingReadOnlyIndexReaderFactory$ReferenceCountingReadOnlyIndexReader@4a25d5
14:01:13,923 ERROR [org.alfresco.thread.WorkerThreadImpl] java.lang.reflect.InvocationTargetException
14:01:13,924 ERROR [org.alfresco.thread.WorkerThreadManager] error on dispatched method [getNodeByUUID]
javax.jcr.ItemNotFoundException
   at org.alfresco.jcr.session.SessionImpl.getNodeByUUID(SessionImpl.java:354)
   at sun.reflect.GeneratedMethodAccessor413.invoke(Unknown Source)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.alfresco.jcr.util.JCRProxyFactory$SessionContextInvocationHandler.invoke(JCRProxyFactory.java:138)
   at $Proxy96.getNodeByUUID(Unknown Source)
   at sun.reflect.GeneratedMethodAccessor413.invoke(Unknown Source)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   at java.lang.reflect.Method.invoke(Method.java:585)
   at org.alfresco.thread.WorkerThreadImpl.run(WorkerThreadImpl.java:99)
   at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
   at java.lang.Thread.run(Thread.java:595)
14:01:13,931 ERROR [org.alfresco.thread.ThreadBoundInvocationHandler] no worker thread found for thread key [120]- not invoking method [isLive]

cleseach
Star Contributor
Star Contributor
Bonjour,

Vous avez visiblement installé des modules spécifiques.
Je pense que le problème est lié à ce code qui recherche des noeuds qui n'existe pas.

Cordialement,
Charles Le Seac'h