You are viewing a plain text version of this content. The canonical link for it is here.
Posted to server-user@james.apache.org by "Dion, Kevin" <kd...@harris.com> on 2012/03/15 16:16:00 UTC

James quits shortly after startup for unknown reason

I am having an issue with the beta4 snapshot build of james, specifically apache-james-3.0-beta4-20120302.131953-590. It starts up, and then quits without throwing an exception. I turned up logging on everything in the log4j.properties, and I saw some early Spring errors along the lines of:

DEBUG 08:54:55,482 | org.springframework.beans.factory.xml.ResourceEntityResolver | Could not resolve XML entity [classpath:org/springframework/beans/factory/xml/spring-beans-3.0.xsd] against system root URL
java.net.MalformedURLException: unknown protocol: classpath
...stack trace...

But it appears to continue from there for a while (I get several of the MalformedURLExceptions), then end for no apparent reason later. I have included below the last several dozen lines of the log file.

Any assistance would be appreciated

Thanks,
Kevin

Here is the last bit of the james-server.log (can add more if necessary):

DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'datasource'
DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'vendorAdapter'
DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'vendorAdapter'
DEBUG 08:54:57,576 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'vendorAdapter' to allow for resolving potential circular references
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
DEBUG 08:54:57,592 | org.springframework.beans.BeanUtils | No property editor [org.springframework.orm.jpa.vendor.DatabaseEditor] found for type org.springframework.orm.jpa.vendor.Database according to 'Editor' suffix convention
DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'vendorAdapter'
DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Invoking afterPropertiesSet() on bean with name 'entityManagerFactory'
INFO  08:54:57,607 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Building JPA container EntityManagerFactory for persistence unit 'James'
DEBUG 08:54:58,092 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'entityManagerFactory'
INFO  08:54:58,092 | james.domainlist | Set autodetect to: true
INFO  08:54:58,092 | james.domainlist | Set autodetectIP to: true
DEBUG 08:54:58,092 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'domainlist': public void org.apache.james.domainlist.jpa.JPADomainList.init()
INFO  08:54:58,529 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15780d9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostprocessor.FileSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'entityManagerFactory'
INFO  08:54:58,545 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Closing JPA EntityManagerFactory for persistence unit 'James'
DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy method 'close' on bean with name 'datasource'
DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
INFO  08:54:58,545 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49713-1331823297045-0:1) is shutting down
INFO  08:54:59,326 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
INFO  08:54:59,326 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
DEBUG 08:54:59,342 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
INFO  08:54:59,357 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49713-1331823297045-0:1) stopped
DEBUG 08:54:59,357 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#22d166': [(inner bean)]
DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
INFO  08:54:59,357 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
INFO  08:54:59,357 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@6399ae with name: ShutdownTask. -> java.util.concurrent.Executors$FinalizableDelegatedExecutorService@fe9ad1
DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
INFO  08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds

Re: James quits shortly after startup for unknown reason

Posted by Ioan Eugen Stan <st...@gmail.com>.
Hello Kevin,

I've tried installing james with MySQL and it seems to not pick up the
jar from the class path. I was seeing the same kind of output when I
enabled debugging. Maybe the issues are related.

What does bin/wrapper.log say?

Cheers,

