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

As we transition to the new Hyland Community, some post links may be temporarily disrupted as we finalize redirects. We apologize for the inconvenience and are working to resolve this as quickly as possible. Details.

cedric2microtec

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

cedric2microtec

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]