[prev in list] [next in list] [prev in thread] [next in thread] 

List:       james-user
Subject:    Re: problems upgading james
From:       zkn <zkn () abv ! bg>
Date:       2007-03-30 10:28:22
Message-ID: DA85B781-1382-481A-9088-02920794BE55 () abv ! bg
[Download RAW message or body]


On 30.03.2007, at 12:22, Stefano Bagnara wrote:

> zkn ha scritto:
>> Have in mind that this MYOWN directory contains a really big tree  
>> of folders and files - ~50GB. It will be really slow even if james| 
>> phoenix tries only to go trough all of them.
>> I think that's all I can give as information. If your are not able  
>> to help me I will have to keep using 2.2.
>
> Everything bring us to something weird in the new phoenix.
> It seems that the James code is not even reached when you are waiting.
>
> Can you give us a stacktrace of phoenix (kill -3 <pid> or jstack  
> <pid>) while you "wait" for the folder scan? If you take a couple  
> of them during this wait period it will help us.
>
I executed kill -3 three times and the result is below. Seems like  
the problem is here:
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)

STARTED Phoenix Fri Mar 30 03:13:04 PDT 2007

Phoenix 4.2

Full thread dump Java HotSpot(TM) Client VM (1.4.2_13-b06 mixed mode):

"Thread-0" daemon prio=1 tid=0xaa4e5880 nid=0x6591 waiting on  
condition [0xaa102000..0xaa102868]
	at java.lang.Thread.sleep(Native Method)
	at org.apache.avalon.excalibur.monitor.impl.ActiveMonitor.run 
(ActiveMonitor.java:101)
	at java.lang.Thread.run(Thread.java:534)

"Signal Dispatcher" daemon prio=1 tid=0xaab14470 nid=0x658e waiting  
on condition [0x00000000..0x00000000]

"Finalizer" daemon prio=1 tid=0xaab00690 nid=0x658c in Object.wait()  
[0xaacad000..0xaacad868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
	- locked <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)

"Reference Handler" daemon prio=1 tid=0x0808d770 nid=0x658b in  
Object.wait() [0xaad2e000..0xaad2e868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31fa00> (a java.lang.ref.Reference$Lock)
	at java.lang.Object.wait(Object.java:429)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:115)
	- locked <0xab31fa00> (a java.lang.ref.Reference$Lock)

"main" prio=1 tid=0x08057c98 nid=0x6588 runnable  
[0xbfffa000..0xbfffbeb8]
	at java.io.ExpiringCache.cleanup(ExpiringCache.java:99)
	at java.io.ExpiringCache.get(ExpiringCache.java:51)
	- locked <0xab3224f8> (a java.io.ExpiringCache)
	at java.io.UnixFileSystem.canonicalize(UnixFileSystem.java:137)
	at java.io.File.getCanonicalPath(File.java:513)
	at java.io.FilePermission$1.run(FilePermission.java:218)
	at java.security.AccessController.doPrivileged(Native Method)
	at java.io.FilePermission.init(FilePermission.java:212)
	at java.io.FilePermission.<init>(FilePermission.java:264)
	at java.lang.SecurityManager.checkRead(SecurityManager.java:863)
	at java.io.File.isDirectory(File.java:699)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:168)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.r 
esolveFileSet(DefaultLoaderResolver.java:131)
	at  
org.apache.avalon.phoenix.components.classloader.SarLoaderResolver.resol 
veFileSet(SarLoaderResolver.java:169)
	at  
org.realityforge.classman.builder.LoaderBuilder.buildRegularClassLoader( 
LoaderBuilder.java:210)
	at org.realityforge.classman.builder.LoaderBuilder.processClassLoader 
(LoaderBuilder.java:126)
	at org.realityforge.classman.builder.LoaderBuilder.addAllClassLoaders 
(LoaderBuilder.java:71)
	at org.realityforge.classman.builder.LoaderBuilder.buildClassLoaders 
(LoaderBuilder.java:48)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultClassLoaderManag 
er.createClassLoaderSet(DefaultClassLoaderManager.java:233)
	at  
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy 
(DefaultDeployer.java:331)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:542)
	- locked <0xab343058> (a  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:535)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
s(DefaultEmbeddor.java:520)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployDefa 
ultApplications(DefaultEmbeddor.java:509)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.execute 
(DefaultEmbeddor.java:268)
	at org.apache.avalon.phoenix.frontends.CLIMain.run(CLIMain.java:198)
	at org.apache.avalon.phoenix.frontends.CLIMain.execute(CLIMain.java: 
184)
	at org.apache.avalon.phoenix.frontends.CLIMain.main(CLIMain.java:145)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke 
