e-mail works couple off hours than halts and needs restarting

salty

New member
Joined
Sep 29, 2007
Messages
4
Hi,
I've been having an exim problem for a couple of weeks now and can't figure out how to solve it.
E-mail goes fine for a couple of hours than stay on the server and and very often I recieve this error or nothing happens at all The address I'm sending to here is on the same server as the one I'm sending from

a SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-24 19:10:43 1IZrNO-0002ro-1T <[email protected]>: spamcheck transport output: An error was detected while processing a file of BSMTP input.

Because I really don't know where to start solving this, heres the end off my log (not working email) till the restart after which everything works again.
Really hope somebody can help.
Thanks
Ive just noticed in the log a socket bind error, could this be causing problems, even with this error for now I can still send and recieve mails but only for a couple of hours

2007-09-24 19:10:43 SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-24 19:10:43 1IZrNO-0002ro-1T <[email protected]>: spamcheck transport output: An error was detected while processing a file of BSMTP input.
2007-09-24 19:10:43 1IZrNO-0002ro-1T ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process of spamcheck transp
2007-09-24 19:10:43 1IZrSF-0002sa-7H <= <> R=1IZrNO-0002ro-1T U=mail P=local S=2017 T="Mail delivery failed: returning message to sender" from <> for
2007-09-24 19:10:43 1IZrNO-0002ro-1T Completed
2007-09-24 19:10:43 1IZrSF-0002sa-7H => info <[email protected]> F=<> R=virtual_user T=virtual_localdelivery S=2157
2007-09-24 19:10:43 1IZrSF-0002sa-7H Completed
2007-09-24 19:11:22 1IYPqg-0006rC-Tf == [email protected] R=lookuphost T=remote_smtp defer (-44): SMTP error from remote mail server after
2007-09-24 19:13:32 1IZrUy-0002vc-Hl <= [email protected] H=py-out-1112.google.com [64.233.166.177] P=esmtp S=2298 id=352c93420709241013v71a23
2007-09-24 19:14:36 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (9 more tries)
2007-09-24 19:15:06 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (8 more tries)
2007-09-24 19:15:26 H=dhcp-077-250-248-065.chello.nl ([127.0.0.1]) [77.250.248.65] incomplete transaction (QUIT) from <[email protected]>
2007-09-24 19:15:36 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (7 more tries)
2007-09-24 19:15:43 H=dhcp-077-250-248-065.chello.nl ([127.0.0.1]) [77.250.248.65] incomplete transaction (QUIT) from <[email protected]>
2007-09-24 19:15:53 1IZrXF-0002wk-7K <= [email protected] H=dhcp-077-250-248-065.chello.nl ([127.0.0.1]) [77.250.248.65] P=esmtpa A=plain:info@klikst
2007-09-24 19:16:06 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (6 more tries)
2007-09-24 19:16:16 1IZrXF-0002wn-Pv <= [email protected] U=mail P=spam-scanned S=862 [email protected] T="test" from <info@klikstudi
2007-09-24 19:16:16 1IZrUy-0002vf-M7 <= [email protected] U=mail P=spam-scanned S=2496 [email protected]
2007-09-24 19:16:16 1IZrXF-0002wn-Pv => info <[email protected]> F=<[email protected]> R=virtual_user T=virtual_localdelivery S=1026
2007-09-24 19:16:16 1IZrXF-0002wn-Pv Completed
2007-09-24 19:16:16 1IZrXF-0002wk-7K => info <[email protected]> F=<[email protected]> R=spamcheck_director T=spamcheck S=739
2007-09-24 19:16:16 1IZrXF-0002wk-7K Completed
2007-09-24 19:16:19 exim 4.60 daemon started: pid=11379, -q15m, listening for SMTP on port 25 (IPv4) port 587 (IPv4)
2007-09-24 19:16:19 1IZrUy-0002vf-M7 => info <[email protected]> F=<[email protected]> R=virtual_user T=virtual_localdelivery S=2674
2007-09-24 19:16:19 1IZrUy-0002vf-M7 Completed
2007-09-24 19:16:19 1IZrUy-0002vc-Hl => info <[email protected]> F=<[email protected]> R=spamcheck_director T=spamcheck S=2373
2007-09-24 19:16:19 1IZrUy-0002vc-Hl Completed
2007-09-24 19:16:36 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (5 more tries)
2007-09-24 19:17:00 1IZrYD-000313-AX <= [email protected] H=dhcp-077-250-248-065.chello.nl ([127.0.0.1]) [77.250.248.65] P=esmtpa A=plain:info@klikst
2007-09-24 19:17:05 1IZrYK-000316-RG <= [email protected] U=mail P=spam-scanned S=1097 [email protected] T="(geen onderwerp)" from <i
2007-09-24 19:17:05 1IZrYK-000316-RG => info <[email protected]> F=<[email protected]> R=virtual_user T=virtual_localdelivery S=1261
2007-09-24 19:17:05 1IZrYK-000316-RG Completed
2007-09-24 19:17:05 1IZrYD-000313-AX => info <[email protected]> F=<[email protected]> R=spamcheck_director T=spamcheck S=974
2007-09-24 19:17:05 1IZrYD-000313-AX Completed
2007-09-24 19:17:06 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (4 more tries)
2007-09-24 19:17:36 socket bind() to port 25 for address (any IPv4) failed: Address already in use: waiting 30s before trying again (3 more tries)
2007-09-24 19:17:47 H=(tbqrm) [88.254.212.185] F=<[email protected]> rejected RCPT <[email protected]>:
2007-09-24 19:17:47 H=(tbqrm) [88.254.212.185] incomplete transaction (QUIT) from <[email protected]>
 
