Hi,

It seems I'm having an issue with James SMTP not announcing 8BITMIME. Seeing 
the following error in mail.log on certain emails:


dsn: . 550 MtaRejected <[email protected]<mailto:[email protected]>> -> 
<[email protected]<mailto:[email protected]>>: on_succ=0, on_dly=1, 
on_fail=1, never=0, warn_sender=, DSN_passed_on=0, destiny=-3, mta_resp: "550 
5.6.3 id=02074-04 - Rejected by next-hop MTA on relaying, Conversion to 7BIT 
required but not supported"



This particular log entry seems to culprit:



Jan  5 08:39:40 smtp amavis[32190]: (32190-01) (!)requested BODY type is 
8BITMIME, but MTA does not announce 8bit-MIMEtransport capability



Here's the log in its entirety. James is listening on port 10025:



Jan  5 08:39:40 smtp amavis[32190]: (32190-01) about to connect to 
smtp:[127.0.0.1]:10025, Pjqt83Ia4zs4 FWD from <[email protected]> -> 
<[email protected]>

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline fwd_init - deadline 
in 478.5 s, set to 479.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp session: setting up a new 
session

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) establish_or_refresh, state: down

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) new socket using IO::Socket::IP 
to [127.0.0.1]:10025, timeout 35

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) connected to [127.0.0.1]:10025 
successfully

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=0, timeout=35

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: receiving

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop read 67 chars< 220 smtp 
SMTP Server ready Sun, 5 Jan 2020 08:39:40 -0500 (EST)\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp greeting: 220 smtp SMTP 
Server ready Sun, 5 Jan 2020 08:39:40 -0500 (EST), dt: 2.7 ms

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp cmd> EHLO localhost

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=0, flush=1, 
wr=1, timeout=300

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: sending 16 chars

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop sent 16> EHLO 
localhost\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=0, timeout=300

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: receiving

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop read 52 chars< 250-smtp 
Hello localhost (localhost [127.0.0.1])\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=0, timeout=300

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: receiving

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop read 65 chars< 
250-PIPELINING\r\n250-ENHANCEDSTATUSCODES\r\n250 XFORWARD NAME ADDR\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp resp to EHLO: 250 smtp 
Hello localhost (localhost 
[127.0.0.1])\nPIPELINING\nENHANCEDSTATUSCODES\nXFORWARD NAME ADDR

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) tls active=0, capable=, 
sec_level=0

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) Remote host presents itself as: 
smtp Hello localhost (localhost [127.0.0.1]), handles PIPELINING

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp cmd> XFORWARD 
ADDR=209.85.222.174 NAME=mail-qk1-f174.google.com

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=0, flush=1, 
wr=1, timeout=300

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: sending 60 chars

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop sent 60> XFORWARD 
ADDR=209.85.222.174 NAME=mail-qk1-f174.google.com\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=0, timeout=300

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: receiving

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop read 8 chars< 250 Ok\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp resp to XFORWARD: 250 Ok

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) AUTH not needed, user='', MTA 
offers ''

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) (!)requested BODY type is 
8BITMIME, but MTA does not announce 8bit-MIMEtransport capability

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) no valid recipients, skip data 
transfer

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp cmd> RSET

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=1, timeout=20

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: sending 6 chars

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop sent 6> RSET\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: needline=1, flush=0, 
wr=0, timeout=20

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop: receiving

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) rw_loop read 14 chars< 250 2.0.0 
OK\r\n

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) smtp resp to RSET: 250 2.0.0 OK

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) Amavis::Out::SMTP::Session 
close, keeping connection

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline fwd-end-chkpnt - 
deadline in 478.5 s, set to 288.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) prolong_timer fwd-end-chkpnt: 
timer 288, was 0, deadline in 478.5 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) (!)Pjqt83Ia4zs4 FWD from 
<[email protected]> -> <[email protected]>,  550 5.6.3 Conversion to 7BIT 
required but not supported

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline forwarding - 
deadline in 478.5 s, set to 288.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) prolong_timer forwarding: timer 
288, was 288, deadline in 478.5 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) DSN: sender is credible (dkim), 
SA: 0.501, <[email protected]>

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) lookup 
[spam_crediblefrom_dsn_cutoff_level_bysender] => undef, "[email protected]" 
does not match

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) dsn: . 550 MtaRejected 
<[email protected]> -> <[email protected]>: on_succ=0, on_dly=1, on_fail=1, 
never=0, warn_sender=, DSN_passed_on=0, destiny=-3, mta_resp: "550 5.6.3 
id=32190-01 - Rejected by next-hop MTA on relaying, Conversion to 7BIT required 
but not supported"

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) DSN: FAIL . 550 MtaRejected, 
status propagated back: <[email protected]> -> <[email protected]>

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) delivery_status_notification: 
notif 0 bytes, suppressed: no

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) one_response_for_all, 
per_recip_capable: N, suppressed: N

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) one_response_for_all 
<[email protected]>: REJECTs, '550 5.6.3 id=32190-01 - Rejected by next-hop MTA 
on relaying, Conversion to 7BIT required but not supported'

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) notif=N, suppressed=0, 
ndn_needed=, exit=69, 550 5.6.3 id=32190-01 - Rejected by next-hop MTA on 
relaying, Conversion to 7BIT required but not supported

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline 
delivery-notification - deadline in 478.5 s, set to 288.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) prolong_timer 
delivery-notification: timer 288, was 288, deadline in 478.5 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) status counters: 
InMsgsStatus{Rejected,RejectedInbound}

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline snmp-counters - 
deadline in 478.5 s, set to 288.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) prolong_timer snmp-counters: 
timer 288, was 288, deadline in 478.5 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) orcpt_encode rfc822, 
[email protected], smtputf8

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) 
oldest_public_ip_addr_from_received: 75.XXX.XXX.XXX

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) Blocked MTA-BLOCKED 
{RejectedInbound,Quarantined}, [209.85.222.174]:43156 [75.XXX.XXX.XXX] 
<[email protected]> -> <[email protected]>, quarantine: 
clean/P/Pjqt83Ia4zs4, Queue-ID: B7211623A7, Message-ID: 
<[email protected]>, mail_id: Pjqt83Ia4zs4, Hits: 
0.501, size: 4464, dkim_sd=20161025:gmail.com, 1571 ms

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) get_deadline main_log_entry - 
deadline in 478.5 s, set to 288.000 s

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) prolong_timer main_log_entry: 
timer 288, was 288, deadline in 478.5 s



Thanks!

_______________________________________________
Users mailing list
[email protected]
https://lists.ciphermail.com/mailman/listinfo/users

Reply via email to