(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke 
(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:324)
	at org.apache.avalon.phoenix.launcher.Main.startup(Main.java:128)
	at org.apache.avalon.phoenix.launcher.Main.main(Main.java:83)

"VM Thread" prio=1 tid=0x0808c508 nid=0x658a runnable

"VM Periodic Task Thread" prio=1 tid=0xaab16c88 nid=0x6590 waiting on  
condition
"Suspend Checker Thread" prio=1 tid=0xaab139c8 nid=0x658d runnable
Full thread dump Java HotSpot(TM) Client VM (1.4.2_13-b06 mixed mode):

"Thread-0" daemon prio=1 tid=0xaa4e5880 nid=0x6591 waiting on  
condition [0xaa102000..0xaa102868]
	at java.lang.Thread.sleep(Native Method)
	at org.apache.avalon.excalibur.monitor.impl.ActiveMonitor.run 
(ActiveMonitor.java:101)
	at java.lang.Thread.run(Thread.java:534)

"Signal Dispatcher" daemon prio=1 tid=0xaab14470 nid=0x658e waiting  
on condition [0x00000000..0x00000000]

"Finalizer" daemon prio=1 tid=0xaab00690 nid=0x658c in Object.wait()  
[0xaacad000..0xaacad868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
	- locked <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)

"Reference Handler" daemon prio=1 tid=0x0808d770 nid=0x658b in  
Object.wait() [0xaad2e000..0xaad2e868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31fa00> (a java.lang.ref.Reference$Lock)
	at java.lang.Object.wait(Object.java:429)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:115)
	- locked <0xab31fa00> (a java.lang.ref.Reference$Lock)

"main" prio=1 tid=0x08057c98 nid=0x6588 runnable  
[0xbfffa000..0xbfffbeb8]
	at java.security.AccessController.doPrivileged(Native Method)
	at java.io.FilePermission.init(FilePermission.java:212)
	at java.io.FilePermission.<init>(FilePermission.java:264)
	at java.lang.SecurityManager.checkRead(SecurityManager.java:863)
	at java.io.File.isDirectory(File.java:699)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:168)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.r 
esolveFileSet(DefaultLoaderResolver.java:131)
	at  
org.apache.avalon.phoenix.components.classloader.SarLoaderResolver.resol 
veFileSet(SarLoaderResolver.java:169)
	at  
org.realityforge.classman.builder.LoaderBuilder.buildRegularClassLoader( 
LoaderBuilder.java:210)
	at org.realityforge.classman.builder.LoaderBuilder.processClassLoader 
(LoaderBuilder.java:126)
	at org.realityforge.classman.builder.LoaderBuilder.addAllClassLoaders 
(LoaderBuilder.java:71)
	at org.realityforge.classman.builder.LoaderBuilder.buildClassLoaders 
(LoaderBuilder.java:48)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultClassLoaderManag 
er.createClassLoaderSet(DefaultClassLoaderManager.java:233)
	at  
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy 
(DefaultDeployer.java:331)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:542)
	- locked <0xab343058> (a  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:535)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
s(DefaultEmbeddor.java:520)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployDefa 
ultApplications(DefaultEmbeddor.java:509)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.execute 
(DefaultEmbeddor.java:268)
	at org.apache.avalon.phoenix.frontends.CLIMain.run(CLIMain.java:198)
	at org.apache.avalon.phoenix.frontends.CLIMain.execute(CLIMain.java: 
184)
	at org.apache.avalon.phoenix.frontends.CLIMain.main(CLIMain.java:145)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke 
