Alfresco working very slow

[soumyajit_halda]

Hi All,

I hardly have any idea about alfresco. The greatest mistake that I have made is that I have successfully installed RHEL 5 on a PC. The PC is running with 2GB RAM. People out here using it as there application and database server.

There application looks like follow:
                            Client Tier: Windows XP
                            Middle Tier: Alfresco WAR deployed in jboss-4.2.2.GA on RHEL 5 with jdk-1.6.0
                            Database: MySQL 5.1.3 on RHEL 5

Now, previously, exactly the same application was deployed on RHEL 4 and it was working fine. But, after moving it to RHEL 5, the application has become extremely SLOW.

I really don't have any idea about Alfresco. I am a hard-core Oralce DBA.

It will will be great if you all can guide me to suggest our application people some solution.

Thanks in advance,
Soumyajit Haldar

[derek]

Hi,

Please post the startup logs for your server so that we can see the VM memory assignments, etc.

Another common mistake people make with JBoss is with the log4j settings: http://wiki.alfresco.com/wiki/Log4J_Configuration
It is very easy, with the XML Log4J config, to get zero DEBUG output while actually generating zillions of DEBUG Strings - and walking vast tree structures doing so.

Regards

[soumyajit_halda]

Hi,

Thanks for the reply. I am studing on Log4J and also pasting the Startup Log below:


=========================================================================

  JBoss Bootstrap Environment

  JBOSS_HOME: /eforms/jboss-4.2.2.GA

  JAVA: /mysql/jdk-1.6.0/bin/java

  JAVA_OPTS: -XX:MaxPermSize=256M -Dprogram.name=run.sh -Dprogram.name=run.sh -server -Xms128m -Xmx512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djava.net.preferIPv4Stack=true -Xms1024m  -Xmx2048m -Xss1024K -Xcomp -Xbatch -XX:NewSize=512m -XX:MaxPermSize=256m  -XX:CMSInitiatingOccupancyFraction=80  -XX:+UseConcMarkSweepGC -XX:+CMSIncrementalMode

  CLASSPATH: /eforms/jboss-4.2.2.GA/bin/run.jar:/mysql/jdk-1.6.0/lib/tools.jar

=========================================================================

