smtp timeout ramdomly with postfix and sasl

Sylvain
2013-02-12
2013-02-12
  • Sylvain
    Sylvain
    2013-02-12

    Hello,

    For my proxy server, I use Postfix (submission) with SASL for ldap authentication.

    Randomly, I can’t send messages: timeout from the client (thunderbird)

    This is my configuration:

    Red Hat enterprise linux 5.4 64bits

    Postfix 2.9.1

    Cyrus sasl 2.1.22

    I think that the problem is SASL, but I’m not sure.

    When the mail is not send, my log stops at “xsasl_cyrus_server_first: decoded initial response”

    This is my logs:

    First the log where the mail is send:

    Feb 1 09:41:19 frlusv128 postfix/smtpd[13455]: name_mask: all

    Feb 1 09:41:19 frlusv128 postfix/smtpd[13455]: inet_addr_local: configured 2 IPv4 addresses

    Feb 1 09:41:19 frlusv128 postfix/smtpd[13455]: inet_addr_local: configured 2 IPv6 addresses

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: process generation: 100 (100)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: mynetworks ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: mynetworks ~? fast_flush_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: mynetworks ~? mynetworks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? fast_flush_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? mynetworks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? permit_mx_backup_networks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? qmqpd_authorized_clients

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: relay_domains ~? relay_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: permit_mx_backup_networks ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: permit_mx_backup_networks ~? fast_flush_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: permit_mx_backup_networks ~? mynetworks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: permit_mx_backup_networks ~? permit_mx_backup_networks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_open: Using LDAP source /etc/postfix/ldap-mail-accounts

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: server_host = ldap1-prod

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: server_port = 389

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: version = 3

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_open: /etc/postfix/ldap-mail-accounts server_host URL is ldap://ldap1-prod:389

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: scope = sub

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: search_base = dc=vetoquinol

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: timeout = 10

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: query_filter = (&(objectClass=InetOrgPerson)(mail=%s))

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: result_format = <NULL>

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: result_filter = %s

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: domain =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: terminal_result_attribute =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: leaf_result_attribute =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: result_attribute = mail

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: special_result_attribute =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: bind = yes

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: bind_dn = cn=sogo,ou=special users,dc=vetoquinol

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: bind_pw = gr0upm41l

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_bool: /etc/postfix/ldap-mail-accounts: cache = off

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: cache_expiry = -1

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: cache_size = -1

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: recursion_limit = 1000

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: expansion_limit = 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: size_limit = 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: dereference = 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_bool: /etc/postfix/ldap-mail-accounts: chase_referrals = off

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_bool: /etc/postfix/ldap-mail-accounts: start_tls = off

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_bool: /etc/postfix/ldap-mail-accounts: tls_require_cert = off

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_ca_cert_file =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_ca_cert_dir =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_cert =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_key =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_random_file =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_str: /etc/postfix/ldap-mail-accounts: tls_cipher_suite =

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: cfg_get_int: /etc/postfix/ldap-mail-accounts: debuglevel = 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: dict_open: ldap:/etc/postfix/ldap-mail-accounts

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? fast_flush_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? mynetworks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? permit_mx_backup_networks

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? qmqpd_authorized_clients

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? relay_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: smtpd_access_maps ~? smtpd_access_maps

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: unknown_helo_hostname_tempfail_action = defer_if_permit

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: unknown_address_tempfail_action = defer_if_permit

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: unverified_recipient_tempfail_action = defer_if_permit

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: unverified_sender_tempfail_action = defer_if_permit

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: debug_peer_list ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: xsasl_cyrus_server_init: SASL config file is smtpd.conf

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: 1

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: auto_clnt_create: transport=local endpoint=private/tlsmgr

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: auto_clnt_open: connected to private/tlsmgr

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr request = seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr size = 32

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: gMlOWaIGKT7aP+2BrP84DGwKHUl1PURSNU/4IgJstuQ=

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: (list terminator)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: CVE-2005-2969

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: CVE-2010-4180

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr request = policy

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr cache_type = smtpd

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: cachable

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: cachable

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: (list terminator)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: fast_flush_domains ~? debug_peer_list

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_string: fast_flush_domains ~? fast_flush_domains

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: auto_clnt_create: transport=local endpoint=private/anvil

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: connection established

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: master_notify: status 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: resource

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: software

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: connect from unknown[80.11.121.186]

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? mydomain.com

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? mydomain.com

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: smtp_stream_setup: maxtime=300 enable_deadline=0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 127.0.0.0/8

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 127.0.0.0/8

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 192.168.0.128/25

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 192.168.0.128/25

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.17.0.0/16

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.17.0.0/16

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.16.0.0/16

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.16.0.0/16

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: auto_clnt_open: connected to private/anvil

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr request = connect

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr ident = submission:80.11.121.186

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: count

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: count

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 4

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: rate

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: rate

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 4

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: (list terminator)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 220 smtp.mytestdomain.org ESMTP Postfix

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: EHLO [192.168.1.45]

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-smtp.mytestdomain.org

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-PIPELINING

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-SIZE 6990506

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-VRFY

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-ETRN

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-STARTTLS

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-ENHANCEDSTATUSCODES

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-8BITMIME

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250 DSN

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: STARTTLS

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 220 2.0.0 Ready to start TLS

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr request = seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: send attr size = 32

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: seed

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute value: Kbzbj3R0gjCJnkWGzlfPja+PJn/YjmwxnzWzrrm0se8=

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: private/tlsmgr: wanted attribute: (list terminator)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: Anonymous TLS connection established from unknown[80.11.121.186]: TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: xsasl_cyrus_server_create: SASL service=smtp, realm=(null)

    Feb 1 09:41:19 frlusv128 postfix/submission/smtpd[13455]: name_mask: noanonymous

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: EHLO [192.168.1.45]

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-smtp.mytestdomain.org

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-PIPELINING

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-SIZE 6990506

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-VRFY

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-ETRN

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-AUTH LOGIN PLAIN

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-ENHANCEDSTATUSCODES

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250-8BITMIME

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250 DSN

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: AUTH PLAIN ADcwMDc2AFZUUTcwMDc2

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: xsasl_cyrus_server_first: sasl_method PLAIN, init_response ADcwMDc2AFZUUTcwMDc2

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: xsasl_cyrus_server_first: decoded initial response

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 235 2.7.0 Authentication successful

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: MAIL FROM:bill.bresil@mydomain.com SIZE=415

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: extract_addr: input: bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: smtpd_check_addr: addr=bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: connect to subsystem private/rewrite

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = rewrite

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr rule = local

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr address = bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: rewrite_clnt: local: bill.bresil@mydomain.com -> bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = resolve

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr sender =

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr address = bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: transport

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: transport

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: smtp

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: nexthop

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: nexthop

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 172.16.34.60

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: recipient

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: recipient

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 2048

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: resolve_clnt: ' ->bill.bresil@mydomain.com' -> transp=smtp' host=172.16.34.60' rcpt=`bill.bresil@mydomain.com' flags= class=relay

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: ctable_locate: install entry key bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: extract_addr: in: bill.bresil@mydomain.com, result: bill.bresil@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: smtpd_check_rewrite: trying: permit_inet_interfaces

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: permit_inet_interfaces: unknown 80.11.121.186

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: fsspace: .: block size 4096, blocks free 2319108

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: smtpd_check_queue: blocks 4096 avail 2319108 min_free 0 msg_size_limit 6990506

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250 2.1.0 Ok

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: RCPT TO:test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: extract_addr: input: test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: smtpd_check_addr: addr=test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = rewrite

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr rule = local

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr address = test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: rewrite_clnt: local: test@mydomain.com-> test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = resolve

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr sender =

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr address = test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: transport

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: transport

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: smtp

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: nexthop

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: nexthop

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 172.16.34.60

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: recipient

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: recipient

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 2048

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: resolve_clnt: ' ->test@mydomain.com' -> transp=smtp' host=172.16.34.60' rcpt=`test@mydomain.com' flags= class=relay

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: ctable_locate: install entry key test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: extract_addr: in: test@mydomain.com, result: test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = rewrite

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr rule = local

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr address = double-bounce

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: flags

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: address

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: double-bounce@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/rewrite socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: rewrite_clnt: local: double-bounce -> double-bounce@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: >>> START Client host RESTRICTIONS <<<

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_sasl_authenticated

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_sasl_authenticated status=1

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: >>> START Recipient address RESTRICTIONS <<<

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_mynetworks

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: permit_mynetworks: unknown 80.11.121.186

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 127.0.0.0/8

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 127.0.0.0/8

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 192.168.0.128/25

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 192.168.0.128/25

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.17.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.17.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.16.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.16.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_mynetworks status=0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_sasl_authenticated

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: generic_checks: name=permit_sasl_authenticated status=1

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: >>> CHECKING RECIPIENT MAPS <<<

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: ctable_locate: leave existing entry key test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: recipient_canonical_maps: test@mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: recipient_canonical_maps: test: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: recipient_canonical_maps: @mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: mail_addr_find: test@mydomain.com-> (not found)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: canonical_maps: test@mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: canonical_maps: test: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: canonical_maps: @mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: mail_addr_find: test@mydomain.com-> (not found)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: virtual_alias_maps: test@mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: virtual_alias_maps: test: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: virtual_alias_maps: @mydomain.com: not found

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: mail_addr_find: test@mydomain.com-> (not found)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_lookup: In dict_ldap_lookup

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_lookup: No existing connection for LDAP source /etc/postfix/ldap-mail-accounts, reopening

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_connect: Connecting to server ldap://ldap1-prod:389

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_connect: Actual Protocol version used is 3.

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_connect: Binding to server ldap://ldap1-prod:389 with dn cn=sogo,ou=special users,dc=vetoquinol

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_connect: Successful bind to server ldap://ldap1-prod:389 with dn cn=sogo,ou=special users,dc=vetoquinol

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_connect: Cached connection handle for LDAP source /etc/postfix/ldap-mail-accounts

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_lookup: /etc/postfix/ldap-mail-accounts: Searching with filter (&(objectClass=InetOrgPerson)(mail=test@mydomain.com))

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_get_values[1]: Search found 1 match(es)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_get_values[1]: search returned 1 value(s) for requested result attribute mail

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_get_values[1]: Leaving dict_ldap_get_values

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: dict_ldap_lookup: Search returned test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: maps_find: relay_recipient_maps: ldap:/etc/postfix/ldap-mail-accounts(0,lock|fold_fix): test@mydomain.com= test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: mail_addr_find: test@mydomain.com-> test@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: before input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping enable_milters

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: after input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: connect to subsystem public/cleanup

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: public/cleanup socket: wanted attribute: queue_id

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: queue_id

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 345A614004B

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: public/cleanup socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr flags = 178

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: 345A614004B: client=unknown[80.11.121.186], sasl_method=PLAIN, sasl_username=70076

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250 2.1.5 Ok

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: DATA

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 354 End data with <CR><LF>.<CR><LF>

    Feb 1 09:41:20 frlusv128 postfix/cleanup[13449]: 345A614004B: message-id=510B7FBC.1050203@mydomain.com

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: public/cleanup socket: wanted attribute: status

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: public/cleanup socket: wanted attribute: reason

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: reason

    Feb 1 09:41:20 frlusv128 postfix/qmgr[2375]: 345A614004B: from=bill.bresil@mydomain.com, size=609, nrcpt=1 (queue active)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: public/cleanup socket: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 250 2.0.0 Ok: queued as 345A614004B

    Feb 1 09:41:20 frlusv128 postfix/smtp[13450]: 345A614004B: to=test@mydomain.com, relay=172.16.34.60[172.16.34.60]:25, delay=0.24, delays=0.23/0/0/0, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 2AE5FFA47)

    Feb 1 09:41:20 frlusv128 postfix/qmgr[2375]: 345A614004B: removed

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: < unknown[80.11.121.186]: QUIT

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: > unknown[80.11.121.186]: 221 2.0.0 Bye

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 127.0.0.0/8

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 127.0.0.0/8

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 192.168.0.128/25

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 192.168.0.128/25

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.17.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.17.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostname: unknown ~? 172.16.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_hostaddr: 80.11.121.186 ~? 172.16.0.0/16

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: unknown: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr request = disconnect

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: send attr ident = submission:80.11.121.186

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: status

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: status

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute value: 0

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: private/anvil: wanted attribute: (list terminator)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: input attribute name: (end)

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: disconnect from unknown[80.11.121.186]

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: master_notify: status 1

    Feb 1 09:41:20 frlusv128 postfix/submission/smtpd[13455]: connection closed

    Feb 1 09:41:23 frlusv128 perdition[13456]: Connect: 80.11.121.186->192.168.0.142

    Feb 1 09:41:24 frlusv128 perdition[13456]: Auth: 80.11.121.186->192.168.0.142 user="70076" passwd="XXXXXX" server="imap1" port="993" status="ok"

    Feb 1 09:41:24 frlusv128 postfix/submission/smtpd[13455]: auto_clnt_close: disconnect private/tlsmgr stream

    Feb 1 09:41:25 frlusv128 postfix/submission/smtpd[13455]: rewrite stream disconnect

    Feb 1 09:41:30 frlusv128 perdition[13452]: Close: 80.11.121.186->192.168.0.142 user="70076" received=930 sent=125

    Feb 1 09:41:30 frlusv128 perdition[13451]: Close: 80.11.121.186->192.168.0.142 user="70076" received=358 sent=2099

    Feb 1 09:41:30 frlusv128 perdition[12769]: Close: 80.11.121.186->192.168.0.142 user="70076" received=341 sent=1142

    Feb 1 09:41:30 frlusv128 perdition[13456]: Close: 80.11.121.186->192.168.0.142 user="70076" received=262 sent=2436

    The second log : the mail is not send (timeout)

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: connection established

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: master_notify: status 0

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: name_mask: resource

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: name_mask: software

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: connect from unknown[80.11.121.186]

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostname: unknown ~? mydomain.com

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostaddr: 80.11.121.186 ~? mydomain.com

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: smtp_stream_setup: maxtime=300 enable_deadline=0

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostname: unknown ~? 127.0.0.0/8

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostaddr: 80.11.121.186 ~? 127.0.0.0/8

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostname: unknown ~? 192.168.0.128/25

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostaddr: 80.11.121.186 ~? 192.168.0.128/25

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostname: unknown ~? 172.17.0.0/16

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostaddr: 80.11.121.186 ~? 172.17.0.0/16

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostname: unknown ~? 172.16.0.0/16

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_hostaddr: 80.11.121.186 ~? 172.16.0.0/16

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: send attr request = connect

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: send attr ident = submission:80.11.121.186

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: private/anvil: wanted attribute: status

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute name: status

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute value: 0

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: private/anvil: wanted attribute: count

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute name: count

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute value: 3

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: private/anvil: wanted attribute: rate

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute name: rate

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute value: 3

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: private/anvil: wanted attribute: (list terminator)

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: input attribute name: (end)

    Feb 1 09:41:07 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 220 smtp.mytestdomain.org ESMTP Postfix

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: < unknown[80.11.121.186]: EHLO [192.168.1.45]

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-smtp.mytestdomain.org

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-PIPELINING

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-SIZE 6990506

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-VRFY

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-ETRN

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-STARTTLS

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-ENHANCEDSTATUSCODES

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-8BITMIME

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250 DSN

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: < unknown[80.11.121.186]: STARTTLS

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 220 2.0.0 Ready to start TLS

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: auto_clnt_open: connected to private/tlsmgr

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: send attr request = seed

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: send attr size = 32

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: private/tlsmgr: wanted attribute: status

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: input attribute name: status

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: input attribute value: 0

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: private/tlsmgr: wanted attribute: seed

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: input attribute name: seed

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: input attribute value: x/OFRk3I7CHsTJ6k2HHcmCp9FZ+ytRQVVe0n4d+Fkkg=

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: private/tlsmgr: wanted attribute: (list terminator)

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: input attribute name: (end)

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: Anonymous TLS connection established from unknown[80.11.121.186]: TLSv1 with cipher DHE-RSA-AES256-SHA (256/256 bits)

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: xsasl_cyrus_server_create: SASL service=smtp, realm=(null)

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: name_mask: noanonymous

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: < unknown[80.11.121.186]: EHLO [192.168.1.45]

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: match_list_match: unknown: no match

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: match_list_match: 80.11.121.186: no match

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-smtp.mytestdomain.org

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-PIPELINING

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-SIZE 6990506

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-VRFY

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-ETRN

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-AUTH LOGIN PLAIN

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-ENHANCEDSTATUSCODES

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250-8BITMIME

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: > unknown[80.11.121.186]: 250 DSN

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: < unknown[80.11.121.186]: AUTH PLAIN ADcwMDc2AFZUUTcwMDc2

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: xsasl_cyrus_server_first: sasl_method PLAIN, init_response ADcwMDc2AFZUUTcwMDc2

    Feb 1 09:41:08 frlusv128 postfix/submission/smtpd[13447]: xsasl_cyrus_server_first: decoded initial response

    Many thanks in advance for your help.

    Sylvain.