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 Stephen Goodey <st...@test-direct.net> on 2004/06/09 12:20:09 UTC
javax.mail.MessagingException
Hi,
I have been using James v2.1.3 for 2-3 months now, and have almost ironed
out all the problems I have encountered. Yesterday though, a user tried to
send an email to a yahoo.co.uk address and received the following message
back, several hours later.
<--
Hi, this is the James mail server at zeus.
I'm afraid ..........
*******@yahoo.co.uk
Could not connect to SMTP host: mx2.mail.ukl.yahoo.com., port: 25
-->
I quick run through the logs and I managed to track down the following which
might help.
JAMES
08/06/04 15:43:15 DEBUG James: Mail Mail1086705795031-463 pushed in spool
MAILET LOG
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Attempting delivery of
Mail1086705795031-463-to-yahoo.co.uk to host mx1.mail.ukl.yahoo.com. to
addresses [******@yahoo.co.uk]
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Temporary exception
delivering mail (Mail1086705795031-463-to-yahoo.co.uk:
javax.mail.MessagingException: Could not connect to SMTP host:
mx1.mail.ukl.yahoo.com., port: 25
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:899)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:158)
at javax.mail.Service.connect(Service.java:233)
at javax.mail.Service.connect(Service.java:134)
at javax.mail.Service.connect(Service.java:86)
at com.sun.mail.smtp.SMTPTransport.connect(SMTPTransport.java:95)
at
org.apache.james.transport.mailets.RemoteDelivery.deliver(RemoteDelivery.jav
a:305)
at
org.apache.james.transport.mailets.RemoteDelivery.run(RemoteDelivery.java:75
8)
at java.lang.Thread.run(Unknown Source)
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Storing message
Mail1086705795031-463-to-yahoo.co.uk into outgoing after 0 retries
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Attempting delivery of
Mail1086705795031-463-to-yahoo.co.uk to host mx2.mail.ukl.yahoo.com. to
addresses [******@yahoo.co.uk]
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Temporary exception
delivering mail (Mail1086705795031-463-to-yahoo.co.uk:
javax.mail.MessagingException: Could not connect to SMTP host:
mx2.mail.ukl.yahoo.com., port: 25
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:899)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:158)
at javax.mail.Service.connect(Service.java:233)
at javax.mail.Service.connect(Service.java:134)
at javax.mail.Service.connect(Service.java:86)
at com.sun.mail.smtp.SMTPTransport.connect(SMTPTransport.java:95)
at
org.apache.james.transport.mailets.RemoteDelivery.deliver(RemoteDelivery.jav
a:305)
at
org.apache.james.transport.mailets.RemoteDelivery.run(RemoteDelivery.java:75
8)
at java.lang.Thread.run(Unknown Source)
08/06/04 15:43:15 INFO James.Mailet: RemoteDelivery: Storing message
Mail1086705795031-463-to-yahoo.co.uk into outgoing after 1 retries
SMTP SERVER
08/06/04 15:43:15 DEBUG smtpserver: Retrieving a
org.apache.james.smtpserver.SMTPHandler from the pool
08/06/04 15:43:15 DEBUG smtpserver: Getting SMTPHandler from pool.
08/06/04 15:43:15 INFO smtpserver: Connection from hebe.testdirect.local
(192.168.102.121)
08/06/04 15:43:15 DEBUG smtpserver: Sent: 220 test-direct.com SMTP Server
(JAMES SMTP Server 2.1.3) ready Tue, 8 Jun 2004 15:43:15 +0100 (BST)
08/06/04 15:43:15 DEBUG smtpserver: Calling start()
08/06/04 15:43:15 DEBUG smtpserver: Watchdog default Worker #26 has time to
sleep 360000
08/06/04 15:43:15 DEBUG smtpserver: Command received: HELO Hebe
08/06/04 15:43:15 DEBUG smtpserver: Sent: 250 test-direct.com Hello Hebe
(hebe.testdirect.local [192.168.102.121])
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Command received: MAIL FROM:
<******@test-direct.com <ma...@test-direct.com> >
08/06/04 15:43:15 DEBUG smtpserver: Sent: 250 Sender <******@test-direct.com
<ma...@test-direct.com> > OK
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Command received: RCPT TO:
<******@yahoo.co.uk <ma...@yahoo.co.uk> >
08/06/04 15:43:15 DEBUG smtpserver: Sent: 250 Recipient <******@yahoo.co.uk
<ma...@yahoo.co.uk> > OK
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Command received: DATA
08/06/04 15:43:15 DEBUG smtpserver: Sent: 354 Ok Send data ending with
<CRLF>.<CRLF>
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Successfully spooled mail
)Mail1086705795031-463 from ******@test-direct.com
<ma...@test-direct.com> for [******@yahoo.co.uk]
08/06/04 15:43:15 DEBUG smtpserver: Sent: 250 Message received
08/06/04 15:43:15 DEBUG smtpserver: Calling reset() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Command received: QUIT
08/06/04 15:43:15 DEBUG smtpserver: Sent: 221 test-direct.com Service
closing transmission channel
08/06/04 15:43:15 DEBUG smtpserver: Calling stop() default Worker #26
08/06/04 15:43:15 DEBUG smtpserver: Closing socket.
08/06/04 15:43:15 DEBUG smtpserver: Calling disposeWatchdog() default Worker
#26
08/06/04 15:43:15 DEBUG smtpserver: Returning SMTPHandler to pool.
08/06/04 15:43:15 DEBUG smtpserver: Returning a
org.apache.james.smtpserver.SMTPHandler to the pool
08/06/04 15:43:15 DEBUG smtpserver: Watchdog default Worker #26 is exiting
run().
08/06/04 15:43:41 DEBUG smtpserver: Retrieving a
org.apache.james.smtpserver.SMTPHandler from the pool
08/06/04 15:43:41 DEBUG smtpserver: Getting SMTPHandler from pool.
08/06/04 15:43:41 INFO smtpserver: Connection from hades.testdirect.local
(192.168.102.101)
08/06/04 15:43:41 DEBUG smtpserver: Sent: 220 test-direct.com SMTP Server
(JAMES SMTP Server 2.1.3) ready Tue, 8 Jun 2004 15:43:41 +0100 (BST)
08/06/04 15:43:41 DEBUG smtpserver: Calling start()
08/06/04 15:43:41 DEBUG smtpserver: Watchdog default Worker #21 has time to
sleep 360000
08/06/04 15:43:41 DEBUG smtpserver: Command received: QUIT
08/06/04 15:43:41 DEBUG smtpserver: Sent: 221 test-direct.com Service
closing transmission channel
08/06/04 15:43:41 DEBUG smtpserver: Calling stop() default Worker #21
08/06/04 15:43:41 DEBUG smtpserver: Closing socket.
08/06/04 15:43:41 DEBUG smtpserver: Calling disposeWatchdog() default Worker
#21
08/06/04 15:43:41 DEBUG smtpserver: Watchdog default Worker #21 is exiting
run().
08/06/04 15:43:41 DEBUG smtpserver: Returning SMTPHandler to pool.
08/06/04 15:43:41 DEBUG smtpserver: Returning a
org.apache.james.smtpserver.SMTPHandler to the pool
SPOOLMANAGER
08/06/04 15:43:15 DEBUG spoolmanager: ==== Begin processing mail
Mail1086705795031-463====
08/06/04 15:43:15 DEBUG spoolmanager: Processing Mail1086705795031-463
through root
08/06/04 15:43:15 DEBUG spoolmanager.root: Servicing mail:
Mail1086705795031-463
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.All@15d17d7
08/06/04 15:43:15 DEBUG spoolmanager.root: Servicing Mail1086705795031-463
by Postmaster aliasing mailet
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.SenderInFakeDomain@c8376b
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.RelayLimit@349471
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.SenderIs@19d75ee
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.SenderIs@a98932
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.SenderIs@6e4365
08/06/04 15:43:15 DEBUG spoolmanager.root: Checking Mail1086705795031-463
with org.apache.james.transport.matchers.SenderIs@10ab09f
08/06/04 15:43:15 DEBUG spoolmanager.root: Servicing Mail1086705795031-463
by ToProcessor Mailet
08/06/04 15:43:15 DEBUG spoolmanager: Processed Mail1086705795031-463
through root
08/06/04 15:43:15 DEBUG spoolmanager: Result was transport
08/06/04 15:43:15 DEBUG spoolmanager: ==== Begin processing mail
Mail1086705795031-463====
08/06/04 15:43:15 DEBUG spoolmanager: Processing Mail1086705795031-463
through transport
08/06/04 15:43:15 DEBUG spoolmanager.transport: Servicing mail:
Mail1086705795031-463
08/06/04 15:43:15 DEBUG spoolmanager.transport: Checking
Mail1086705795031-463 with
org.apache.james.transport.matchers.RecipientIsLocal@f0b7f8
08/06/04 15:43:15 DEBUG spoolmanager.transport: Checking
Mail1086705795031-463 with
org.apache.james.transport.matchers.HostIsLocal@1be16f5
08/06/04 15:43:15 DEBUG spoolmanager.transport: Checking
Mail1086705795031-463 with
org.apache.james.transport.matchers.RemoteAddrNotInNetwork@d56b37
08/06/04 15:43:15 DEBUG spoolmanager.transport: Checking
Mail1086705795031-463 with org.apache.james.transport.matchers.All@171f189
08/06/04 15:43:15 DEBUG spoolmanager.transport: Servicing
Mail1086705795031-463 by RemoteDelivery Mailet
08/06/04 15:43:15 DEBUG spoolmanager: Processed
Mail1086705795031-463-to-yahoo.co.uk through transport
08/06/04 15:43:15 DEBUG spoolmanager: Result was ghost
08/06/04 15:43:15 DEBUG spoolmanager: ==== Removed from spool mail
Mail1086705795031-463-to-yahoo.co.uk====
Sometime later I managed to track this down aswell, looks like it retried
again then gave up.
MAILET
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Attempting delivery of
Mail1086705795031-463-to-yahoo.co.uk to host mx1.mail.ukl.yahoo.com. to
addresses [missyleonarduk@yahoo.co.uk]
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Temporary exception
delivering mail (Mail1086705795031-463-to-yahoo.co.uk:
javax.mail.MessagingException: Could not connect to SMTP host:
mx1.mail.ukl.yahoo.com., port: 25
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:899)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:158)
at javax.mail.Service.connect(Service.java:233)
at javax.mail.Service.connect(Service.java:134)
at javax.mail.Service.connect(Service.java:86)
at com.sun.mail.smtp.SMTPTransport.connect(SMTPTransport.java:95)
at
org.apache.james.transport.mailets.RemoteDelivery.deliver(RemoteDelivery.jav
a:305)
at
org.apache.james.transport.mailets.RemoteDelivery.run(RemoteDelivery.java:75
8)
at java.lang.Thread.run(Unknown Source)
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Storing message
Mail1086705795031-463-to-yahoo.co.uk into outgoing after 4 retries
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Attempting delivery of
Mail1086705795031-463-to-yahoo.co.uk to host mx2.mail.ukl.yahoo.com. to
addresses [missyleonarduk@yahoo.co.uk]
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Temporary exception
delivering mail (Mail1086705795031-463-to-yahoo.co.uk:
javax.mail.MessagingException: Could not connect to SMTP host:
mx2.mail.ukl.yahoo.com., port: 25
at com.sun.mail.smtp.SMTPTransport.openServer(SMTPTransport.java:899)
at com.sun.mail.smtp.SMTPTransport.protocolConnect(SMTPTransport.java:158)
at javax.mail.Service.connect(Service.java:233)
at javax.mail.Service.connect(Service.java:134)
at javax.mail.Service.connect(Service.java:86)
at com.sun.mail.smtp.SMTPTransport.connect(SMTPTransport.java:95)
at
org.apache.james.transport.mailets.RemoteDelivery.deliver(RemoteDelivery.jav
a:305)
at
org.apache.james.transport.mailets.RemoteDelivery.run(RemoteDelivery.java:75
8)
at java.lang.Thread.run(Unknown Source)
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Bouncing message
Mail1086705795031-463-to-yahoo.co.uk after 5 retries
09/06/04 05:50:14 INFO James.Mailet: RemoteDelivery: Sending failure
message Mail1086705795031-463-to-yahoo.co.uk
If anyone has any ideas why this is happening then please let me know, i'm
bashing my head against a brick wall at the moment.
Regards
Stephen