Matus:
cat /var/log/mail.log |grep "4Hth4H05w6z20nfj"
Nov 16 10:45:03 thebe4 postfix/smtpd[21880]: 4Hth4H05w6z20nfj:
client=s2b.hekko.net.pl[195.78.66.142]
Nov 16 10:45:03 thebe4 postfix/cleanup[23606]: 4Hth4H05w6z20nfj:
message-id=<3dd29e4f-f107-67f0-2331-3219fd752...@pendragon.pl>
Nov 16 10:45:03 thebe4 postfix/cleanup[23606]: 4Hth4H05w6z20nfj:
warning: header Subject:
=?UTF-8?Q?Re=3a_Naro=c5=bcnik_drzwi_6543_PL/21?= from
s2b.hekko.net.pl[195.78.66.142]; from=<ser...@pendragon.pl>
to=<robertbr...@alufire.pl> proto=ESMTP helo=<s2b.hekko.net.pl>
Nov 16 10:45:03 thebe4 postfix/qmgr[18808]: 4Hth4H05w6z20nfj:
from=<ser...@pendragon.pl>, size=258293, nrcpt=1 (queue active)
Nov 16 10:45:08 thebe4 postfix/smtp[19395]: 4Hth4H05w6z20nfj:
to=<robertbr...@alufire.pl>, relay=127.0.0.1[127.0.0.1]:10628,
delay=5.3, delays=0.65/0.16/0/4.5, dsn=4.4.2, status=deferred (host
127.0.0.1[127.0.0.1] said: 421 4.4.2 id=13177-06 - Temporary MTA failure
on relaying, from MTA(smtp:[86.xxx.xxx.199]:10027): 421 4.4.2
thebe4.ccccc.pl Error: timeout exceeded (in reply to end of DATA command))
Nov 16 10:45:51 thebe4 postfix/qmgr[18808]: 4Hth4H05w6z20nfj:
from=<ser...@pendragon.pl>, size=258293, nrcpt=1 (queue active)
Nov 16 10:45:55 thebe4 postfix/smtp[19425]: 4Hth4H05w6z20nfj:
to=<cccc...@domain.pl>, relay=127.0.0.1[127.0.0.1]:10628, delay=53,
delays=49/0/0/4.1, dsn=2.0.0, status=sent (250 2.0.0 from
MTA(smtp:[86.xxx.2xxx.199]:10027): 250 2.0.0 Ok: queued as 4Hth5H45t3z20nW6)
Nov 16 10:45:55 thebe4 postfix/qmgr[18808]: 4Hth4H05w6z20nfj: removed
cat /var/log/mail.log |grep "4Hth5H45t3z20nW6"
Nov 16 10:45:55 thebe4 postfix/filtered/smtpd[23352]: 4Hth5H45t3z20nW6:
client=unknown[86.xxx.xxx.125] - one of amavis
Nov 16 10:45:55 thebe4 postfix/cleanup[24165]: 4Hth5H45t3z20nW6:
message-id=<3dd29e4f-f107-67f0-2331-3219fd752...@pendragon.pl>
Nov 16 10:45:55 thebe4 postfix/qmgr[18808]: 4Hth5H45t3z20nW6:
from=<ser...@pendragon.pl>, size=258865, nrcpt=1 (queue active)
Nov 16 10:45:55 thebe4 postfix/lmtp[23876]: 4Hth5H45t3z20nW6:
to=<cc...@domain.pl>, relay=10.0.100.5[10.0.100.5]:24, delay=0.33,
delays=0.25/0/0/0.07, dsn=2.0.0, status=sent (250 2.0.0
<robertbr...@alufire.pl> gF20MdN9k2H3KgAA5fQimA Saved)
Nov 16 10:45:55 thebe4 postfix/qmgr[18808]: 4Hth5H45t3z20nW6: removed
10.0.100.5 - this is this local ip (in thebe4) for lmtp to dovecot
On 16.11.2021 10:41, natan wrote:
> On 16.11.2021 10:22, Matus UHLAR - fantomas wrote:
>> On 16.11.21 10:06, natan wrote:
>>> I need some help about uderstand log:
>>>
>>> I have
>>> FILTER smtp-amavis:[127.0.0.1]:10628
>> you have this where?
> in master.cf:
>
> smtp-amavis unix - - - - 140 smtp
> -o smtp_data_done_timeout=6000s
> -o smtp_send_xforward_command=yes
> -o disable_dns_lookups=yes
>
> (in amavis I have 145)
>>> this is local haproxy where connect postfix to port 10628 like:
>>>
>>> ...
>>> bind 127.0.0.1:10628
>>>
>>> server amavis1 86.xxx.xxx.125:10628 check maxconn
>>> server amavis2 86.xxx.xxx.155:10628 check maxconn
>>> server amavis3 86.xxx.xxx.234:10628 check maxconn
>>>
>>> and come back from amavis to postfix is like
>>>
>>> 86.xxx.xxx.199:10027 inet n - n - 140 smtpd
>>> -o smtpd_proxy_timeout=900s
>>> -o content_filter=
>>> -o mynetworks_style=host
>>> -o
>>> mynetworks=10.0.100.0/24,86.xxx.xxx.199/32,46.xxx.xxx.98/32,86.xxx.xxx.159/32,86.xxx.xxx.125/32,86.xxx.xxx.155/32,86.xxx.xxx.234/32
>>>
>> I recommend adding something like
>> -o syslog_name=postfix/filtered
> I added but nothing
>
> But in amavis I found:
>
> Nov 16 10:32:17 amavis1 amavis[1501]: (01501-06) smtp resp to MAIL
> (pip): 421 4.4.2 thebe4.domain.pl Error: timeout exceeded
> Nov 16 10:32:17 amavis1 amavis[1501]: (01501-06) mail_via_smtp: session
> failed: No response to RCPT (pip) (<zdzpl...@zdz.gda.pl>), dt: 0.000 s
> Nov 16 10:32:17 amavis1 amavis[1501]: (01501-06) (!)mail_via_smtp:
> NOTICE: aborting SMTP session, No response to RCPT (pip)
> (<zdzpl...@zdz.gda.pl>), dt: 0.000 s
> Nov 16 10:32:17 amavis1 amavis[1501]: (01501-06) (!)U9YOHznNngXZ FWD
> from
> <sm.6286645179.rsezoc459uie1e2p05-mailing=expert4you...@emlgrid.com> ->
> <zdzpl...@zdz.gda.pl>, BODY=7BIT 451 4.5.0 From
> MTA(smtp:[86.xxx.xxx.199]:10027) during fwd-rcpt-pip (No response to
> RCPT (pip) (<zdzpl...@zdz.gda.pl>), dt: 0.000 s): id=01501-06
> Nov 16 10:32:17 amavis1 amavis[1501]: (01501-06) Blocked MTA-BLOCKED
> {TempFailedInbound}, [91.227.202.170]:1909 [91.227.202.170]
> <sm.6286645179.rsezoc459uie1e2p05-mailing=expert4you...@emlgrid.com> ->
> <zdzpl...@zdz.gda.pl>, Queue-ID: 4HtgnT4F6Gz20nSb, Message-ID:
> <6286645179.55132991@emlgrid.com6286645179>, mail_id: U9YOHznNngXZ,
> Hits: 109.953, size: 160692, dkim_sd=salesmanago:expert4you.pl, 4099 ms
>
>
> Is problem postfix to amavis - but I dont known where
>> to see clearly when the mail comes from your content filter.
>>
>>> Some times I get in logs "Temporary MTA failure on relaying" and I dont
>>> known where is problem
>>> 1)in postfix ?
>>> 2)in amavis ?
>>> beacuse is to cleary for me
>>>
>>> log:
>>> Nov 16 09:45:59 thebe4 postfix/smtpd[476]: 4Htfm74ZJCz20nZL:
>>> client=mail.firmshop.pl[80.211.143.207]
>>> Nov 16 09:45:59 thebe4 postfix/cleanup[800]: 4Htfm74ZJCz20nZL:
>>> message-id=<20211116074501-0.1.53.wynw.0.3c4546q...@firmshop.pl>
>>> Nov 16 09:45:59 thebe4 postfix/cleanup[800]: 4Htfm74ZJCz20nZL: warning:
>>> header Subject: Fotowoltaika- propozycja instalacji from
>>> mail.firmshop.pl[80.211.143.207]; from=<cc...@fdomain.pl>
>>> to=<x...@xxxx.ltd> proto=ESMTP helo=<mail.firmshop.pl>
>>> Nov 16 09:45:59 thebe4 postfix/qmgr[21807]: 4Htfm74ZJCz20nZL:
>>> from=<krystian.os...@firmshop.pl>, size=2367, nrcpt=1 (queue active)
>>>
>>> Nov 16 09:46:03 thebe4 postfix/smtp[25808]: 4Htfm74ZJCz20nZL:
>>> to=<x...@xxxx.ltd>, relay=127.0.0.1[127.0.0.1]:10628, delay=4.1,
>>> delays=0.19/0/0/3.9, dsn=4.4.2, status=deferred (host
>>> 127.0.0.1[127.0.0.1] said: 421 4.4.2 id=25846-08 - Temporary MTA failure
>>> on relaying, from MTA(smtp:[86.xxx.xxx.199]:10027): 421 4.4.2
>>> thebe4.domain.ltd Error: timeout exceeded (in reply to end of DATA
>>> command))
>> looks like your incoming smtpd on port 10027 said this to content_filter
>> which further said this to your postfix.
>>
>> however, I don't see where your postfix [86.xxx.xxx.199]:10027
>> rejected the
>> mail. You should have that in logs, and if you do what I recommended
>> above,
>> you'll see those errors in log under name "postfix/filtered/smtpd"
>>
>>> Nov 16 09:50:24 thebe4 postfix/qmgr[4959]: 4Htfm74ZJCz20nZL:
>>> from=<krystian.os...@firmshop.pl>, size=2367, nrcpt=1 (queue active)
>>> Nov 16 09:50:31 thebe4 postfix/smtp[5087]: 4Htfm74ZJCz20nZL:
>>> to=<ku...@saletyni.pl>, relay=127.0.0.1[127.0.0.1]:10628, delay=272,
>>> delays=265/3.9/0/2.6, dsn=2.0.0, status=sent (250 2.0.0 from
>>> MTA(smtp:[86.xxx.xxx.199]:10027): 250 2.0.0 Ok: queued as
>>> 4HtfsM1LTZz20nWG)
>>> Nov 16 09:50:31 thebe4 postfix/qmgr[4959]: 4Htfm74ZJCz20nZL: removed
>> after retry the mail went well.
>>
>>
>>
>>
> --
>
--