update log

Sorry just noticed that the part off the log I sent is old and the port problem is already solved this is the real end off the file
2007-09-29 20:21:46 1Ibgru-0000TR-EL <[email protected]>: spamcheck transport output: An error was detected while processing a file of BSMTP input.
2007-09-29 20:21:46 1Ibgru-0000TR-EL ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process of spamcheck tra
2007-09-29 20:21:46 1Ibgwk-0000Vf-Jq <= <> R=1Ibgru-0000TR-EL U=mail P=local S=3627 T="Mail delivery failed: returning message to sender" from <> fo
2007-09-29 20:21:46 1Ibgru-0000TR-EL Completed
2007-09-29 20:21:53 1Ibgwk-0000Vf-Jq ** [email protected] F=<> R=lookuphost T=remote_smtp: SMTP error from remote mail server after RCPT TO:<kjbu
2007-09-29 20:21:53 1Ibgwk-0000Vf-Jq Frozen (delivery error message)
2007-09-29 20:22:44 1Ibgxf-0000Vk-HN <= [email protected] H=wsip-70-184-85-43.ph.ph.cox.net [70.184.85.43] P=smtp S=2399 id=e01501c386b6$e5be2
2007-09-29 20:27:44 SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-29 20:27:44 1Ibgxf-0000Vk-HN <[email protected]>: spamcheck transport output: An error was detected while processing a file of B
2007-09-29 20:27:44 1Ibgxf-0000Vk-HN ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process of
2007-09-29 20:27:44 1Ibh2W-0000W3-A1 <= <> R=1Ibgxf-0000Vk-HN U=mail P=local S=3768 T="Mail delivery failed: returning message to sender" from <> fo
2007-09-29 20:27:44 1Ibgxf-0000Vk-HN Completed
2007-09-29 20:27:51 1Ibh2W-0000W3-A1 ** [email protected] F=<> R=lookuphost T=remote_smtp: SMTP error from remote mail server after RCPT TO:<j
2007-09-29 20:27:51 1Ibh2W-0000W3-A1 Frozen (delivery error message)
2007-09-29 20:28:48 1Ibh3X-0000W8-Db <= [email protected] H=(-1214025464) [122.47.93.10] P=smtp S=2116 id=1336840435.20070929182841@gerstenbe
2007-09-29 20:29:20 1Ibh43-0000WL-SR <= [email protected] H=ekw152.neoplus.adsl.tpnet.pl [83.21.190.152] P=esmtp S=9205 id=01c802c6$b58a2990$98be
2007-09-29 20:33:48 SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-29 20:33:48 1Ibh3X-0000W8-Db <[email protected]>: spamcheck transport output: An error was detected while processing a file of B
2007-09-29 20:33:48 1Ibh3X-0000W8-Db ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process o
2007-09-29 20:33:48 1Ibh8O-0000Z6-KC <= <> R=1Ibh3X-0000W8-Db U=mail P=local S=3488 T="Mail delivery failed: returning message to sender" from <> fo
2007-09-29 20:33:48 1Ibh3X-0000W8-Db Completed
2007-09-29 20:33:57 1Ibh8O-0000Z6-KC ** [email protected] F=<> R=lookuphost T=remote_smtp: SMTP error from remote mail server after RCPT TO:<
2007-09-29 20:33:57 1Ibh8O-0000Z6-KC Frozen (delivery error message)
2007-09-29 20:34:20 SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-29 20:34:20 1Ibh43-0000WL-SR <[email protected]>: spamcheck transport output: An error was detected while processing a file of BSMTP in
2007-09-29 20:34:20 1Ibh43-0000WL-SR ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process of spamcheck
2007-09-29 20:34:20 1Ibh8u-0000ZB-S8 <= <> R=1Ibh43-0000WL-SR U=mail P=local S=10544 T="Mail delivery failed: returning message to sender" from <> f
2007-09-29 20:34:20 1Ibh43-0000WL-SR Completed
2007-09-29 20:34:46 1Ibh8u-0000ZB-S8 => [email protected] F=<> R=lookuphost T=remote_smtp S=10790 H=mail.belec.de [193.41.253.90] X=TLSv1:DHE-RSA
2007-09-29 20:34:46 1Ibh8u-0000ZB-S8 Completed
2007-09-29 20:38:13 1IbhCe-0000ZS-5V <= [email protected] H=(dvn.com) [88.233.170.244] P=smtp S=2451 id=030501c802c7$e5c4b340$c0a80104@Ruper
2007-09-29 20:43:13 SMTP data timeout (message abandoned) on connection from local process F=<[email protected]>
2007-09-29 20:43:13 1IbhCe-0000ZS-5V <[email protected]>: spamcheck transport output: An error was detected while processing a file of BSMTP input.
2007-09-29 20:43:13 1IbhCe-0000ZS-5V ** [email protected] F=<[email protected]> R=spamcheck_director T=spamcheck: Child process of spamchec
2007-09-29 20:43:13 1IbhHV-0000Zt-6F <= <> R=1IbhCe-0000ZS-5V U=mail P=local S=3793 T="Mail delivery failed: returning message to sender" from <> fo
2007-09-29 20:43:13 1IbhCe-0000ZS-5V Completed
2007-09-29 20:43:13 1IbhHV-0000Zt-6F ** [email protected] F=<> R=lookuphost T=remote_smtp: SMTP error from remote mail server after RCPT TO:
2007-09-29 20:43:13 1IbhHV-0000Zt-6F Frozen (delivery error message)
2007-09-29 20:50:36 1IbhOd-0000cj-Dj <= [email protected] H=dhcp-077-250-248-065.chello.nl ([127.0.0.1]) [77.250.248.65] P=esmtpa A=plain:info@klik
2007-09-29 20:51:08 1IbhOe-0000cm-11 <= [email protected] U=mail P=spam-scanned S=885 [email protected] T="again" from <info@klikst
2007-09-29 20:51:08 1IbhOe-0000cm-11 => info <[email protected]> F=<[email protected]> R=virtual_user T=virtual_localdelivery S=999
2007-09-29 20:51:08 1IbhOe-0000cm-11 Completed
2007-09-29 20:51:08 1IbhOd-0000cj-Dj => info <[email protected]> F=<[email protected]> R=spamcheck_director T=spamcheck S=762
2007-09-29 20:51:08 1IbhOd-0000cj-Dj Completed
2007-09-29 20:51:11 exim 4.60 daemon started: pid=2455, -q15m, listening for SMTP on port 25 (IPv4) port 587 (IPv4)
 