2012/3/16 Dion, Kevin <kd...@harris.com>:
> Charles,
>
> I don't believe the spring errors shown in the log are affecting the run, because when I turn up logging on a previous installation that runs fine, I see those same exceptions. Also, I am running on a windows machine, but have sufficient permissions to open ports below 1024 (again, a previous 3.0-beta2 installation runs fine)
>
> With regards to your recommendation to run a beta5 snapshot - I have installed the latest snapshot build and have gotten it to run a bit longer before dying by fixing some configuration settings - but it still dies after a second or two. Below is the last bit of the log, it seems to start dying when calling init on bean 'mailprocessor' - the init() throws an exception (not shown) then everything starts shutting down. Relevant line:
>
> DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception
>
> I've checked my <processor> elements in mailetcontainer.conf, but I don't have anything crazy in there, pretty much exactly the same things as in a working (beta2) configuration, with mostly default configurations as well. If necessary I can include that configuration.
>
> Thanks,
> Kevin
>
> End of james-server.log :
>
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'usersrepository'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'mailetcontext': ResourceElement for public void org.apache.james.mailetcontainer.impl.JamesMailetContext.setDomainList(org.apache.james.domainlist.api.DomainList)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'domainlist'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'domainlist'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Found injected element on class [org.apache.james.domainlist.xml.XMLDomainList]: ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'domainlist' to allow for resolving potential circular references
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'domainlist': ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Returning cached instance of singleton bean 'dnsservice'
> INFO  08:31:53,600 | james.domainlist | Set autodetect to: true
> INFO  08:31:53,600 | james.domainlist | Set autodetectIP to: true
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'domainlist'
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'mailetcontext'
> DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailprocessor': [mailetcontext]
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailetcontext': [mailprocessor]
> INFO  08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4693f9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostprocessor.FileSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
> DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
> DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
> DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
> DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
> INFO  08:31:53,631 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49811-1331908313131-0:1) is shutting down
> INFO  08:31:55,397 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
> INFO  08:31:55,397 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
> DEBUG 08:31:55,413 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
> INFO  08:31:55,428 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49811-1331908313131-0:1) stopped
> DEBUG 08:31:55,428 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#1cb7a1': [(inner bean)]
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
> INFO  08:31:55,428 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
> INFO  08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
> DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@935741 with name: ShutdownTask. -> java.util.concurrent.Executors$FinalizableDelegatedExecutorService@1458657
> DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>
> -----Original Message-----
> From: Eric Charles [mailto:eric@apache.org]
> Sent: Friday, March 16, 2012 5:08 AM
> To: James Users List
> Subject: Re: James quits shortly after startup for unknown reason
>
> Hi,
>
> We defined the xsd url being classpath:... to avoid failure on startup
> if firewall block access to the Internet. But it seems tuning the log
> levels to DEBUG gives an exception... if this is the case, we need to
> tackle this with low priority, as it still starts?
>
> As you said, it continues to start, and after it fails/shutdowns...
> really no exception or error/warn messages to see in the log? Do you run
> with root privileges to start sockets below 1024?
>
> There may be problems with snapshots begin of March, any chance you give
> a try with a recent one from
> https://repository.apache.org/content/repositories/snapshots/org/apache/james/apache-james/3.0-beta5-SNAPSHOT/
> ?
>
> Thx, Eric
>
> On 15/03/12 16:16, Dion, Kevin wrote:
>> I am having an issue with the beta4 snapshot build of james, specifically apache-james-3.0-beta4-20120302.131953-590. It starts up, and then quits without throwing an exception. I turned up logging on everything in the log4j.properties, and I saw some early Spring errors along the lines of:
>>
>> DEBUG 08:54:55,482 | org.springframework.beans.factory.xml.ResourceEntityResolver | Could not resolve XML entity [classpath:org/springframework/beans/factory/xml/spring-beans-3.0.xsd] against system root URL
>> java.net.MalformedURLException: unknown protocol: classpath
>> ...stack trace...
>>
>> But it appears to continue from there for a while (I get several of the MalformedURLExceptions), then end for no apparent reason later. I have included below the last several dozen lines of the log file.
>>
>> Any assistance would be appreciated
>>
>> Thanks,
>> Kevin
>>
>> Here is the last bit of the james-server.log (can add more if necessary):
>>
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'datasource'
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'vendorAdapter'
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'vendorAdapter'
>> DEBUG 08:54:57,576 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'vendorAdapter' to allow for resolving potential circular references
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,592 | org.springframework.beans.BeanUtils | No property editor [org.springframework.orm.jpa.vendor.DatabaseEditor] found for type org.springframework.orm.jpa.vendor.Database according to 'Editor' suffix convention
>> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'vendorAdapter'
>> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Invoking afterPropertiesSet() on bean with name 'entityManagerFactory'
>> INFO  08:54:57,607 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Building JPA container EntityManagerFactory for persistence unit 'James'
>> DEBUG 08:54:58,092 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'entityManagerFactory'
>> INFO  08:54:58,092 | james.domainlist | Set autodetect to: true
>> INFO  08:54:58,092 | james.domainlist | Set autodetectIP to: true
>> DEBUG 08:54:58,092 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'domainlist': public void org.apache.james.domainlist.jpa.JPADomainList.init()
>> INFO  08:54:58,529 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15780d9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostpro
>  cessor.F
>  i
> leSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer
>  ,org.spr
>  i
> ngframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'entityManagerFactory'
>> INFO  08:54:58,545 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Closing JPA EntityManagerFactory for persistence unit 'James'
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy method 'close' on bean with name 'datasource'
>> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
>> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
>> INFO  08:54:58,545 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49713-1331823297045-0:1) is shutting down
>> INFO  08:54:59,326 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
>> INFO  08:54:59,326 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
>> DEBUG 08:54:59,342 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
>> INFO  08:54:59,357 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49713-1331823297045-0:1) stopped
>> DEBUG 08:54:59,357 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#22d166': [(inner bean)]
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
>> INFO  08:54:59,357 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
>> INFO  08:54:59,357 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
>> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@6399ae with name: ShutdownTask. ->  java.util.concurrent.Executors$FinalizableDelegatedExecutorService@fe9ad1
>> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>>
>
> --
> eric | http://about.echarles.net | @echarles
>
> ---------------------------------------------------------------------
> 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
>



