alfresco startup very slow

[fiore_pisano]

hello to everyOne
I have a Alfresco 4.2.f on win2008R2 and i have populate it with my procedure. Actualy there are about 800.000 doc.
from last week ,after reboot my server the startup procedure spend about 9 hour for startup.
in the next row there are my last good startup :


mag 09, 2016 10:38:39 AM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-apr-8080"]
mag 09, 2016 10:38:39 AM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 10:38:39 AM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
mag 09, 2016 10:38:39 AM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
mag 09, 2016 10:38:46 AM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-apr-8080"]
mag 09, 2016 10:38:46 AM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 10:38:46 AM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
mag 09, 2016 10:40:47 AM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.29 using APR version 1.4.8.
mag 09, 2016 10:40:47 AM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
mag 09, 2016 10:40:49 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1e 11 Feb 2013)
mag 09, 2016 10:40:49 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
mag 09, 2016 10:40:49 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 10:40:49 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
mag 09, 2016 10:40:50 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 3457 ms
mag 09, 2016 10:40:50 AM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
mag 09, 2016 10:40:50 AM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.52
mag 09, 2016 10:40:50 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
mag 09, 2016 1:36:18 PM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.29 using APR version 1.4.8.
mag 09, 2016 1:36:18 PM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
mag 09, 2016 1:36:19 PM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1e 11 Feb 2013)
mag 09, 2016 1:36:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
mag 09, 2016 1:36:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 1:36:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
mag 09, 2016 1:36:20 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 3528 ms
mag 09, 2016 1:36:20 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
mag 09, 2016 1:36:20 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.52
mag 09, 2016 1:36:20 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
mag 09, 2016 1:42:04 PM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.29 using APR version 1.4.8.
mag 09, 2016 1:42:04 PM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
mag 09, 2016 1:42:05 PM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1e 11 Feb 2013)
mag 09, 2016 1:42:06 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
mag 09, 2016 1:42:06 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 1:42:06 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
mag 09, 2016 1:42:06 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 3417 ms
mag 09, 2016 1:42:06 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
mag 09, 2016 1:42:06 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.52
mag 09, 2016 1:42:07 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
mag 09, 2016 2:49:31 PM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.29 using APR version 1.4.8.
mag 09, 2016 2:49:31 PM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
mag 09, 2016 2:49:32 PM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1e 11 Feb 2013)
mag 09, 2016 2:49:32 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
mag 09, 2016 2:49:32 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 2:49:32 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
mag 09, 2016 2:49:33 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2604 ms
mag 09, 2016 2:49:33 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
mag 09, 2016 2:49:33 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.52
mag 09, 2016 2:49:33 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
mag 09, 2016 9:29:44 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\host-manager
mag 09, 2016 9:29:44 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\manager
mag 09, 2016 9:29:44 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\ROOT
mag 09, 2016 9:29:44 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-8080"]
mag 09, 2016 9:29:44 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-8009"]
mag 09, 2016 9:29:44 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
mag 09, 2016 9:29:44 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 24011030 ms

please note the line:
mag 09, 2016 2:49:33 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
mag 09, 2016 9:29:44 PM org.apache.catalina.startup.HostConfig deployDirectory

in the task manager of my server I see thath the process postgress consume about 25% of cpu

Any Idea ?
very thanks

[steven_okennedy]

Hi,

Can you look at your alfresco.log file or the tomcat/logs/catalina.out file as these will contain more detail around the startup logging of the application itself, rather than just the container (tomcat) and will give finer grain detail into what Alfresco is actually doing during this period

Regards

Steven