13:56:10,340 INFO  [Server] Starting JBoss (MX MicroKernel)…
13:56:10,460 INFO  [Server] Release ID: JBoss [Trinity] 4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)
13:56:10,467 INFO  [Server] Home Dir: /eforms/jboss-4.2.2.GA
13:56:10,468 INFO  [Server] Home URL: file:/eforms/jboss-4.2.2.GA/
13:56:10,478 INFO  [Server] Patch URL: null
13:56:10,478 INFO  [Server] Server Name: default
13:56:10,478 INFO  [Server] Server Home Dir: /eforms/jboss-4.2.2.GA/server/default
13:56:10,486 INFO  [Server] Server Home URL: file:/eforms/jboss-4.2.2.GA/server/default/
13:56:10,486 INFO  [Server] Server Log Dir: /eforms/jboss-4.2.2.GA/server/default/log
13:56:10,491 INFO  [Server] Server Temp Dir: /eforms/jboss-4.2.2.GA/server/default/tmp
13:56:10,507 INFO  [Server] Root Deployment Filename: jboss-service.xml
13:56:15,283 INFO  [ServerInfo] Java version: 1.6.0,Sun Microsystems Inc.
13:56:15,283 INFO  [ServerInfo] Java VM: Java HotSpot(TM) Server VM 1.6.0-b105,Sun Microsystems Inc.
13:56:15,283 INFO  [ServerInfo] OS-System: Linux 2.6.18-92.el5xen,i386
13:56:21,045 INFO  [Server] Core system initialized
13:56:27,894 INFO  [WebService] Using RMI server codebase: http://157.227.245.23:8083/
13:56:27,909 INFO  [Log4jService$URLWatchTimerTask] Configuring from URL: resource:jboss-log4j.xml
13:56:33,031 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc.
13:56:33,031 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
13:56:34,431 INFO  [TransactionManagerService] Starting recovery manager
13:56:35,707 INFO  [TransactionManagerService] Recovery manager started
13:56:35,707 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
13:56:48,623 INFO  [EJB3Deployer] Starting java:comp multiplexer
13:56:51,299 INFO  [STDOUT] no object for null
13:56:51,492 INFO  [STDOUT] no object for null
13:56:51,581 INFO  [STDOUT] no object for null
13:56:51,594 INFO  [STDOUT] no object for {urn:jboss:bean-deployer}supplyType
13:56:51,602 INFO  [STDOUT] no object for {urn:jboss:bean-deployer}dependsType
13:56:55,891 INFO  [NativeServerConfig] JBoss Web Services - Native
13:56:55,893 INFO  [NativeServerConfig] jbossws-native-2.0.1.SP2 (build=200710210837)
13:56:59,746 INFO  [Embedded] Catalina naming disabled
13:57:00,524 INFO  [AprLifecycleListener] The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /mysql/jdk-1.6.0/jre/lib/i386/server:/mysql/jdk-1.6.0/jre/lib/i386:/mysql/jdk-1.6.0/jre/../lib/i386:/usr/java/packages/lib/i386:/lib:/usr/lib
13:57:00,911 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-157.227.245.23-8080
13:57:00,965 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-157.227.245.23-8009
13:57:00,965 INFO  [Catalina] Initialization processed in 1233 ms
13:57:00,995 INFO  [StandardService] Starting service jboss.web
13:57:01,016 INFO  [StandardEngine] Starting Servlet Engine: JBossWeb/2.0.1.GA
13:57:01,259 INFO  [Catalina] Server startup in 293 ms
13:57:02,274 INFO  [TomcatDeployer] deploy, ctxPath=/, warUrl=…/deploy/jboss-web.deployer/ROOT.war/
13:57:06,841 INFO  [TomcatDeployer] deploy, ctxPath=/invoker, warUrl=…/deploy/http-invoker.sar/invoker.war/
13:57:08,720 INFO  [TomcatDeployer] deploy, ctxPath=/jbossws, warUrl=…/deploy/jbossws.sar/jbossws-context.war/
13:57:08,844 INFO  [TomcatDeployer] deploy, ctxPath=/jbossmq-httpil, warUrl=…/deploy/jms/jbossmq-httpil.sar/jbossmq-httpil.war/
13:57:10,367 INFO  [TomcatDeployer] deploy, ctxPath=/web-console, warUrl=…/deploy/management/console-mgr.sar/web-console.war/
13:57:13,209 INFO  [MailService] Mail Service bound to java:/Mail
13:57:13,642 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/jboss-ha-local-jdbc.rar
13:57:13,710 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/jboss-ha-xa-jdbc.rar
13:57:13,731 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/jboss-local-jdbc.rar
13:57:13,757 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/jboss-xa-jdbc.rar
13:57:13,823 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/jms/jms-ra.rar
13:57:13,850 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/mail-ra.rar
13:57:13,958 INFO  [RARDeployment] Required license terms exist, view META-INF/ra.xml in …/deploy/quartz-ra.rar
13:57:13,968 INFO  [QuartzResourceAdapter] start quartz!!!
13:57:14,530 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
13:57:14,649 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
13:57:14,659 INFO  [RAMJobStore] RAMJobStore initialized.
13:57:14,663 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
13:57:14,663 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
13:57:14,694 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
13:57:20,912 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'javaefaultDS'
13:57:25,507 INFO  [A] Bound to JNDI name: queue/A
13:57:25,541 INFO  Bound to JNDI name: queue/B
13:57:25,545 INFO  [C] Bound to JNDI name: queue/C
13:57:25,546 INFO  [D] Bound to JNDI name: queue/D
13:57:25,559 INFO  [ex] Bound to JNDI name: queue/ex
13:57:25,670 INFO  [testTopic] Bound to JNDI name: topic/testTopic
13:57:25,697 INFO  [securedTopic] Bound to JNDI name: topic/securedTopic
13:57:25,698 INFO  [testDurableTopic] Bound to JNDI name: topic/testDurableTopic
13:57:25,738 INFO  [testQueue] Bound to JNDI name: queue/testQueue
13:57:25,853 INFO  [UILServerILService] JBossMQ UIL service available at : /157.227.245.23:8093
13:57:25,990 INFO  [DLQ] Bound to JNDI name: queue/DLQ
13:57:26,621 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
13:57:26,697 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=/jdbc/test' to JNDI name 'java:/jdbc/test'
13:57:36,535 INFO  [TomcatDeployer] deploy, ctxPath=/alfresco, warUrl=…/tmp/deploy/tmp51978alfresco-exp.war/
13:57:42,388 INFO  [[/alfresco]] Set web app root system property: 'webapp.root' = [/eforms/jboss-4.2.2.GA/server/default/./tmp/deploy/tmp51978alfresco-exp.war/]
13:57:42,442 INFO  [[/alfresco]] Loading Spring root WebApplicationContext
13:58:51,728 INFO  [STDOUT] 13:58:51,658  INFO  [config.xml.XMLConfigService$PropertyConfigurer] Loading properties file from class path resource [alfresco/file-servers.properties]
13:58:57,774 INFO  [STDOUT] 13:58:57,772  INFO  [alfresco.mbeans.VirtServerRegistry] Creating VirtServerRegistry MBean
13:58:58,001 INFO  [STDOUT] 13:58:58,001  WARN  [remoting.rmi.RmiRegistryFactoryBean] Could not detect RMI registry - creating new one
13:59:00,851 INFO  [STDOUT] 13:59:00,851  INFO  [alfresco.mbeans.VirtServerRegistry] Created JMX serverConnector
13:59:20,947 INFO  [STDOUT] 13:59:20,947  ERROR [transform.swf.PDFToSWFContentTransformer] Failed to start SWF2PDF transformer:
Execution result:
   os:         Linux
   command:    pdf2swf -V
   succeeded:  false
   exit code:  1
   out:       
   err:        Cannot run program "pdf2swf": java.io.IOException: error=2, No such file or directory