update on mail problem

In the hope that somebody can help me, this is an update on the problem.

Last night I restarted exim, everything went fine, i could send and receive mail without problems, this morning I sent a test mail form one user on the server to another
This is the return email I get when this happens

"This message was created automatically by mail delivery software.

A message that you sent could not be delivered to one or more of its
recipients. This is a permanent error. The following address(es) failed:

[email protected]
local delivery failed

The following text was generated during the delivery attempt:

------ [email protected] ------

An error was detected while processing a file of BSMTP input.
The error message was:

421 SMTP incoming data timeout - message abandoned

The SMTP transaction started in line 0.
The error was detected in line 3.
0 previous messages were successfully processed.
The rest of the batch was abandoned.
421 SMTP incoming data timeout - message abandoned
Transaction started in line 0
Error detected in line 3

------ This is a copy of the message, including all the headers. ------

Return-path: <[email protected]>
Received: from dhcp-077-250-248-065.chello.nl ([77.250.248.65] helo=[127.0.0.1])
by server.klikstudio.nl with esmtpa (Exim 4.60)
(envelope-from <[email protected]>)
id 1IcEy3-0007cP-1L
for [email protected]; Mon, 01 Oct 2007 08:41:24 +0200
Message-ID: <[email protected]>
Date: Mon, 01 Oct 2007 08:41:24 +0200
From: "[email protected]" <[email protected]>
User-Agent: Thunderbird 2.0.0.6 (Windows/20070728)
MIME-Version: 1.0
To: "[email protected]" <[email protected]>
Subject: test
Content-Type: text/plain; charset=ISO-8859-1; format=flowed
Content-Transfer-Encoding: 7bit
X-Antivirus: avast! (VPS 000777-4, 09/30/2007), Outbound message
X-Antivirus-Status: Clean"

My paniclog has this entry everyday
2007-10-01 04:02:10 1IcAbp-0006Fb-ST User 0 set for local_delivery transport is on the never_users list
2007-10-01 04:02:10 1IcAbq-0006GD-52 User 0 set for local_delivery transport is on the never_users list

Can anybody point me in the right direction??
 
I don't know about others, but when I see long log extracts I don't try to read them. It's just too time-consuming. Can you imagine how I'd felt if I read the first and then saw your second post?

If you can find a section of any of the exim logs that show why exim is shutting down, just post a few lines.

The paniclog entry you've posted doesn't mean anything important. It means that an email was sent to root and exim stopped trying to send it because it's not supposed to handle messages to root.

You might want to create a .forward file in your /root directory to send root email elsewhere to eliminate those messages and to be able to see what the emails creating them are trying to tell you.

Jeff
 
Hi Jasman,
Thanks for your reply, posting a large chunk was a desperation as I couldnt figure out what was going on.
I never solved the problem but put a cron job restarting exim automatically every hour which works fine. not elegant but much better than nothing!
 
Back
Top