-- 
Ioan Eugen Stan
http://ieugen.blogspot.com/  *** http://bucharest-jug.github.com/ ***

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


Re: James quits shortly after startup for unknown reason

Posted by Ioan Eugen Stan <st...@gmail.com>.
Hello Gufiya,

It should be fixed in 3.0-beta5 (unreleased). To fix bet4 change
wrapper.conf and add conf/lib to the classpath (or use run.sh to start
james which builds the classpath ok).

https://issues.apache.org/jira/browse/JAMESAPP-8

Cheers,

2012/6/26 gufiya <gu...@gmail.com>:
>
> I have the same problem here.
> Here is a flow to reproduce it:
> 1. Download James3-beta4
> 2. Update "james-database.properties" to use MySQL
> 3. Put "mysql-connector-java-5.1.18-bin.jar" in conf/lib dir
> 4. Install service with "james install" script
> 5. Run James with "james start" script
> 5. Same problem happens:
>  5a. James start and stops after 2 seconds
>  5b. nothing relevant appears in logfile (only if you turn on debug mode,
> as people here mentioned).
> 6. My machine:
>  6a. Windows 7 with all updates
>  6b. JDK6 update 30
>  6c. JAVA_HOME, JDK\bin PATH and admin privileges were all set
>
> Can you please check it out?
> This version is simply useless for me if I want to use MySQL.
>
> --
> View this message in context: http://old.nabble.com/James-quits-shortly-after-startup-for-unknown-reason-tp33510703p34070895.html
> Sent from the James - Users mailing list archive at Nabble.com.
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: server-user-unsubscribe@james.apache.org
> For additional commands, e-mail: server-user-help@james.apache.org
>



-- 
Ioan Eugen Stan / CTO / http://axemblr.com

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


Re: James quits shortly after startup for unknown reason

Posted by gufiya <gu...@gmail.com>.
I have the same problem here.
Here is a flow to reproduce it:
1. Download James3-beta4
2. Update "james-database.properties" to use MySQL
3. Put "mysql-connector-java-5.1.18-bin.jar" in conf/lib dir
4. Install service with "james install" script
5. Run James with "james start" script
5. Same problem happens:
  5a. James start and stops after 2 seconds
  5b. nothing relevant appears in logfile (only if you turn on debug mode,
as people here mentioned).
6. My machine:
  6a. Windows 7 with all updates
  6b. JDK6 update 30
  6c. JAVA_HOME, JDK\bin PATH and admin privileges were all set 

Can you please check it out?
This version is simply useless for me if I want to use MySQL.

-- 
View this message in context: http://old.nabble.com/James-quits-shortly-after-startup-for-unknown-reason-tp33510703p34070895.html
Sent from the James - Users mailing list archive at Nabble.com.


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


Re: James quits shortly after startup for unknown reason

Posted by Eric Charles <er...@apache.org>.
Maybe we have new requirements regarding JDK versions between beta2 and 
beta3?

Can you type 'java -version' and send us the result?
(If you are running an 'old' JDK, can you retry with the last version?)

Thx, Eric

