<?xml version="1.0" encoding="UTF-8"?>
<rss xmlns:content="http://purl.org/rss/1.0/modules/content/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:rdf="http://www.w3.org/1999/02/22-rdf-syntax-ns#" xmlns:taxo="http://purl.org/rss/1.0/modules/taxonomy/" version="2.0">
  <channel>
    <title>topic Alfresco startup takes more than 30 min. in Alfresco Archive</title>
    <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301383#M254513</link>
    <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi,&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;I'm begginer in Alfresco. Lately our client ask us about Alfresco startup time reduction which takes more than 30 minutes.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;Alfresco is&amp;nbsp; setup on one phisicall machine in number of two instances(Version :Community - v3.4.0 (d 3370)). Logs from startup shows that there is in total 22 minutes gap beetwen operation. I was trying to find some info on internet regarding phases of Alfresco startup process, but after two weeks I gave up. Is there any chcance to increase details of logs - I don't see such properties in log4j.properties file and also could not find them on internet. What is the average Alfresco startup time? &lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;The system is operated by max 30 concurrent users.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;The average number of queries per day is 5500&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;The server details: 2 x CPU Quad Core 2,0 GHz/32 GB RAM/Windows Server 2008 Enterprise R2/Tomcat 6.0.29&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;1)&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:27,574&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] Schema managed by database dialect org.alfresco.repo.domain.hibernate.dialect.AlfrescoOracle9Dialect.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:09:18,141&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] No changes were made to the schema.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;2)&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:09:18,141&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] No changes were made to the schema.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,166&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;3)&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,851&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:00,067 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;The etire log file (for first 30 minutes) looks like this (alfresco instance no.1):&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Class path contains multiple SLF4J bindings.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Found binding in [jar:file:/C:/apps/alfresco1/tomcat/webapps/alfresco/WEB-INF/lib/slf4j-log4j12-1.5.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Found binding in [jar:file:/C:/apps/alfresco1/tomcat/webapps/alfresco/WEB-INF/lib/slf4j-log4j12-1.5.11.jar!/org/slf4j/impl/StaticLoggerBinder.class]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: See &lt;/SPAN&gt;&lt;A href="http://www.slf4j.org/codes.html#multiple_bindings" rel="nofollow noopener noreferrer"&gt;http://www.slf4j.org/codes.html#multiple_bindings&lt;/A&gt;&lt;SPAN&gt; for an explanation.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,273&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,367&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,383&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco1\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\cao-alfresco-amp\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,383&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco1\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\test\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,383&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco1\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\tests\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,383&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/C:/apps/alfresco1/tomcat/shared/classes/alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,664&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,789&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:00:43,836&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:18,557&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:18,557&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:27,574&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] Schema managed by database dialect org.alfresco.repo.domain.hibernate.dialect.AlfrescoOracle9Dialect.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:09:18,141&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] No changes were made to the schema.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,166&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,276&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,276&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,276&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:28,369&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:33,088&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:33,119&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:33,119&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:33,119&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:34,651&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:34,651&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:34,713&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:34,713&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:34,713&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:36,994&amp;nbsp; WARN&amp;nbsp; [alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:36,994&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:44,401&amp;nbsp; INFO&amp;nbsp; [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: E:\alf_data&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:44,588&amp;nbsp; INFO&amp;nbsp; [admin.patch.PatchExecuter] Checking for patches to apply …&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,213&amp;nbsp; INFO&amp;nbsp; [admin.patch.PatchExecuter] No patches were required.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,276 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Found 2 module(s).&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,338 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Starting module 'cao-alfresco-amp' version 1.1.5.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,495 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Starting module 'Oracle.for.Alfresco.3.4.a.Community' version 1.0.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,510&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,557&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,557&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:46,557&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,557&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,557&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,588&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,604&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,604&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,870&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,870&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,885&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,885&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:47,885&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,026&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,026&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,041&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,041&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,041&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,120&amp;nbsp; WARN&amp;nbsp; [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,120&amp;nbsp; WARN&amp;nbsp; [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,135&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,135&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,151&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,151&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:48,151&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:49,666&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:49,666&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] Disabled - clear non-missing user usages …&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:49,838 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,838&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] Found 0 users to clear&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,838&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] … cleared non-missing usages for 0 users&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,838&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,854&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,854&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,854&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,932 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfinst]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,979 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,979 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:50,979 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,198 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,323 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfinst] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,323 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, ldap1]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,385 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 1&amp;nbsp;547ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,416 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,416 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,416 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,854 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, ldap1] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:51,854 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Synchronizing users and groups with user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:52,057 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Retrieving groups changed since 2015-05-28 09:48:44 from user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:52,166 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 Group Analysis: Commencing batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:52,166 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 Group Analysis: Completed batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:15:52,182 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Retrieving users changed since 2015-09-06 02:46:27 from user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:02,698 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 User Creation and Association: Commencing batch of 10 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,245 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 User Creation and Association: Processed 10 entries out of 10. 100% complete. Rate: 3 per second. 0 failures detected.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,245 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 User Creation and Association: Completed batch of 10 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,542 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Finished synchronizing users and groups with user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,542 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] 10 user(s) and 0 group(s) processed&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,635&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,760&amp;nbsp; INFO&amp;nbsp; [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_45-b06; maximum heap size 13721,625MB&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,760&amp;nbsp; INFO&amp;nbsp; [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (d 3370) schema 4113 - Originally installed version 3.4.0 (d 3370) schema 4113&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,776&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,776&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,776&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,776&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:16:05,792&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:17:04,339 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:17:05,871 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 74&amp;nbsp;486ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:17:05,871 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,014 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,999 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,999 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 985ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:10,609 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:11,640 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 10&amp;nbsp;641ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:11,640 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,835 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 491 Web Scripts (+0 failed), 758 URLs&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,835 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) &lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,835 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) &lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,835 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 397533.88ms)&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,851&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:22:46,851&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:00,067 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:01,098 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:01,098 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 1&amp;nbsp;031ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:07,192 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:07,989 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 6&amp;nbsp;891ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:30:07,989 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:00,001 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:00,845 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:00,845 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 844ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:07,111 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:07,783 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 6&amp;nbsp;938ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:40:07,783 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:45:00,102 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.OnDemandIndexTrackingActionExecuter] Execute action 'on-demand-index-tracking-action' - {dry-run=false, force=false, max-record-set-size=20000, days-back=-1}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:45:55,950 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.OnDemandIndexTrackingActionExecuter] Action finished - 'on-demand-index-tracking-action' - {dry-run=false, force=false, max-record-set-size=20000, days-back=-1}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:50:00,031 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;2)The etire log file (for the first 20 minutes) looks like this (alfresco instance no.2):&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Class path contains multiple SLF4J bindings.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Found binding in [jar:file:/C:/apps/alfresco2/tomcat/webapps/alfresco/WEB-INF/lib/slf4j-log4j12-1.5.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: Found binding in [jar:file:/C:/apps/alfresco2/tomcat/webapps/alfresco/WEB-INF/lib/slf4j-log4j12-1.5.11.jar!/org/slf4j/impl/StaticLoggerBinder.class]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SLF4J: See &lt;/SPAN&gt;&lt;A href="http://www.slf4j.org/codes.html#multiple_bindings" rel="nofollow noopener noreferrer"&gt;http://www.slf4j.org/codes.html#multiple_bindings&lt;/A&gt;&lt;SPAN&gt; for an explanation.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,700&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,731&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,747&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco2\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\cao-alfresco-amp\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,747&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco2\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\test\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,747&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from file [C:\apps\alfresco2\tomcat\webapps\alfresco\WEB-INF\classes\alfresco\module\tests\alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,747&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/C:/apps/alfresco2/tomcat/shared/classes/alfresco-global.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,841&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:45,966&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:01:46,013&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:02:11,890&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:02:11,890&amp;nbsp; INFO&amp;nbsp; [extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:02:18,359&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] Schema managed by database dialect org.alfresco.repo.domain.hibernate.dialect.AlfrescoOracle9Dialect.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:11:19,838&amp;nbsp; INFO&amp;nbsp; [domain.schema.SchemaBootstrap] No changes were made to the schema.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,012&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,231&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,059&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,137&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,340&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,340&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,387&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,403&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:30,403&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:31,809&amp;nbsp; WARN&amp;nbsp; [alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:31,809&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:37,637&amp;nbsp; INFO&amp;nbsp; [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: E:\alf_data&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:37,715&amp;nbsp; INFO&amp;nbsp; [admin.patch.PatchExecuter] Checking for patches to apply …&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,497&amp;nbsp; INFO&amp;nbsp; [admin.patch.PatchExecuter] No patches were required.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,528 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Found 2 module(s).&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,575 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Starting module 'cao-alfresco-amp' version 1.1.5.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,684 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [repo.module.ModuleServiceImpl] Starting module 'Oracle.for.Alfresco.3.4.a.Community' version 1.0.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,700&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,762&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,762&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:39,762&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,591&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,591&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,622&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,622&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,622&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,700&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,700&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,716&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,716&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,716&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,809&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,809&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,856&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,856&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,856&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,997&amp;nbsp; WARN&amp;nbsp; [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'blockedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.lang.String)]: [public void org.alfresco.email.server.EmailServer.setBlockedSenders(java.util.List)]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:40,997&amp;nbsp; WARN&amp;nbsp; [springframework.beans.GenericTypeAwarePropertyDescriptor] Invalid JavaBean property 'allowedSenders' being accessed! Ambiguous write methods found next to actually used [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.util.List)]: [public void org.alfresco.email.server.EmailServer.setAllowedSenders(java.lang.String)]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:41,012&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:41,012&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:41,091&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:41,091&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:41,091&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,262&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,262&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] Disabled - clear non-missing user usages …&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,356&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] Found 0 users to clear&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,356&amp;nbsp; INFO&amp;nbsp; [repo.usage.UserUsageTrackingComponent] … cleared non-missing usages for 0 users&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,356&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,450&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,450&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,450&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,497 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,575 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfinst]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,653 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,653 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,653 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,825 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfinst] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,825 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, ldap1]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,887 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,887 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:42,887 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,028 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, ldap1] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,028 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Synchronizing users and groups with user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,059 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Retrieving groups changed since 2015-05-28 09:48:44 from user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,200 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 Group Analysis: Commencing batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,216 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 Group Analysis: Completed batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,216 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Retrieving users changed since 2015-09-07 04:01:26 from user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,544 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 User Creation and Association: Commencing batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,544 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] ldap1 User Creation and Association: Completed batch of 0 entries&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,606 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] Finished synchronizing users and groups with user registry 'ldap1'&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,606 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [security.sync.ChainingUserRegistrySynchronizer] 0 user(s) and 0 group(s) processed&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,622 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,637&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,700&amp;nbsp; INFO&amp;nbsp; [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_45-b06; maximum heap size 13721,625MB&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,700&amp;nbsp; INFO&amp;nbsp; [service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.4.0 (d 3370) schema 4113 - Originally installed version 3.4.0 (d 3370) schema 4113&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,700&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,700&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/version.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,716&amp;nbsp; INFO&amp;nbsp; [alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,716&amp;nbsp; INFO&amp;nbsp; [alfresco.config.FixedPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/domain/cache-strategies.properties]&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,716&amp;nbsp; INFO&amp;nbsp; [management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:43,731 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 1&amp;nbsp;234ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:19:11,763 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:19:13,153 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 29&amp;nbsp;422ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:19:13,153 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,014 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Execute action 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,796 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_send" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 2&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:00,796 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_send - 0 objects changed in 782ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:06,733 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Executing query: +TYPE:"omo&lt;img id="smileysurprised" class="emoticon emoticon-smileysurprised" src="https://connect.hyland.com/i/smilies/16x16_smiley-surprised.png" alt="Smiley Surprised" title="Smiley Surprised" /&gt;ffice_document_out" +@omo\:task:"ready_to_pass" +(@omo\:registration_date:[2013-01-01T00:00:00.000 TO MAX]) -@omo\:case_removed:"true" -@omo\:task:"removed" returns results: 3242&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:07,624 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Status check for ready_to_pass - 0 objects changed in 6&amp;nbsp;828ms&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:07,624 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem DEBUG [alfresco.action.VerifyObjectIndexActionExecuter] Action finished - 'verify-object-index-action' - {dry-run=false, lag-duration=10}&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:32,828 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 491 Web Scripts (+0 failed), 758 URLs&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:32,828 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) &lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:32,828 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) &lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:20:32,828 User&lt;img id="smileyfrustrated" class="emoticon emoticon-smileyfrustrated" src="https://connect.hyland.com/i/smilies/16x16_smiley-frustrated.png" alt="Smiley Frustrated" title="Smiley Frustrated" /&gt;ystem INFO&amp;nbsp; [extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 106134.05ms)&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I would be thankfull for any piece information for how to speed up Alfresco startup process.&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
    <pubDate>Tue, 08 Sep 2015 07:58:39 GMT</pubDate>
    <dc:creator>martinsmith</dc:creator>
    <dc:date>2015-09-08T07:58:39Z</dc:date>
    <item>
      <title>Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301383#M254513</link>
      <description>Hi,I'm begginer in Alfresco. Lately our client ask us about Alfresco startup time reduction which takes more than 30 minutes.Alfresco is&amp;nbsp; setup on one phisicall machine in number of two instances(Version :Community - v3.4.0 (d 3370)). Logs from startup shows that there is in total 22 minutes gap bee</description>
      <pubDate>Tue, 08 Sep 2015 07:58:39 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301383#M254513</guid>
      <dc:creator>martinsmith</dc:creator>
      <dc:date>2015-09-08T07:58:39Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301384#M254514</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hello,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;it looks like schema validation and any operations that occur between schema validation and start of sysadmin subsystem are already costing you around 14 - 16 minutes alone.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;These three log statements are interesting:&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:02:18,359 INFO [domain.schema.SchemaBootstrap] Schema managed by database dialect org.alfresco.repo.domain.hibernate.dialect.AlfrescoOracle9Dialect.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:11:19,838 INFO [domain.schema.SchemaBootstrap] No changes were made to the schema.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;05:18:27,012 INFO [management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;One thing you can try for starters is to disable schema validation. This is typically only required for upgrade scenarios and not that relevant in the day-to-day operation. Also, I know from personal experience that Oracle can be slow when retrieving database metadata from a shared service (did not figure out why precisely) / larger database server.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Depending on how much that drops your startup time, I suggest you go ahead and add some SQL profiling / logging to your Alfresco system to see what Alfresco is talking with the database. Even if the database is fast, there may be an issue where Alfresco is talking "a lot" with the database which can slow things down depending on network overhead.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;SQL logging can be added via P6Spy or other JDBC logging facades, if it is not possible to log / monitor on the DB server side.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;One customer of ours once encountered a bug in Alfresco which would created thousands of unnecessary transactions due to bad scoping, which only hurt the customer due to a "larger than normal" network roundtrip time.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Regards&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;Axel&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Tue, 08 Sep 2015 08:30:56 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301384#M254514</guid>
      <dc:creator>afaust</dc:creator>
      <dc:date>2015-09-08T08:30:56Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301385#M254515</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi there,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I have same problem - alfresco is ready to work after 48min!&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I have no idea how to speed up this process &lt;img id="smileysad" class="emoticon emoticon-smileysad" src="https://connect.hyland.com/i/smilies/16x16_smiley-sad.png" alt="Smiley Sad" title="Smiley Sad" /&gt;&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;How exactly I can disable schema validation? I was going through alfresco-global.properties configuration file but no clue there.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Thanks&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Wed, 10 Feb 2016 09:29:00 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301385#M254515</guid>
      <dc:creator>andrewjones</dc:creator>
      <dc:date>2016-02-10T09:29:00Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301386#M254516</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi there,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I have same problem - alfresco is ready to work after 48min!&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I have no idea how to speed up this process &lt;img id="smileysad" class="emoticon emoticon-smileysad" src="https://connect.hyland.com/i/smilies/16x16_smiley-sad.png" alt="Smiley Sad" title="Smiley Sad" /&gt;&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;How exactly I can disable schema validation? I was going through alfresco-global.properties configuration file but no clue there.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Thanks&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;—&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;A.J.&lt;/SPAN&gt;&lt;BR /&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Wed, 10 Feb 2016 09:41:32 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301386#M254516</guid>
      <dc:creator>andrewjones</dc:creator>
      <dc:date>2016-02-10T09:41:32Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301387#M254517</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;See the documentation about &amp;lt;a href="&lt;/SPAN&gt;&lt;A href="http://docs.alfresco.com/4.2/concepts/maincomponents-disable.html" rel="nofollow noopener noreferrer"&gt;http://docs.alfresco.com/4.2/concepts/maincomponents-disable.html&lt;/A&gt;&lt;SPAN&gt;"&amp;gt;disabling Alfresco features&amp;lt;/a&amp;gt;. Schema validation is part of the schema update feature.&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Wed, 10 Feb 2016 17:02:27 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301387#M254517</guid>
      <dc:creator>afaust</dc:creator>
      <dc:date>2016-02-10T17:02:27Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301388#M254518</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi Axel,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;thanks for fast answer. Just to be 100% sure is it db.schema.update=false? In documentation there is info: " Specifies whether the system bootstrap should create or upgrade the database schema automatically." - I'm not quite sure is it about schema validation?&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Thanks&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Thu, 11 Feb 2016 09:04:56 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301388#M254518</guid>
      <dc:creator>andrewjones</dc:creator>
      <dc:date>2016-02-11T09:04:56Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301389#M254519</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;No that is not schema validation, as far as I can see there is no property to control schema validation.&amp;nbsp;&amp;nbsp; However schema validation does run after an upgrade so turning off upgrade also turns off the validation after the upgrade.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;However you shouldn't be upgrading every time you start alfresco,&amp;nbsp; that's an abnormal condition.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Are you sure you are seeing exactly the same problem as the OP?&amp;nbsp;&amp;nbsp; With an old version of alfresco and the same community oracle plug in?&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Alfresco startup typically takes a couple of minutes. It can take longer on first start up and during an upgrade when patches are running.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;It can also take a long time rebuilding the lucene indexes if an inconsistency is detected.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Anything else is unexpected.&amp;nbsp;&amp;nbsp; It can for example take far longer if you are trying to run alfresco with too little memory or if there are network connectivity issues.&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Thu, 11 Feb 2016 14:03:00 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301389#M254519</guid>
      <dc:creator>mrogers</dc:creator>
      <dc:date>2016-02-11T14:03:00Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301390#M254520</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi, Thanks for participation in this conversation. I have same issue as OP but in my case startup takes up to 45-50 minutes. I have no Idea what's the cause. I don't know if the data from NAGIOS client&amp;nbsp; would be helpful - i.e. if I provide You info about moments when respective indicators are set on green (OK) status along with the repository logs?&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Tue, 16 Feb 2016 07:47:00 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301390#M254520</guid>
      <dc:creator>andrewjones</dc:creator>
      <dc:date>2016-02-16T07:47:00Z</dc:date>
    </item>
    <item>
      <title>Re: Alfresco startup takes more than 30 min.</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301391#M254521</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hello,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;the most useful items for analyzing long startup times are the alfresco.log and any SQL profiling data you can gather. It is important to identify which parts of the startup are taking what percentages of the total time. I.e. there are also some features of Alfresco that pro-actively traverse / cache data structures that may delay startup due to sheer amount of data to process (and potentially cold DB caches), such as IMAP server functionality which as far as I remember caches the folder structure.&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;I don't believe Nagios will provide much interesting data apart from CPU / memory / network utilisation which might indicate resource bottlenecks in your configuration. But simply when what status changes to green should be too abstract for any meaningful analysis.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Regards&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;Axel&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Tue, 16 Feb 2016 08:27:55 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/alfresco-startup-takes-more-than-30-min/m-p/301391#M254521</guid>
      <dc:creator>afaust</dc:creator>
      <dc:date>2016-02-16T08:27:55Z</dc:date>
    </item>
  </channel>
</rss>

