11:52 a.m.
On Wed, 2008-09-03 at 16:20 +0200, Sacha Labourey wrote:
Damned.... that's a LOT, is this what Adrian is supposed to
optimize?
At least find out what is wrong and report it to whoever
is responsible.
Find out what is wrong at least and report it to whoever
is responsible. :-)
hprof sampling (not very accurate but useful for finding
"braindeaths"/hotspots) shows the time spent in;
* vfs ZIP handling (and some other vfs calls such isLeaf())
* aop point cut matching
* annotation scanning
* ClassLoader.defineClass1()
The last one is probably spurious since hprof does
byte code manipulation to add its hooks during class definition
and it would a JDK issue anyway. :-)
It needs more detailed analysis (and better numbers).
To determine where/why these are slow and whether they can
be optimised further.
I did some anaylsis last month which cut the "default"
config bootstrap from 1 minute to 45 seconds on my laptop.
Marko has already done some fixes to the VFS based
on this earlier analysis, but they don't look to
have made a major difference - or maybe it got
slower elsewhere to compensate. :-)
Although this is misleading since the
> -----Original Message-----
> From: jboss-development-bounces(a)lists.jboss.org [mailto:jboss-
> development-bounces(a)lists.jboss.org] On Behalf Of Dimitris Andreadis
> Sent: mercredi, 3 septembre 2008 16:17
> To: JBoss.org development list
> Subject: Re: [jboss-dev] AS is hanging at startup
>
> The boot delays are so far due to annotation/vfs processing. This
> particular one on my
> machine appears to be a 4sec:
>
> 2008-09-03 17:10:56,046 DEBUG
> [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer]
> (main) Processing unit=invoker.war, structure:
> http-invoker.sar
>
> +invoker.war
>
>
> 2008-09-03 17:11:00,937 DEBUG
> [org.jboss.deployment.OptAnnotationMetaDataDeployer] (main)
> Deployment is metadata-complete, skipping annotation processing,
> ejbJarMetaData=null,
> jbossWebMetaData=org.jboss.metadata.web.spec.Web24MetaData@1f,
> jbossClientMetaData=null,
> metaDataCompleteIsDefault=false
> 2008-09-03 17:11:00,968 DEBUG
> [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer]
> (main)
> vfsfile:/X:/cvs/jboss-public/jboss-head/build/output/jboss-
> 5.0.0.CR2/server/default/deploy/jbossws.sar/
> endpoint mappings:
>
>
>
>
> Sacha Labourey wrote:
> > 30 seconds:
> >
> > ...
> > 15:09:27,671 INFO [JMXKernel] Legacy JMX core initialized
> > 15:09:31,406 INFO [MetaDataAwareProfile] Using profile
> > root:C:\SVN_HOME\trunk\b
> > uild\output\jboss-5.0.0.CR2\server\web-profile
> > 15:10:02,062 INFO [TransactionManagerService] JBossTS Transaction
> Service
> > (JTA
> > version) - JBoss Inc.
> > 15:10:02,062 INFO [TransactionManagerService] Setting up property
> manager
> > MBean
> > and JMX layer
> > ...
> >
> > Any idea why? I am connected to the Internet.
> >
> > Actually, it doesn't really hang, but doing things pretty slowly and
> then
> > there is this:
> >
> > 2008-09-03 15:09:48,562 DEBUG
> > [org.jboss.classloader.spi.base.BaseClassLoaderDomain] (main)
> >
> ClassLoaderDomain@faaa93{vfsfile:/C:/SVN_HOME/trunk/build/output/jboss-
> 5.0.0
> > .CR2/server/web-profile/deploy/jmx-console.war/} registerClassLoader
> > BaseClassLoader@d4b411{vfsfile:/C:/SVN_HOME/trunk/build/output/jboss-
> 5.0.0.C
> > R2/server/web-profile/deploy/jmx-console.war/}
> > 2008-09-03 15:09:49,390 DEBUG
> > [org.jboss.deployment.OptAnnotationMetaDataDeployer] (main)
> Deployment is
> > metadata-complete, skipping annotation processing,
> ejbJarMetaData=null,
> > jbossWebMetaData=org.jboss.metadata.web.spec.Web23MetaData@1f,
> > jbossClientMetaData=null, metaDataCompleteIsDefault=false
> > 2008-09-03 15:09:49,406 DEBUG
> > [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer] (main)
> > vfsfile:/C:/SVN_HOME/trunk/build/output/jboss-5.0.0.CR2/server/web-
> profile/d
> > eploy/http-invoker.sar/ endpoint mappings:
> >
> > 2008-09-03 15:09:49,406 DEBUG
> > [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer] (main)
> > Processing unit=invoker.war, structure:
> > http-invoker.sar
> >
> > +invoker.war
> >
> >
> > 2008-09-03 15:09:58,984 DEBUG
> > [org.jboss.deployment.OptAnnotationMetaDataDeployer] (main)
> Deployment is
> > metadata-complete, skipping annotation processing,
> ejbJarMetaData=null,
> > jbossWebMetaData=org.jboss.metadata.web.spec.Web23MetaData@1f,
> > jbossClientMetaData=null, metaDataCompleteIsDefault=false
> > 2008-09-03 15:09:58,984 DEBUG
> > [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer] (main)
> > vfsfile:/C:/SVN_HOME/trunk/build/output/jboss-5.0.0.CR2/server/web-
> profile/d
> > eploy/ROOT.war/ endpoint mappings:
> >
> > 2008-09-03 15:09:58,984 DEBUG
> > [org.jboss.deployment.MappedReferenceMetaDataResolverDeployer] (main)
> > Processing unit=ROOT.war, structure:
> > ROOT.war
> >
> >
> > 2008-09-03 15:09:59,046 DEBUG
> > [org.jboss.deployment.OptAnnotationMetaDataDeployer] (main)
> Deployment is
> > metadata-complete, skipping annotation processing,
> ejbJarMetaData=null,
> > jbossWebMetaData=org.jboss.metadata.web.spec.Web23MetaData@1f,
> > jbossClientMetaData=null, metaDataCompleteIsDefault=false
> >
> >
> > _______________________________________________
> > jboss-development mailing list
> > jboss-development(a)lists.jboss.org
> > https://lists.jboss.org/mailman/listinfo/jboss-development
> _______________________________________________
> jboss-development mailing list
> jboss-development(a)lists.jboss.org
> https://lists.jboss.org/mailman/listinfo/jboss-development
_______________________________________________
jboss-development mailing list
jboss-development(a)lists.jboss.org
https://lists.jboss.org/mailman/listinfo/jboss-development
--
xxxxxxxxxxxxxxxxxxxxxxxxxxxx
Adrian Brock
Chief Scientist
JBoss, a division of Red Hat
xxxxxxxxxxxxxxxxxxxxxxxxxxxx