On 16/03/12 15:45, Dion, Kevin wrote:
> Charles,
>
> I don't believe the spring errors shown in the log are affecting the run, because when I turn up logging on a previous installation that runs fine, I see those same exceptions. Also, I am running on a windows machine, but have sufficient permissions to open ports below 1024 (again, a previous 3.0-beta2 installation runs fine)
>
> With regards to your recommendation to run a beta5 snapshot - I have installed the latest snapshot build and have gotten it to run a bit longer before dying by fixing some configuration settings - but it still dies after a second or two. Below is the last bit of the log, it seems to start dying when calling init on bean 'mailprocessor' - the init() throws an exception (not shown) then everything starts shutting down. Relevant line:
>
> DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception
>
> I've checked my<processor>  elements in mailetcontainer.conf, but I don't have anything crazy in there, pretty much exactly the same things as in a working (beta2) configuration, with mostly default configurations as well. If necessary I can include that configuration.
>
> Thanks,
> Kevin
>
> End of james-server.log :
>
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'usersrepository'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'mailetcontext': ResourceElement for public void org.apache.james.mailetcontainer.impl.JamesMailetContext.setDomainList(org.apache.james.domainlist.api.DomainList)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'domainlist'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'domainlist'
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Found injected element on class [org.apache.james.domainlist.xml.XMLDomainList]: ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'domainlist' to allow for resolving potential circular references
> DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'domainlist': ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Returning cached instance of singleton bean 'dnsservice'
> INFO  08:31:53,600 | james.domainlist | Set autodetect to: true
> INFO  08:31:53,600 | james.domainlist | Set autodetectIP to: true
> DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'domainlist'
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'mailetcontext'
> DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailprocessor': [mailetcontext]
> DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailetcontext': [mailprocessor]
> INFO  08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4693f9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostprocessor.Fi
 l
eSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer,org.spri
 n
gframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
> DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
> DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
> DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
> DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
> INFO  08:31:53,631 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49811-1331908313131-0:1) is shutting down
> INFO  08:31:55,397 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
> INFO  08:31:55,397 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
> DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
> DEBUG 08:31:55,413 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
> INFO  08:31:55,428 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49811-1331908313131-0:1) stopped
> DEBUG 08:31:55,428 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#1cb7a1': [(inner bean)]
> DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
> INFO  08:31:55,428 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
> INFO  08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
> DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@935741 with name: ShutdownTask. ->  java.util.concurrent.Executors$FinalizableDelegatedExecutorService@1458657
> DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
> INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>
> -----Original Message-----
> From: Eric Charles [mailto:eric@apache.org]
> Sent: Friday, March 16, 2012 5:08 AM
> To: James Users List
> Subject: Re: James quits shortly after startup for unknown reason
>
> Hi,
>
> We defined the xsd url being classpath:... to avoid failure on startup
> if firewall block access to the Internet. But it seems tuning the log
> levels to DEBUG gives an exception... if this is the case, we need to
> tackle this with low priority, as it still starts?
>
> As you said, it continues to start, and after it fails/shutdowns...
> really no exception or error/warn messages to see in the log? Do you run
> with root privileges to start sockets below 1024?
>
> There may be problems with snapshots begin of March, any chance you give
> a try with a recent one from
> https://repository.apache.org/content/repositories/snapshots/org/apache/james/apache-james/3.0-beta5-SNAPSHOT/
> ?
>
> Thx, Eric
>
> On 15/03/12 16:16, Dion, Kevin wrote:
>> I am having an issue with the beta4 snapshot build of james, specifically apache-james-3.0-beta4-20120302.131953-590. It starts up, and then quits without throwing an exception. I turned up logging on everything in the log4j.properties, and I saw some early Spring errors along the lines of:
>>
>> DEBUG 08:54:55,482 | org.springframework.beans.factory.xml.ResourceEntityResolver | Could not resolve XML entity [classpath:org/springframework/beans/factory/xml/spring-beans-3.0.xsd] against system root URL
>> java.net.MalformedURLException: unknown protocol: classpath
>> ...stack trace...
>>
>> But it appears to continue from there for a while (I get several of the MalformedURLExceptions), then end for no apparent reason later. I have included below the last several dozen lines of the log file.
>>
>> Any assistance would be appreciated
>>
>> Thanks,
>> Kevin
>>
>> Here is the last bit of the james-server.log (can add more if necessary):
>>
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'datasource'
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'vendorAdapter'
>> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'vendorAdapter'
>> DEBUG 08:54:57,576 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'vendorAdapter' to allow for resolving potential circular references
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
>> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
>> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
>> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
>> DEBUG 08:54:57,592 | org.springframework.beans.BeanUtils | No property editor [org.springframework.orm.jpa.vendor.DatabaseEditor] found for type org.springframework.orm.jpa.vendor.Database according to 'Editor' suffix convention
>> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'vendorAdapter'
>> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Invoking afterPropertiesSet() on bean with name 'entityManagerFactory'
>> INFO  08:54:57,607 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Building JPA container EntityManagerFactory for persistence unit 'James'
>> DEBUG 08:54:58,092 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'entityManagerFactory'
>> INFO  08:54:58,092 | james.domainlist | Set autodetect to: true
>> INFO  08:54:58,092 | james.domainlist | Set autodetectIP to: true
>> DEBUG 08:54:58,092 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'domainlist': public void org.apache.james.domainlist.jpa.JPADomainList.init()
>> INFO  08:54:58,529 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15780d9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostpro
>   cessor.F
>   i
> leSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer
>   ,org.spr
>   i
> ngframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'entityManagerFactory'
>> INFO  08:54:58,545 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Closing JPA EntityManagerFactory for persistence unit 'James'
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy method 'close' on bean with name 'datasource'
>> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
>> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
>> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
>> INFO  08:54:58,545 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49713-1331823297045-0:1) is shutting down
>> INFO  08:54:59,326 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
>> INFO  08:54:59,326 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
>> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
>> DEBUG 08:54:59,342 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
>> INFO  08:54:59,357 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49713-1331823297045-0:1) stopped
>> DEBUG 08:54:59,357 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#22d166': [(inner bean)]
>> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
>> INFO  08:54:59,357 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
>> INFO  08:54:59,357 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
>> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@6399ae with name: ShutdownTask. ->   java.util.concurrent.Executors$FinalizableDelegatedExecutorService@fe9ad1
>> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
>> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>>
>

