[exim] random smtp delay and error

Top Page
Delete this message
Reply to this message
Author: Steven Settlemyre
Date:  
To: exim-users
Subject: [exim] random smtp delay and error
I've been having some problems recently with exim delaying and reporting
errors when sending mail. It seems to last a few hours then all the
failed messages break loose and send. The machine is a development box
running Ubuntu "Edgy Eft" with Exim 4.62-2.

Maybe some insight/help with reading the log is what need.

Thanks,
Steve

Here is a sample of the exim4/mainlog:

2007-04-24 12:36:49 1HgO0X-0002Jo-Rw <= settlemy@salvage U=www-data
P=local S=1088
2007-04-24 12:39:47 1HgO3P-0002K8-92 <= settlemy@salvage U=root P=local
S=1093
2007-04-24 12:40:51 1HgO4R-0002KJ-Uy <= settlemy@salvage U=root P=local
S=1093
2007-04-24 12:41:07 1HgO4h-0002KS-0p <= settlemy@salvage U=root P=local
S=1083
2007-04-24 12:41:55 1HgO5T-0002KZ-ND <= root@salvage U=root P=local S=335
2007-04-24 12:53:12 Start queue run: pid=8969
2007-04-24 12:53:12 1HgO4h-0002KS-0p Spool file is locked (another
process is handling this message)
2007-04-24 12:53:12 1HgO4R-0002KJ-Uy Spool file is locked (another
process is handling this message)
2007-04-24 12:53:12 1HgO3P-0002K8-92 Spool file is locked (another
process is handling this message)
2007-04-24 12:53:12 1HgO0X-0002Jo-Rw Spool file is locked (another
process is handling this message)
2007-04-24 12:53:12 1HgO5T-0002KZ-ND Spool file is locked (another
process is handling this message)
2007-04-24 12:53:12 End queue run: pid=8969
2007-04-24 13:07:21 1HgO3P-0002K8-92 TLS error on connection to
mailhost.asel.udel.edu [128.175.51.8] (gnutls_handshake): A record
packet with illegal version was received.
2007-04-24 13:07:21 1HgO3P-0002K8-92 == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-37): failure while setting
up TLS session
2007-04-24 13:18:37 1HgO5T-0002KZ-ND TLS error on connection to
mailhost.asel.udel.edu [128.175.51.8] (gnutls_handshake): A record
packet with illegal version was received.
2007-04-24 13:18:37 1HgO5T-0002KZ-ND == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-37): failure while setting
up TLS session
2007-04-24 13:18:49 1HgOfB-0002Kx-Ku <= root@salvage U=root P=local S=335
2007-04-24 13:18:49 1HgOfB-0002Kx-Ku == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-53): retry time not reached
for any host
2007-04-24 13:22:15 1HgO4R-0002KJ-Uy TLS error on connection to
mailhost.asel.udel.edu [128.175.51.8] (gnutls_handshake): A record
packet with illegal version was received.
2007-04-24 13:22:15 1HgO4R-0002KJ-Uy == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-37): failure while setting
up TLS session
2007-04-24 13:23:07 1HgO4h-0002KS-0p TLS error on connection to
mailhost.asel.udel.edu [128.175.51.8] (gnutls_handshake): A record
packet with illegal version was received.
2007-04-24 13:23:07 1HgO4h-0002KS-0p == ssettl2@??? R=smarthost
T=remote_smtp_smarthost defer (-37): failure while setting up TLS session
2007-04-24 13:23:12 Start queue run: pid=8992
2007-04-24 13:23:12 1HgOfB-0002Kx-Ku == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-53): retry time not reached
for any host
2007-04-24 13:23:12 1HgO5T-0002KZ-ND == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-53): retry time not reached
for any host
2007-04-24 13:23:12 1HgO4h-0002KS-0p == ssettl2@??? R=smarthost
T=remote_smtp_smarthost defer (-53): retry time not reached for any host
2007-04-24 13:23:12 1HgO4R-0002KJ-Uy == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-53): retry time not reached
for any host
2007-04-24 13:23:12 1HgO3P-0002K8-92 == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-53): retry time not reached
for any host
2007-04-24 13:23:12 1HgO0X-0002Jo-Rw Spool file is locked (another
process is handling this message)
2007-04-24 13:23:12 End queue run: pid=8992
2007-04-24 13:23:17 1HgO0X-0002Jo-Rw TLS error on connection to
mailhost.asel.udel.edu [128.175.51.8] (gnutls_handshake): A record
packet with illegal version was received.
2007-04-24 13:23:17 1HgO0X-0002Jo-Rw == settlemy@???
R=smarthost T=remote_smtp_smarthost defer (-37): failure while setting
up TLS session
2007-04-24 13:23:17 1HgO0X-0002Jo-Rw == ssettl2@??? R=smarthost
T=remote_smtp_smarthost defer (-37): failure while setting up TLS session
2007-04-24 13:53:12 Start queue run: pid=9777
2007-04-24 13:53:13 1HgOfB-0002Kx-Ku => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8] X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:13 1HgOfB-0002Kx-Ku Completed
2007-04-24 13:53:13 1HgO0X-0002Jo-Rw => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8]* X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:13 1HgO0X-0002Jo-Rw -> ssettl2@??? R=smarthost
T=remote_smtp_smarthost H=mailhost.asel.udel.edu [128.175.51.8]*
X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:13 1HgO0X-0002Jo-Rw Completed
2007-04-24 13:53:13 1HgO4h-0002KS-0p => ssettl2@??? R=smarthost
T=remote_smtp_smarthost H=mailhost.asel.udel.edu [128.175.51.8]*
X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:13 1HgO4h-0002KS-0p Completed
2007-04-24 13:53:14 1HgO4R-0002KJ-Uy => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8]* X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:14 1HgO4R-0002KJ-Uy Completed
2007-04-24 13:53:14 1HgO5T-0002KZ-ND => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8]* X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:14 1HgO5T-0002KZ-ND Completed
2007-04-24 13:53:14 1HgO3P-0002K8-92 => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8]* X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 13:53:14 1HgO3P-0002K8-92 Completed
2007-04-24 13:53:14 End queue run: pid=9777
2007-04-24 14:04:26 1HgPNK-0002cZ-Ob <= root@salvage U=root P=local S=335
2007-04-24 14:04:27 1HgPNK-0002cZ-Ob => settlemy@???
R=smarthost T=remote_smtp_smarthost H=mailhost.asel.udel.edu
[128.175.51.8] X=TLS-1.0:RSA_AES_256_CBC_SHA1:32
2007-04-24 14:04:27 1HgPNK-0002cZ-Ob Completed