1 2 Previous Next 19 Replies Latest reply on Apr 24, 2017 9:52 AM by User258546

    UCM Search is not working , i'm getting error while perform search

    User258546

      I'm getting below error while performing UCM search

      Event generated by user 'weblogic' at host 'imguat2.ebiz.tyvvc.com:16200'. Error occurred while processing. Unable to return results. [ Details ]

      An error has occurred. The stack trace below shows more information.

      !csUserEventMessage,weblogic,imguat2.ebiz.verizon.com:16200!$!csSearchUnableToReturnResults
      intradoc.common.ServiceException: !csSearchUnableToReturnResults
      *ScriptStack GET_SEARCH_RESULTS
      3:getSearchResults,**no captured values**
              at intradoc.server.SearchManager.retrieveSearchInfoAsBinder(SearchManager.java:295)
              at intradoc.server.SearchService.retrieveSearchInfo(SearchService.java:1902)
              at intradoc.server.SearchService.doLocalSearch(SearchService.java:1381)
              at intradoc.server.SearchService.getSearchResults(SearchService.java:674)

       

      using

      Search Engine Name:ORACLETEXTSEARCH

      Index Engine Name:ORACLETEXTSEARCH

        • 1. Re: UCM Search is not working , i'm getting error while perform search
          Bunty

          what are you searching on?

           

          also enable systemdatabase in trace and see for detailed error message.

          • 2. Re: UCM Search is not working , i'm getting error while perform search
            User258546

            I did a open search  like application -->Search

            • 3. Re: UCM Search is not working , i'm getting error while perform search
              Jonathan Hult

              Turn on search* and systemdatabase section tracing, clear the output, run the search, view the output, post the output to the forum.

               

              Jonathan

              https://jonathanhult.com

              • 4. Re: UCM Search is not working , i'm getting error while perform search
                User258546

                systemdatabase/7 04.20 11:06:52.395 index update work (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID
                systemdatabase/7 04.20 11:06:52.395 index update work   FROM Revisions
                systemdatabase/7 04.20 11:06:52.395 index update work   WHERE ((dStatus = 'DELETED')
                systemdatabase/7 04.20 11:06:52.395 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))
                >systemdatabase/6 04.20 11:06:52.448 index update work 52 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID
                systemdatabase/6 04.20 11:06:52.448 index update work   FROM Revisions
                systemdatabase/6 04.20 11:06:52.448 index update work   WHERE ((dStatus = 'DELETED')
                systemdatabase/6 04.20 11:06:52.448 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:06:52.448 index update work Closing statement in closing internals
                >systemdatabase/6 04.20 11:06:52.448 index update work Closing active result set
                >systemdatabase/6 04.20 11:06:52.448 index update work commit called.
                >systemdatabase/6 04.20 11:06:52.448 index update work tran committed
                >indexer/7 04.20 11:06:52.455 index update work isRebuild?false; IndexerStep:Replication;  Class:intradoc.server.IndexerReplication
                >indexer/7 04.20 11:06:52.459 index update work isRebuild?false; IndexerStep:PostIndexingStep;  Action:postIndexingStep
                >indexer/7 04.20 11:06:52.463 index update work isRebuild?false; IndexerStep:Cleanup;  Class:intradoc.indexer.Indexer
                >systemdatabase/7 04.20 11:06:52.469 index update work (start) UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions
                systemdatabase/7 04.20 11:06:52.469 index update work   SET dIndexerState = ''
                systemdatabase/7 04.20 11:06:52.469 index update work   WHERE dIndexerState = 'A'
                >systemdatabase/6 04.20 11:06:52.485 index update work 15 ms. UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions
                systemdatabase/6 04.20 11:06:52.485 index update work   SET dIndexerState = ''
                systemdatabase/6 04.20 11:06:52.485 index update work   WHERE dIndexerState = 'A'[Executed. 0 row(s) affected.]
                >systemdatabase/6 04.20 11:06:52.490 index update work !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:06:52.490 index update work Connection with id of 'index update work.78' is removed from active connections with key of 'index update work'.
                >systemdatabase/6 04.20 11:06:52.490 index update work release pool connection
                >indexer/7 04.20 11:06:52.500 index update work isRebuild?false; IndexerStep:PostCleanupStep;  Action:postCleanupStep
                >indexer/7 04.20 11:06:52.505 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer
                >indexer/7 04.20 11:06:52.508 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager
                >indexer/7 04.20 11:06:52.511 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges
                >systemdatabase/7 04.20 11:06:55.158 SubjectManager assigning connection
                >systemdatabase/6 04.20 11:06:55.159 SubjectManager Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:06:55.159 SubjectManager !csMonitorActiveDbConnections,2
                >systemdatabase/6 04.20 11:06:55.159 SubjectManager Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'SubjectManager'.
                >systemdatabase/6 04.20 11:06:55.159 SubjectManager Assigned connection to this thread, took 1.22 ms.  connect
                >systemdatabase/6 04.20 11:06:55.160 SubjectManager Preparing connection for use, id initialized as SubjectManager.76
                >systemdatabase/7 04.20 11:06:55.160 SubjectManager (start) SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',
                systemdatabase/7 04.20 11:06:55.160 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate
                >systemdatabase/6 04.20 11:06:55.162 SubjectManager 1.87 ms. SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',
                systemdatabase/6 04.20 11:06:55.162 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:06:55.162 SubjectManager Closing active result set
                >systemdatabase/6 04.20 11:06:55.162 SubjectManager Closing statement in closing internals
                >systemdatabase/7 04.20 11:06:55.162 SubjectManager (start) UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'
                systemdatabase/7 04.20 11:06:55.162 SubjectManager   WHERE ((dConversionState = 'Aborted') OR
                systemdatabase/7 04.20 11:06:55.162 SubjectManager   (dConvStartDate < {ts '2017-04-20 07:06:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:36:00.000'} AND
                systemdatabase/7 04.20 11:06:55.162 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR
                systemdatabase/7 04.20 11:06:55.162 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))
                >systemdatabase/6 04.20 11:06:55.163 SubjectManager 1.05 ms. UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'
                systemdatabase/6 04.20 11:06:55.163 SubjectManager   WHERE ((dConversionState = 'Aborted') OR
                systemdatabase/6 04.20 11:06:55.163 SubjectManager   (dConvStartDate < {ts '2017-04-20 07:06:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:36:00.000'} AND
                systemdatabase/6 04.20 11:06:55.163 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR
                systemdatabase/6 04.20 11:06:55.163 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))[Executed. 0 row(s) affected.]
                >systemdatabase/6 04.20 11:06:55.170 SubjectManager !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:06:55.170 SubjectManager Connection with id of 'SubjectManager.76' is removed from active connections with key of 'SubjectManager'.
                >systemdatabase/6 04.20 11:06:55.170 SubjectManager release pool connection
                >systemdatabase/7 04.20 11:07:17.255 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:07:17.257 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:07:17.258 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,2
                >systemdatabase/6 04.20 11:07:17.258 DocumentStateMonitor wcc_cluster Connection with last id of sj_immediate_work.75 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:07:17.258 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 2.98 ms.  connect
                >systemdatabase/6 04.20 11:07:17.258 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75
                >systemdatabase/7 04.20 11:07:17.258 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:07:17.259 DocumentStateMonitor wcc_cluster 0.84 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:07:17.259 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:07:17.259 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:07:17.259 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster 0.79 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:07:17.260 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:07:20.191 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:07:20.191 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:07:20.192 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:07:20.192 WebDAVUnlocker !csMonitorActiveDbConnections,2
                >systemdatabase/6 04.20 11:07:20.192 WebDAVUnlocker Connection with last id of index update work.78 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:07:20.192 WebDAVUnlocker Assigned connection to this thread, took 1.26 ms.  connect
                >systemdatabase/6 04.20 11:07:20.192 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.78
                >systemdatabase/7 04.20 11:07:20.192 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:07:20.192'}
                >systemdatabase/6 04.20 11:07:20.194 WebDAVUnlocker 1.99 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:07:20.192'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:07:20.194 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:07:20.194 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:07:20.194 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:07:20.195 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:07:20.195 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:07:20.195 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.78' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:07:20.195 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:07:30.125 IdcServer-1507 (start) SELECT 1 FROM DUAL
                >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 0.75 ms. SELECT 1 FROM DUAL[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 !csDbUnableToExecuteCallableQuery,CotsSearchQuery!$ORA-20000: Oracle Text error:
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50857: oracle error in ctx_query.result_set
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-20000: Oracle Text error:
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50850: ORA-01013: user requested cancel of current operation
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "CTXSYS.DRUE"\, line 160
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "CTXSYS.CTX_QUERY"\, line 800
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "VZPROD_OCS.CONTENT_SEARCH"\, line 125
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "VZPROD_OCS.CONTENT_SEARCH"\, line 320
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at line 1

                >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 run: 0.98 ms.  total 2.59 ms. [ORA-20000: Oracle Text error:
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50857: oracle error in ctx_query.result_set
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-20000: Oracle Text error:
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50850: ORA-01013: user requested cancel of current operation
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "CTXSYS.DRUE", line 160
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "CTXSYS.CTX_QUERY", line 800
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "VZPROD_OCS.CONTENT_SEARCH", line 125
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at "VZPROD_OCS.CONTENT_SEARCH", line 320
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-06512: at line 1
                systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ]
                >searchquery/6 04.20 11:07:30.126 IdcServer-1507 !csMonitorActiveDbConnections,0
                >searchquery/6 04.20 11:07:30.126 IdcServer-1507 Connection is removed from active connections with key of '[ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)''.
                >searchquery/6 04.20 11:07:30.126 IdcServer-1507 release pool connection
                >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 Removing query: CotsSearchQuery
                >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 Closing statement.
                >systemdatabase/6 04.20 11:07:30.127 IdcServer-1507 !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:07:30.127 IdcServer-1507 Connection with id of 'IdcServer-1507([ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)').77' is removed from active connections with key of '[ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)''.
                >systemdatabase/6 04.20 11:07:30.127 IdcServer-1507 Closing active result set
                >systemdatabase/6 04.20 11:07:30.127 IdcServer-1507 Closing statement in closing internals
                >systemdatabase/6 04.20 11:07:30.127 IdcServer-1507 release pool connection
                >services/3 04.20 11:07:30.128 IdcServer-1507 !csUserEventMessage,weblogic,imguat2.ebiz.verizon.com:16200!$ intradoc.common.ServiceException: !csSearchUnableToReturnResults
                services/3 04.20 11:07:30.128 IdcServer-1507 *ScriptStack GET_SEARCH_RESULTS
                services/3 04.20 11:07:30.128 IdcServer-1507 3:getSearchResults,**no captured values**
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.SearchManager.retrieveSearchInfoAsBinder(SearchManager.java:295)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.SearchService.retrieveSearchInfo(SearchService.java:1902)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.SearchService.doLocalSearch(SearchService.java:1381)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.SearchService.getSearchResults(SearchService.java:674)
                services/3 04.20 11:07:30.128 IdcServer-1507         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                services/3 04.20 11:07:30.128 IdcServer-1507         at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
                services/3 04.20 11:07:30.128 IdcServer-1507         at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
                services/3 04.20 11:07:30.128 IdcServer-1507         at java.lang.reflect.Method.invoke(Method.java:597)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.common.IdcMethodHolder.invokeMethod(IdcMethodHolder.java:86)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.common.ClassHelperUtils.executeMethodEx(ClassHelperUtils.java:310)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.common.ClassHelperUtils.executeMethod(ClassHelperUtils.java:295)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.doCodeEx(Service.java:620)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.doCode(Service.java:575)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.ServiceRequestImplementor.doAction(ServiceRequestImplementor.java:1643)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.doAction(Service.java:547)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.ServiceRequestImplementor.doActions(ServiceRequestImplementor.java:1458)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.doActions(Service.java:542)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.ServiceRequestImplementor.executeActions(ServiceRequestImplementor.java:1391)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.executeActions(Service.java:528)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.ServiceRequestImplementor.doRequest(ServiceRequestImplementor.java:737)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.Service.doRequest(Service.java:1956)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.ServiceManager.processCommand(ServiceManager.java:437)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.server.IdcServerThread.processRequest(IdcServerThread.java:265)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.idcwls.IdcServletRequestUtils.doRequest(IdcServletRequestUtils.java:1354)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.idcwls.IdcServletRequestUtils.processFilterEvent(IdcServletRequestUtils.java:1731)
                services/3 04.20 11:07:30.128 IdcServer-1507         at intradoc.idcwls.IdcIntegrateWrapper.processFilterEvent(IdcIntegrateWrapper.java:223)
                services/3 04.20 11:07:30.128 IdcServer-1507         at sun.reflect.GeneratedMethodAccessor204.invoke(Unknown Source)
                services/3 04.20 11:07:30.128 IdcServer-1507         ... 33 more
                >requestaudit/6 04.20 11:07:30.244 IdcServer-1507 GET_SEARCH_RESULTS [dUser=weblogic][QueryText= ((z49504D5359535F4150505F31) WITHIN zdSecurityGroup)   and   ((IpmApp\_1) WITHIN xIdcProfile) ][StatusCode=-1][StatusMessage=Unable to retrieve search results. Error occurred while processing. Unable to return results.] 60.23545837402344(secs)
                >systemdatabase/6 04.20 11:07:50.199 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:07:50.199 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:07:50.200 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:07:50.200 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:07:50.200 WebDAVUnlocker Connection with last id of SubjectManager.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:07:50.200 WebDAVUnlocker Assigned connection to this thread, took 1.03 ms.  connect
                >systemdatabase/6 04.20 11:07:50.200 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:07:50.200 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:07:50.200'}
                >systemdatabase/6 04.20 11:07:50.201 WebDAVUnlocker 1.04 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:07:50.200'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:07:50.202 WebDAVUnlocker release pool connection
                >requestaudit/6 04.20 11:08:00.007 Audit Request Monitor !csMonitorTotalRequests,4,1,0.03333166614174843,15.276749610900879,1
                >requestaudit/6 04.20 11:08:00.010 Audit Request Monitor Request Audit Report over the last 120 Seconds for server wcc_cluster****
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor -Num Requests 4 Errors 1 Reqs/sec. 0.03333166614174843 Avg. Latency (secs) 15.276749610900879 Max Thread Count 1
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor 1 Service GET_SEARCH_RESULTS Total Elapsed Time (secs) 60.23500061035156 Num requests 1 Num errors 1 Avg. Latency (secs) 60.23500061035156
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor 2 Service GET_DOC_PAGE Total Elapsed Time (secs) 0.8080000281333923 Num requests 1 Num errors 0 Avg. Latency (secs) 0.8080000281333923
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor 3 Service GET_PERSONALIZED_JAVASCRIPT Total Elapsed Time (secs) 0.057999998331069946 Num requests 1 Num errors 0 Avg. Latency (secs) 0.057999998331069946
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor 4 Service GET_SCHEMA_VIEW_FRAGMENT Total Elapsed Time (secs) 0.006000000052154064 Num requests 1 Num errors 0 Avg. Latency (secs) 0.006000000052154064
                requestaudit/6 04.20 11:08:00.010 Audit Request Monitor ****End Audit Report*****
                >systemdatabase/7 04.20 11:08:17.268 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.42 ms.  connect
                >systemdatabase/6 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75
                >systemdatabase/7 04.20 11:08:17.269 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:08:17.270 DocumentStateMonitor wcc_cluster 0.69 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:08:17.270 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:08:17.270 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:08:17.270 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster 0.71 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:08:17.271 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:08:20.219 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:08:20.219 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:08:20.232 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:08:20.232 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:08:20.232 WebDAVUnlocker Connection with last id of IdcServer-1507([ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)').77 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:08:20.232 WebDAVUnlocker Assigned connection to this thread, took 12 ms.  connect
                >systemdatabase/6 04.20 11:08:20.232 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.77
                >systemdatabase/7 04.20 11:08:20.232 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:08:20.232'}
                >systemdatabase/6 04.20 11:08:20.233 WebDAVUnlocker 1.03 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:08:20.232'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:08:20.233 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:08:20.233 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:08:20.233 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:08:20.234 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:08:20.234 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:08:20.234 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.77' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:08:20.234 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:08:50.243 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:08:50.243 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:08:50.244 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:08:50.244 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:08:50.244 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:08:50.244 WebDAVUnlocker Assigned connection to this thread, took 1.00 ms.  connect
                >systemdatabase/6 04.20 11:08:50.244 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:08:50.244 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:08:50.244'}
                >systemdatabase/6 04.20 11:08:50.245 WebDAVUnlocker 0.92 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:08:50.244'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:08:50.245 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:08:50.245 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:08:50.245 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:08:50.246 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:08:50.246 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:08:50.246 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:08:50.246 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:09:17.273 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.20 ms.  connect
                >systemdatabase/6 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75
                >systemdatabase/7 04.20 11:09:17.274 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:09:17.275 DocumentStateMonitor wcc_cluster 0.92 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:09:17.275 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:09:17.275 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:09:17.275 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:09:17.276 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:09:20.249 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:09:20.249 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:09:20.250 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:09:20.250 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:09:20.250 WebDAVUnlocker Connection with last id of WebDAVUnlocker.77 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:09:20.250 WebDAVUnlocker Assigned connection to this thread, took 1.21 ms.  connect
                >systemdatabase/6 04.20 11:09:20.250 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.77
                >systemdatabase/7 04.20 11:09:20.250 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:09:20.250'}
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker 1.11 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:09:20.250'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.77' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:09:20.252 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:09:50.253 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:09:50.253 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:09:50.254 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:09:50.254 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:09:50.254 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:09:50.254 WebDAVUnlocker Assigned connection to this thread, took 1.15 ms.  connect
                >systemdatabase/6 04.20 11:09:50.255 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:09:50.255 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:09:50.255'}
                >systemdatabase/6 04.20 11:09:50.256 WebDAVUnlocker 1.04 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:09:50.255'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:09:50.256 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:09:50.256 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:09:50.256 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:09:50.256 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:09:50.257 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:09:50.257 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:09:50.257 WebDAVUnlocker release pool connection
                >requestaudit/6 04.20 11:10:00.006 Audit Request Monitor Request Audit Report over the last 120 Seconds for server wcc_cluster****
                requestaudit/6 04.20 11:10:00.006 Audit Request Monitor -Num Requests 0 No requests occurred during this period
                requestaudit/6 04.20 11:10:00.006 Audit Request Monitor ****End Audit Report*****
                >systemdatabase/7 04.20 11:10:17.282 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.14 ms.  connect
                >systemdatabase/6 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75
                >systemdatabase/7 04.20 11:10:17.283 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:10:17.284 DocumentStateMonitor wcc_cluster 0.81 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:10:17.284 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:10:17.284 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:10:17.284 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster 0.72 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:10:17.285 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:10:20.262 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:10:20.262 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:10:20.263 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:10:20.263 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:10:20.263 WebDAVUnlocker Connection with last id of WebDAVUnlocker.77 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:10:20.263 WebDAVUnlocker Assigned connection to this thread, took 1.00 ms.  connect
                >systemdatabase/6 04.20 11:10:20.263 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.77
                >systemdatabase/7 04.20 11:10:20.263 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:10:20.263'}
                >systemdatabase/6 04.20 11:10:20.264 WebDAVUnlocker 0.98 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:10:20.263'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:10:20.264 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:10:20.264 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:10:20.265 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:10:20.265 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:10:20.265 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:10:20.265 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.77' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:10:20.265 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:10:50.266 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:10:50.266 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:10:50.267 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:10:50.267 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:10:50.267 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:10:50.267 WebDAVUnlocker Assigned connection to this thread, took 1.05 ms.  connect
                >systemdatabase/6 04.20 11:10:50.267 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:10:50.268 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:10:50.268'}
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker 0.98 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:10:50.268'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:10:50.269 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:11:02.174 IdcServer-1521 assigning connection
                >systemdatabase/6 04.20 11:11:02.175 IdcServer-1521 Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:02.175 IdcServer-1521 !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:02.175 IdcServer-1521 Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of '[ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)''.
                >systemdatabase/6 04.20 11:11:02.175 IdcServer-1521 Assigned connection to this thread, took 1.11 ms.  connect
                >systemdatabase/6 04.20 11:11:02.175 IdcServer-1521 Preparing connection for use, id initialized as IdcServer-1521([ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)').75
                >systemdatabase/7 04.20 11:11:02.175 IdcServer-1521 (start) SELECT * FROM Users WHERE LOWER(dName) = LOWER('weblogic')
                >systemdatabase/6 04.20 11:11:02.176 IdcServer-1521 1.11 ms. SELECT * FROM Users WHERE LOWER(dName) = LOWER('weblogic')[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:11:02.499 IdcServer-1521 Closing active result set
                >systemdatabase/6 04.20 11:11:02.500 IdcServer-1521 Closing statement in closing internals
                >systemdatabase/7 04.20 11:11:02.500 IdcServer-1521 (start) SELECT * FROM UserExtendedAttributes WHERE UPPER(dUserName)=UPPER('weblogic')
                >systemdatabase/6 04.20 11:11:02.501 IdcServer-1521 1.36 ms. SELECT * FROM UserExtendedAttributes WHERE UPPER(dUserName)=UPPER('weblogic')[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:02.630 IdcServer-1521 !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:02.630 IdcServer-1521 Connection with id of 'IdcServer-1521([ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)').75' is removed from active connections with key of '[ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)''.
                >systemdatabase/6 04.20 11:11:02.630 IdcServer-1521 Closing active result set
                >systemdatabase/6 04.20 11:11:02.630 IdcServer-1521 Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:02.630 IdcServer-1521 release pool connection
                >requestaudit/6 04.20 11:11:02.763 IdcServer-1521 CONFIG_INFO [dUser=weblogic] 0.5913619995117188(secs)
                >systemdatabase/7 04.20 11:11:17.287 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster Connection with last id of WebDAVUnlocker.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.25 ms.  connect
                >systemdatabase/6 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:11:17.288 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:11:17.289 DocumentStateMonitor wcc_cluster 0.85 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:11:17.289 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:11:17.290 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:11:17.290 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:11:17.304 DocumentStateMonitor wcc_cluster 14 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:11:17.304 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:17.304 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.77' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:11:17.304 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:11:17.304 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:17.305 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:11:20.275 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:11:20.275 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:11:20.276 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:20.276 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:20.276 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:11:20.276 WebDAVUnlocker Assigned connection to this thread, took 1.08 ms.  connect
                >systemdatabase/6 04.20 11:11:20.276 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:11:20.276 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:11:20.276'}
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker 1.26 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:11:20.276'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:11:20.278 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:11:50.279 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:11:50.279 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:11:50.280 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:50.280 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:50.280 WebDAVUnlocker Connection with last id of IdcServer-1521([ACTIVE] ExecuteThread: '2' for queue: 'weblogic.kernel.Default (self-tuning)').75 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:11:50.280 WebDAVUnlocker Assigned connection to this thread, took 0.99 ms.  connect
                >systemdatabase/6 04.20 11:11:50.280 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.75
                >systemdatabase/7 04.20 11:11:50.281 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:11:50.281'}
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker 0.98 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:11:50.281'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.75' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:11:50.282 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:11:52.703 sj_immediate_work assigning connection
                >systemdatabase/6 04.20 11:11:52.704 sj_immediate_work Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:52.704 sj_immediate_work !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:52.704 sj_immediate_work Connection with last id of DocumentStateMonitor wcc_cluster.77 is added to active connections with key of 'sj_immediate_work'.
                >systemdatabase/6 04.20 11:11:52.704 sj_immediate_work Assigned connection to this thread, took 1.11 ms.  connect
                >systemdatabase/6 04.20 11:11:52.704 sj_immediate_work Preparing connection for use, id initialized as sj_immediate_work.77
                >systemdatabase/7 04.20 11:11:52.704 sj_immediate_work (start) SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'
                systemdatabase/7 04.20 11:11:52.704 sj_immediate_work     ORDER BY dSjPriority ASC
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work 1.05 ms. SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'
                systemdatabase/6 04.20 11:11:52.705 sj_immediate_work     ORDER BY dSjPriority ASC[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work Connection with id of 'sj_immediate_work.77' is removed from active connections with key of 'sj_immediate_work'.
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work Closing active result set
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:52.705 sj_immediate_work release pool connection
                >indexer/6 04.20 11:11:52.723 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'
                >indexer/7 04.20 11:11:52.723 index update work /apps/opt/mw/admin/ipm_domain/wcc_cluster/cs/search/search.cfg doesn't exist.
                >indexer/6 04.20 11:11:52.723 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'
                >indexer/7 04.20 11:11:52.747 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer
                >indexer/7 04.20 11:11:52.751 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager
                >indexer/7 04.20 11:11:52.754 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges
                >systemdatabase/7 04.20 11:11:52.764 index update work assigning connection
                >systemdatabase/6 04.20 11:11:52.765 index update work Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:52.765 index update work !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:52.765 index update work Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'index update work'.
                >systemdatabase/6 04.20 11:11:52.766 index update work Assigned connection to this thread, took 1.10 ms.  connect
                >systemdatabase/6 04.20 11:11:52.766 index update work Preparing connection for use, id initialized as index update work.76
                >systemdatabase/7 04.20 11:11:52.766 index update work (start) SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions
                systemdatabase/7 04.20 11:11:52.766 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND
                systemdatabase/7 04.20 11:11:52.766 index update work   Revisions.dOutDate < {ts '2017-04-20 11:12:52.764'} AND (dWorkflowState IS NULL or dWorkflowState = '')
                >systemdatabase/6 04.20 11:11:52.767 index update work 1.31 ms. SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions
                systemdatabase/6 04.20 11:11:52.767 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND
                systemdatabase/6 04.20 11:11:52.767 index update work   Revisions.dOutDate < {ts '2017-04-20 11:12:52.764'} AND (dWorkflowState IS NULL or dWorkflowState = '')[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:52.767 index update work Closing active result set
                >systemdatabase/6 04.20 11:11:52.767 index update work Closing statement in closing internals
                >systemdatabase/7 04.20 11:11:52.768 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID
                systemdatabase/7 04.20 11:11:52.768 index update work   FROM Revisions
                systemdatabase/7 04.20 11:11:52.768 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')
                systemdatabase/7 04.20 11:11:52.768 index update work   AND Revisions.dInDate<={ts '2017-04-20 11:12:52.764'}
                >systemdatabase/6 04.20 11:11:52.769 index update work 1.21 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID
                systemdatabase/6 04.20 11:11:52.769 index update work   FROM Revisions
                systemdatabase/6 04.20 11:11:52.769 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')
                systemdatabase/6 04.20 11:11:52.769 index update work   AND Revisions.dInDate<={ts '2017-04-20 11:12:52.764'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:52.774 index update work begin tran - soft
                >systemdatabase/6 04.20 11:11:52.774 index update work Closing active result set
                >systemdatabase/6 04.20 11:11:52.774 index update work Closing statement in closing internals
                >systemdatabase/7 04.20 11:11:52.775 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID
                systemdatabase/7 04.20 11:11:52.775 index update work   FROM Revisions
                systemdatabase/7 04.20 11:11:52.775 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))
                systemdatabase/7 04.20 11:11:52.775 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))
                systemdatabase/7 04.20 11:11:52.775 index update work   AND (dStatus <> 'GENWWW'))
                >systemdatabase/6 04.20 11:11:52.782 index update work 7.55 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID
                systemdatabase/6 04.20 11:11:52.782 index update work   FROM Revisions
                systemdatabase/6 04.20 11:11:52.782 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))
                systemdatabase/6 04.20 11:11:52.782 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))
                systemdatabase/6 04.20 11:11:52.782 index update work   AND (dStatus <> 'GENWWW'))[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:52.782 index update work Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:52.782 index update work Closing active result set
                >systemdatabase/6 04.20 11:11:52.782 index update work commit called.
                >systemdatabase/6 04.20 11:11:52.783 index update work tran committed
                >systemdatabase/6 04.20 11:11:52.783 index update work begin tran - soft
                >systemdatabase/7 04.20 11:11:52.783 index update work (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID
                systemdatabase/7 04.20 11:11:52.783 index update work   FROM Revisions
                systemdatabase/7 04.20 11:11:52.783 index update work   WHERE ((dStatus = 'DELETED')
                systemdatabase/7 04.20 11:11:52.783 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))
                >systemdatabase/6 04.20 11:11:52.791 index update work 7.95 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID
                systemdatabase/6 04.20 11:11:52.791 index update work   FROM Revisions
                systemdatabase/6 04.20 11:11:52.791 index update work   WHERE ((dStatus = 'DELETED')
                systemdatabase/6 04.20 11:11:52.791 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:52.791 index update work Closing statement in closing internals
                >systemdatabase/6 04.20 11:11:52.791 index update work Closing active result set
                >systemdatabase/6 04.20 11:11:52.791 index update work commit called.
                >systemdatabase/6 04.20 11:11:52.792 index update work tran committed
                >indexer/7 04.20 11:11:52.799 index update work isRebuild?false; IndexerStep:Replication;  Class:intradoc.server.IndexerReplication
                >indexer/7 04.20 11:11:52.806 index update work isRebuild?false; IndexerStep:PostIndexingStep;  Action:postIndexingStep
                >indexer/7 04.20 11:11:52.809 index update work isRebuild?false; IndexerStep:Cleanup;  Class:intradoc.indexer.Indexer
                >systemdatabase/7 04.20 11:11:52.824 index update work (start) UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions
                systemdatabase/7 04.20 11:11:52.824 index update work   SET dIndexerState = ''
                systemdatabase/7 04.20 11:11:52.824 index update work   WHERE dIndexerState = 'A'
                >systemdatabase/6 04.20 11:11:52.825 index update work 1.16 ms. UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions
                systemdatabase/6 04.20 11:11:52.825 index update work   SET dIndexerState = ''
                systemdatabase/6 04.20 11:11:52.825 index update work   WHERE dIndexerState = 'A'[Executed. 0 row(s) affected.]
                >systemdatabase/6 04.20 11:11:52.828 index update work !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:52.828 index update work Connection with id of 'index update work.76' is removed from active connections with key of 'index update work'.
                >systemdatabase/6 04.20 11:11:52.828 index update work release pool connection
                >indexer/7 04.20 11:11:52.833 index update work isRebuild?false; IndexerStep:PostCleanupStep;  Action:postCleanupStep
                >indexer/7 04.20 11:11:52.845 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer
                >indexer/7 04.20 11:11:52.848 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager
                >indexer/7 04.20 11:11:52.851 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges
                >systemdatabase/7 04.20 11:11:55.712 SubjectManager assigning connection
                >systemdatabase/6 04.20 11:11:55.712 SubjectManager Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:11:55.712 SubjectManager !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:11:55.712 SubjectManager Connection with last id of WebDAVUnlocker.75 is added to active connections with key of 'SubjectManager'.
                >systemdatabase/6 04.20 11:11:55.713 SubjectManager Assigned connection to this thread, took 1.03 ms.  connect
                >systemdatabase/6 04.20 11:11:55.713 SubjectManager Preparing connection for use, id initialized as SubjectManager.75
                >systemdatabase/7 04.20 11:11:55.713 SubjectManager (start) SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',
                systemdatabase/7 04.20 11:11:55.713 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate
                >systemdatabase/6 04.20 11:11:55.714 SubjectManager 0.94 ms. SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',
                systemdatabase/6 04.20 11:11:55.714 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:11:55.714 SubjectManager Closing active result set
                >systemdatabase/6 04.20 11:11:55.714 SubjectManager Closing statement in closing internals
                >systemdatabase/7 04.20 11:11:55.714 SubjectManager (start) UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'
                systemdatabase/7 04.20 11:11:55.714 SubjectManager   WHERE ((dConversionState = 'Aborted') OR
                systemdatabase/7 04.20 11:11:55.714 SubjectManager   (dConvStartDate < {ts '2017-04-20 07:11:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:41:00.000'} AND
                systemdatabase/7 04.20 11:11:55.714 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR
                systemdatabase/7 04.20 11:11:55.714 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))
                >systemdatabase/6 04.20 11:11:55.715 SubjectManager 1.17 ms. UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'
                systemdatabase/6 04.20 11:11:55.715 SubjectManager   WHERE ((dConversionState = 'Aborted') OR
                systemdatabase/6 04.20 11:11:55.715 SubjectManager   (dConvStartDate < {ts '2017-04-20 07:11:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:41:00.000'} AND
                systemdatabase/6 04.20 11:11:55.715 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR
                systemdatabase/6 04.20 11:11:55.715 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))[Executed. 0 row(s) affected.]
                >systemdatabase/6 04.20 11:11:55.721 SubjectManager !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:11:55.721 SubjectManager Connection with id of 'SubjectManager.75' is removed from active connections with key of 'SubjectManager'.
                >systemdatabase/6 04.20 11:11:55.721 SubjectManager release pool connection
                >requestaudit/6 04.20 11:12:00.008 Audit Request Monitor !csMonitorTotalRequests,1,0,0.008333194069564342,0.5910000205039978,1
                >requestaudit/6 04.20 11:12:00.009 Audit Request Monitor Request Audit Report over the last 120 Seconds for server wcc_cluster****
                requestaudit/6 04.20 11:12:00.009 Audit Request Monitor -Num Requests 1 Errors 0 Reqs/sec. 0.008333194069564342 Avg. Latency (secs) 0.5910000205039978 Max Thread Count 1
                requestaudit/6 04.20 11:12:00.009 Audit Request Monitor 1 Service CONFIG_INFO Total Elapsed Time (secs) 0.5910000205039978 Num requests 1 Num errors 0 Avg. Latency (secs) 0.5910000205039978
                requestaudit/6 04.20 11:12:00.009 Audit Request Monitor ****End Audit Report*****
                >systemdatabase/7 04.20 11:12:17.312 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster Connection with last id of sj_immediate_work.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.21 ms.  connect
                >systemdatabase/6 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:12:17.313 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:12:17.314 DocumentStateMonitor wcc_cluster 0.73 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:12:17.314 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:12:17.314 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:12:17.314 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster 0.64 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.77' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:12:17.315 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:12:20.288 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:12:20.288 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:12:20.289 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:12:20.289 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:12:20.289 WebDAVUnlocker Connection with last id of index update work.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:12:20.289 WebDAVUnlocker Assigned connection to this thread, took 1.03 ms.  connect
                >systemdatabase/6 04.20 11:12:20.289 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:12:20.289 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:12:20.289'}
                >systemdatabase/6 04.20 11:12:20.290 WebDAVUnlocker 0.94 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:12:20.289'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:12:20.290 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:12:20.290 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:12:20.290 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:12:20.291 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:12:20.291 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:12:20.291 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:12:20.291 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:12:50.292 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:12:50.293 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:12:50.293 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:12:50.293 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:12:50.294 WebDAVUnlocker Connection with last id of SubjectManager.75 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:12:50.294 WebDAVUnlocker Assigned connection to this thread, took 1.06 ms.  connect
                >systemdatabase/6 04.20 11:12:50.294 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.75
                >systemdatabase/7 04.20 11:12:50.294 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:12:50.294'}
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker 0.99 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:12:50.294'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:12:50.295 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.75' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:12:50.296 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:13:17.317 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.12 ms.  connect
                >systemdatabase/6 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:13:17.318 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:13:17.319 DocumentStateMonitor wcc_cluster 0.72 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:13:17.319 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:13:17.319 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:13:17.319 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster 0.65 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.77' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:13:17.320 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:13:20.297 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:13:20.297 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:13:20.298 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:13:20.298 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:13:20.298 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:13:20.298 WebDAVUnlocker Assigned connection to this thread, took 1.05 ms.  connect
                >systemdatabase/6 04.20 11:13:20.298 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:13:20.298 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:13:20.298'}
                >systemdatabase/6 04.20 11:13:20.299 WebDAVUnlocker 0.92 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:13:20.298'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:13:20.299 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:13:20.299 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:13:20.299 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:13:20.300 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:13:20.300 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:13:20.300 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:13:20.300 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:13:50.302 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:13:50.302 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:13:50.303 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:13:50.303 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:13:50.303 WebDAVUnlocker Connection with last id of WebDAVUnlocker.75 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:13:50.303 WebDAVUnlocker Assigned connection to this thread, took 1.50 ms.  connect
                >systemdatabase/6 04.20 11:13:50.303 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.75
                >systemdatabase/7 04.20 11:13:50.303 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:13:50.303'}
                >systemdatabase/6 04.20 11:13:50.304 WebDAVUnlocker 1.01 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:13:50.303'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.75' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:13:50.305 WebDAVUnlocker release pool connection
                >requestaudit/6 04.20 11:14:00.002 Audit Request Monitor Request Audit Report over the last 120 Seconds for server wcc_cluster****
                requestaudit/6 04.20 11:14:00.002 Audit Request Monitor -Num Requests 0 No requests occurred during this period
                requestaudit/6 04.20 11:14:00.002 Audit Request Monitor ****End Audit Report*****
                >systemdatabase/7 04.20 11:14:17.322 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.10 ms.  connect
                >systemdatabase/6 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:14:17.323 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:14:17.324 DocumentStateMonitor wcc_cluster 0.73 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:14:17.324 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:14:17.324 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:14:17.324 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster 0.63 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.77' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:14:17.325 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:14:20.306 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:14:20.306 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:14:20.307 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:14:20.307 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:14:20.307 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:14:20.307 WebDAVUnlocker Assigned connection to this thread, took 0.99 ms.  connect
                >systemdatabase/6 04.20 11:14:20.307 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76
                >systemdatabase/7 04.20 11:14:20.308 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:14:20.308'}
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker 1.08 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:14:20.308'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:14:20.309 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:14:50.311 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:14:50.311 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:14:50.312 WebDAVUnlocker Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:14:50.312 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:14:50.312 WebDAVUnlocker Connection with last id of WebDAVUnlocker.75 is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:14:50.312 WebDAVUnlocker Assigned connection to this thread, took 1.15 ms.  connect
                >systemdatabase/6 04.20 11:14:50.312 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.75
                >systemdatabase/7 04.20 11:14:50.312 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:14:50.312'}
                >systemdatabase/6 04.20 11:14:50.314 WebDAVUnlocker 1.70 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:14:50.312'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:14:50.314 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:14:50.314 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:14:50.314 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:14:50.315 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:14:50.315 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:14:50.315 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.75' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:14:50.315 WebDAVUnlocker release pool connection
                >systemdatabase/7 04.20 11:15:17.327 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:15:17.328 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:15:17.328 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:15:17.328 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:15:17.328 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.19 ms.  connect
                >systemdatabase/6 04.20 11:15:17.328 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:15:17.329 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:15:17.329 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:15:17.329 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:15:17.329 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:15:17.330 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:15:17.330 DocumentStateMonitor wcc_cluster 0.67 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:15:17.330 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:15:17.330 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.77' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:15:17.330 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:15:17.331 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/6 04.20 11:15:17.331 DocumentStateMonitor wcc_cluster release pool connection
                >systemdatabase/6 04.20 11:15:20.319 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:15:20.319 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:15:20.390 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'
                >systemdatabase/6 04.20 11:15:20.390 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'
                >systemdatabase/6 04.20 11:15:20.391 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'
                >systemdatabase/6 04.20 11:15:20.391 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'
                >systemdatabase/6 04.20 11:15:20.392 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'
                >systemdatabase/6 04.20 11:15:20.392 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'
                >systemdatabase/6 04.20 11:15:20.393 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'
                >systemdatabase/6 04.20 11:15:20.393 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'
                >systemdatabase/6 04.20 11:15:20.395 WebDAVUnlocker New connection retrieved from external pool.
                >systemdatabase/6 04.20 11:15:20.395 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:15:20.395 WebDAVUnlocker Connection with last id of <unassigned> is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:15:20.395 WebDAVUnlocker Assigned connection to this thread, took 75 ms.  connect
                >systemdatabase/6 04.20 11:15:20.395 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.79
                >systemdatabase/7 04.20 11:15:20.395 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:15:20.395'}
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker 2.66 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:15:20.395'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.79' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:15:20.398 WebDAVUnlocker release pool connection
                >systemdatabase/6 04.20 11:15:50.400 WebDAVUnlocker begin tran - soft
                >systemdatabase/7 04.20 11:15:50.400 WebDAVUnlocker assigning connection
                >systemdatabase/6 04.20 11:15:50.477 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'
                >systemdatabase/6 04.20 11:15:50.478 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'
                >systemdatabase/6 04.20 11:15:50.478 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'
                >systemdatabase/6 04.20 11:15:50.479 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'
                >systemdatabase/6 04.20 11:15:50.480 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'
                >systemdatabase/6 04.20 11:15:50.480 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'
                >systemdatabase/6 04.20 11:15:50.481 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'
                >systemdatabase/6 04.20 11:15:50.481 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'
                >systemdatabase/6 04.20 11:15:50.483 WebDAVUnlocker New connection retrieved from external pool.
                >systemdatabase/6 04.20 11:15:50.483 WebDAVUnlocker !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:15:50.483 WebDAVUnlocker Connection with last id of <unassigned> is added to active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:15:50.483 WebDAVUnlocker Assigned connection to this thread, took 83 ms.  connect
                >systemdatabase/6 04.20 11:15:50.483 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.80
                >systemdatabase/7 04.20 11:15:50.483 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:15:50.483'}
                >systemdatabase/6 04.20 11:15:50.485 WebDAVUnlocker 1.87 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:15:50.483'}[Executed. Returned row(s): false]
                >systemdatabase/6 04.20 11:15:50.485 WebDAVUnlocker Closing active result set
                >systemdatabase/6 04.20 11:15:50.485 WebDAVUnlocker Closing statement in closing internals
                >systemdatabase/6 04.20 11:15:50.485 WebDAVUnlocker commit called.
                >systemdatabase/6 04.20 11:15:50.486 WebDAVUnlocker tran committed
                >systemdatabase/6 04.20 11:15:50.486 WebDAVUnlocker !csMonitorActiveDbConnections,0
                >systemdatabase/6 04.20 11:15:50.486 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.80' is removed from active connections with key of 'WebDAVUnlocker'.
                >systemdatabase/6 04.20 11:15:50.486 WebDAVUnlocker release pool connection
                >requestaudit/6 04.20 11:16:00.008 Audit Request Monitor Request Audit Report over the last 120 Seconds for server wcc_cluster****
                requestaudit/6 04.20 11:16:00.008 Audit Request Monitor -Num Requests 0 No requests occurred during this period
                requestaudit/6 04.20 11:16:00.008 Audit Request Monitor ****End Audit Report*****
                >systemdatabase/7 04.20 11:16:17.332 DocumentStateMonitor wcc_cluster assigning connection
                >systemdatabase/6 04.20 11:16:17.333 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.
                >systemdatabase/6 04.20 11:16:17.333 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1
                >systemdatabase/6 04.20 11:16:17.333 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.77 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.
                >systemdatabase/6 04.20 11:16:17.333 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.22 ms.  connect
                >systemdatabase/6 04.20 11:16:17.333 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.77
                >systemdatabase/7 04.20 11:16:17.334 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'
                >systemdatabase/6 04.20 11:16:17.335 DocumentStateMonitor wcc_cluster 0.85 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:16:17.335 DocumentStateMonitor wcc_cluster Closing active result set
                >systemdatabase/6 04.20 11:16:17.335 DocumentStateMonitor wcc_cluster Closing statement in closing internals
                >systemdatabase/7 04.20 11:16:17.335 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'
                >systemdatabase/6 04.20 11:16:17.336 DocumentStateMonitor wcc_cluster 0.69 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]
                >systemdatabase/6 04.20 11:16:17.336 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0
                >

                • 5. Re: UCM Search is not working , i'm getting error while perform search
                  User258546

                  we don't have permissions to attach any files so I'm copying here

                  • 6. Re: UCM Search is not working , i'm getting error while perform search
                    User258546

                    >systemdatabase/7 04.20 10:51:43.606 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:51:43.612 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:51:43.612 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:51:43.612 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:51:43.612 WebDAVUnlocker Assigned connection to this thread, took 6.80 ms.  connect

                    >systemdatabase/6 04.20 10:51:43.613 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:51:43.613 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:51:43.613'}

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker 1.07 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:51:43.613'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:51:43.614 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:51:44.210 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster Connection with last id of sj_immediate_work.71 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.08 ms.  connect

                    >systemdatabase/6 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.71

                    >systemdatabase/7 04.20 10:51:44.211 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:51:44.212 DocumentStateMonitor wcc_cluster 0.77 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:51:44.212 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:51:44.212 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:51:44.212 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster 0.70 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.71' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:51:44.213 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:52:13.617 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:52:13.617 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:52:13.618 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:52:13.618 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:52:13.618 WebDAVUnlocker Connection with last id of SubjectManager.72 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:52:13.618 WebDAVUnlocker Assigned connection to this thread, took 1.21 ms.  connect

                    >systemdatabase/6 04.20 10:52:13.618 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.72

                    >systemdatabase/7 04.20 10:52:13.618 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:52:13.618'}

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker 1.15 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:52:13.618'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.72' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:52:13.620 WebDAVUnlocker release pool connection

                    >indexer/6 04.20 10:52:24.563 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                    >indexer/7 04.20 10:52:24.564 index update work /apps/opt/mw/admin/ipm_domain/wcc_cluster/cs/search/search.cfg doesn't exist.

                    >indexer/6 04.20 10:52:24.564 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                    >indexer/7 04.20 10:52:24.575 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                    >indexer/7 04.20 10:52:24.578 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                    >indexer/7 04.20 10:52:24.581 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                    >systemdatabase/7 04.20 10:52:24.591 index update work assigning connection

                    >systemdatabase/6 04.20 10:52:24.592 index update work Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:52:24.592 index update work !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:52:24.592 index update work Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'index update work'.

                    >systemdatabase/6 04.20 10:52:24.592 index update work Assigned connection to this thread, took 1.11 ms.  connect

                    >systemdatabase/6 04.20 10:52:24.592 index update work Preparing connection for use, id initialized as index update work.73

                    >systemdatabase/7 04.20 10:52:24.592 index update work (start) SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                    systemdatabase/7 04.20 10:52:24.592 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                    systemdatabase/7 04.20 10:52:24.592 index update work   Revisions.dOutDate < {ts '2017-04-20 10:53:24.591'} AND (dWorkflowState IS NULL or dWorkflowState = '')

                    >systemdatabase/6 04.20 10:52:24.594 index update work 1.51 ms. SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                    systemdatabase/6 04.20 10:52:24.594 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                    systemdatabase/6 04.20 10:52:24.594 index update work   Revisions.dOutDate < {ts '2017-04-20 10:53:24.591'} AND (dWorkflowState IS NULL or dWorkflowState = '')[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:24.594 index update work Closing active result set

                    >systemdatabase/6 04.20 10:52:24.594 index update work Closing statement in closing internals

                    >systemdatabase/7 04.20 10:52:24.594 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                    systemdatabase/7 04.20 10:52:24.594 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:52:24.594 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                    systemdatabase/7 04.20 10:52:24.594 index update work   AND Revisions.dInDate<={ts '2017-04-20 10:53:24.591'}

                    >systemdatabase/6 04.20 10:52:24.595 index update work 1.19 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                    systemdatabase/6 04.20 10:52:24.595 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:52:24.595 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                    systemdatabase/6 04.20 10:52:24.595 index update work   AND Revisions.dInDate<={ts '2017-04-20 10:53:24.591'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:24.602 index update work begin tran - soft

                    >systemdatabase/6 04.20 10:52:24.602 index update work Closing active result set

                    >systemdatabase/6 04.20 10:52:24.602 index update work Closing statement in closing internals

                    >systemdatabase/7 04.20 10:52:24.602 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                    systemdatabase/7 04.20 10:52:24.602 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:52:24.602 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                    systemdatabase/7 04.20 10:52:24.602 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                    systemdatabase/7 04.20 10:52:24.602 index update work   AND (dStatus <> 'GENWWW'))

                    >systemdatabase/6 04.20 10:52:24.610 index update work 7.51 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                    systemdatabase/6 04.20 10:52:24.610 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:52:24.610 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                    systemdatabase/6 04.20 10:52:24.610 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                    systemdatabase/6 04.20 10:52:24.610 index update work   AND (dStatus <> 'GENWWW'))[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:24.610 index update work Closing statement in closing internals

                    >systemdatabase/6 04.20 10:52:24.610 index update work Closing active result set

                    >systemdatabase/6 04.20 10:52:24.610 index update work commit called.

                    >systemdatabase/6 04.20 10:52:24.611 index update work tran committed

                    >systemdatabase/6 04.20 10:52:24.611 index update work begin tran - soft

                    >systemdatabase/7 04.20 10:52:24.611 index update work (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                    systemdatabase/7 04.20 10:52:24.611 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:52:24.611 index update work   WHERE ((dStatus = 'DELETED')

                    systemdatabase/7 04.20 10:52:24.611 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))

                    >systemdatabase/6 04.20 10:52:24.619 index update work 7.72 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                    systemdatabase/6 04.20 10:52:24.619 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:52:24.619 index update work   WHERE ((dStatus = 'DELETED')

                    systemdatabase/6 04.20 10:52:24.619 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:24.619 index update work Closing statement in closing internals

                    >systemdatabase/6 04.20 10:52:24.619 index update work Closing active result set

                    >systemdatabase/6 04.20 10:52:24.619 index update work commit called.

                    >systemdatabase/6 04.20 10:52:24.619 index update work tran committed

                    >indexer/7 04.20 10:52:24.626 index update work isRebuild?false; IndexerStep:Replication;  Class:intradoc.server.IndexerReplication

                    >indexer/7 04.20 10:52:24.629 index update work isRebuild?false; IndexerStep:PostIndexingStep;  Action:postIndexingStep

                    >indexer/7 04.20 10:52:24.633 index update work isRebuild?false; IndexerStep:Cleanup;  Class:intradoc.indexer.Indexer

                    >systemdatabase/7 04.20 10:52:24.641 index update work (start) UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                    systemdatabase/7 04.20 10:52:24.641 index update work   SET dIndexerState = ''

                    systemdatabase/7 04.20 10:52:24.641 index update work   WHERE dIndexerState = 'A'

                    >systemdatabase/6 04.20 10:52:24.642 index update work 0.89 ms. UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                    systemdatabase/6 04.20 10:52:24.642 index update work   SET dIndexerState = ''

                    systemdatabase/6 04.20 10:52:24.642 index update work   WHERE dIndexerState = 'A'[Executed. 0 row(s) affected.]

                    >systemdatabase/6 04.20 10:52:24.645 index update work !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:52:24.645 index update work Connection with id of 'index update work.73' is removed from active connections with key of 'index update work'.

                    >systemdatabase/6 04.20 10:52:24.645 index update work release pool connection

                    >indexer/7 04.20 10:52:24.649 index update work isRebuild?false; IndexerStep:PostCleanupStep;  Action:postCleanupStep

                    >indexer/7 04.20 10:52:24.652 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                    >indexer/7 04.20 10:52:24.655 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                    >indexer/7 04.20 10:52:24.658 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                    >systemdatabase/6 04.20 10:52:43.628 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:52:43.628 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:52:43.629 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:52:43.629 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:52:43.629 WebDAVUnlocker Connection with last id of DocumentStateMonitor wcc_cluster.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:52:43.629 WebDAVUnlocker Assigned connection to this thread, took 1.03 ms.  connect

                    >systemdatabase/6 04.20 10:52:43.629 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:52:43.629 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:52:43.629'}

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker 1.48 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:52:43.629'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:52:43.631 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:52:44.220 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster Connection with last id of WebDAVUnlocker.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 0.97 ms.  connect

                    >systemdatabase/6 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:52:44.221 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:52:44.222 DocumentStateMonitor wcc_cluster 0.71 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:52:44.222 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:52:44.222 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:52:44.222 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster 0.71 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:52:44.223 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:53:13.639 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:53:13.639 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:53:13.640 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:53:13.640 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:53:13.640 WebDAVUnlocker Connection with last id of index update work.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:53:13.640 WebDAVUnlocker Assigned connection to this thread, took 1.12 ms.  connect

                    >systemdatabase/6 04.20 10:53:13.640 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:53:13.640 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:53:13.640'}

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker 1.22 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:53:13.640'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:53:13.642 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 10:53:43.650 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:53:43.650 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:53:43.651 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:53:43.651 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:53:43.651 WebDAVUnlocker Connection with last id of WebDAVUnlocker.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:53:43.651 WebDAVUnlocker Assigned connection to this thread, took 1.07 ms.  connect

                    >systemdatabase/6 04.20 10:53:43.651 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:53:43.651 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:53:43.651'}

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker 1.00 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:53:43.651'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:53:43.653 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:53:44.230 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.08 ms.  connect

                    >systemdatabase/6 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:53:44.231 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:53:44.232 DocumentStateMonitor wcc_cluster 0.73 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:53:44.232 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:53:44.232 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:53:44.232 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster 0.67 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:53:44.233 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:54:13.670 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:54:13.670 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:54:13.671 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:54:13.671 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:54:13.671 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:54:13.671 WebDAVUnlocker Assigned connection to this thread, took 0.88 ms.  connect

                    >systemdatabase/6 04.20 10:54:13.671 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:54:13.671 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:54:13.671'}

                    >systemdatabase/6 04.20 10:54:13.672 WebDAVUnlocker 0.90 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:54:13.671'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:54:13.672 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:54:13.672 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:54:13.672 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:54:13.673 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:54:13.673 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:54:13.673 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:54:13.673 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 10:54:43.680 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:54:43.680 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:54:43.681 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:54:43.681 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:54:43.681 WebDAVUnlocker Connection with last id of WebDAVUnlocker.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:54:43.681 WebDAVUnlocker Assigned connection to this thread, took 0.93 ms.  connect

                    >systemdatabase/6 04.20 10:54:43.681 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:54:43.682 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:54:43.681'}

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker 0.94 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:54:43.681'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:54:43.683 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:54:44.240 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:54:44.241 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:54:44.241 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:54:44.241 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:54:44.241 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.00 ms.  connect

                    >systemdatabase/6 04.20 10:54:44.241 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:54:44.242 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:54:44.242 DocumentStateMonitor wcc_cluster 0.70 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:54:44.242 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:54:44.242 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster 0.64 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:54:44.243 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:54:44.244 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:55:13.689 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:55:13.689 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:55:13.690 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:55:13.690 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:55:13.690 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:55:13.690 WebDAVUnlocker Assigned connection to this thread, took 1.04 ms.  connect

                    >systemdatabase/6 04.20 10:55:13.690 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:55:13.692 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:55:13.691'}

                    >systemdatabase/6 04.20 10:55:13.693 WebDAVUnlocker 1.69 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:55:13.691'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:55:13.693 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:55:13.693 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:55:13.694 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:55:13.694 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:55:13.694 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:55:13.694 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:55:13.694 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 10:55:43.695 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:55:43.695 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:55:43.696 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:55:43.696 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:55:43.696 WebDAVUnlocker Connection with last id of WebDAVUnlocker.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:55:43.696 WebDAVUnlocker Assigned connection to this thread, took 1.02 ms.  connect

                    >systemdatabase/6 04.20 10:55:43.696 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:55:43.696 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:55:43.696'}

                    >systemdatabase/6 04.20 10:55:43.697 WebDAVUnlocker 1.00 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:55:43.696'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:55:43.697 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:55:43.697 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:55:43.697 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:55:43.697 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:55:43.698 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:55:43.698 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:55:43.698 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:55:44.251 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.12 ms.  connect

                    >systemdatabase/6 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:55:44.252 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:55:44.253 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:55:44.253 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:55:44.253 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:55:44.253 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster 0.69 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:55:44.254 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:56:13.718 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:56:13.718 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:56:13.719 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:56:13.719 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:56:13.719 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:56:13.719 WebDAVUnlocker Assigned connection to this thread, took 0.96 ms.  connect

                    >systemdatabase/6 04.20 10:56:13.719 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:56:13.719 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:56:13.719'}

                    >systemdatabase/6 04.20 10:56:13.720 WebDAVUnlocker 0.95 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:56:13.719'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:56:13.720 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:56:13.721 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:56:15.971 sj_immediate_work assigning connection

                    >systemdatabase/6 04.20 10:56:15.971 sj_immediate_work Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:56:15.972 sj_immediate_work !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:56:15.972 sj_immediate_work Connection with last id of WebDAVUnlocker.71 is added to active connections with key of 'sj_immediate_work'.

                    >systemdatabase/6 04.20 10:56:15.972 sj_immediate_work Assigned connection to this thread, took 1.05 ms.  connect

                    >systemdatabase/6 04.20 10:56:15.972 sj_immediate_work Preparing connection for use, id initialized as sj_immediate_work.71

                    >systemdatabase/7 04.20 10:56:15.972 sj_immediate_work (start) SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                    systemdatabase/7 04.20 10:56:15.972 sj_immediate_work     ORDER BY dSjPriority ASC

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work 0.96 ms. SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                    systemdatabase/6 04.20 10:56:15.973 sj_immediate_work     ORDER BY dSjPriority ASC[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work Connection with id of 'sj_immediate_work.71' is removed from active connections with key of 'sj_immediate_work'.

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work Closing active result set

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work Closing statement in closing internals

                    >systemdatabase/6 04.20 10:56:15.973 sj_immediate_work release pool connection

                    >systemdatabase/7 04.20 10:56:18.974 SubjectManager assigning connection

                    >systemdatabase/6 04.20 10:56:18.974 SubjectManager Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:56:18.975 SubjectManager !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:56:18.975 SubjectManager Connection with last id of DocumentStateMonitor wcc_cluster.72 is added to active connections with key of 'SubjectManager'.

                    >systemdatabase/6 04.20 10:56:18.975 SubjectManager Assigned connection to this thread, took 1.01 ms.  connect

                    >systemdatabase/6 04.20 10:56:18.975 SubjectManager Preparing connection for use, id initialized as SubjectManager.72

                    >systemdatabase/7 04.20 10:56:18.975 SubjectManager (start) SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                    systemdatabase/7 04.20 10:56:18.975 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate

                    >systemdatabase/6 04.20 10:56:18.976 SubjectManager 0.95 ms. SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                    systemdatabase/6 04.20 10:56:18.976 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:56:18.976 SubjectManager Closing active result set

                    >systemdatabase/6 04.20 10:56:18.976 SubjectManager Closing statement in closing internals

                    >systemdatabase/7 04.20 10:56:18.976 SubjectManager (start) UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'

                    systemdatabase/7 04.20 10:56:18.976 SubjectManager   WHERE ((dConversionState = 'Aborted') OR

                    systemdatabase/7 04.20 10:56:18.976 SubjectManager   (dConvStartDate < {ts '2017-04-20 06:56:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:26:00.000'} AND

                    systemdatabase/7 04.20 10:56:18.976 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR

                    systemdatabase/7 04.20 10:56:18.976 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))

                    >systemdatabase/6 04.20 10:56:18.977 SubjectManager 0.90 ms. UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'

                    systemdatabase/6 04.20 10:56:18.977 SubjectManager   WHERE ((dConversionState = 'Aborted') OR

                    systemdatabase/6 04.20 10:56:18.977 SubjectManager   (dConvStartDate < {ts '2017-04-20 06:56:00.000'} AND ((dConvActionDate < {ts '2017-04-20 10:26:00.000'} AND

                    systemdatabase/6 04.20 10:56:18.977 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR

                    systemdatabase/6 04.20 10:56:18.977 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))[Executed. 0 row(s) affected.]

                    >systemdatabase/6 04.20 10:56:18.977 SubjectManager !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:56:18.977 SubjectManager Connection with id of 'SubjectManager.72' is removed from active connections with key of 'SubjectManager'.

                    >systemdatabase/6 04.20 10:56:18.977 SubjectManager release pool connection

                    >systemdatabase/6 04.20 10:56:43.729 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:56:43.729 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:56:43.730 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:56:43.730 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:56:43.730 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:56:43.730 WebDAVUnlocker Assigned connection to this thread, took 1.00 ms.  connect

                    >systemdatabase/6 04.20 10:56:43.730 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:56:43.730 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:56:43.730'}

                    >systemdatabase/6 04.20 10:56:43.731 WebDAVUnlocker 0.97 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:56:43.730'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:56:43.731 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:56:43.731 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:56:43.731 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:56:43.732 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:56:43.732 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:56:43.732 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:56:43.732 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:56:44.261 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster Connection with last id of sj_immediate_work.71 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 0.96 ms.  connect

                    >systemdatabase/6 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.71

                    >systemdatabase/7 04.20 10:56:44.262 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:56:44.263 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:56:44.263 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:56:44.263 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:56:44.263 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster 0.72 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.71' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:56:44.264 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:57:13.732 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:57:13.732 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:57:13.733 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:57:13.733 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:57:13.733 WebDAVUnlocker Connection with last id of SubjectManager.72 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:57:13.733 WebDAVUnlocker Assigned connection to this thread, took 1.03 ms.  connect

                    >systemdatabase/6 04.20 10:57:13.733 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.72

                    >systemdatabase/7 04.20 10:57:13.733 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:57:13.733'}

                    >systemdatabase/6 04.20 10:57:13.734 WebDAVUnlocker 0.95 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:57:13.733'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:13.734 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:57:13.734 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:57:13.734 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:57:13.735 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:57:13.735 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:57:13.735 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.72' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:57:13.735 WebDAVUnlocker release pool connection

                    >indexer/6 04.20 10:57:25.113 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                    >indexer/7 04.20 10:57:25.114 index update work /apps/opt/mw/admin/ipm_domain/wcc_cluster/cs/search/search.cfg doesn't exist.

                    >indexer/6 04.20 10:57:25.114 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                    >indexer/7 04.20 10:57:25.124 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                    >indexer/7 04.20 10:57:25.128 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                    >indexer/7 04.20 10:57:25.131 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                    >systemdatabase/7 04.20 10:57:25.140 index update work assigning connection

                    >systemdatabase/6 04.20 10:57:25.141 index update work Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:57:25.141 index update work !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:57:25.141 index update work Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'index update work'.

                    >systemdatabase/6 04.20 10:57:25.141 index update work Assigned connection to this thread, took 1.04 ms.  connect

                    >systemdatabase/6 04.20 10:57:25.141 index update work Preparing connection for use, id initialized as index update work.73

                    >systemdatabase/7 04.20 10:57:25.142 index update work (start) SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                    systemdatabase/7 04.20 10:57:25.142 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                    systemdatabase/7 04.20 10:57:25.142 index update work   Revisions.dOutDate < {ts '2017-04-20 10:58:25.140'} AND (dWorkflowState IS NULL or dWorkflowState = '')

                    >systemdatabase/6 04.20 10:57:25.143 index update work 1.21 ms. SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                    systemdatabase/6 04.20 10:57:25.143 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                    systemdatabase/6 04.20 10:57:25.143 index update work   Revisions.dOutDate < {ts '2017-04-20 10:58:25.140'} AND (dWorkflowState IS NULL or dWorkflowState = '')[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:25.143 index update work Closing active result set

                    >systemdatabase/6 04.20 10:57:25.143 index update work Closing statement in closing internals

                    >systemdatabase/7 04.20 10:57:25.143 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                    systemdatabase/7 04.20 10:57:25.143 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:57:25.143 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                    systemdatabase/7 04.20 10:57:25.143 index update work   AND Revisions.dInDate<={ts '2017-04-20 10:58:25.140'}

                    >systemdatabase/6 04.20 10:57:25.144 index update work 1.16 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                    systemdatabase/6 04.20 10:57:25.144 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:57:25.144 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                    systemdatabase/6 04.20 10:57:25.144 index update work   AND Revisions.dInDate<={ts '2017-04-20 10:58:25.140'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:25.151 index update work begin tran - soft

                    >systemdatabase/6 04.20 10:57:25.151 index update work Closing active result set

                    >systemdatabase/6 04.20 10:57:25.151 index update work Closing statement in closing internals

                    >systemdatabase/7 04.20 10:57:25.151 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                    systemdatabase/7 04.20 10:57:25.151 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:57:25.151 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                    systemdatabase/7 04.20 10:57:25.151 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                    systemdatabase/7 04.20 10:57:25.151 index update work   AND (dStatus <> 'GENWWW'))

                    >systemdatabase/6 04.20 10:57:25.159 index update work 8.43 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                    systemdatabase/6 04.20 10:57:25.159 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:57:25.159 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                    systemdatabase/6 04.20 10:57:25.159 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                    systemdatabase/6 04.20 10:57:25.159 index update work   AND (dStatus <> 'GENWWW'))[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:25.159 index update work Closing statement in closing internals

                    >systemdatabase/6 04.20 10:57:25.160 index update work Closing active result set

                    >systemdatabase/6 04.20 10:57:25.160 index update work commit called.

                    >systemdatabase/6 04.20 10:57:25.160 index update work tran committed

                    >systemdatabase/6 04.20 10:57:25.160 index update work begin tran - soft

                    >systemdatabase/7 04.20 10:57:25.160 index update work (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                    systemdatabase/7 04.20 10:57:25.160 index update work   FROM Revisions

                    systemdatabase/7 04.20 10:57:25.160 index update work   WHERE ((dStatus = 'DELETED')

                    systemdatabase/7 04.20 10:57:25.160 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))

                    >systemdatabase/6 04.20 10:57:25.170 index update work 9.34 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                    systemdatabase/6 04.20 10:57:25.170 index update work   FROM Revisions

                    systemdatabase/6 04.20 10:57:25.170 index update work   WHERE ((dStatus = 'DELETED')

                    systemdatabase/6 04.20 10:57:25.170 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:25.170 index update work Closing statement in closing internals

                    >systemdatabase/6 04.20 10:57:25.170 index update work Closing active result set

                    >systemdatabase/6 04.20 10:57:25.170 index update work commit called.

                    >systemdatabase/6 04.20 10:57:25.170 index update work tran committed

                    >indexer/7 04.20 10:57:25.177 index update work isRebuild?false; IndexerStep:Replication;  Class:intradoc.server.IndexerReplication

                    >indexer/7 04.20 10:57:25.180 index update work isRebuild?false; IndexerStep:PostIndexingStep;  Action:postIndexingStep

                    >indexer/7 04.20 10:57:25.183 index update work isRebuild?false; IndexerStep:Cleanup;  Class:intradoc.indexer.Indexer

                    >systemdatabase/7 04.20 10:57:25.192 index update work (start) UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                    systemdatabase/7 04.20 10:57:25.192 index update work   SET dIndexerState = ''

                    systemdatabase/7 04.20 10:57:25.192 index update work   WHERE dIndexerState = 'A'

                    >systemdatabase/6 04.20 10:57:25.192 index update work 0.93 ms. UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                    systemdatabase/6 04.20 10:57:25.192 index update work   SET dIndexerState = ''

                    systemdatabase/6 04.20 10:57:25.192 index update work   WHERE dIndexerState = 'A'[Executed. 0 row(s) affected.]

                    >systemdatabase/6 04.20 10:57:25.195 index update work !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:57:25.195 index update work Connection with id of 'index update work.73' is removed from active connections with key of 'index update work'.

                    >systemdatabase/6 04.20 10:57:25.195 index update work release pool connection

                    >indexer/7 04.20 10:57:25.199 index update work isRebuild?false; IndexerStep:PostCleanupStep;  Action:postCleanupStep

                    >indexer/7 04.20 10:57:25.203 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                    >indexer/7 04.20 10:57:25.205 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                    >indexer/7 04.20 10:57:25.209 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                    >systemdatabase/6 04.20 10:57:43.735 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:57:43.735 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:57:43.736 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:57:43.736 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:57:43.736 WebDAVUnlocker Connection with last id of DocumentStateMonitor wcc_cluster.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:57:43.736 WebDAVUnlocker Assigned connection to this thread, took 0.93 ms.  connect

                    >systemdatabase/6 04.20 10:57:43.736 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:57:43.736 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:57:43.736'}

                    >systemdatabase/6 04.20 10:57:43.737 WebDAVUnlocker 0.93 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:57:43.736'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:57:43.737 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:57:43.737 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:57:43.737 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:57:43.738 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:57:43.738 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:57:43.738 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:57:43.738 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:57:44.271 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster Connection with last id of WebDAVUnlocker.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 0.98 ms.  connect

                    >systemdatabase/6 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:57:44.272 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:57:44.273 DocumentStateMonitor wcc_cluster 0.75 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:57:44.273 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:57:44.273 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:57:44.273 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster 0.72 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:57:44.274 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:58:13.738 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:58:13.738 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:58:13.739 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:58:13.739 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:58:13.739 WebDAVUnlocker Connection with last id of index update work.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:58:13.739 WebDAVUnlocker Assigned connection to this thread, took 1.06 ms.  connect

                    >systemdatabase/6 04.20 10:58:13.740 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:58:13.740 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:58:13.740'}

                    >systemdatabase/6 04.20 10:58:13.741 WebDAVUnlocker 1.04 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:58:13.740'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:58:13.741 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:58:13.741 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:58:13.741 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:58:13.742 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:58:13.742 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:58:13.742 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:58:13.742 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 10:58:43.749 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:58:43.750 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:58:43.750 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:58:43.750 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:58:43.750 WebDAVUnlocker Connection with last id of WebDAVUnlocker.71 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:58:43.751 WebDAVUnlocker Assigned connection to this thread, took 0.96 ms.  connect

                    >systemdatabase/6 04.20 10:58:43.751 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.71

                    >systemdatabase/7 04.20 10:58:43.751 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:58:43.751'}

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker 0.99 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:58:43.751'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.71' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:58:43.752 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:58:44.281 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:58:44.282 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:58:44.282 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:58:44.282 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.72 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:58:44.282 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.02 ms.  connect

                    >systemdatabase/6 04.20 10:58:44.283 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.72

                    >systemdatabase/7 04.20 10:58:44.283 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:58:44.283 DocumentStateMonitor wcc_cluster 0.73 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:58:44.284 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:58:44.284 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:58:44.284 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster 0.76 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.72' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:58:44.285 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 10:59:13.752 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:59:13.753 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:59:13.753 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:59:13.753 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:59:13.754 WebDAVUnlocker Connection with last id of WebDAVUnlocker.73 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:59:13.754 WebDAVUnlocker Assigned connection to this thread, took 1.02 ms.  connect

                    >systemdatabase/6 04.20 10:59:13.754 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.73

                    >systemdatabase/7 04.20 10:59:13.754 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:59:13.754'}

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker 0.94 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:59:13.754'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.73' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:59:13.755 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 10:59:43.756 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 10:59:43.756 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 10:59:43.827 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'

                    >systemdatabase/6 04.20 10:59:43.828 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'

                    >systemdatabase/6 04.20 10:59:43.828 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'

                    >systemdatabase/6 04.20 10:59:43.829 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'

                    >systemdatabase/6 04.20 10:59:43.830 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'

                    >systemdatabase/6 04.20 10:59:43.830 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'

                    >systemdatabase/6 04.20 10:59:43.831 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'

                    >systemdatabase/6 04.20 10:59:43.831 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'

                    >systemdatabase/6 04.20 10:59:43.833 WebDAVUnlocker New connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:59:43.833 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:59:43.833 WebDAVUnlocker Connection with last id of <unassigned> is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:59:43.833 WebDAVUnlocker Assigned connection to this thread, took 77 ms.  connect

                    >systemdatabase/6 04.20 10:59:43.833 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.74

                    >systemdatabase/7 04.20 10:59:43.833 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:59:43.833'}

                    >systemdatabase/6 04.20 10:59:43.835 WebDAVUnlocker 2.04 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 10:59:43.833'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 10:59:43.835 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 10:59:43.835 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 10:59:43.835 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 10:59:43.836 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 10:59:43.836 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:59:43.836 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.74' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 10:59:43.836 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 10:59:44.292 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 10:59:44.359 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'

                    >systemdatabase/6 04.20 10:59:44.360 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'

                    >systemdatabase/6 04.20 10:59:44.361 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'

                    >systemdatabase/6 04.20 10:59:44.361 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'

                    >systemdatabase/6 04.20 10:59:44.361 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'

                    >systemdatabase/6 04.20 10:59:44.362 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'

                    >systemdatabase/6 04.20 10:59:44.362 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'

                    >systemdatabase/6 04.20 10:59:44.363 DocumentStateMonitor wcc_cluster Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'

                    >systemdatabase/6 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster New connection retrieved from external pool.

                    >systemdatabase/6 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster Connection with last id of <unassigned> is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 77 ms.  connect

                    >systemdatabase/6 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75

                    >systemdatabase/7 04.20 10:59:44.369 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 10:59:44.370 DocumentStateMonitor wcc_cluster 1.05 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:59:44.370 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:59:44.370 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 10:59:44.371 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster 1.03 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 10:59:44.372 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 11:00:13.839 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 11:00:13.839 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 11:00:13.945 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'

                    >systemdatabase/6 04.20 11:00:13.946 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'

                    >systemdatabase/6 04.20 11:00:13.946 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'

                    >systemdatabase/6 04.20 11:00:13.947 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'

                    >systemdatabase/6 04.20 11:00:13.947 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'

                    >systemdatabase/6 04.20 11:00:13.948 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'

                    >systemdatabase/6 04.20 11:00:13.949 WebDAVUnlocker Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'

                    >systemdatabase/6 04.20 11:00:13.949 WebDAVUnlocker Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'

                    >systemdatabase/6 04.20 11:00:13.951 WebDAVUnlocker New connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:00:13.951 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:00:13.951 WebDAVUnlocker Connection with last id of <unassigned> is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:00:13.951 WebDAVUnlocker Assigned connection to this thread, took 112 ms.  connect

                    >systemdatabase/6 04.20 11:00:13.951 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76

                    >systemdatabase/7 04.20 11:00:13.951 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:00:13.951'}

                    >systemdatabase/6 04.20 11:00:13.953 WebDAVUnlocker 1.74 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:00:13.951'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:00:13.953 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 11:00:13.953 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 11:00:13.953 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 11:00:13.953 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 11:00:13.954 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:00:13.954 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:00:13.954 WebDAVUnlocker release pool connection

                    >systemdatabase/6 04.20 11:00:43.954 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 11:00:43.954 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 11:00:43.955 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:00:43.955 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:00:43.955 WebDAVUnlocker Connection with last id of WebDAVUnlocker.74 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:00:43.955 WebDAVUnlocker Assigned connection to this thread, took 1.11 ms.  connect

                    >systemdatabase/6 04.20 11:00:43.955 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.74

                    >systemdatabase/7 04.20 11:00:43.955 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:00:43.955'}

                    >systemdatabase/6 04.20 11:00:43.956 WebDAVUnlocker 0.96 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:00:43.955'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:00:43.956 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 11:00:43.956 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 11:00:43.957 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 11:00:43.957 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 11:00:43.957 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:00:43.957 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.74' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:00:43.957 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 11:00:44.374 DocumentStateMonitor wcc_cluster assigning connection

                    >systemdatabase/6 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.15 ms.  connect

                    >systemdatabase/6 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.75

                    >systemdatabase/7 04.20 11:00:44.375 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                    >systemdatabase/6 04.20 11:00:44.376 DocumentStateMonitor wcc_cluster 0.76 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:00:44.376 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 11:00:44.376 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/7 04.20 11:00:44.376 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.75' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster Closing active result set

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                    >systemdatabase/6 04.20 11:00:44.377 DocumentStateMonitor wcc_cluster release pool connection

                    >systemdatabase/6 04.20 11:01:13.965 WebDAVUnlocker begin tran - soft

                    >systemdatabase/7 04.20 11:01:13.965 WebDAVUnlocker assigning connection

                    >systemdatabase/6 04.20 11:01:13.966 WebDAVUnlocker Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:13.966 WebDAVUnlocker !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:13.966 WebDAVUnlocker Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:01:13.966 WebDAVUnlocker Assigned connection to this thread, took 1.17 ms.  connect

                    >systemdatabase/6 04.20 11:01:13.966 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.76

                    >systemdatabase/7 04.20 11:01:13.966 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:01:13.966'}

                    >systemdatabase/6 04.20 11:01:13.967 WebDAVUnlocker 0.89 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 11:01:13.966'}[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:01:13.967 WebDAVUnlocker Closing active result set

                    >systemdatabase/6 04.20 11:01:13.967 WebDAVUnlocker Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:13.967 WebDAVUnlocker commit called.

                    >systemdatabase/6 04.20 11:01:13.968 WebDAVUnlocker tran committed

                    >systemdatabase/6 04.20 11:01:13.968 WebDAVUnlocker !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:13.968 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.76' is removed from active connections with key of 'WebDAVUnlocker'.

                    >systemdatabase/6 04.20 11:01:13.968 WebDAVUnlocker release pool connection

                    >systemdatabase/7 04.20 11:01:16.482 sj_immediate_work assigning connection

                    >systemdatabase/6 04.20 11:01:16.483 sj_immediate_work Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.483 sj_immediate_work !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.483 sj_immediate_work Connection with last id of WebDAVUnlocker.74 is added to active connections with key of 'sj_immediate_work'.

                    >systemdatabase/6 04.20 11:01:16.483 sj_immediate_work Assigned connection to this thread, took 1.20 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.483 sj_immediate_work Preparing connection for use, id initialized as sj_immediate_work.74

                    >systemdatabase/7 04.20 11:01:16.483 sj_immediate_work (start) SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                    systemdatabase/7 04.20 11:01:16.483 sj_immediate_work     ORDER BY dSjPriority ASC

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work 4.03 ms. SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                    systemdatabase/6 04.20 11:01:16.488 sj_immediate_work     ORDER BY dSjPriority ASC[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work Connection with id of 'sj_immediate_work.74' is removed from active connections with key of 'sj_immediate_work'.

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work Closing active result set

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:16.488 sj_immediate_work release pool connection

                    >systemdatabase/7 04.20 11:01:16.509 Scheduled System Events assigning connection

                    >systemdatabase/6 04.20 11:01:16.510 Scheduled System Events Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.510 Scheduled System Events !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.510 Scheduled System Events Connection with last id of DocumentStateMonitor wcc_cluster.75 is added to active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.510 Scheduled System Events Assigned connection to this thread, took 1.07 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.510 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.75

                    >systemdatabase/7 04.20 11:01:16.510 Scheduled System Events (start) SELECT/*+ USE_NL (WorkflowDocuments Revisions) LEADING(WorkflowDocuments)INDEX (WorkflowDocuments dWfDocState)*/ DISTINCT Revisions.dRevClassID

                    systemdatabase/7 04.20 11:01:16.510 Scheduled System Events   FROM WorkflowDocuments, Revisions

                    systemdatabase/7 04.20 11:01:16.510 Scheduled System Events   WHERE WorkflowDocuments.dDocName=Revisions.dDocName

                    systemdatabase/7 04.20 11:01:16.510 Scheduled System Events   AND Revisions.dStatus<>'DELETED'

                    systemdatabase/7 04.20 11:01:16.510 Scheduled System Events   AND WorkflowDocuments.dWfDocState='INPROCESS'

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events 39 ms. SELECT/*+ USE_NL (WorkflowDocuments Revisions) LEADING(WorkflowDocuments)INDEX (WorkflowDocuments dWfDocState)*/ DISTINCT Revisions.dRevClassID

                    systemdatabase/6 04.20 11:01:16.549 Scheduled System Events   FROM WorkflowDocuments, Revisions

                    systemdatabase/6 04.20 11:01:16.549 Scheduled System Events   WHERE WorkflowDocuments.dDocName=Revisions.dDocName

                    systemdatabase/6 04.20 11:01:16.549 Scheduled System Events   AND Revisions.dStatus<>'DELETED'

                    systemdatabase/6 04.20 11:01:16.549 Scheduled System Events   AND WorkflowDocuments.dWfDocState='INPROCESS'[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events Connection with id of 'Scheduled System Events.75' is removed from active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:16.549 Scheduled System Events release pool connection

                    >systemdatabase/7 04.20 11:01:16.694 Scheduled System Events assigning connection

                    >systemdatabase/6 04.20 11:01:16.695 Scheduled System Events Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.695 Scheduled System Events !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.695 Scheduled System Events Connection with last id of WebDAVUnlocker.76 is added to active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.695 Scheduled System Events Assigned connection to this thread, took 1.19 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.695 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.76

                    >systemdatabase/7 04.20 11:01:16.695 Scheduled System Events (start) SELECT * FROM ScheduledJobs

                    systemdatabase/7 04.20 11:01:16.695 Scheduled System Events     WHERE dSjState in ('I') AND dSjType in ('O', 'R') AND dSjQueueType='S'

                    systemdatabase/7 04.20 11:01:16.695 Scheduled System Events     ORDER BY dSjPriority ASC

                    >systemdatabase/6 04.20 11:01:16.699 Scheduled System Events 3.59 ms. SELECT * FROM ScheduledJobs

                    systemdatabase/6 04.20 11:01:16.699 Scheduled System Events     WHERE dSjState in ('I') AND dSjType in ('O', 'R') AND dSjQueueType='S'

                    systemdatabase/6 04.20 11:01:16.699 Scheduled System Events     ORDER BY dSjPriority ASC[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.704 Scheduled System Events begin tran - soft

                    >systemdatabase/6 04.20 11:01:16.704 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.704 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.705 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarDays'

                    >systemdatabase/6 04.20 11:01:16.712 Scheduled System Events 7.67 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarDays'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.714 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.714 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.714 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarDays'

                    >systemdatabase/6 04.20 11:01:16.715 Scheduled System Events 0.85 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarDays'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.716 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.717 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:16.717 Scheduled System Events commit called.

                    >systemdatabase/6 04.20 11:01:16.717 Scheduled System Events tran committed

                    >systemdatabase/6 04.20 11:01:16.718 Scheduled System Events !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.718 Scheduled System Events Connection with id of 'Scheduled System Events.76' is removed from active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.718 Scheduled System Events release pool connection

                    >systemdatabase/6 04.20 11:01:16.723 Scheduled System Events begin tran - soft

                    >systemdatabase/7 04.20 11:01:16.723 Scheduled System Events assigning connection

                    >systemdatabase/6 04.20 11:01:16.724 Scheduled System Events Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.724 Scheduled System Events !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.724 Scheduled System Events Connection with last id of sj_immediate_work.74 is added to active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.724 Scheduled System Events Assigned connection to this thread, took 0.74 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.724 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.74

                    >systemdatabase/7 04.20 11:01:16.724 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarMonths'

                    >systemdatabase/6 04.20 11:01:16.725 Scheduled System Events 1.19 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarMonths'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.727 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.727 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.727 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarMonths'

                    >systemdatabase/6 04.20 11:01:16.728 Scheduled System Events 0.81 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarMonths'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.729 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.729 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:16.729 Scheduled System Events commit called.

                    >systemdatabase/6 04.20 11:01:16.729 Scheduled System Events tran committed

                    >systemdatabase/6 04.20 11:01:16.731 Scheduled System Events !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.731 Scheduled System Events Connection with id of 'Scheduled System Events.74' is removed from active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.731 Scheduled System Events release pool connection

                    >systemdatabase/6 04.20 11:01:16.733 Scheduled System Events begin tran - soft

                    >systemdatabase/7 04.20 11:01:16.733 Scheduled System Events assigning connection

                    >systemdatabase/6 04.20 11:01:16.734 Scheduled System Events Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.734 Scheduled System Events !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.734 Scheduled System Events Connection with last id of Scheduled System Events.75 is added to active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.734 Scheduled System Events Assigned connection to this thread, took 0.85 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.734 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.75

                    >systemdatabase/7 04.20 11:01:16.734 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='ZipRenditionStaticAccess'

                    >systemdatabase/6 04.20 11:01:16.736 Scheduled System Events 1.29 ms. SELECT * FROM ScheduledJobs WHERE dSjName='ZipRenditionStaticAccess'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.754 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.754 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.754 Scheduled System Events (start) UPDATE ScheduledJobs SET dSjState='A', dSjProgress='!wwSjStarted',

                    systemdatabase/7 04.20 11:01:16.754 Scheduled System Events     dSjLastProcessedTs={ts '2017-04-20 11:01:16.737'}, dSjLastProcessedStatus='S'

                    systemdatabase/7 04.20 11:01:16.754 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'

                    >systemdatabase/6 04.20 11:01:16.757 Scheduled System Events 2.64 ms. UPDATE ScheduledJobs SET dSjState='A', dSjProgress='!wwSjStarted',

                    systemdatabase/6 04.20 11:01:16.757 Scheduled System Events     dSjLastProcessedTs={ts '2017-04-20 11:01:16.737'}, dSjLastProcessedStatus='S'

                    systemdatabase/6 04.20 11:01:16.757 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'[Executed. 1 row(s) affected.]

                    >systemdatabase/7 04.20 11:01:16.757 Scheduled System Events (start) INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                    systemdatabase/7 04.20 11:01:16.757 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                    systemdatabase/7 04.20 11:01:16.757 Scheduled System Events     VALUES ('2ec59f4a8ce1a90','ZipRenditionStaticAccess',{ts '2017-04-20 11:01:16.737'},'A','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!wwSjStarted')

                    >systemdatabase/6 04.20 11:01:16.804 Scheduled System Events 46 ms. INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                    systemdatabase/6 04.20 11:01:16.804 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                    systemdatabase/6 04.20 11:01:16.804 Scheduled System Events     VALUES ('2ec59f4a8ce1a90','ZipRenditionStaticAccess',{ts '2017-04-20 11:01:16.737'},'A','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!wwSjStarted')[Executed. 1 row(s) affected.]

                    >systemdatabase/6 04.20 11:01:16.804 Scheduled System Events commit called.

                    >systemdatabase/6 04.20 11:01:16.805 Scheduled System Events tran committed

                    >systemdatabase/7 04.20 11:01:16.807 Scheduled System Events (start) SELECT *  FROM ZRMJobs WHERE dExtractJobState = 'E' ORDER BY dExtractJobCreatedDate

                    >systemdatabase/6 04.20 11:01:16.809 Scheduled System Events 2.08 ms. SELECT *  FROM ZRMJobs WHERE dExtractJobState = 'E' ORDER BY dExtractJobCreatedDate[Executed. Returned row(s): false]

                    >systemdatabase/6 04.20 11:01:16.810 Scheduled System Events begin tran - soft

                    >systemdatabase/6 04.20 11:01:16.810 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.810 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.810 Scheduled System Events (start) INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                    systemdatabase/7 04.20 11:01:16.810 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                    systemdatabase/7 04.20 11:01:16.810 Scheduled System Events     VALUES ('3f91703125a18ee','ZipRenditionStaticAccess',{ts '2017-04-20 11:01:16.809'},'S','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!csSjFinalProgress,1,1')

                    >systemdatabase/6 04.20 11:01:16.820 Scheduled System Events 9.99 ms. INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                    systemdatabase/6 04.20 11:01:16.820 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                    systemdatabase/6 04.20 11:01:16.820 Scheduled System Events     VALUES ('3f91703125a18ee','ZipRenditionStaticAccess',{ts '2017-04-20 11:01:16.809'},'S','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!csSjFinalProgress,1,1')[Executed. 1 row(s) affected.]

                    >systemdatabase/7 04.20 11:01:16.821 Scheduled System Events (start) UPDATE ScheduledJobs SET dSjState='I', dSjLastProcessedStatus='S', dSjLastProcessedTs={ts '2017-04-20 11:01:16.809'},

                    systemdatabase/7 04.20 11:01:16.821 Scheduled System Events     dSjProgress='!csSjProgressReport,1,1'

                    systemdatabase/7 04.20 11:01:16.821 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'

                    >systemdatabase/6 04.20 11:01:16.822 Scheduled System Events 1.48 ms. UPDATE ScheduledJobs SET dSjState='I', dSjLastProcessedStatus='S', dSjLastProcessedTs={ts '2017-04-20 11:01:16.809'},

                    systemdatabase/6 04.20 11:01:16.822 Scheduled System Events     dSjProgress='!csSjProgressReport,1,1'

                    systemdatabase/6 04.20 11:01:16.822 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'[Executed. 1 row(s) affected.]

                    >systemdatabase/6 04.20 11:01:16.827 Scheduled System Events commit called.

                    >systemdatabase/6 04.20 11:01:16.828 Scheduled System Events tran committed

                    >systemdatabase/6 04.20 11:01:16.829 Scheduled System Events !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.829 Scheduled System Events Connection with id of 'Scheduled System Events.75' is removed from active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.829 Scheduled System Events release pool connection

                    >systemdatabase/6 04.20 11:01:16.834 Scheduled System Events begin tran - soft

                    >systemdatabase/7 04.20 11:01:16.835 Scheduled System Events assigning connection

                    >systemdatabase/6 04.20 11:01:16.835 Scheduled System Events Reusing connection retrieved from external pool.

                    >systemdatabase/6 04.20 11:01:16.835 Scheduled System Events !csMonitorActiveDbConnections,1

                    >systemdatabase/6 04.20 11:01:16.835 Scheduled System Events Connection with last id of Scheduled System Events.76 is added to active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.835 Scheduled System Events Assigned connection to this thread, took 0.84 ms.  connect

                    >systemdatabase/6 04.20 11:01:16.835 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.76

                    >systemdatabase/7 04.20 11:01:16.836 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'

                    >systemdatabase/6 04.20 11:01:16.837 Scheduled System Events 1.12 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.839 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.839 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/7 04.20 11:01:16.839 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'

                    >systemdatabase/6 04.20 11:01:16.840 Scheduled System Events 0.94 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'[Executed. Returned row(s): true]

                    >systemdatabase/6 04.20 11:01:16.841 Scheduled System Events Closing active result set

                    >systemdatabase/6 04.20 11:01:16.841 Scheduled System Events Closing statement in closing internals

                    >systemdatabase/6 04.20 11:01:16.841 Scheduled System Events commit called.

                    >systemdatabase/6 04.20 11:01:16.842 Scheduled System Events tran committed

                    >systemdatabase/6 04.20 11:01:16.842 Scheduled System Events !csMonitorActiveDbConnections,0

                    >systemdatabase/6 04.20 11:01:16.842 Scheduled System Events Connection with id of 'Scheduled System Events.76' is removed from active connections with key of 'Scheduled System Events'.

                    >systemdatabase/6 04.20 11:01:16.842 Scheduled System Events release pool connection

                    >systemdatabase/6 04.20 11:01:16.847 Scheduled System Events begin tran - soft

                    • 7. Re: UCM Search is not working , i'm getting error while perform search
                      User258546

                      >systemdatabase/6 04.20 12:01:15.506 Scheduled System Events 1.21 ms. SELECT *  FROM ZRMJobs WHERE dExtractJobState = 'E' ORDER BY dExtractJobCreatedDate[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:01:15.534 Scheduled System Events begin tran - soft

                      >systemdatabase/6 04.20 12:01:15.534 Scheduled System Events Closing active result set

                      >systemdatabase/6 04.20 12:01:15.534 Scheduled System Events Closing statement in closing internals

                      >systemdatabase/7 04.20 12:01:15.538 Scheduled System Events (start) INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                      systemdatabase/7 04.20 12:01:15.538 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                      systemdatabase/7 04.20 12:01:15.538 Scheduled System Events     VALUES ('d04cb3f12234d93','ZipRenditionStaticAccess',{ts '2017-04-20 12:01:15.520'},'S','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!csSjFinalProgress,1,1')

                      >systemdatabase/6 04.20 12:01:15.549 Scheduled System Events 10 ms. INSERT INTO ScheduledJobsHistory (dSjHistoryGUID, dSjName, dSjLastProcessedTs, dSjLastProcessedStatus,

                      systemdatabase/6 04.20 12:01:15.549 Scheduled System Events     dSjDescription, dSjCategory, dSjEndUser, dSjExceptionJob, dSjMessage)

                      systemdatabase/6 04.20 12:01:15.549 Scheduled System Events     VALUES ('d04cb3f12234d93','ZipRenditionStaticAccess',{ts '2017-04-20 12:01:15.520'},'S','csZipRenditionUnpackagerJobDescription','Renditions','sysadmin','','!csSjFinalProgress,1,1')[Executed. 1 row(s) affected.]

                      >systemdatabase/7 04.20 12:01:15.557 Scheduled System Events (start) UPDATE ScheduledJobs SET dSjState='I', dSjLastProcessedStatus='S', dSjLastProcessedTs={ts '2017-04-20 12:01:15.520'},

                      systemdatabase/7 04.20 12:01:15.557 Scheduled System Events     dSjProgress='!csSjProgressReport,1,1'

                      systemdatabase/7 04.20 12:01:15.557 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'

                      >systemdatabase/6 04.20 12:01:15.558 Scheduled System Events 1.32 ms. UPDATE ScheduledJobs SET dSjState='I', dSjLastProcessedStatus='S', dSjLastProcessedTs={ts '2017-04-20 12:01:15.520'},

                      systemdatabase/6 04.20 12:01:15.558 Scheduled System Events     dSjProgress='!csSjProgressReport,1,1'

                      systemdatabase/6 04.20 12:01:15.558 Scheduled System Events     WHERE dSjName='ZipRenditionStaticAccess'[Executed. 1 row(s) affected.]

                      >systemdatabase/6 04.20 12:01:15.567 Scheduled System Events commit called.

                      >systemdatabase/6 04.20 12:01:15.568 Scheduled System Events tran committed

                      >systemdatabase/6 04.20 12:01:15.570 Scheduled System Events !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:15.570 Scheduled System Events Connection with id of 'Scheduled System Events.3' is removed from active connections with key of 'Scheduled System Events'.

                      >systemdatabase/6 04.20 12:01:15.570 Scheduled System Events release pool connection

                      >systemdatabase/6 04.20 12:01:15.574 Scheduled System Events begin tran - soft

                      >systemdatabase/7 04.20 12:01:15.574 Scheduled System Events assigning connection

                      >systemdatabase/6 04.20 12:01:15.575 Scheduled System Events Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:15.575 Scheduled System Events !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:15.575 Scheduled System Events Connection with last id of Scheduled System Events.1 is added to active connections with key of 'Scheduled System Events'.

                      >systemdatabase/6 04.20 12:01:15.575 Scheduled System Events Assigned connection to this thread, took 1.02 ms.  connect

                      >systemdatabase/6 04.20 12:01:15.575 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.1

                      >systemdatabase/7 04.20 12:01:15.575 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'

                      >systemdatabase/6 04.20 12:01:15.577 Scheduled System Events 1.29 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:15.580 Scheduled System Events Closing active result set

                      >systemdatabase/6 04.20 12:01:15.580 Scheduled System Events Closing statement in closing internals

                      >systemdatabase/7 04.20 12:01:15.580 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'

                      >systemdatabase/6 04.20 12:01:15.581 Scheduled System Events 0.94 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionRetentionRevisions'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:15.582 Scheduled System Events Closing active result set

                      >systemdatabase/6 04.20 12:01:15.582 Scheduled System Events Closing statement in closing internals

                      >systemdatabase/6 04.20 12:01:15.582 Scheduled System Events commit called.

                      >systemdatabase/6 04.20 12:01:15.583 Scheduled System Events tran committed

                      >systemdatabase/6 04.20 12:01:15.584 Scheduled System Events !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:15.584 Scheduled System Events Connection with id of 'Scheduled System Events.1' is removed from active connections with key of 'Scheduled System Events'.

                      >systemdatabase/6 04.20 12:01:15.584 Scheduled System Events release pool connection

                      >systemdatabase/6 04.20 12:01:15.588 Scheduled System Events begin tran - soft

                      >systemdatabase/7 04.20 12:01:15.588 Scheduled System Events assigning connection

                      >systemdatabase/6 04.20 12:01:15.589 Scheduled System Events Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:15.589 Scheduled System Events !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:15.589 Scheduled System Events Connection with last id of Scheduled System Events.2 is added to active connections with key of 'Scheduled System Events'.

                      >systemdatabase/6 04.20 12:01:15.589 Scheduled System Events Assigned connection to this thread, took 0.79 ms.  connect

                      >systemdatabase/6 04.20 12:01:15.589 Scheduled System Events Preparing connection for use, id initialized as Scheduled System Events.2

                      >systemdatabase/7 04.20 12:01:15.589 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarYears'

                      >systemdatabase/6 04.20 12:01:15.590 Scheduled System Events 0.95 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarYears'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:15.596 Scheduled System Events Closing active result set

                      >systemdatabase/6 04.20 12:01:15.596 Scheduled System Events Closing statement in closing internals

                      >systemdatabase/7 04.20 12:01:15.596 Scheduled System Events (start) SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarYears'

                      >systemdatabase/6 04.20 12:01:15.597 Scheduled System Events 0.95 ms. SELECT * FROM ScheduledJobs WHERE dSjName='FoldersRetentionCalendarYears'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:15.598 Scheduled System Events Closing active result set

                      >systemdatabase/6 04.20 12:01:15.599 Scheduled System Events Closing statement in closing internals

                      >systemdatabase/6 04.20 12:01:15.599 Scheduled System Events commit called.

                      >systemdatabase/6 04.20 12:01:15.599 Scheduled System Events tran committed

                      >systemdatabase/6 04.20 12:01:15.600 Scheduled System Events !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:15.600 Scheduled System Events Connection with id of 'Scheduled System Events.2' is removed from active connections with key of 'Scheduled System Events'.

                      >systemdatabase/6 04.20 12:01:15.600 Scheduled System Events release pool connection

                      >systemdatabase/7 04.20 12:01:18.040 SubjectManager assigning connection

                      >systemdatabase/6 04.20 12:01:18.040 SubjectManager Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:18.040 SubjectManager !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:18.040 SubjectManager Connection with last id of Scheduled System Events.3 is added to active connections with key of 'SubjectManager'.

                      >systemdatabase/6 04.20 12:01:18.040 SubjectManager Assigned connection to this thread, took 0.83 ms.  connect

                      >systemdatabase/6 04.20 12:01:18.040 SubjectManager Preparing connection for use, id initialized as SubjectManager.3

                      >systemdatabase/7 04.20 12:01:18.041 SubjectManager (start) SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                      systemdatabase/7 04.20 12:01:18.041 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate

                      >systemdatabase/6 04.20 12:01:18.041 SubjectManager 0.80 ms. SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                      systemdatabase/6 04.20 12:01:18.041 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:01:18.042 SubjectManager Closing active result set

                      >systemdatabase/6 04.20 12:01:18.042 SubjectManager Closing statement in closing internals

                      >systemdatabase/7 04.20 12:01:18.042 SubjectManager (start) UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'

                      systemdatabase/7 04.20 12:01:18.042 SubjectManager   WHERE ((dConversionState = 'Aborted') OR

                      systemdatabase/7 04.20 12:01:18.042 SubjectManager   (dConvStartDate < {ts '2017-04-20 08:01:00.000'} AND ((dConvActionDate < {ts '2017-04-20 11:31:00.000'} AND

                      systemdatabase/7 04.20 12:01:18.042 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR

                      systemdatabase/7 04.20 12:01:18.042 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))

                      >systemdatabase/6 04.20 12:01:18.042 SubjectManager 0.67 ms. UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'

                      systemdatabase/6 04.20 12:01:18.042 SubjectManager   WHERE ((dConversionState = 'Aborted') OR

                      systemdatabase/6 04.20 12:01:18.042 SubjectManager   (dConvStartDate < {ts '2017-04-20 08:01:00.000'} AND ((dConvActionDate < {ts '2017-04-20 11:31:00.000'} AND

                      systemdatabase/6 04.20 12:01:18.042 SubjectManager   dConversionState IN ('Preparing', 'Processing', 'PostProc', 'Aborted')) OR

                      systemdatabase/6 04.20 12:01:18.042 SubjectManager   dConversionState IN ('Submitted', 'Retry'))))[Executed. 0 row(s) affected.]

                      >systemdatabase/6 04.20 12:01:18.050 SubjectManager !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:18.050 SubjectManager Connection with id of 'SubjectManager.3' is removed from active connections with key of 'SubjectManager'.

                      >systemdatabase/6 04.20 12:01:18.050 SubjectManager release pool connection

                      >systemdatabase/7 04.20 12:01:18.051 sj_immediate_work assigning connection

                      >systemdatabase/6 04.20 12:01:18.051 sj_immediate_work Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:18.051 sj_immediate_work !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:18.051 sj_immediate_work Connection with last id of Scheduled System Events.1 is added to active connections with key of 'sj_immediate_work'.

                      >systemdatabase/6 04.20 12:01:18.051 sj_immediate_work Assigned connection to this thread, took 0.79 ms.  connect

                      >systemdatabase/6 04.20 12:01:18.051 sj_immediate_work Preparing connection for use, id initialized as sj_immediate_work.1

                      >systemdatabase/7 04.20 12:01:18.052 sj_immediate_work (start) SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                      systemdatabase/7 04.20 12:01:18.052 sj_immediate_work     ORDER BY dSjPriority ASC

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work 2.11 ms. SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                      systemdatabase/6 04.20 12:01:18.054 sj_immediate_work     ORDER BY dSjPriority ASC[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work Connection with id of 'sj_immediate_work.1' is removed from active connections with key of 'sj_immediate_work'.

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work Closing active result set

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work Closing statement in closing internals

                      >systemdatabase/6 04.20 12:01:18.054 sj_immediate_work release pool connection

                      >systemdatabase/7 04.20 12:01:18.796 DocumentStateMonitor wcc_cluster assigning connection

                      >systemdatabase/6 04.20 12:01:18.796 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:18.796 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:18.796 DocumentStateMonitor wcc_cluster Connection with last id of Scheduled System Events.2 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:01:18.796 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 0.93 ms.  connect

                      >systemdatabase/6 04.20 12:01:18.797 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.2

                      >systemdatabase/7 04.20 12:01:18.797 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                      >systemdatabase/6 04.20 12:01:18.797 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:18.798 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:01:18.798 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/7 04.20 12:01:18.798 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                      >systemdatabase/6 04.20 12:01:18.798 DocumentStateMonitor wcc_cluster 0.66 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:01:18.799 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:18.799 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.2' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:01:18.799 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:01:18.799 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/6 04.20 12:01:18.799 DocumentStateMonitor wcc_cluster release pool connection

                      >systemdatabase/6 04.20 12:01:44.635 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:01:44.635 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:01:44.636 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:01:44.636 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:01:44.636 WebDAVUnlocker Connection with last id of SubjectManager.3 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:01:44.636 WebDAVUnlocker Assigned connection to this thread, took 1.08 ms.  connect

                      >systemdatabase/6 04.20 12:01:44.636 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.3

                      >systemdatabase/7 04.20 12:01:44.637 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:01:44.636'}

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker 1.10 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:01:44.636'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.3' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:01:44.638 WebDAVUnlocker release pool connection

                      >systemdatabase/6 04.20 12:02:14.642 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:02:14.644 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:02:14.645 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:02:14.645 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:02:14.645 WebDAVUnlocker Connection with last id of sj_immediate_work.1 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:02:14.645 WebDAVUnlocker Assigned connection to this thread, took 1.03 ms.  connect

                      >systemdatabase/6 04.20 12:02:14.645 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.1

                      >systemdatabase/7 04.20 12:02:14.645 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:02:14.645'}

                      >systemdatabase/6 04.20 12:02:14.646 WebDAVUnlocker 1.01 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:02:14.645'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:02:14.646 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:02:14.646 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:02:14.646 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:02:14.648 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:02:14.648 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:02:14.648 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.1' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:02:14.648 WebDAVUnlocker release pool connection

                      >systemdatabase/7 04.20 12:02:18.806 DocumentStateMonitor wcc_cluster assigning connection

                      >systemdatabase/6 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.2 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.14 ms.  connect

                      >systemdatabase/6 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.2

                      >systemdatabase/7 04.20 12:02:18.807 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                      >systemdatabase/6 04.20 12:02:18.808 DocumentStateMonitor wcc_cluster 0.64 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:02:18.808 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:02:18.808 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/7 04.20 12:02:18.808 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster 0.66 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.2' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/6 04.20 12:02:18.809 DocumentStateMonitor wcc_cluster release pool connection

                      >systemdatabase/6 04.20 12:02:44.649 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:02:44.649 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:02:44.650 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:02:44.650 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:02:44.650 WebDAVUnlocker Connection with last id of WebDAVUnlocker.3 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:02:44.650 WebDAVUnlocker Assigned connection to this thread, took 0.98 ms.  connect

                      >systemdatabase/6 04.20 12:02:44.650 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.3

                      >systemdatabase/7 04.20 12:02:44.650 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:02:44.650'}

                      >systemdatabase/6 04.20 12:02:44.651 WebDAVUnlocker 0.95 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:02:44.650'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.3' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:02:44.652 WebDAVUnlocker release pool connection

                      >systemdatabase/6 04.20 12:03:14.652 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:03:14.653 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:03:14.653 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:03:14.654 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:03:14.654 WebDAVUnlocker Connection with last id of WebDAVUnlocker.1 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:03:14.654 WebDAVUnlocker Assigned connection to this thread, took 1.06 ms.  connect

                      >systemdatabase/6 04.20 12:03:14.654 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.1

                      >systemdatabase/7 04.20 12:03:14.654 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:03:14.654'}

                      >systemdatabase/6 04.20 12:03:14.655 WebDAVUnlocker 1.24 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:03:14.654'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:03:14.655 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:03:14.655 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:03:14.655 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:03:14.656 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:03:14.656 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:03:14.656 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.1' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:03:14.656 WebDAVUnlocker release pool connection

                      >systemdatabase/7 04.20 12:03:18.816 DocumentStateMonitor wcc_cluster assigning connection

                      >systemdatabase/6 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.2 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.04 ms.  connect

                      >systemdatabase/6 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.2

                      >systemdatabase/7 04.20 12:03:18.817 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                      >systemdatabase/6 04.20 12:03:18.818 DocumentStateMonitor wcc_cluster 0.75 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:03:18.818 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:03:18.818 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/7 04.20 12:03:18.818 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster 0.69 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.2' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/6 04.20 12:03:18.819 DocumentStateMonitor wcc_cluster release pool connection

                      >systemdatabase/6 04.20 12:03:44.659 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:03:44.659 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:03:44.660 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:03:44.660 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:03:44.660 WebDAVUnlocker Connection with last id of WebDAVUnlocker.3 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:03:44.660 WebDAVUnlocker Assigned connection to this thread, took 0.90 ms.  connect

                      >systemdatabase/6 04.20 12:03:44.660 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.3

                      >systemdatabase/7 04.20 12:03:44.661 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:03:44.660'}

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker 0.95 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:03:44.660'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.3' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:03:44.662 WebDAVUnlocker release pool connection

                      >systemdatabase/6 04.20 12:04:14.662 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:04:14.663 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:04:14.663 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:04:14.663 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:04:14.664 WebDAVUnlocker Connection with last id of WebDAVUnlocker.1 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:04:14.664 WebDAVUnlocker Assigned connection to this thread, took 1.02 ms.  connect

                      >systemdatabase/6 04.20 12:04:14.664 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.1

                      >systemdatabase/7 04.20 12:04:14.664 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:04:14.664'}

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker 1.02 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:04:14.664'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:04:14.665 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:04:14.666 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.1' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:04:14.666 WebDAVUnlocker release pool connection

                      >systemdatabase/7 04.20 12:04:18.826 DocumentStateMonitor wcc_cluster assigning connection

                      >systemdatabase/6 04.20 12:04:18.827 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:04:18.827 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:04:18.827 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.2 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:04:18.827 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.03 ms.  connect

                      >systemdatabase/6 04.20 12:04:18.827 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.2

                      >systemdatabase/7 04.20 12:04:18.828 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                      >systemdatabase/6 04.20 12:04:18.828 DocumentStateMonitor wcc_cluster 0.71 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:04:18.828 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:04:18.829 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/7 04.20 12:04:18.829 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                      >systemdatabase/6 04.20 12:04:18.829 DocumentStateMonitor wcc_cluster 0.68 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:04:18.829 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:04:18.830 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.2' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:04:18.830 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:04:18.830 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/6 04.20 12:04:18.830 DocumentStateMonitor wcc_cluster release pool connection

                      >systemdatabase/6 04.20 12:04:44.674 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:04:44.674 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:04:44.674 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:04:44.674 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:04:44.675 WebDAVUnlocker Connection with last id of WebDAVUnlocker.3 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:04:44.675 WebDAVUnlocker Assigned connection to this thread, took 0.94 ms.  connect

                      >systemdatabase/6 04.20 12:04:44.675 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.3

                      >systemdatabase/7 04.20 12:04:44.675 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:04:44.675'}

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker 0.96 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:04:44.675'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.3' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:04:44.676 WebDAVUnlocker release pool connection

                      >systemdatabase/6 04.20 12:05:14.677 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:05:14.677 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:05:14.678 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:05:14.678 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:05:14.678 WebDAVUnlocker Connection with last id of WebDAVUnlocker.1 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:05:14.678 WebDAVUnlocker Assigned connection to this thread, took 0.97 ms.  connect

                      >systemdatabase/6 04.20 12:05:14.678 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.1

                      >systemdatabase/7 04.20 12:05:14.678 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:05:14.678'}

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker 0.98 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:05:14.678'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.1' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:05:14.679 WebDAVUnlocker release pool connection

                      >systemdatabase/7 04.20 12:05:18.837 DocumentStateMonitor wcc_cluster assigning connection

                      >systemdatabase/6 04.20 12:05:18.837 DocumentStateMonitor wcc_cluster Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:05:18.838 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:05:18.838 DocumentStateMonitor wcc_cluster Connection with last id of DocumentStateMonitor wcc_cluster.2 is added to active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:05:18.838 DocumentStateMonitor wcc_cluster Assigned connection to this thread, took 1.06 ms.  connect

                      >systemdatabase/6 04.20 12:05:18.838 DocumentStateMonitor wcc_cluster Preparing connection for use, id initialized as DocumentStateMonitor wcc_cluster.2

                      >systemdatabase/7 04.20 12:05:18.838 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'

                      >systemdatabase/6 04.20 12:05:18.839 DocumentStateMonitor wcc_cluster 0.74 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'GENWWW'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:05:18.839 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:05:18.839 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/7 04.20 12:05:18.839 DocumentStateMonitor wcc_cluster (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster 0.67 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ COUNT(*) FROM Revisions WHERE Revisions.dStatus = 'DONE'[Executed. Returned row(s): true]

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster Connection with id of 'DocumentStateMonitor wcc_cluster.2' is removed from active connections with key of 'DocumentStateMonitor wcc_cluster'.

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster Closing active result set

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster Closing statement in closing internals

                      >systemdatabase/6 04.20 12:05:18.840 DocumentStateMonitor wcc_cluster release pool connection

                      >systemdatabase/6 04.20 12:05:44.680 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:05:44.680 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:05:44.681 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:05:44.681 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:05:44.681 WebDAVUnlocker Connection with last id of WebDAVUnlocker.3 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:05:44.681 WebDAVUnlocker Assigned connection to this thread, took 1.05 ms.  connect

                      >systemdatabase/6 04.20 12:05:44.681 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.3

                      >systemdatabase/7 04.20 12:05:44.681 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:05:44.681'}

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker 1.28 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:05:44.681'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.3' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:05:44.683 WebDAVUnlocker release pool connection

                      >systemdatabase/6 04.20 12:06:14.687 WebDAVUnlocker begin tran - soft

                      >systemdatabase/7 04.20 12:06:14.687 WebDAVUnlocker assigning connection

                      >systemdatabase/6 04.20 12:06:14.688 WebDAVUnlocker Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:06:14.688 WebDAVUnlocker !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:06:14.688 WebDAVUnlocker Connection with last id of WebDAVUnlocker.1 is added to active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:06:14.688 WebDAVUnlocker Assigned connection to this thread, took 0.97 ms.  connect

                      >systemdatabase/6 04.20 12:06:14.688 WebDAVUnlocker Preparing connection for use, id initialized as WebDAVUnlocker.1

                      >systemdatabase/7 04.20 12:06:14.688 WebDAVUnlocker (start) SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:06:14.688'}

                      >systemdatabase/6 04.20 12:06:14.689 WebDAVUnlocker 0.93 ms. SELECT * FROM WebdavLock WHERE lExpirationDate <= {ts '2017-04-20 12:06:14.688'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:14.689 WebDAVUnlocker Closing active result set

                      >systemdatabase/6 04.20 12:06:14.689 WebDAVUnlocker Closing statement in closing internals

                      >systemdatabase/6 04.20 12:06:14.689 WebDAVUnlocker commit called.

                      >systemdatabase/6 04.20 12:06:14.690 WebDAVUnlocker tran committed

                      >systemdatabase/6 04.20 12:06:14.690 WebDAVUnlocker !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:06:14.690 WebDAVUnlocker Connection with id of 'WebDAVUnlocker.1' is removed from active connections with key of 'WebDAVUnlocker'.

                      >systemdatabase/6 04.20 12:06:14.690 WebDAVUnlocker release pool connection

                      >systemdatabase/7 04.20 12:06:15.653 sj_immediate_work assigning connection

                      >indexer/6 04.20 12:06:15.671 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                      >indexer/7 04.20 12:06:15.672 index update work /apps/opt/mw/admin/ipm_domain/wcc_cluster/cs/search/search.cfg doesn't exist.

                      >indexer/6 04.20 12:06:15.672 index update work Retrieving indexer workspace: Provider name is 'SystemDatabase'

                      >indexer/7 04.20 12:06:15.691 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                      >indexer/7 04.20 12:06:15.696 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                      >indexer/7 04.20 12:06:15.700 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                      >systemdatabase/7 04.20 12:06:15.712 index update work assigning connection

                      >systemdatabase/6 04.20 12:06:15.713 index update work Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:06:15.713 index update work !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:06:15.713 index update work Connection with last id of WebDAVUnlocker.3 is added to active connections with key of 'index update work'.

                      >systemdatabase/6 04.20 12:06:15.713 index update work Assigned connection to this thread, took 1.27 ms.  connect

                      >systemdatabase/6 04.20 12:06:15.713 index update work Preparing connection for use, id initialized as index update work.3

                      >systemdatabase/7 04.20 12:06:15.714 index update work (start) SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                      systemdatabase/7 04.20 12:06:15.714 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                      systemdatabase/7 04.20 12:06:15.714 index update work   Revisions.dOutDate < {ts '2017-04-20 12:07:15.712'} AND (dWorkflowState IS NULL or dWorkflowState = '')

                      >systemdatabase/6 04.20 12:06:15.715 index update work 1.57 ms. SELECT dID, dRevClassID, dReleaseState, dDocName, dSecurityGroup FROM Revisions

                      systemdatabase/6 04.20 12:06:15.715 index update work   WHERE (Revisions.dStatus='RELEASED' OR Revisions.dStatus='DONE') AND

                      systemdatabase/6 04.20 12:06:15.715 index update work   Revisions.dOutDate < {ts '2017-04-20 12:07:15.712'} AND (dWorkflowState IS NULL or dWorkflowState = '')[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:15.715 index update work Closing active result set

                      >systemdatabase/6 04.20 12:06:15.716 index update work Closing statement in closing internals

                      >systemdatabase/7 04.20 12:06:15.716 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                      systemdatabase/7 04.20 12:06:15.716 index update work   FROM Revisions

                      systemdatabase/7 04.20 12:06:15.716 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                      systemdatabase/7 04.20 12:06:15.716 index update work   AND Revisions.dInDate<={ts '2017-04-20 12:07:15.712'}

                      >systemdatabase/6 04.20 12:06:15.717 index update work 1.30 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dID

                      systemdatabase/6 04.20 12:06:15.717 index update work   FROM Revisions

                      systemdatabase/6 04.20 12:06:15.717 index update work   WHERE Revisions.dReleaseState = 'N' AND Revisions.dStatus in ('DONE', 'RELEASED', 'DELETED')

                      systemdatabase/6 04.20 12:06:15.717 index update work   AND Revisions.dInDate<={ts '2017-04-20 12:07:15.712'}[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:15.724 index update work begin tran - soft

                      >systemdatabase/6 04.20 12:06:15.725 index update work Closing active result set

                      >systemdatabase/6 04.20 12:06:15.725 index update work Closing statement in closing internals

                      >systemdatabase/7 04.20 12:06:15.725 index update work (start) SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                      systemdatabase/7 04.20 12:06:15.725 index update work   FROM Revisions

                      systemdatabase/7 04.20 12:06:15.725 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                      systemdatabase/7 04.20 12:06:15.725 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                      systemdatabase/7 04.20 12:06:15.725 index update work   AND (dStatus <> 'GENWWW'))

                      >systemdatabase/6 04.20 12:06:15.733 index update work 7.62 ms. SELECT/*+ INDEX (Revisions dReleaseState_Revisions)*/ dRevClassID

                      systemdatabase/6 04.20 12:06:15.733 index update work   FROM Revisions

                      systemdatabase/6 04.20 12:06:15.733 index update work   WHERE ((dReleaseState in ('R', 'U', 'I', 'D'))

                      systemdatabase/6 04.20 12:06:15.733 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y'))

                      systemdatabase/6 04.20 12:06:15.733 index update work   AND (dStatus <> 'GENWWW'))[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:15.733 index update work Closing statement in closing internals

                      >systemdatabase/6 04.20 12:06:15.733 index update work Closing active result set

                      >systemdatabase/6 04.20 12:06:15.733 index update work commit called.

                      >systemdatabase/6 04.20 12:06:15.733 index update work tran committed

                      >systemdatabase/6 04.20 12:06:15.733 index update work begin tran - soft

                      >systemdatabase/7 04.20 12:06:15.734 index update work (start) SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                      systemdatabase/7 04.20 12:06:15.734 index update work   FROM Revisions

                      systemdatabase/7 04.20 12:06:15.734 index update work   WHERE ((dStatus = 'DELETED')

                      systemdatabase/7 04.20 12:06:15.734 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))

                      >systemdatabase/6 04.20 12:06:15.742 index update work 8.16 ms. SELECT/*+ INDEX (Revisions dStatus_Revisions)*/ dRevClassID

                      systemdatabase/6 04.20 12:06:15.742 index update work   FROM Revisions

                      systemdatabase/6 04.20 12:06:15.742 index update work   WHERE ((dStatus = 'DELETED')

                      systemdatabase/6 04.20 12:06:15.742 index update work   AND (dIndexerState is null OR dIndexerState in (' ', 'Y')))[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:15.742 index update work Closing statement in closing internals

                      >systemdatabase/6 04.20 12:06:15.742 index update work Closing active result set

                      >systemdatabase/6 04.20 12:06:15.742 index update work commit called.

                      >systemdatabase/6 04.20 12:06:15.742 index update work tran committed

                      >systemdatabase/6 04.20 12:06:15.751 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET optimizer_mode = 'FIRST_ROWS_100'

                      >indexer/7 04.20 12:06:15.751 index update work isRebuild?false; IndexerStep:Replication;  Class:intradoc.server.IndexerReplication

                      >systemdatabase/6 04.20 12:06:15.752 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET NLS_LENGTH_SEMANTICS = 'CHAR'

                      >systemdatabase/6 04.20 12:06:15.753 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET NLS_SORT = 'BINARY'

                      >systemdatabase/6 04.20 12:06:15.753 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET NLS_COMP = 'BINARY'

                      >systemdatabase/6 04.20 12:06:15.754 sj_immediate_work Initializing Connection. Executing query:  ALTER SESSION SET NLS_NUMERIC_CHARACTERS = '.,'

                      >systemdatabase/6 04.20 12:06:15.755 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET CURSOR_SHARING = 'FORCE'

                      >indexer/7 04.20 12:06:15.755 index update work isRebuild?false; IndexerStep:PostIndexingStep;  Action:postIndexingStep

                      >systemdatabase/6 04.20 12:06:15.755 sj_immediate_work Initializing Connection. Executing query:  ALTER SESSION SET NLS_DATE_FORMAT = 'YYYY-MM-DD HH24:MI:SS'

                      >systemdatabase/6 04.20 12:06:15.756 sj_immediate_work Initializing Connection. Executing query: ALTER SESSION SET EVENTS '30579 trace name context forever, level 2'

                      >systemdatabase/6 04.20 12:06:15.758 sj_immediate_work New connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:06:15.758 sj_immediate_work !csMonitorActiveDbConnections,2

                      >systemdatabase/6 04.20 12:06:15.758 sj_immediate_work Connection with last id of <unassigned> is added to active connections with key of 'sj_immediate_work'.

                      >systemdatabase/6 04.20 12:06:15.758 sj_immediate_work Assigned connection to this thread, took 104 ms.  connect

                      >systemdatabase/6 04.20 12:06:15.758 sj_immediate_work Preparing connection for use, id initialized as sj_immediate_work.6

                      >systemdatabase/7 04.20 12:06:15.758 sj_immediate_work (start) SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                      systemdatabase/7 04.20 12:06:15.758 sj_immediate_work     ORDER BY dSjPriority ASC

                      >indexer/7 04.20 12:06:15.758 index update work isRebuild?false; IndexerStep:Cleanup;  Class:intradoc.indexer.Indexer

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work 9.77 ms. SELECT * FROM ScheduledJobs WHERE dSjState in ('I') AND dSjType='I'

                      systemdatabase/6 04.20 12:06:15.768 sj_immediate_work     ORDER BY dSjPriority ASC[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work Connection with id of 'sj_immediate_work.6' is removed from active connections with key of 'sj_immediate_work'.

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work Closing active result set

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work Closing statement in closing internals

                      >systemdatabase/6 04.20 12:06:15.768 sj_immediate_work release pool connection

                      >systemdatabase/7 04.20 12:06:15.770 index update work (start) UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                      systemdatabase/7 04.20 12:06:15.770 index update work   SET dIndexerState = ''

                      systemdatabase/7 04.20 12:06:15.770 index update work   WHERE dIndexerState = 'A'

                      >systemdatabase/6 04.20 12:06:15.772 index update work 1.80 ms. UPDATE/*+ INDEX (Revisions dIndexerState_Revisions)*/ Revisions

                      systemdatabase/6 04.20 12:06:15.772 index update work   SET dIndexerState = ''

                      systemdatabase/6 04.20 12:06:15.772 index update work   WHERE dIndexerState = 'A'[Executed. 0 row(s) affected.]

                      >systemdatabase/6 04.20 12:06:15.775 index update work !csMonitorActiveDbConnections,0

                      >systemdatabase/6 04.20 12:06:15.775 index update work Connection with id of 'index update work.3' is removed from active connections with key of 'index update work'.

                      >systemdatabase/6 04.20 12:06:15.775 index update work release pool connection

                      >indexer/7 04.20 12:06:15.780 index update work isRebuild?false; IndexerStep:PostCleanupStep;  Action:postCleanupStep

                      >indexer/7 04.20 12:06:15.784 index update work isRebuild?false; IndexerStep:Init;  Class:intradoc.indexer.Indexer

                      >indexer/7 04.20 12:06:15.787 index update work isRebuild?false; IndexerStep:CheckCollection;  Class:intradoc.indexer.IndexerCollectionManager

                      >indexer/7 04.20 12:06:15.790 index update work isRebuild?false; IndexerStep:BuildChanges;  Class:entoracle.indexer.EOIndexerBuildChanges

                      >systemdatabase/7 04.20 12:06:18.663 SubjectManager assigning connection

                      >systemdatabase/6 04.20 12:06:18.664 SubjectManager Reusing connection retrieved from external pool.

                      >systemdatabase/6 04.20 12:06:18.664 SubjectManager !csMonitorActiveDbConnections,1

                      >systemdatabase/6 04.20 12:06:18.664 SubjectManager Connection with last id of index update work.3 is added to active connections with key of 'SubjectManager'.

                      >systemdatabase/6 04.20 12:06:18.664 SubjectManager Assigned connection to this thread, took 0.99 ms.  connect

                      >systemdatabase/6 04.20 12:06:18.664 SubjectManager Preparing connection for use, id initialized as SubjectManager.3

                      >systemdatabase/7 04.20 12:06:18.664 SubjectManager (start) SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                      systemdatabase/7 04.20 12:06:18.664 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate

                      >systemdatabase/6 04.20 12:06:18.665 SubjectManager 0.86 ms. SELECT * FROM RefineryJobs WHERE dConversionState IN ('Converted', 'PassThru', 'Incomplete',

                      systemdatabase/6 04.20 12:06:18.665 SubjectManager   'Failed', 'Expired') ORDER BY dConvActionDate[Executed. Returned row(s): false]

                      >systemdatabase/6 04.20 12:06:18.665 SubjectManager Closing active result set

                      >systemdatabase/6 04.20 12:06:18.665 SubjectManager Closing statement in closing internals

                      >systemdatabase/7 04.20 12:06:18.665 SubjectManager (start) UPDATE RefineryJobs Set dConversionState = 'Expired', dConvMessage = '!csRefineryJobExpired'

                      systemdatabase/7 04.20 12:06:18.665 SubjectManager   WHERE ((dConversionState = 'Aborted') OR

                      systemdatabase/7 04.20 12:06:18.665 SubjectManager   (dConvStartDate < {ts '2017-04-20 08:06:00.000'} AND ((dConvActionDate < {ts '2017-04-20 11:36:00.000'} AND

                      • 8. Re: UCM Search is not working , i'm getting error while perform search
                        William Phelps

                        systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 run: 0.98 ms.  total 2.59 ms. [ORA-20000: Oracle Text error:

                        systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50857: oracle error in ctx_query.result_set

                        systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-20000: Oracle Text error:

                        systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50850: ORA-01013: user requested cancel of current operation

                         

                        Most likely a timeout occurred somewhere.  You may be trying to return too many results.

                         

                        Open ended searches against a large repository is not a good idea in general.  I've posted about this in the past, so I'll spare the community from repeating it

                        • 9. Re: UCM Search is not working , i'm getting error while perform search
                          Bunty

                          this trace is not enough... do as Jonathan asked.

                           

                          requestaudit/6 04.20 11:08:00.010 Audit Request Monitor 1 Service GET_SEARCH_RESULTS Total Elapsed Time (secs) 60.23500061035156 Num requests 1 Num errors 1 Avg. Latency (secs) 60.23500061035156

                           

                          but on system database it is not even 1 sec

                           

                          >systemdatabase/7 04.20 11:07:30.125 IdcServer-1507 (start) SELECT 1 FROM DUAL

                          >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 0.75 ms. SELECT 1 FROM DUAL[Executed. Returned row(s): true]

                          >systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 !csDbUnableToExecuteCallableQuery,CotsSearchQuery!$ORA-20000: Oracle Text error:

                          systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50857: oracle error in ctx_query.result_set

                          systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 ORA-20000: Oracle Text error:

                          systemdatabase/6 04.20 11:07:30.126 IdcServer-1507 DRG-50850: ORA-01013: user requested cancel of current operation

                          systemdatabase/6 04.20 11:07:30.126 IdcServer-1507

                          systemdatabase/6 04.20 11:07:30.126 IdcServer-1507

                           

                           

                          I had seen this issue in the past. In my case it was because of LDAP timeout ...

                          every CS search request was hitting LDAP and getting user groups in real time... and it was timing out.

                           

                           

                           

                          • 10. Re: UCM Search is not working , i'm getting error while perform search
                            William Phelps

                            Yeah, I've seen LDAP, especially Active Directory hang logins, searches, etc.  What appears to happen in those cases is that the LDAP call was made inside a DB transaction - it's waiting to write data to the USERS table and LDAP times out, causing the DB transaction to fail..

                             

                            I'm not sure if that's the issue here though.  The snippet that you pulled out shows a select 1 from dual query.  Is that the data source provider opening a connection?  The next line shows the Oracle Text error.  I wonder if this was not an open ended search would ANYTHING come back.

                             

                            Now if you still think it's LDAP related, there is a setting in the AD provider (assuming this is Active Directory) to use the token groups algorithm to resolve group memberships.  That would cut down or eliminate some of the calls back to AD to get group information.

                            • 11. Re: UCM Search is not working , i'm getting error while perform search
                              User258546

                              Hi William,

                               

                              Could you provide me workaround steps to resolve this..yes, we are using LDAP based security here.

                              Below are the data source tested data source

                              DB.jpeg

                              How to modify to token group algorithm

                              • 12. Re: UCM Search is not working , i'm getting error while perform search
                                William Phelps

                                It hasn't been established if LDAP/AD is the issue.

                                 

                                If you do a regular search, meaning a search that has some type of defined query (like Title=My document and Security Group = Public), instead of an open-ended blank search, do you get results returned?  If so, then I hesitate to think it's LDAP/AD related - the same group lookup would still occur on a structured search.

                                 

                                How many content items are in the content repository today?

                                • 13. Re: UCM Search is not working , i'm getting error while perform search
                                  Bunty

                                  on second thought... the user performing search is weblogic. Don't think this will hit AD (?).

                                   

                                  could you enable tracing as Jonathan posted and get the trace

                                  search*, systemdatabase

                                  • 14. Re: UCM Search is not working , i'm getting error while perform search
                                    Srinath Menon-Oracle

                                    Most likely in these kind of cases it turns out to be an open ended search which is returning a whole lot of results and the DB has not be tuned for that aspect . Since this a OTS search engine and could be a case where the contents have been loaded to it , I would start with checking the db health and seeing what exact time is the Query returning results from DB directly .

                                     

                                    Collecting AWR report for the time from start of search till end would give real good information as well.

                                     

                                    In addition to the trace suggested , add the following 2 as well :

                                    requestaudit,task* + Full verbose

                                    1 2 Previous Next