-- 
eric | http://about.echarles.net | @echarles

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


RE: James quits shortly after startup for unknown reason

Posted by "Dion, Kevin" <kd...@harris.com>.
Charles,

I don't believe the spring errors shown in the log are affecting the run, because when I turn up logging on a previous installation that runs fine, I see those same exceptions. Also, I am running on a windows machine, but have sufficient permissions to open ports below 1024 (again, a previous 3.0-beta2 installation runs fine)

With regards to your recommendation to run a beta5 snapshot - I have installed the latest snapshot build and have gotten it to run a bit longer before dying by fixing some configuration settings - but it still dies after a second or two. Below is the last bit of the log, it seems to start dying when calling init on bean 'mailprocessor' - the init() throws an exception (not shown) then everything starts shutting down. Relevant line:

DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception

I've checked my <processor> elements in mailetcontainer.conf, but I don't have anything crazy in there, pretty much exactly the same things as in a working (beta2) configuration, with mostly default configurations as well. If necessary I can include that configuration.

Thanks,
Kevin

End of james-server.log :

DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'usersrepository'
DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'mailetcontext': ResourceElement for public void org.apache.james.mailetcontainer.impl.JamesMailetContext.setDomainList(org.apache.james.domainlist.api.DomainList)
DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'domainlist'
DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'domainlist'
DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Found injected element on class [org.apache.james.domainlist.xml.XMLDomainList]: ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'domainlist' to allow for resolving potential circular references
DEBUG 08:31:53,600 | org.springframework.beans.factory.annotation.InjectionMetadata | Processing injected method of bean 'domainlist': ResourceElement for public void org.apache.james.domainlist.lib.AbstractDomainList.setDNSService(org.apache.james.dnsservice.api.DNSService)
DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Returning cached instance of singleton bean 'dnsservice'
INFO  08:31:53,600 | james.domainlist | Set autodetect to: true
INFO  08:31:53,600 | james.domainlist | Set autodetectIP to: true
DEBUG 08:31:53,600 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'domainlist'
DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'mailetcontext'
DEBUG 08:31:53,616 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'mailprocessor': public void org.apache.james.mailetcontainer.lib.AbstractStateCompositeProcessor.init() throws java.lang.Exception
DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailprocessor': [mailetcontext]
DEBUG 08:31:53,616 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'mailetcontext': [mailprocessor]
INFO  08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4693f9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostprocessor.FileSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
DEBUG 08:31:53,631 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
DEBUG 08:31:53,631 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
INFO  08:31:53,631 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49811-1331908313131-0:1) is shutting down
INFO  08:31:55,397 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
INFO  08:31:55,397 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
DEBUG 08:31:55,397 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
DEBUG 08:31:55,413 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
INFO  08:31:55,428 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49811-1331908313131-0:1) stopped
DEBUG 08:31:55,428 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#1cb7a1': [(inner bean)]
DEBUG 08:31:55,428 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
INFO  08:31:55,428 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
INFO  08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@935741 with name: ShutdownTask. -> java.util.concurrent.Executors$FinalizableDelegatedExecutorService@1458657
DEBUG 08:31:55,428 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
INFO  08:31:55,444 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
INFO  08:31:55,444 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds

-----Original Message-----
From: Eric Charles [mailto:eric@apache.org] 
Sent: Friday, March 16, 2012 5:08 AM
To: James Users List
Subject: Re: James quits shortly after startup for unknown reason

Hi,

We defined the xsd url being classpath:... to avoid failure on startup 
if firewall block access to the Internet. But it seems tuning the log 
levels to DEBUG gives an exception... if this is the case, we need to 
tackle this with low priority, as it still starts?

As you said, it continues to start, and after it fails/shutdowns... 
really no exception or error/warn messages to see in the log? Do you run 
with root privileges to start sockets below 1024?

There may be problems with snapshots begin of March, any chance you give 
a try with a recent one from 
https://repository.apache.org/content/repositories/snapshots/org/apache/james/apache-james/3.0-beta5-SNAPSHOT/ 
?

Thx, Eric

On 15/03/12 16:16, Dion, Kevin wrote:
> I am having an issue with the beta4 snapshot build of james, specifically apache-james-3.0-beta4-20120302.131953-590. It starts up, and then quits without throwing an exception. I turned up logging on everything in the log4j.properties, and I saw some early Spring errors along the lines of:
>
> DEBUG 08:54:55,482 | org.springframework.beans.factory.xml.ResourceEntityResolver | Could not resolve XML entity [classpath:org/springframework/beans/factory/xml/spring-beans-3.0.xsd] against system root URL
> java.net.MalformedURLException: unknown protocol: classpath
> ...stack trace...
>
> But it appears to continue from there for a while (I get several of the MalformedURLExceptions), then end for no apparent reason later. I have included below the last several dozen lines of the log file.
>
> Any assistance would be appreciated
>
> Thanks,
> Kevin
>
> Here is the last bit of the james-server.log (can add more if necessary):
>
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'datasource'
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'vendorAdapter'
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'vendorAdapter'
> DEBUG 08:54:57,576 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'vendorAdapter' to allow for resolving potential circular references
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,592 | org.springframework.beans.BeanUtils | No property editor [org.springframework.orm.jpa.vendor.DatabaseEditor] found for type org.springframework.orm.jpa.vendor.Database according to 'Editor' suffix convention
> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'vendorAdapter'
> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Invoking afterPropertiesSet() on bean with name 'entityManagerFactory'
> INFO  08:54:57,607 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Building JPA container EntityManagerFactory for persistence unit 'James'
> DEBUG 08:54:58,092 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'entityManagerFactory'
> INFO  08:54:58,092 | james.domainlist | Set autodetect to: true
> INFO  08:54:58,092 | james.domainlist | Set autodetectIP to: true
> DEBUG 08:54:58,092 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'domainlist': public void org.apache.james.domainlist.jpa.JPADomainList.init()
> INFO  08:54:58,529 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15780d9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostpro
 cessor.F
 i
leSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer
 ,org.spr
 i
ngframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'entityManagerFactory'
> INFO  08:54:58,545 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Closing JPA EntityManagerFactory for persistence unit 'James'
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy method 'close' on bean with name 'datasource'
> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
> INFO  08:54:58,545 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49713-1331823297045-0:1) is shutting down
> INFO  08:54:59,326 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
> INFO  08:54:59,326 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
> DEBUG 08:54:59,342 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
> INFO  08:54:59,357 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49713-1331823297045-0:1) stopped
> DEBUG 08:54:59,357 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#22d166': [(inner bean)]
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
> INFO  08:54:59,357 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
> INFO  08:54:59,357 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@6399ae with name: ShutdownTask. ->  java.util.concurrent.Executors$FinalizableDelegatedExecutorService@fe9ad1
> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>

-- 
eric | http://about.echarles.net | @echarles

