lsalamon / nhin-d

Automatically exported from code.google.com/p/nhin-d
0 stars 0 forks source link

Unknown error occurred while processing DATA. While using James 3Beta 4(direct-project-stock-3.0.1.tar.gz) with default config #232

Open GoogleCodeExporter opened 9 years ago

GoogleCodeExporter commented 9 years ago
What steps will reproduce the problem?
1.I am getting error while running apache-james3beta4. I followed the steps to 
configure here 
"http://api.nhindirect.org/java/site/assembly/stock/3.0.1/users-guide/depl-hisp-
only.html#Major_Updates_in_Version_3.0" and installed on windows server 2008 
but i am getting this log while i send a test mail from 
"http://transport-testing.nist.gov/ttt/". please help me i attached the log 
below.
2.just i changed domain name in domain list
3.i changed postmaster address and mydomain.com to my domain name

What is the expected output? What do you see instead?
Need to receive mail but unable to do it.

Is their any config issues make me correct. And I would like to change the 
storage location to mysql.
But when i used james-2.3.2 then its working fine but here is no imap so i 
would like to keep apache-james3Beta4.

What version of the product are you using? On what operating system?

direct-project-stock-3.0.1.tar.gz on windows server 2008 64-bit

Please provide any additional information below.

STATUS | wrapper  | 2014/03/07 02:53:18 | Apache James Server App installed.
STATUS | wrapper  | 2014/03/07 02:53:24 | Starting the Apache James Server App 
service...
STATUS | wrapper  | 2014/03/07 02:53:24 | --> Wrapper Started as Service
STATUS | wrapper  | 2014/03/07 02:53:24 | Launching a JVM...
INFO   | jvm 1    | 2014/03/07 02:53:25 | Wrapper (Version 3.2.3) 
http://wrapper.tanukisoftware.org
INFO   | jvm 1    | 2014/03/07 02:53:25 |   Copyright 1999-2006 Tanuki 
Software, Inc.  All Rights Reserved.
INFO   | jvm 1    | 2014/03/07 02:53:25 |
INFO   | jvm 1    | 2014/03/07 02:53:25 |
INFO   | jvm 1    | 2014/03/07 02:53:25 | WARNING - Unable to load the 
Wrapper's native library because none of the
INFO   | jvm 1    | 2014/03/07 02:53:25 |           following files:
INFO   | jvm 1    | 2014/03/07 02:53:25 |             wrapper-windows-x86-64.dll
INFO   | jvm 1    | 2014/03/07 02:53:25 |             wrapper.dll
INFO   | jvm 1    | 2014/03/07 02:53:25 |           could be located on the 
following java.library.path:
INFO   | jvm 1    | 2014/03/07 02:53:25 |             C:\Program 
Files\direct\apache-james-3.0-beta4\bin\..\lib
INFO   | jvm 1    | 2014/03/07 02:53:25 |           Please see the 
documentation for the wrapper.java.library.path
INFO   | jvm 1    | 2014/03/07 02:53:25 |           configuration property.
INFO   | jvm 1    | 2014/03/07 02:53:25 |           System signals will not be 
handled correctly.
INFO   | jvm 1    | 2014/03/07 02:53:25 |
INFO   | jvm 1    | 2014/03/07 02:53:25 | INFO  02:53:25,833 | 
org.apache.james.container.spring.context.JamesServerApplicationContext | 
Refreshing 
org.apache.james.container.spring.context.JamesServerApplicationContext@40110c31
: startup date [Fri Mar 07 02:53:25 EST 2014]; root of context hierarchy
INFO   | jvm 1    | 2014/03/07 02:53:29 | log4j:WARN No appenders could be 
found for logger (org.apache.commons.configuration.ConfigurationUtils).
INFO   | jvm 1    | 2014/03/07 02:53:29 | log4j:WARN Please initialize the 
log4j system properly.
INFO   | jvm 1    | 2014/03/07 02:53:29 | log4j:WARN See 
http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
STATUS | wrapper  | 2014/03/07 02:53:29 | Apache James Server App started.
INFO   | jvm 1    | 2014/03/07 02:53:29 | INFO  02:53:29,459 | 
org.apache.james.container.spring.context.JamesServerApplicationContext | Bean 
'logprovider' of type [class 
org.apache.james.container.spring.lifecycle.LogProviderImpl] is not eligible 
for getting processed by all BeanPostProcessors (for example: not eligible for 
auto-proxying)
INFO   | jvm 1    | 2014/03/07 02:53:30 | INFO  02:53:30,087 | 
james.mailrepositorystore | JamesMailStore init...
INFO   | jvm 1    | 2014/03/07 02:53:30 | INFO  02:53:30,106 | 
james.mailrepositorystore | Registering Repository instance of class 
org.apache.james.mailrepository.file.FileMailRepository to handle file protocol 
requests for repositories with key file
INFO   | jvm 1    | 2014/03/07 02:53:30 | INFO  02:53:30,106 | 
james.mailrepositorystore | Registering Repository instance of class 
org.apache.james.mailrepository.jdbc.JDBCMailRepository to handle db protocol 
requests for repositories with key db
INFO   | jvm 1    | 2014/03/07 02:53:30 | INFO  02:53:30,107 | 
james.mailrepositorystore | Registering Repository instance of class 
org.apache.james.mailrepository.jdbc.JDBCMailRepository to handle dbfile 
protocol requests for repositories with key dbfile
INFO   | jvm 1    | 2014/03/07 02:53:30 | INFO  02:53:30,107 | 
james.mailrepositorystore | Registering Repository instance of class 
org.apache.james.mailrepository.file.MBoxMailRepository to handle mbox protocol 
requests for repositories with key mbox
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,151 | james.dnsservice 
| Autodiscovery is enabled - trying to discover your system's DNS Servers
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,159 | james.dnsservice 
| Adding autodiscovered server 75.75.75.75
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,159 | james.dnsservice 
| Adding autodiscovered server 75.75.76.76
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,160 | james.dnsservice 
| DNS Server is: 75.75.75.75
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,161 | james.dnsservice 
| DNS Server is: 75.75.76.76
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,181 | james.dnsservice 
| Registered cache, resolver and search paths as DNSJava defaults
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,220 | james.domainlist 
| Set autodetect to: true
INFO   | jvm 1    | 2014/03/07 02:53:31 | INFO  02:53:31,221 | james.domainlist 
| Set autodetectIP to: true
INFO   | jvm 1    | 2014/03/07 02:53:31 | 38  James  WARN   
[WrapperSimpleAppMain] openjpa.Runtime - An error occurred while registering a 
ClassTransformer with PersistenceUnitInfo: name 'James', root URL 
[file:/C:/Program%20Files/direct/apache-james-3.0-beta4/conf/]. The error has 
been consumed. To see it, set your openjpa.Runtime log level to TRACE. 
Load-time class transformation will not be available.
INFO   | jvm 1    | 2014/03/07 02:53:31 | 98  James  INFO   
[WrapperSimpleAppMain] openjpa.Runtime - Starting OpenJPA 2.1.0
INFO   | jvm 1    | 2014/03/07 02:53:31 | 167  James  INFO   
[WrapperSimpleAppMain] openjpa.jdbc.JDBC - Using dictionary class 
"org.apache.openjpa.jdbc.sql.DerbyDictionary".
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,528 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,546 | 
james.mailprocessor | Mailet PostmasterAlias instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,551 | 
james.mailprocessor | Matcher RelayLimit=30 instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,555 | 
james.mailprocessor | Mailet Null instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,559 | 
james.mailprocessor | Matcher 
HasMailAttributeWithValue=org.apache.james.infected, true instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,563 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,567 | 
james.mailprocessor | Matcher HasMailAttribute=spamChecked instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,567 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,568 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,572 | 
james.mailprocessor | Mailet SetMailAttribute instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,576 | 
james.mailprocessor | Matcher SMTPAuthSuccessful instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,577 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,581 | 
james.mailprocessor | Matcher InSpammerBlacklist=query.bondedsender.org. 
instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,582 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,582 | 
james.mailprocessor | Matcher InSpammerBlacklist=dnsbl.njabl.org. instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,583 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,583 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:34 | INFO  02:53:34,584 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,919 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,949 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentObjectRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,951 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentObjectRepository opened in 
..\var\mail\error
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,952 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentStreamRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,953 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentStreamRepository opened in 
..\var\mail\error
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,955 | 
james.mailrepositorystore | added repository: 
file://var/mail/error/->org.apache.james.mailrepository.file.FileMailRepository
INFO   | jvm 1    | 2014/03/07 02:53:35 | INFO  02:53:35,955 | 
james.mailprocessor | Mailet ToRepository instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,083 | 
james.mailprocessor | Matcher SMTPAuthSuccessful instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,092 | 
james.mailprocessor | Mailet SetMimeHeader instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,093 | 
james.mailprocessor | Matcher 
HasMailAttribute=org.apache.james.SMIMECheckSignature instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,094 | 
james.mailprocessor | Mailet SetMimeHeader instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,540 | 
james.mailprocessor | Matcher 
org.nhind.james.matcher.RecipientIsXdAndNotSMIME=http://localhost:8081/config-se
rvice/ConfigurationService instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,927 | 
james.mailprocessor | Mailet org.nhind.james.mailet.DirectXdMailet instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:36 | INFO  02:53:36,937 | 
james.mailprocessor | Matcher 
org.nhindirect.gateway.smtp.james.matcher.RecipAndSenderIsNotLocal=sdirect.emedp
ractice.net instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,658 | 
james.mailprocessor | Mailet 
org.nhindirect.gateway.smtp.james.mailet.NHINDSecurityAndTrustMailet 
instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,670 | 
james.mailprocessor | Matcher 
org.nhindirect.gateway.smtp.james.matcher.IsNotification instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,690 | 
james.mailprocessor | Mailet 
org.nhindirect.gateway.smtp.james.mailet.SuppressAndTrackAggregate instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,696 | 
james.mailprocessor | Matcher 
org.nhind.james.matcher.RecipientIsXdAndNotSMIME=http://localhost:8081/config-se
rvice/ConfigurationService instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,701 | 
james.mailprocessor | Mailet org.nhind.james.mailet.DirectXdMailet instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:38 | INFO  02:53:38,714 | 
james.mailprocessor | Matcher RecipientIsLocal instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,924 | 
james.mailprocessor | Mailet 
org.nhindirect.gateway.smtp.james.mailet.TimelyAndReliableLocalDelivery 
instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,939 | 
james.mailprocessor | Matcher HostIsLocal instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,940 | 
james.mailprocessor | Mailet ToProcessor instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,941 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,971 | 
james.mailetcontext | maxRetries is larger than total number of attempts 
specified.  Increasing last delayTime with 19 attempts
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,971 | 
james.mailetcontext | Delay of 21600000 msecs is now attempted: 20 times
INFO   | jvm 1    | 2014/03/07 02:53:39 | INFO  02:53:38,988 | 
james.mailprocessor | Mailet RemoteDelivery instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,933 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,936 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentObjectRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,937 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentObjectRepository opened in 
..\var\mail\spam
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,937 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentStreamRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,937 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentStreamRepository opened in 
..\var\mail\spam
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,938 | 
james.mailrepositorystore | added repository: 
file://var/mail/spam/->org.apache.james.mailrepository.file.FileMailRepository
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:39,938 | 
james.mailprocessor | Mailet ToRepository instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,087 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,088 | 
james.mailprocessor | Mailet SetMailAttribute instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,089 | 
james.mailprocessor | Matcher SMTPAuthSuccessful instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,124 | 
james.mailprocessor | Mailet Bounce instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,125 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,126 | 
james.mailprocessor | Mailet Null instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,435 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,450 | 
james.mailprocessor | Mailet 
org.nhindirect.gateway.smtp.james.mailet.DirectBounce instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,597 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,599 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentObjectRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,600 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentObjectRepository opened in 
..\var\mail\relay-denied
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,600 | 
james.mailrepositorystore | Init 
org.apache.james.repository.file.FilePersistentStreamRepository Store
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,601 | 
james.mailrepositorystore | 
org.apache.james.repository.file.FilePersistentStreamRepository opened in 
..\var\mail\relay-denied
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,601 | 
james.mailrepositorystore | added repository: 
file://var/mail/relay-denied/->org.apache.james.mailrepository.file.FileMailRepo
sitory
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,602 | 
james.mailprocessor | Mailet ToRepository instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,760 | 
james.mailprocessor | Matcher All instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,780 | 
james.mailprocessor | Mailet DSNBounce instantiated.
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,925 | 
james.mailspooler | org.apache.james.mailetcontainer.impl.JamesMailSpooler 
init...
INFO   | jvm 1    | 2014/03/07 02:53:40 | INFO  02:53:40,926 | 
james.mailspooler | org.apache.james.mailetcontainer.impl.JamesMailSpooler uses 
20 Thread(s)
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:40,931 | 
james.mailspooler | Run org.apache.james.mailetcontainer.impl.JamesMailSpooler: 
dequeuer-1
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:40,931 | 
james.mailspooler | Queue=MailQueue:spool
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:40,933 | 
james.mailspooler | Run org.apache.james.mailetcontainer.impl.JamesMailSpooler: 
dequeuer-2
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:40,933 | 
james.mailspooler | Queue=MailQueue:spool
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:40,982 | james.fetchmail 
| FetchMail Disabled
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,060 | james.smtpserver 
| SMTP Service bound to: 0.0.0.0:25
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,062 | james.smtpserver 
| SMTP Service is running on: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,062 | james.smtpserver 
| SMTP Service handler hello name is: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,063 | james.smtpserver 
| SMTP Service handler connection timeout is: 360
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,063 | james.smtpserver 
| SMTP Service connection backlog is: 200
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,064 | james.smtpserver 
| This SMTP server requires authentication.
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,064 | james.smtpserver 
| No maximum message size is enforced for this server.
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,546 | james.smtpserver 
| Init SMTP Service done
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,566 | james.lmtpserver 
| LMTP Service disabled by configuration
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,583 | james.pop3server 
| POP3 Service bound to: 0.0.0.0:110
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,584 | james.pop3server 
| POP3 Service is running on: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,584 | james.pop3server 
| POP3 Service handler hello name is: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,585 | james.pop3server 
| POP3 Service handler connection timeout is: 1200
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,585 | james.pop3server 
| POP3 Service connection backlog is: 200
INFO   | jvm 1    | 2014/03/07 02:53:41 | INFO  02:53:41,735 | james.pop3server 
| Init POP3 Service done
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,050 | james.imapserver 
| IMAP Service bound to: 0.0.0.0:143
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,051 | james.imapserver 
| IMAP Service is running on: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,051 | james.imapserver 
| IMAP Service handler hello name is: normsoftweb01
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,051 | james.imapserver 
| IMAP Service handler connection timeout is: 300
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,051 | james.imapserver 
| IMAP Service connection backlog is: 200
INFO   | jvm 1    | 2014/03/07 02:53:42 | INFO  02:53:42,056 | james.imapserver 
| Init IMAP Service done
INFO   | jvm 1    | 2014/03/07 02:53:43 | INFO  02:53:43,761 | 
org.apache.james.app.spring.JamesAppSpringMain | Apache James Server is 
successfully started in 18158 milliseconds.
INFO   | jvm 1    | 2014/03/07 02:55:27 | 115676  James  INFO   [RMI TCP 
Connection(4)-192.168.5.15] openjpa.Runtime - The Entity 
"org.apache.james.mailbox.jpa.user.model.JPASubscription" was enhanced at level 
"2", but the current level of enhancement is "1,055,128".
INFO   | jvm 1    | 2014/03/07 02:55:27 | 115680  James  INFO   [RMI TCP 
Connection(4)-192.168.5.15] openjpa.Runtime - A down level Entity was detected 
and logged. Please enable RUNTIME trace to see all down level Entities.
INFO   | jvm 1    | 2014/03/07 02:58:41 | INFO  02:58:41,780 | james.pop3server 
| Id='1194686530' User='' Connection established from 122.125.252.241
INFO   | jvm 1    | 2014/03/07 02:58:43 | INFO  02:58:43,499 | james.pop3server 
| Id='1194686530' User='myuser@mydomainname.net' Connection closed for 
122.125.252.241
INFO   | jvm 1    | 2014/03/07 02:59:24 | INFO  02:59:24,563 | james.smtpserver 
| Id='1709572287' User='' Connection established from 54.241.23.17
INFO   | jvm 1    | 2014/03/07 02:59:25 | ERROR 02:59:25,375 | james.smtpserver 
| Id='1709572287' User='' Unknown error occurred while processing DATA.
INFO   | jvm 1    | 2014/03/07 02:59:25 | java.io.IOException: The system 
cannot find the path specified
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
java.io.WinNTFileSystem.createFileExclusively(Native Method)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
java.io.File.checkAndCreate(Unknown Source)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
java.io.File.createTempFile(Unknown Source)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.commons.io.output.DeferredFileOutputStream.thresholdReached(DeferredF
ileOutputStream.java:179)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.commons.io.output.ThresholdingOutputStream.checkThreshold(Thresholdin
gOutputStream.java:226)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.commons.io.output.ThresholdingOutputStream.write(ThresholdingOutputSt
ream.java:111)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.smtpserver.DataLineJamesMessageHookHandler.onLine(DataLineJames
MessageHookHandler.java:133)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:84)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:67)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onBodyLine(Separat
ingDataLineFilter.java:111)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.SeparatingDataLineFilter.onLine(SeparatingD
ataLineFilter.java:69)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:84)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:67)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.esmtp.MailSizeEsmtpExtension.onLine(MailSiz
eEsmtpExtension.java:173)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:84)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.smtp.core.DataCmdHandler$DataLineFilterWrapper.onLine
(DataCmdHandler.java:67)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.apache.james.protocols.netty.LineHandlerUpstreamHandler.messageReceived(Line
HandlerUpstreamHandler.java:50)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChanne
lUpstreamHandler.java:75)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeli
ne.java:558)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.send
Upstream(DefaultChannelPipeline.java:777)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.messageReceived(SimpleChann
elUpstreamHandler.java:129)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.SimpleChannelUpstreamHandler.handleUpstream(SimpleChanne
lUpstreamHandler.java:75)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.DefaultChannelPipeline.sendUpstream(DefaultChannelPipeli
ne.java:558)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.channel.DefaultChannelPipeline$DefaultChannelHandlerContext.send
Upstream(DefaultChannelPipeline.java:777)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.handler.execution.ChannelUpstreamEventRunnable.run(ChannelUpstre
amEventRunnable.java:44)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
org.jboss.netty.handler.execution.OrderedMemoryAwareThreadPoolExecutor$ChildExec
utor.run(OrderedMemoryAwareThreadPoolExecutor.java:312)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(Unknown Source)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
INFO   | jvm 1    | 2014/03/07 02:59:25 |     at java.lang.Thread.run(Unknown 
Source)
INFO   | jvm 1    | 2014/03/07 02:59:25 | INFO  02:59:25,438 | james.smtpserver 
| Id='1709572287' User='' Connection closed for 54.241.23.17
STATUS | wrapper  | 2014/03/07 03:08:21 | Stopping the Apache James Server App 
service...
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,182 | 
org.apache.james.container.spring.context.JamesServerApplicationContext | 
Closing 
org.apache.james.container.spring.context.JamesServerApplicationContext@40110c31
: startup date [Fri Mar 07 02:53:25 EST 2014]; root of context hierarchy
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,209 | james.imapserver 
| Dispose IMAP Service
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,219 | james.imapserver 
| Dispose IMAP Service done
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,220 | james.pop3server 
| Dispose POP3 Service
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,224 | james.pop3server 
| Dispose POP3 Service done
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,225 | james.lmtpserver 
| Dispose LMTP Service
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,225 | james.lmtpserver 
| Dispose LMTP Service done
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,225 | james.smtpserver 
| Dispose SMTP Service
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,230 | james.smtpserver 
| Dispose SMTP Service done
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,231 | 
james.mailspooler | org.apache.james.mailetcontainer.impl.JamesMailSpooler 
dispose...
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,232 | 
james.mailspooler | org.apache.james.mailetcontainer.impl.JamesMailSpooler 
thread shutdown completed.
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,233 | 
james.mailspooler | Stop 
org.apache.james.mailetcontainer.impl.JamesMailSpooler: dequeuer-1
INFO   | jvm 1    | 2014/03/07 03:08:22 | INFO  03:08:22,233 | 
james.mailspooler | Stop 
org.apache.james.mailetcontainer.impl.JamesMailSpooler: dequeuer-2
STATUS | wrapper  | 2014/03/07 03:08:23 | <-- Wrapper Stopped
STATUS | wrapper  | 2014/03/07 03:08:25 | Apache James Server App stopped.

Original issue reported on code.google.com by itsharsh...@gmail.com on 8 Mar 2014 at 8:42