(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke 
(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:324)
	at org.apache.avalon.phoenix.launcher.Main.startup(Main.java:128)
	at org.apache.avalon.phoenix.launcher.Main.main(Main.java:83)

"VM Thread" prio=1 tid=0x0808c508 nid=0x658a runnable

"VM Periodic Task Thread" prio=1 tid=0xaab16c88 nid=0x6590 waiting on  
condition
"Suspend Checker Thread" prio=1 tid=0xaab139c8 nid=0x658d runnable
Full thread dump Java HotSpot(TM) Client VM (1.4.2_13-b06 mixed mode):

"Thread-0" daemon prio=1 tid=0xaa4e5880 nid=0x6591 waiting on  
condition [0xaa102000..0xaa102868]
	at java.lang.Thread.sleep(Native Method)
	at org.apache.avalon.excalibur.monitor.impl.ActiveMonitor.run 
(ActiveMonitor.java:101)
	at java.lang.Thread.run(Thread.java:534)

"Signal Dispatcher" daemon prio=1 tid=0xaab14470 nid=0x658e waiting  
on condition [0x00000000..0x00000000]

"Finalizer" daemon prio=1 tid=0xaab00690 nid=0x658c in Object.wait()  
[0xaacad000..0xaacad868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
	- locked <0xab31f998> (a java.lang.ref.ReferenceQueue$Lock)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)

"Reference Handler" daemon prio=1 tid=0x0808d770 nid=0x658b in  
Object.wait() [0xaad2e000..0xaad2e868]
	at java.lang.Object.wait(Native Method)
	- waiting on <0xab31fa00> (a java.lang.ref.Reference$Lock)
	at java.lang.Object.wait(Object.java:429)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:115)
	- locked <0xab31fa00> (a java.lang.ref.Reference$Lock)

"main" prio=1 tid=0x08057c98 nid=0x6588 runnable  
[0xbfffa000..0xbfffbeb8]
	at java.security.AccessController.doPrivileged(Native Method)
	at java.io.FilePermission.init(FilePermission.java:212)
	at java.io.FilePermission.<init>(FilePermission.java:264)
	at java.lang.SecurityManager.checkRead(SecurityManager.java:863)
	at java.io.File.isDirectory(File.java:699)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:168)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.s 
canDir(DefaultLoaderResolver.java:170)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultLoaderResolver.r 
esolveFileSet(DefaultLoaderResolver.java:131)
	at  
org.apache.avalon.phoenix.components.classloader.SarLoaderResolver.resol 
veFileSet(SarLoaderResolver.java:169)
	at  
org.realityforge.classman.builder.LoaderBuilder.buildRegularClassLoader( 
LoaderBuilder.java:210)
	at org.realityforge.classman.builder.LoaderBuilder.processClassLoader 
(LoaderBuilder.java:126)
	at org.realityforge.classman.builder.LoaderBuilder.addAllClassLoaders 
(LoaderBuilder.java:71)
	at org.realityforge.classman.builder.LoaderBuilder.buildClassLoaders 
(LoaderBuilder.java:48)
	at  
org.apache.avalon.phoenix.components.classloader.DefaultClassLoaderManag 
er.createClassLoaderSet(DefaultClassLoaderManager.java:233)
	at  
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy 
(DefaultDeployer.java:331)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:542)
	- locked <0xab343058> (a  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
(DefaultEmbeddor.java:535)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile 
s(DefaultEmbeddor.java:520)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployDefa 
ultApplications(DefaultEmbeddor.java:509)
	at  
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.execute 
(DefaultEmbeddor.java:268)
	at org.apache.avalon.phoenix.frontends.CLIMain.run(CLIMain.java:198)
	at org.apache.avalon.phoenix.frontends.CLIMain.execute(CLIMain.java: 
184)
	at org.apache.avalon.phoenix.frontends.CLIMain.main(CLIMain.java:145)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke 
(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke 
(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:324)
	at org.apache.avalon.phoenix.launcher.Main.startup(Main.java:128)
	at org.apache.avalon.phoenix.launcher.Main.main(Main.java:83)

"VM Thread" prio=1 tid=0x0808c508 nid=0x658a runnable

"VM Periodic Task Thread" prio=1 tid=0xaab16c88 nid=0x6590 waiting on  
condition
"Suspend Checker Thread" prio=1 tid=0xaab139c8 nid=0x658d runnable
JVM exiting abnormally. Shutting down Phoenix.
STOPPED Fri Mar 30 03:18:05 PDT 2007

> Furthermore if you can check if James uses 100% or simply wait  
> during this startup it would help.
>
CPU usage for the java process seems fine but there is a big iowait  
which stopped when I stopped james.

> Furthermore feel free to open a JIRA issue so we can keep track of  
> this bug while we try to solve it.
>
OK

> Stefano
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: server-user-unsubscribe@james.apache.org
> For additional commands, e-mail: server-user-help@james.apache.org
>
>


---------------------------------------------------------------------
To unsubscribe, e-mail: server-user-unsubscribe@james.apache.org
For additional commands, e-mail: server-user-help@james.apache.org

[prev in list] [next in list] [prev in thread] [next in thread] 

Configure | About | News | Add a list | Sponsored by KoreLogic