---------------------------------------------------------------------
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


Re: James quits shortly after startup for unknown reason

Posted by Eric Charles <er...@apache.org>.
Hi,

We defined the xsd url being classpath:... to avoid failure on startup 
if firewall block access to the Internet. But it seems tuning the log 
levels to DEBUG gives an exception... if this is the case, we need to 
tackle this with low priority, as it still starts?

As you said, it continues to start, and after it fails/shutdowns... 
really no exception or error/warn messages to see in the log? Do you run 
with root privileges to start sockets below 1024?

There may be problems with snapshots begin of March, any chance you give 
a try with a recent one from 
https://repository.apache.org/content/repositories/snapshots/org/apache/james/apache-james/3.0-beta5-SNAPSHOT/ 
?

Thx, Eric

On 15/03/12 16:16, Dion, Kevin wrote:
> I am having an issue with the beta4 snapshot build of james, specifically apache-james-3.0-beta4-20120302.131953-590. It starts up, and then quits without throwing an exception. I turned up logging on everything in the log4j.properties, and I saw some early Spring errors along the lines of:
>
> DEBUG 08:54:55,482 | org.springframework.beans.factory.xml.ResourceEntityResolver | Could not resolve XML entity [classpath:org/springframework/beans/factory/xml/spring-beans-3.0.xsd] against system root URL
> java.net.MalformedURLException: unknown protocol: classpath
> ...stack trace...
>
> But it appears to continue from there for a while (I get several of the MalformedURLExceptions), then end for no apparent reason later. I have included below the last several dozen lines of the log file.
>
> Any assistance would be appreciated
>
> Thanks,
> Kevin
>
> Here is the last bit of the james-server.log (can add more if necessary):
>
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'datasource'
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating shared instance of singleton bean 'vendorAdapter'
> DEBUG 08:54:57,560 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Creating instance of bean 'vendorAdapter'
> DEBUG 08:54:57,576 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Eagerly caching bean 'vendorAdapter' to allow for resolving potential circular references
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Initializing new StandardEnvironment
> DEBUG 08:54:57,576 | org.springframework.core.env.StandardEnvironment | Adding [systemProperties] PropertySource with lowest search precedence
> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Adding [systemEnvironment] PropertySource with lowest search precedence
> DEBUG 08:54:57,592 | org.springframework.core.env.StandardEnvironment | Initialized StandardEnvironment with PropertySources [systemProperties,systemEnvironment]
> DEBUG 08:54:57,592 | org.springframework.beans.BeanUtils | No property editor [org.springframework.orm.jpa.vendor.DatabaseEditor] found for type org.springframework.orm.jpa.vendor.Database according to 'Editor' suffix convention
> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'vendorAdapter'
> DEBUG 08:54:57,592 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Invoking afterPropertiesSet() on bean with name 'entityManagerFactory'
> INFO  08:54:57,607 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Building JPA container EntityManagerFactory for persistence unit 'James'
> DEBUG 08:54:58,092 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Finished creating instance of bean 'entityManagerFactory'
> INFO  08:54:58,092 | james.domainlist | Set autodetect to: true
> INFO  08:54:58,092 | james.domainlist | Set autodetectIP to: true
> DEBUG 08:54:58,092 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking init method on bean 'domainlist': public void org.apache.james.domainlist.jpa.JPADomainList.init()
> INFO  08:54:58,529 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15780d9: defining beans [org.springframework.context.annotation.CommonAnnotationBeanPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,org.apache.james.container.spring.lifecycle.LogEnabledBeanPostProcessor#0,logprovider,org.apache.james.container.spring.bean.factorypostprocessor.ConfigurationBeanFactoryPostProcessor#0,org.apache.james.container.spring.lifecycle.ConfigurableBeanPostProcessor#0,configurationprovider,mailrepositorystore,mailqueuefactory,broker,amqConnectionFactory,blobTransferPolicy,jmsConnectionFactory,jmsTransactionManager,mailprocessor,mailetcontext,mailspooler,mailetloader,matcherloader,agent,producerTemplate,consumerTemplate,jamesCamelContext:beanPostProcessor,jamesCamelContext,org.apache.james.container.spring.bean.factorypostprocessor.F
 i
leSystemBeanFactoryPostProcessor#0,filesystem,dnsservice,fetchmail,protocolhandlerloader,smtpserver,lmtpserver,pop3server,imapserver,imapProcessor,imapDecoder,imapDecoderFactory,imapEncoder,imapEncoderFactory,org.apache.james.container.spring.bean.factorypostprocessor.MailboxConfigurationBeanFactoryPostProcessor#0,locker,jvm-locker,authenticator,lazyIndex,luceneIndex,ramDirectory,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#1,jpa-mailboxmanager,jpa-subscriptionManager,jpa-sessionMapperFactory,jpa-uidProvider,jpa-modSeqProvider,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#0,datasource,entityManagerFactory,vendorAdapter,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#1,maildir-mailboxmanager,maildir-subscriptionManager,maildir-sessionMapperFactory,maildirStore,memory-mailboxmanager,memory-subscriptionManager,memory-sessionMapperFactory,mailboxcopier,aclResolver,groupMembershipResolver,james23importer,org.spr
 i
ngframework.beans.factory.config.PropertyPlaceholderConfigurer#2,org.springframework.beans.factory.config.PropertyPlaceholderConfigurer#3,mbeanserver,serverConnector,registry,restrictedRmiSocketFactory,exporter,usersrepositorymanagement,recipientrewritetablemanagement,domainlistmanagement,mailboxmanagermanagement,mailboxcopiermanagement,james23importermanagement,usersrepository,recipientrewritetable,domainlist,usersrepository23]; root of factory hierarchy
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'entityManagerFactory'
> INFO  08:54:58,545 | org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean | Closing JPA EntityManagerFactory for persistence unit 'James'
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy method 'close' on bean with name 'datasource'
> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'mailqueuefactory': public void org.apache.james.queue.library.AbstractMailQueueFactory.destroy()
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jmsConnectionFactory'
> DEBUG 08:54:58,545 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)#3': [amqConnectionFactory]
> DEBUG 08:54:58,545 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.xbean.XBeanBrokerService.destroy() throws java.lang.Exception
> INFO  08:54:58,545 | org.apache.activemq.broker.BrokerService | ActiveMQ Message Broker (james, ID:direct-49713-1331823297045-0:1) is shutting down
> INFO  08:54:59,326 | org.apache.activemq.broker.TransportConnector | Connector tcp://localhost:0 Stopped
> INFO  08:54:59,326 | org.apache.activemq.store.kahadb.plist.PListStore | PListStore:..\var\store\activemq\brokers\james\tmp_storage stopped
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Waitng for checkpoint to complete.
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint started.
> DEBUG 08:54:59,326 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Checkpoint done.
> DEBUG 08:54:59,342 | org.apache.activemq.store.amq.AMQPersistenceAdapter | Journal close
> INFO  08:54:59,357 | org.apache.activemq.broker.BrokerService | ActiveMQ JMS Message Broker (james, ID:direct-49713-1331823297045-0:1) stopped
> DEBUG 08:54:59,357 | org.springframework.context.annotation.CommonAnnotationBeanPostProcessor | Invoking destroy method on bean 'broker': public void org.apache.activemq.broker.BrokerService.stop() throws java.lang.Exception
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean '(inner bean)': [broker]
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DefaultListableBeanFactory | Retrieved dependent beans for bean 'amq:policyEntry#22d166': [(inner bean)]
> DEBUG 08:54:59,357 | org.springframework.beans.factory.support.DisposableBeanAdapter | Invoking destroy() on bean with name 'jamesCamelContext'
> INFO  08:54:59,357 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext:jamesCamelContext) is shutting down
> INFO  08:54:59,357 | org.apache.camel.impl.DefaultShutdownStrategy | Starting to graceful shutdown 0 routes (timeout 300 seconds)
> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultExecutorServiceStrategy | Created new single thread pool for source: org.apache.camel.impl.DefaultShutdownStrategy@6399ae with name: ShutdownTask. ->  java.util.concurrent.Executors$FinalizableDelegatedExecutorService@fe9ad1
> DEBUG 08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | There are 0 routes to shutdown
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultShutdownStrategy | Graceful shutdown of 0 routes completed in 0 seconds
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Uptime: not started
> INFO  08:54:59,373 | org.apache.camel.impl.DefaultCamelContext | Apache Camel 2.5.0 (CamelContext: jamesCamelContext) is shutdown in 0.016 seconds
>

-- 
eric | http://about.echarles.net | @echarles

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