A complaint from one of our users ... something to consider in terms of
effective logging. I have already replied to his mis-configuration issue.
I trimmed the stack trace, which he included it its entirety, but I have
left the phoenix log attached.
--- Noel
-----Original Message-----
From: boxed [mailto:[EMAIL PROTECTED]
Sent: Tuesday, August 26, 2003 17:30
To: [EMAIL PROTECTED]
Subject: Useful error messages
I installed the James server today and the first thing that happens
after I've edited the config.xml file and attempt to start the server is
that I am greeted with the following error message. I have attached the
config file for you to check out. This error message gives me no
meaningful information whatsoever, and it repeats it several times. This
looks like a basic flaw in usability to me.
Using PHOENIX_HOME: C:\Programming\system\james
Using PHOENIX_TMPDIR: C:\Programming\system\james\temp
Using JAVA_HOME: c:\programming\system\jdk
Phoenix 4.0.1
There was an uncaught exception:
---------------------------------------------------------
--- Message ---
Failed to start application james.
--- Stack Trace ---
org.apache.avalon.phoenix.interfaces.DeploymentException: Failed to
start application james.
at
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy(Default
Deployer.java:379)
[... and lots of equally useless stuff hiding the real problem ...]
---------------------------------------------------------
The log file may contain further details of error.
Please check the configuration files and restart Phoenix.
If the problem persists, contact the Avalon project. See
http://jakarta.apache.org/avalon for more information.
Shutting down Phoenix.
"the log file" is an interesting question also. Which file does it refer
to? james/log/pheonix.log? I have attached this file also. There are
however 51 more logfiles in james/apps/james/logs that I did not attach.
Anders Hovm�ller
INFO 2003-08-26 23:10:00.312 [Phoenix ] (): Logger started
WARN 2003-08-26 23:10:00.359 [Phoenix ] (): Phoenix was not started by the daemon
thus it will not be possible to restart the JVM via the Management interface.
INFO 2003-08-26 23:10:00.468 [Phoenix.] (): Installing Sar located at
file:/C:/Programming/system/james/apps/james.sar.
WARN 2003-08-26 23:10:00.578 [Phoenix.] (): The file SAR-INF/lib/mm.mysql.LICENCE
can not be extracted from the Sar "file:/C:/Programming/system/james/apps/james.sar"
into directory C:\Programming\system\james\apps\james\SAR-INF\lib\mm.mysql.LICENCE
because there is a file in the way.
WARN 2003-08-26 23:10:00.578 [Phoenix.] (): The file conf/sqlResources.xml can not
be extracted from the Sar "file:/C:/Programming/system/james/apps/james.sar" into
directory C:\Programming\system\james\apps\james\conf\sqlResources.xml because there
is a file in the way.
WARN 2003-08-26 23:10:00.578 [Phoenix.] (): The file SAR-INF/config.xml can not be
extracted from the Sar "file:/C:/Programming/system/james/apps/james.sar" into
directory C:\Programming\system\james\apps\james\SAR-INF\config.xml because there is a
file in the way.
WARN 2003-08-26 23:10:00.578 [Phoenix.] (): The file SAR-INF/assembly.xml can not
be extracted from the Sar "file:/C:/Programming/system/james/apps/james.sar" into
directory C:\Programming\system\james\apps\james\SAR-INF\assembly.xml because there is
a file in the way.
WARN 2003-08-26 23:10:00.578 [Phoenix.] (): The file SAR-INF/environment.xml can
not be extracted from the Sar "file:/C:/Programming/system/james/apps/james.sar" into
directory C:\Programming\system\james\apps\james\SAR-INF\environment.xml because there
is a file in the way.
INFO 2003-08-26 23:10:00.687 [Phoenix.] (): No policy specified in server.xml,
giving full permissions to ServerApplication.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that the name specified for
Blocks and BlockListeners are valid.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that the name specified for
Blocks and BlockListeners are unique.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that the specified
Dependencies are valid according to BlockInfo.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that the dependencies of
Blocks are valid with respect to other Blocks.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that there are no circular
dependencies between Blocks.
INFO 2003-08-26 23:10:01.000 [Phoenix.] (): Verifying that the specified Blocks
have valid types.
INFO 2003-08-26 23:10:01.046 [Phoenix.] (): Verifying that the specified
BlockListeners have valid types.
INFO 2003-08-26 23:10:01.140 [Phoenix.] (): 17 Blocks to process for phase
"startup". Order of processing = [dnsserver, objectstorage, database-connections,
mailstore, users-store, thread-manager, connections, sockets, scheduler, James,
spoolmanager, remotemanager, pop3server, smtpserver, nntp-repository, nntpserver,
fetchpop].
ERROR 2003-08-26 23:10:01.593 [Phoenix.] (): Component named "mailstore" failed to
pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).
ERROR 2003-08-26 23:10:01.593 [Phoenix.] (): There was an error running phase
"startup" for Block named "mailstore". (Reason: Component named "mailstore" failed to
pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).).
org.apache.excalibur.containerkit.lifecycle.LifecycleException: Component named
"mailstore" failed to pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.fail(LifecycleHelper.java:289)
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.startup(LifecycleHelper.java:159)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.startup(DefaultApplication.java:480)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.doRunPhase(DefaultApplication.java:428)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.runPhase(DefaultApplication.java:364)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.start(DefaultApplication.java:138)
at
org.apache.avalon.framework.container.ContainerUtil.start(ContainerUtil.java:251)
rethrown from
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository
at org.apache.james.core.AvalonMailStore.select(AvalonMailStore.java:369)
at org.apache.james.core.AvalonMailStore.initialize(AvalonMailStore.java:179)
at
org.apache.avalon.framework.container.ContainerUtil.initialize(ContainerUtil.java:235)
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.startup(LifecycleHelper.java:144)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.startup(DefaultApplication.java:480)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.doRunPhase(DefaultApplication.java:428)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.runPhase(DefaultApplication.java:364)
rethrown from
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository: Unable to form canonical representation of
C:\Programming\system\james\apps\james\c:\Programming\system\james\mail\spool
at
org.apache.avalon.cornerstone.blocks.masterstore.RepositoryManager.select(RepositoryManager.java:205)
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.components.application.BlockInvocationHandler.invoke(BlockInvocationHandler.java:92)
at $Proxy1.select(Unknown Source)
rethrown from
org.apache.avalon.framework.configuration.ConfigurationException: Unable to form
canonical representation of
C:\Programming\system\james\apps\james\c:\Programming\system\james\mail\spool
at
org.apache.james.mailrepository.filepair.AbstractFileRepository.setDestination(AbstractFileRepository.java:223)
at
org.apache.james.mailrepository.filepair.AbstractFileRepository.configure(AbstractFileRepository.java:140)
at
org.apache.avalon.cornerstone.blocks.masterstore.RepositoryManager.select(RepositoryManager.java:186)
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)
INFO 2003-08-26 23:10:01.609 [Phoenix.] (): exception while starting:Component
named "mailstore" failed to pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).
WARN 2003-08-26 23:10:01.812 [Phoenix.] (): Failed to start application james.
org.apache.avalon.framework.CascadingException: Failed to start application james.
at
org.apache.avalon.phoenix.components.kernel.DefaultKernel.startup(DefaultKernel.java:195)
at
org.apache.avalon.phoenix.components.kernel.DefaultKernel.addApplication(DefaultKernel.java:254)
at
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy(DefaultDeployer.java:353)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile(DefaultEmbeddor.java:498)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile(DefaultEmbeddor.java:491)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFiles(DefaultEmbeddor.java:476)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployDefaultApplications(DefaultEmbeddor.java:466)
rethrown from
org.apache.avalon.phoenix.interfaces.ApplicationException: Component named "mailstore"
failed to pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).
at
org.apache.avalon.phoenix.components.application.DefaultApplication.start(DefaultApplication.java:144)
at
org.apache.avalon.framework.container.ContainerUtil.start(ContainerUtil.java:251)
at
org.apache.avalon.phoenix.components.kernel.DefaultKernel.startup(DefaultKernel.java:178)
at
org.apache.avalon.phoenix.components.kernel.DefaultKernel.addApplication(DefaultKernel.java:254)
at
org.apache.avalon.phoenix.components.deployer.DefaultDeployer.deploy(DefaultDeployer.java:353)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile(DefaultEmbeddor.java:498)
at
org.apache.avalon.phoenix.components.embeddor.DefaultEmbeddor.deployFile(DefaultEmbeddor.java:491)
rethrown from
org.apache.excalibur.containerkit.lifecycle.LifecycleException: Component named
"mailstore" failed to pass through the Initialization stage. (Reason:
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository).
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.fail(LifecycleHelper.java:289)
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.startup(LifecycleHelper.java:159)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.startup(DefaultApplication.java:480)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.doRunPhase(DefaultApplication.java:428)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.runPhase(DefaultApplication.java:364)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.start(DefaultApplication.java:138)
at
org.apache.avalon.framework.container.ContainerUtil.start(ContainerUtil.java:251)
rethrown from
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository
at org.apache.james.core.AvalonMailStore.select(AvalonMailStore.java:369)
at org.apache.james.core.AvalonMailStore.initialize(AvalonMailStore.java:179)
at
org.apache.avalon.framework.container.ContainerUtil.initialize(ContainerUtil.java:235)
at
org.apache.excalibur.containerkit.lifecycle.LifecycleHelper.startup(LifecycleHelper.java:144)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.startup(DefaultApplication.java:480)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.doRunPhase(DefaultApplication.java:428)
at
org.apache.avalon.phoenix.components.application.DefaultApplication.runPhase(DefaultApplication.java:364)
rethrown from
org.apache.avalon.framework.component.ComponentException: Cannot find or init
repository: Unable to form canonical representation of
C:\Programming\system\james\apps\james\c:\Programming\system\james\mail\spool
at
org.apache.avalon.cornerstone.blocks.masterstore.RepositoryManager.select(RepositoryManager.java:205)
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.components.application.BlockInvocationHandler.invoke(BlockInvocationHandler.java:92)
at $Proxy1.select(Unknown Source)
rethrown from
org.apache.avalon.framework.configuration.ConfigurationException: Unable to form
canonical representation of
C:\Programming\system\james\apps\james\c:\Programming\system\james\mail\spool
at
org.apache.james.mailrepository.filepair.AbstractFileRepository.setDestination(AbstractFileRepository.java:223)
at
org.apache.james.mailrepository.filepair.AbstractFileRepository.configure(AbstractFileRepository.java:140)
at
org.apache.avalon.cornerstone.blocks.masterstore.RepositoryManager.select(RepositoryManager.java:186)
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)
WARN 2003-08-26 23:10:01.828 [Phoenix.] (): Error deleting Work Directory
"C:\Programming\system\james\work\james-1061932200468". (Reason: File
C:\Programming\system\james\work\james-1061932200468\SAR-INF\lib\mm.mysql-2.0.14.jar
unable to be deleted.)
java.io.IOException: File
C:\Programming\system\james\work\james-1061932200468\SAR-INF\lib\mm.mysql-2.0.14.jar
unable to be deleted.
at org.apache.avalon.excalibur.io.FileUtil.forceDelete(FileUtil.java:638)
at org.apache.avalon.excalibur.io.FileUtil.cleanDirectory(FileUtil.java:806)
at org.apache.avalon.excalibur.io.FileUtil.deleteDirectory(FileUtil.java:762)
at org.apache.avalon.excalibur.io.FileUtil.forceDelete(FileUtil.java:630)
at org.apache.avalon.excalibur.io.FileUtil.cleanDirectory(FileUtil.java:806)
at org.apache.avalon.excalibur.io.FileUtil.deleteDirectory(FileUtil.java:762)
at org.apache.avalon.excalibur.io.FileUtil.forceDelete(FileUtil.java:630)
WARN 2003-08-26 23:10:01.843 [Phoenix.] (): Failed to stop application james as it
is not initialized/started.
---------------------------------------------------------------------
To unsubscribe, e-mail: [EMAIL PROTECTED]
For additional commands, e-mail: [EMAIL PROTECTED]
