Conversion to 7BIT required but not supported

Dino Edwards dino.edwards at mydirectmail.net
Sun Jan 5 14:59:55 CET 2020 

HI Damian,

> $interface_policy{'10021'} = 'FIRST';
> $interface_policy{'10025'} = 'SECOND'; $policy_bank{'FIRST'} = {
>   forward_method => 'smtp:[127.0.0.1]:10025', }; 
> $policy_bank{'SECOND'} = {
>   forward_method              => 'smtp:[127.0.0.1]:10026',
>   smtpd_discard_ehlo_keywords => ['8BITMIME'], };

I don't have any policy like that. The only one I have is one to bypass amavis altogether for certain senders but this particular sender is not affected with that policy:

$interface_policy{'10030'} = 'BYPASSALLCHECKS';
$policy_bank{'BYPASSALLCHECKS'} = { # mail from the pickup daemon
    log_level => 5,
    bypass_spam_checks_maps   => ['@whitelist_sender_maps'],  # don't spam-check this mail
    bypass_banned_checks_maps => ['@whitelist_sender_maps'],  # don't banned-check this mail
    bypass_header_checks_maps => ['@whitelist_sender_maps'],  # don't header-check this mail
    bypass_virus_checks_maps  => ['@whitelist_sender_maps'],  # don't virus-check this mail
};



> If that is not the case either, then a more complete log-snippet with $log_level 5 could help. There you will see a log line that looks like:

> Remote host presents itself as: [127.0.0.1], handles DSN, PIPELINING

> Please verify that 8BITMIME is indeed not listed there, when your issue occurs.

Here are logs with $log_level5:

Jan  5 08:39:40 smtp amavis[32190]: (32190-01) about to connect to smtp:[127.0.0.1]:10025, Pjqt83Ia4zs4 FWD from <someone at gmail.com> -> <dedwards at example.com>
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 <someone at gmail.com> -> <dedwards at example.com>,  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, <someone at gmail.com>
Jan  5 08:39:40 smtp amavis[32190]: (32190-01) lookup [spam_crediblefrom_dsn_cutoff_level_bysender] => undef, "someone at gmail.com" does not match
Jan  5 08:39:40 smtp amavis[32190]: (32190-01) dsn: . 550 MtaRejected <someone at gmail.com> -> <dedwards at example.com>: 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: <someone at gmail.com> -> <dedwards at example.com>
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 <someone at gmail.com>: 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, dedwards at example.com, 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] <someone at gmail.com> -> <dedwards at example.com>, quarantine: clean/P/Pjqt83Ia4zs4, Queue-ID: B7211623A7, Message-ID: <99680d7b-36ef-2790-9a4d-2832ac598379 at gmail.com>, 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

More information about the amavis-users mailing list