rkslinux
(usa Debian)
Enviado em 25/05/2013 - 12:19h
Esse erro é muito estranho, pois ele fala que entregou a mensagem, mas depois de algum tempo, aparece a mensagem "status=deferred (host mx3.bol.com.br[200.147.36.13] said: 421 4.4.2 a2-silver16.bol.com.br Error: timeout exceeded (in reply to end of DATA command))". A minha máquina em uma DMZ, trabalhando com SplitDNS. O meu problema está só no envio de e-mail, pois consigo receber e-mails de qualquer domínio, sem problemas. Preciso criar alguma regra especial, pelo fato de estar usando a porta de submissão 587?
May 25 12:02:48 mail saslauthd[17893]: zmauth: authenticating against elected url 'https://mail.dominio.com.br:7071/service/admin/soap/' ...
May 25 12:02:48 mail saslauthd[17893]: zmpost: url='https://mail.dominio.com.br:7071/service/admin/soap/' returned buffer->data='<soap:Envelope xmlns:soap="http://www.w3.org/2003/05/soap-envelope"><soap:Header><context xmlns="urn:zimbra"><change token="9825"/></context></soap:Header><soap:Body><AuthResponse xmlns="urn:zimbraAccount"><authToken>0_0c4530b05da9c80230931ae67a2326b692fec2fa_69643d33363a36316539326136612d366431362d346562382d613665302d6637393766373662353537313b6578703d31333a313336393636363936383830363b747970653d363a7a696d6272613b</authToken><lifetime>172800000</lifetime><skin>serenity</skin></AuthResponse></soap:Body></soap:Envelope>', hti->error=''
May 25 12:02:48 mail saslauthd[17893]: auth_zimbra: robson@dominio.com.br auth OK
May 25 12:02:48 mail postfix/submission/smtpd[28295]: NOQUEUE: filter: RCPT from 189-69-248-130.dial-up.telesp.net.br[189.69.248.130]: <robson@dominio.com.br>: Sender address triggers FILTER smtp-amavis:[127.0.0.1]:10026; from=<robson@dominio.com.br> to=<robson.o.santos@bol.com.br> proto=ESMTP helo=<[192.168.1.36]>
May 25 12:02:48 mail postfix/submission/smtpd[28295]: CD05C161434: client=189-69-248-130.dial-up.telesp.net.br[189.69.248.130], sasl_method=PLAIN, sasl_username=robson@dominio.com.br
May 25 12:02:48 mail postfix/cleanup[28296]: CD05C161434: message-id=<51A0D295.9070506@dominio.com.br>
May 25 12:02:48 mail postfix/qmgr[17885]: CD05C161434: from=<robson@dominio.com.br>, size=634, nrcpt=1 (queue active)
May 25 12:02:48 mail amavis[17491]: (17491-06) ESMTP:[127.0.0.1]:10026 /opt/zimbra/data/amavisd/tmp/amavis-20130525T055340-17491-uH6RbXQ1: <robson@dominio.com.br> -> <robson.o.santos@bol.com.br> Received: from mail.mipc.com.br ([127.0.0.1]) by localhost (mail.dominio.com.br [127.0.0.1]) (amavisd-new, port 10026) with ESMTP for <robson.o.santos@bol.com.br>; Sat, 25 May 2013 12:02:48 -0300 (BRT)
May 25 12:02:48 mail amavis[17491]: (17491-06) Checking: apTlS0FpsjE2 ORIGINATING [189.69.248.130] <robson@dominio.com.br> -> <robson.o.santos@bol.com.br>
May 25 12:02:48 mail postfix/submission/smtpd[28295]: disconnect from 189-69-248-130.dial-up.telesp.net.br[189.69.248.130]
May 25 12:02:48 mail postfix/dkimmilter/smtpd[28300]: connect from localhost.localdomain[127.0.0.1]
May 25 12:02:48 mail postfix/dkimmilter/smtpd[28300]: F3972161436: client=localhost.localdomain[127.0.0.1]
May 25 12:02:49 mail postfix/cleanup[28296]: F3972161436: message-id=<51A0D295.9070506@dominio.com.br>
May 25 12:02:49 mail opendkim[17904]: F3972161436: no signing table match for 'robson@dominio.com.br'
May 25 12:02:49 mail postfix/qmgr[17885]: F3972161436: from=<robson@dominio.com.br>, size=1129, nrcpt=1 (queue active)
May 25 12:02:49 mail postfix/dkimmilter/smtpd[28300]: disconnect from localhost.localdomain[127.0.0.1]
May 25 12:02:49 mail amavis[17491]: (17491-06) FWD from <robson@dominio.com.br> -> <robson.o.santos@bol.com.br>,BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10030): 250 2.0.0 Ok: queued as F3972161436
May 25 12:02:49 mail amavis[17491]: (17491-06) Passed CLEAN {RelayedOutbound}, ORIGINATING LOCAL [189.69.248.130]:20842 [189.69.248.130] <robson@mipc.com.br> -> <robson.o.santos@bol.com.br>, Queue-ID: CD05C161434, Message-ID: <51A0D295.9070506@dominio.com.br>, mail_id: apTlS0FpsjE2, Hits: -, size: 634, queued_as: F3972161436, 147 ms
May 25 12:02:49 mail postfix/smtp[28297]: CD05C161434: to=<robson.o.santos@bol.com.br>, relay=127.0.0.1[127.0.0.1]:10026, delay=0.23, delays=0.08/0.01/0/0.14, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10030): 250 2.0.0 Ok: queued as F3972161436)
May 25 12:02:49 mail postfix/qmgr[17885]: CD05C161434: removed
May 25 12:02:49 mail amavis[17494]: (17494-05) ESMTP:[127.0.0.1]:10032 /opt/zimbra/data/amavisd/tmp/amavis-20130525T055415-17494-lDXz64iX: <robson@mipc.com.br> -> <robson.o.santos@bol.com.br> SIZE=1129 Received: from mail.dominio.com.br ([127.0.0.1]) by localhost (mail.dominio.com.br [127.0.0.1]) (amavisd-new, port 10032) with ESMTP for <robson.o.santos@bol.com.br>; Sat, 25 May 2013 12:02:49 -0300 (BRT)
May 25 12:02:49 mail amavis[17494]: (17494-05) Checking: Gn-MSQ9_ExhC ORIGINATING_POST/MYNETS [127.0.0.1] <robson@dominio.com.br> -> <robson.o.santos@bol.com.br>
May 25 12:02:49 mail postfix/amavisd/smtpd[28304]: connect from localhost.localdomain[127.0.0.1]
May 25 12:02:49 mail postfix/amavisd/smtpd[28304]: 56144161434: client=localhost.localdomain[127.0.0.1]
May 25 12:02:49 mail postfix/cleanup[28296]: 56144161434: message-id=<51A0D295.9070506@dominio.com.br>
May 25 12:02:49 mail postfix/amavisd/smtpd[28304]: disconnect from localhost.localdomain[127.0.0.1]
May 25 12:02:49 mail postfix/qmgr[17885]: 56144161434: from=<robson@dominio.com.br>, size=1511, nrcpt=1 (queue active)
May 25 12:02:49 mail amavis[17494]: (17494-05) FWD from <robson@mipc.com.br> -> <robson.o.santos@bol.com.br>,BODY=7BIT 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 56144161434
May 25 12:02:49 mail amavis[17494]: (17494-05) Passed CLEAN {RelayedOutbound}, ORIGINATING_POST/MYNETS LOCAL [127.0.0.1]:51805 [189.69.248.130] <robson@dominio.com.br> -> <robson.o.santos@bol.com.br>, Queue-ID: F3972161436, Message-ID: <51A0D295.9070506@dominio.com.br>, mail_id: Gn-MSQ9_ExhC, Hits: 2.56, size: 1095, queued_as: 56144161434, 315 ms
May 25 12:02:49 mail postfix/smtp[28302]: F3972161436: to=<robson.o.santos@bol.com.br>, relay=127.0.0.1[127.0.0.1]:10032, delay=0.37, delays=0.05/0.01/0/0.31, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 56144161434)
May 25 12:02:49 mail postfix/qmgr[17885]: F3972161436: removed
May 25 12:02:52 mail zmconfigd[15604]: Fetching All configs
May 25 12:02:52 mail zmconfigd[15604]: All configs fetched in 0.03 seconds
May 25 12:02:53 mail zmconfigd[15604]: Watchdog: service antivirus status is OK.
May 25 12:02:53 mail zmconfigd[15604]: All rewrite threads completed in 0.00 sec
May 25 12:02:53 mail zmconfigd[15604]: All restarts completed in 0.00 sec
May 25 12:02:57 mail postfix/smtpd[13518]: connect from pmta-vmta19.zcolo.com.br[177.126.168.160]
May 25 12:02:57 mail postfix/smtpd[13518]: NOQUEUE: filter: RCPT from pmta-vmta19.zcolo.com.br[177.126.168.160]: <server08@midiamailmkt.com.br>: Sender address triggers FILTER smtp-amavis:[127.0.0.1]:10026; from=<server08@midiamailmkt.com.br> to=<rui@dominio.com.br> proto=ESMTP helo=<pmta-vmta19.zcolo.com.br>
May 25 12:02:57 mail postfix/smtpd[13518]: NOQUEUE: filter: RCPT from pmta-vmta19.zcolo.com.br[177.126.168.160]: <server08@midiamailmkt.com.br>: Sender address triggers FILTER smtp-amavis:[127.0.0.1]:10024; from=<server08@midiamailmkt.com.br> to=<rui@dominio.com.br> proto=ESMTP helo=<pmta-vmta19.zcolo.com.br>
May 25 12:02:57 mail postfix/smtpd[13518]: NOQUEUE: reject: RCPT from pmta-vmta19.zcolo.com.br[177.126.168.160]: 450 4.1.8 <server08@midiamailmkt.com.br>: Sender address rejected: Domain not found; from=<server08@midiamailmkt.com.br> to=<rui@dominio.com.br> proto=ESMTP helo=<pmta-vmta19.zcolo.com.br>
May 25 12:02:57 mail postfix/smtpd[13518]: disconnect from pmta-vmta19.zcolo.com.br[177.126.168.160]
May 25 12:03:18 mail postfix/smtp[28274]: B6E951613C1: to=<robson.o.santos@bol.com.br>, relay=mx3.bol.com.br[200.147.36.13]:25, delay=26671, delays=26611/0.01/0.02/60, dsn=4.4.2, status=deferred (host mx3.bol.com.br[200.147.36.13] said: 421 4.4.2 a2-silver13.bol.com.br Error: timeout exceeded (in reply to end of DATA command))
May 25 12:03:18 mail postfix/smtp[28275]: B4F6F161425: to=<robson.o.santos@bol.com.br>, relay=mx3.bol.com.br[200.147.36.13]:25, delay=4682, delays=4622/0.01/0.02/60, dsn=4.4.2, status=deferred (host mx3.bol.com.br[200.147.36.13] said: 421 4.4.2 a2-silver13.bol.com.br Error: timeout exceeded (in reply to end of DATA command))
May 25 12:03:18 mail postfix/smtp[28276]: BD14D161429: to=<robson.o.santos@bol.com.br>, relay=mx3.bol.com.br[200.147.36.13]:25, delay=26671, delays=26611/0.01/0.05/60, dsn=4.4.2, status=deferred (host mx3.bol.com.br[200.147.36.13] said: 421 4.4.2 a2-silver16.bol.com.br Error: timeout exceeded (in reply to end of DATA command))
E-mail recebido:
May 25 12:15:04 mail postfix/qmgr[17885]: 36DAE161437: from=<robson.o.santos@bol.com.br>, size=2568, nrcpt=1 (queue active)
May 25 12:15:04 mail amavis[17491]: (17491-07) FWD from <robson.o.santos@bol.com.br> -> <robson@dominio.com.br>, 250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 36DAE161437
May 25 12:15:04 mail postfix/amavisd/smtpd[2502]: disconnect from localhost.localdomain[127.0.0.1]
May 25 12:15:04 mail postfix/lmtp[2503]: connect to mail.dominio.com.br[xxx.xxx.209.57]:7025: Connection refused
May 25 12:15:04 mail amavis[17491]: (17491-07) Passed CLEAN {RelayedInbound}, [200.147.97.216]:32837 [200.147.97.216] <robson.o.santos@bol.com.br> -> <robson@dominio.com.br>, Queue-ID: 2DC27161435, Message-ID: <51a0d56c28e23_2864dd2046c1c@a4-winter10.tmail>, mail_id: LmZ0h35_zxmF, Hits: 3.954, size: 1515, queued_as: 36DAE161437, dkim_sd=afl:bol.com.br, 6035 ms
May 25 12:15:04 mail postfix/smtp[2493]: 2DC27161435: to=<robson@dominio.com.br>, relay=127.0.0.1[127.0.0.1]:10024, delay=11, delays=4.8/0/0/6, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 36DAE161437)
May 25 12:15:04 mail postfix/qmgr[17885]: 2DC27161435: removed
May 25 12:15:04 mail postfix/lmtp[2503]: 36DAE161437: to=<robson@dominio.com.br>, relay=mail.dominio.com.br[172.16.1.100]:7025, delay=0.09, delays=0.01/0.01/0/0.07, dsn=2.1.5, status=sent (250 2.1.5 Delivery OK)