[Postfixbuch-users] Probs mit "timeout after END-OF-MESSAGE"

ram at i-tux.de ram at i-tux.de
Do Nov 1 14:59:57 CET 2007


Hallo Liste,

ich habe gestern von der kleinen Firma, bei der ich beschäftigt bin, den
MX-Record von unserem Provider weg auf einen selbst administrierten Server
legen lassen. Grösserer Katastrophen sind zum Glück bis jetzt entweder
noch nicht aufgetaucht oder unentdeckt geblieben.

Aber ich habe Probleme mit dem gegnerischen SMTPd, der uns 99% der eMails
einliefert. Dieser (mxout2.volkswagen.de) baut seine Verbindungen auf,
liefert erfolgreich seine eMails ab, aber schliesst nie die Connections.
Das führt soweit, dass er innerhalb von ein paar Minuten zu viele
Connections auf hat.

Im mail.log bildet sich das wie folgend ab:
____________________
Nov  1 14:17:51 mx01 postfix/smtpd[...]: connect from
mxout2.volkswagen.de[194.114.62.48]
Nov  1 14:17:51 mx01 postfix/qmgr[...]: 1D24FD4835C:
from=<name at volkswagen.de>, size=5691, nrcpt=1 (queue active)
Nov  1 14:17:51 mx01 postfix/smtp[...]: 1D24FD4835C:
to=<vw.webticker at meine.domain>, relay=relay.meine.domain[xx.xx.xx.xx]:25,
delay=0.18, delays=0.09/0/0.04/0.05, dsn=2.0.0, status=sent (250 2.0.0
lA1DHp4U001712 Message accepted for delivery)

... aber viel häufiger kommt es zu folgendem:
Nov  1 13:56:14 mx01 postfix/smtpd[14228]: timeout after END-OF-MESSAGE
from mxout2.volkswagen.de[194.114.62.48]
Nov  1 13:56:14 mx01 postfix/smtpd[14228]: disconnect from
mxout2.volkswagen.de[194.114.62.48]
[...] ca. 5 mal hintereinander die gleichen 2 obrigen Zeilen, nur andere
PIDs jeweils

Nov  1 13:56:51 mx01 postfix/smtpd[14257]: connect from
mxout2.volkswagen.de[194.114.62.48]
Nov  1 13:56:51 mx01 postfix/smtpd[14257]: warning: Connection concurrency
limit exceeded: 21 from mxout2.volkswagen.de[194.114.62.48] for service
smtp
Nov  1 13:56:51 mx01 postfix/smtpd[14257]: disconnect from
mxout2.volkswagen.de[194.114.62.48]
  [... Bildschirmseiten füllend nur noch diese Meldungen mit wechselnden
PIDs]
Nov  1 13:56:51 mx01 postfix/smtpd[14248]: connect from
mxout2.volkswagen.de[194.114.62.48]
Nov  1 13:56:51 mx01 postfix/smtpd[14248]: warning: Connection concurrency
limit exceeded: 21 from mxout2.volkswagen.de[194.114.62.48] for service
smtp
Nov  1 13:56:51 mx01 postfix/smtpd[14248]: disconnect from
mxout2.volkswagen.de[194.114.62.48]
(Ich habe `smtpd_client_connection_count_limit = 20' gesetzt in main.cf,
sodass nicht "erst" die 51. Verbindung abgelehnt wird)
____________________

Um den `timeout after END-OF-MESSAGE' zu begegnen, habe ich
`smtp_pix_workaround_maps = hash:/etc/postfix/smtp_pix_workaround' der
main.cf hinzugefügt.

mx01:/etc/postfix# cat smtp_pix_workaround
194.114.62.48   delay_dotcrlf,disable_esmtp

mx01:/etc/postfix# postmap smtp_pix_workaround
mx01:/etc/postfix# /etc/init.d/postfix restart

Leider hat dies nichts Mergliches geändert. :-(

Daher frage ich mich:

- "leidet" mxout2.volkswagen.de[194.114.62.48] an dem PIX-Bug?
- ist dann der Inhalt der `smtp_pix_workaround' richtig?
- Kann ich irgenwie erkennen, ob für Connection von mxout2 die
PIX-Bug-Work-a-rounds angewandt werden?
- gibt etwas entsprechend wie "smtpd_after_end_of_message_timeout"?
- Bin ich komplett auf dem falschem Dampfer??? und was dann?


Gruss und besten Dank!
Reza


P.S.: Wenn Volkswagen nicht Kunde von uns wäre, würde 94.114.62.48 ein
Eintrag im IP Packetflter erhalten und das Problem wäre gelöst ;-)

für die, die es genau wissen wollen, um zu helfen:
--------------------------------------------------
mx01:/etc/postfix# cat /proc/version
Linux version 2.6.18-4-686-bigmem (Debian 2.6.18.dfsg.1-12etch2)
(dannf at debian.org) (gcc version 4.1.2 20061115 (prerelease) (Debian
4.1.1-21)) #1 SMP Thu May 10 00:23:00 UTC 2007

mx01:/etc/postfix# dpkg -l postfix
[...]
||/ Name                                           Version                
                       Description
ii  postfix                                        2.3.8-2+b1             
                       A high-performance mail transport agent

...ganze System ist ein Debian up2date 'stable'-etch

mx01:/etc/postfix# netstat -tunpa | grep 194.114.62.48 | wc -l
20

typisches ATOP:
PRC | sys   0.02s | user   0.02s | #thr     115 | #zombie    0 | #exit    
 0 |
CPU | sys      0% | user      0% | irq       0% | idle    100% | wait     
0% |
MEM | tot    1.0G | free  422.7M | cache 230.3M | buff   55.2M | slab  
48.0M |
SWP | tot    2.0G | free    2.0G |              | vmcom   1.1G | vmlim  
2.5G |
DSK |         sda | busy      0% | read       0 | write     64 | avio    0
ms |
NET |   transport | tcpi     131 | tcpo     137 | udpi      23 | udpo     
23 |
NET |     network | ipi      154 | ipo      160 | ipfrw      0 | deliv   
154 |
NET | dev    eth0 | pcki     138 | pcko     139 | in   14 Kbps | out  15
Kbps |
NET | dev      lo | pcki      21 | pcko      21 | in    1 Kbps | out   1
Kbps |





Mehr Informationen über die Mailingliste Postfixbuch-users