13:59:24,677 INFO  [STDOUT] 13:59:24,677  INFO  [domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
13:59:34,279 INFO  [STDOUT] 13:59:34,279  INFO  [domain.schema.SchemaBootstrap] No changes were made to the schema.
13:59:58,355 INFO  [STDOUT] 13:59:58,355 Userystem WARN  [repo.admin.ConfigurationChecker] The Alfresco 'dir.root' property is set to a relative path './alf_data'.  'dir.root' should be overridden to point to a specific folder.
13:59:58,379 INFO  [STDOUT] 13:59:58,376 Userystem INFO  [repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: ./alf_data
13:59:58,542 INFO  [STDOUT] 13:59:58,542 Userystem INFO  [admin.patch.PatchExecuter] Checking for patches to apply …
13:59:59,417 INFO  [STDOUT] 13:59:59,417 Userystem INFO  [admin.patch.PatchExecuter] No patches were required.
14:00:00,078 INFO  [STDOUT] 14:00:00,078 Userystem INFO  [repo.module.ModuleServiceImpl] Found 0 module(s).
14:03:49,651 INFO  [STDOUT] 14:03:49,651 Userystem WARN  [alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
14:03:51,130 INFO  [STDOUT] 14:03:51,130 Userystem INFO  [service.descriptor.DescriptorService] Alfresco JVM - v1.6.0-b105; maximum heap size 1996.813MB
14:03:51,254 INFO  [STDOUT] 14:03:51,254 Userystem INFO  [service.descriptor.DescriptorService] Alfresco started (Labs): Current version 3.0.0 (nile @build-number@) schema 128 - Installed version 3.0.0 (nile @build-number@) schema 128
14:04:45,299 INFO  [TomcatDeployer] deploy, ctxPath=/jmx-console, warUrl=…/deploy/jmx-console.war/
14:04:49,040 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-157.227.245.23-8080
14:04:51,210 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-157.227.245.23-8009
14:04:51,378 INFO  [Server] JBoss (MX MicroKernel) [4.2.2.GA (build: SVNTag=JBoss_4_2_2_GA date=200710221139)] Started in 8m:40s:857ms

Regards,
Soumyajit

[derek]

Hi,
Your VM settings look good.  There should be no problem.  You could try to run the app in Tomcat (as a test) where you definitely won't be hitting the log4j config issue.
Regards

[soumyajit_halda]

Hi,

Thanks again for your contineous interest.

I have checked with the application people. The same configuration is running fine in other m/c where OS is RHEL 4. Thats the only difference. Even, previously it was running fine on this PC only (OS was RHEL 4).

Thus, I am not sure, whether there is any dependencey with OS.

Regards,
Soumyajit

[derek]

Hi,
I surmised that there might be a dependency on the Log4J settings and hence you should try Tomcat.  The OS and your VM settings look fine.
Regards