Slow Alfresco startup

[agz]

Hi all,
I migrated in installed version of Alfresco community 4.2.f from a server A to server B.
B is a cold clone of A.

When I start Alfresco in B I have that the startup processo is very slow because I have lot of this rows

2016-02-17 15:28:45,189  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.

before alfresco really starts.

I tried to perform a full solr reindex but the problem remains.

Can you help me please?

Feb 17, 2016 3:26:36 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Feb 17, 2016 3:26:36 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.52
Feb 17, 2016 3:26:36 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /opt/alfresco/alfresco-4.2.f/tomcat/conf/Catalina/localhost/solr.xml
Feb 17, 2016 3:26:36 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
2016-02-17 15:26:38,179  WARN  [solr.core.SolrCore] [localhost-startStop-1] [archive] Solr index directory '/opt/alfresco/alfresco-4.2.f/alf_data/solr/archive/SpacesStore/index' doesn't exist. Creating new index…
 2016-02-17 15:26:38,419  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
 2016-02-17 15:26:38,606  WARN  [solr.core.SolrCore] [localhost-startStop-1] [alfresco] Solr index directory '/opt/alfresco/alfresco-4.2.f/alf_data/solr/workspace/SpacesStore/index' doesn't exist. Creating new index…
 2016-02-17 15:26:38,657  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
 Feb 17, 2016 3:26:38 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /opt/alfresco/alfresco-4.2.f/tomcat/webapps/alfresco.war
Feb 17, 2016 3:26:47 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Feb 17, 2016 3:26:48 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2016-02-17 15:26:52,831  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbc:postgresql://*************/alfresco_irl' with user 'alfresco'.
 2016-02-17 15:26:53,617  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.4.1
 2016-02-17 15:26:59,676  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
 2016-02-17 15:26:59,690  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
 2016-02-17 15:27:06,587  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
 2016-02-17 15:27:06,597  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
 2016-02-17 15:27:11,581  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbc:postgresql://warda-ped-db-test.cjsajusxnbjo.eu-central-1.rds.amazonaws.com:5432/alfresco_irl, UserName=alfresco, PostgreSQL Native Driver
 2016-02-17 15:27:11,582  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
 2016-02-17 15:27:18,533  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
 2016-02-17 15:27:22,759  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
 2016-02-17 15:27:22,835  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
 2016-02-17 15:27:23,545  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr]
 2016-02-17 15:27:23,713  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr] complete
 2016-02-17 15:27:24,801  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
 2016-02-17 15:27:24,892  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
 2016-02-17 15:27:24,892  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
 2016-02-17 15:27:25,073  WARN  [alfresco.util.OpenOfficeConnectionTester] [localhost-startStop-1] An initial OpenOffice connection could not be established.
 2016-02-17 15:27:25,077  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
 2016-02-17 15:27:25,099  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alfresco-4.2.f/alf_data
 2016-02-17 15:27:25,198  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
 2016-02-17 15:27:48,842  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
 2016-02-17 15:27:48,932  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 2 module(s).
 2016-02-17 15:27:49,369  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.module.vti' version 1.3.
 2016-02-17 15:27:49,701  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 2.0.4.
 2016-02-17 15:27:49,858  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
 2016-02-17 15:27:55,576  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
 2016-02-17 15:27:55,598  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
 2016-02-17 15:27:55,598  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
 2016-02-17 15:27:55,727  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
 2016-02-17 15:27:55,727  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
 2016-02-17 15:27:55,776  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
 2016-02-17 15:27:55,776  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
 2016-02-17 15:27:55,862  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
 2016-02-17 15:27:55,862  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
 2016-02-17 15:27:55,872  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
 2016-02-17 15:27:56,211  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
 2016-02-17 15:27:58,642  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
 2016-02-17 15:27:59,238  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.7.0_25-b15; maximum heap size 5461.375MB
 2016-02-17 15:27:59,238  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Community). Current version: 4.2.0 (r63893-b12) schema 6,033. Originally installed version: 4.2.0 (r63893-b12) schema 6,033.
 2016-02-17 15:27:59,264  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
 2016-02-17 15:27:59,330  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
 2016-02-17 15:27:59,330  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
 2016-02-17 15:27:59,336  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
 2016-02-17 15:28:00,083  WARN  [alfresco.util.OpenOfficeConnectionTester] [DefaultScheduler_Worker-3] Error trying to query Open Office version information. OpenOffice.org's ConfigurationRegistry not implemented in this version of OOo. This should not affect the operation of OOo.
 2016-02-17 15:28:00,095  INFO  [alfresco.util.OpenOfficeConnectionTester] [DefaultScheduler_Worker-3] The OpenOffice connection was re-established.
 2016-02-17 15:28:45,189  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.
 2016-02-17 15:28:45,189  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out.
 2016-02-17 15:31:00,222  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.
 2016-02-17 15:31:00,283  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-1] Tracking communication timed out.
 2016-02-17 15:33:15,030  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.
 2016-02-17 15:33:15,117  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out.
 2016-02-17 15:35:30,085  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.
 2016-02-17 15:35:30,124  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out.
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

[mrogers]

There is nothing in that log extract that shows a problem.  In fact it shows correct start up in about two minutes.

There are a couple of configuration errors for cifs and open office.

[agz]

No mrogers,
this startup spends about 15/20 mins because the last rows

"WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out."‍

are repeated, and while they are repeated Alfresco doesn't work.

I know errors in OO and CIFS config but they are not relevant.

The difference is that in the old server A the rows

"WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out."‍

were not present and the startup spends about 2/3 minutes.
In server B, this warnings slow down the startup process that spends about 15/20 mins and I don't know why here I have this warnings.

[agz]

Anyone can help me?

[gravitonian]

Hi,

"Tracking communication timed out" indicates that something did not start-up properly. Look at your alfresco.log and make sure the Repository loaded properly (i.e. alfresco.war). Can you access http://localhost:8080/alfresco ?