1

Добрый день.

Настраиваю postfix+ Dovecot + AD (Samba4)
OS CentOS 6.5

postconf -n

 postconf -n
alias_database = hash:/etc/aliases
alias_maps = hash:/etc/aliases
broken_sasl_auth_clients = yes
config_directory = /etc/postfix
content_filter = scan:127.0.0.1:10025
daemon_directory = /usr/libexec/postfix
debug_peer_level = 2
debug_peer_list = 127.0.0.1
default_privs = nobody
html_directory = no
inet_interfaces = all
local_recipient_maps = proxy:unix:passwd.byname $alias_maps
mail_owner = postfix
mail_spool_directory = /var/mail
mailq_path = /usr/bin/mailq
manpage_directory = /usr/local/man
mydestination = $myhostname,localhost.$myhostname,localhost
mydomain = domain.com
myhostname = mailserver.domain.com
mynetworks = 127.0.0.0/8
myorigin = $mydomain
queue_directory = /var/spool/postfix
receive_override_options = no_address_mappings
relay_domains =
sendmail_path = /usr/sbin/sendmail
setgid_group = postdrop
smtpd_banner = $myhostname ESMTP
smtpd_recipient_restrictions = permit_mynetworks,    permit_sasl_authenticated,    reject_unauth_destination,    check_policy_service unix:/var/spool/postfix/postgrey/socket,    reject_non_fqdn_recipient,    reject_unverified_recipient,    reject_rbl_client cbl.abuseat.org,    reject_rbl_client dialups.mail-abuse.org,    permit
smtpd_sasl_auth_enable = no
smtpd_sasl_exceptions_networks = $mynetworks
smtpd_sasl_path = smtpd
smtpd_sasl_security_options = noanonymous
smtpd_sasl_type = cyrus
soft_bounce = no
unknown_local_recipient_reject_code = 550
virtual_alias_maps = ldap:$config_directory/ldap-groups.cf
virtual_gid_maps = static:12
virtual_mailbox_base = /var/vmail
virtual_mailbox_domains = $mydomain
virtual_mailbox_maps = ldap:$config_directory/ldap-users.cf
virtual_minimum_uid = 800
virtual_transport = dovecot
virtual_uid_maps = static:800

doveconf -n

# 2.0.9: /etc/dovecot/dovecot.conf
# OS: Linux 2.6.32-431.3.1.el6.x86_64 x86_64 CentOS release 6.5 (Final) ext4
auth_username_chars = abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ01234567890.-_@&
auth_verbose = yes
default_client_limit = 2048
default_process_limit = 512
disable_plaintext_auth = no
listen = *
login_greeting = Dovecot DA ready.
mail_access_groups = mail
mail_location = maildir:/var/vmail/%u
mail_max_userip_connections = 15
passdb {
  args = /etc/dovecot/dovecot-ldap.conf
  driver = ldap
}
protocols = imap pop3
service auth {
  unix_listener /var/spool/postfix/private/dovecot-auth {
    group = postfix
    mode = 0660
    user = postfix
  }
  user = postfix
}
service imap-login {
  process_min_avail = 16
  user = postfix
}
service pop3-login {
  process_min_avail = 16
  user = postfix
}
ssl = no
userdb {
  args = /etc/dovecot/dovecot-ldap.conf
  driver = ldap
}
verbose_proctitle = yes
protocol pop3 {
  pop3_logout_format = top=%t/%p, retr=%r/%b, del=%d/%m, size=%s, bytes=%i/%o
  pop3_uidl_format = %08Xu%08Xv
}
remote 127.0.0.1 {
  mail_max_userip_connections = 40
}

/etc/dovecot/dovecot-ldap.conf

uris = ldap://127.0.0.1/
base = cn=users,c=domain,DC=com
dn = cn=administrator,cn=users,DC=domain,DC=com
dnpass = *****************
#default_pass_scheme = PLAIN
ldap_version = 3
tls = no
auth_bind = yes
deref = never
debug_level = 1
scope=subtree
user_attrs = homeDirectory=home,uidNumber=uid,gidNumber=gid
user_filter = (uid=%u)
pass_attrs = uid=user,userPassword=password
pass_filter = (uid=%u)

Ниже лог получения и возврата (с ошибкой #< #5.1.1 x-unix; user unknown> #SMTP#) сообщения с ящика user@domain2.com (внешний адрес) на локального пользователя из AD user@domain.com

Mar 18 18:15:28 alpha postfix/smtpd[10776]: connect from mailserver.domain2.com[111.111.111.111]
Mar 18 18:15:28 alpha postgrey[1915]: action=pass, reason=triplet found, delay=342, client_name=mailserver.domain2.com, client_address=111.111.111.111, sender=user@domain2.com, recipient=user@domain.com
Mar 18 18:15:28 alpha postfix/smtpd[10776]: C6C187E0D66: client=mailserver.domain2.com[111.111.111.111]
Mar 18 18:15:28 alpha postfix/cleanup[10790]: C6C187E0D66: message-id=<416592E3D0DEFC47BCA8288454A3624E1A75C9DCE0@server.domain2.com>
Mar 18 18:15:29 alpha postfix/qmgr[8472]: C6C187E0D66: from=<user@domain2.com>, size=8313, nrcpt=1 (queue active)
Mar 18 18:15:29 alpha clamsmtpd: 10000A: accepted connection from: 127.0.0.1
Mar 18 18:15:29 alpha postfix/smtpd[10794]: connect from localhost[127.0.0.1]
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostname: localhost ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostaddr: 127.0.0.1 ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 220 mailserver.domain.com ESMTP
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 220 smtp.passthru
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: EHLO mailserver.domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: EHLO mailserver.domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-mailserver.domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-PIPELINING
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-SIZE 10240000
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-VRFY
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_list_match: localhost: no match
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_list_match: 127.0.0.1: no match
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-ETRN
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-XFORWARD NAME ADDR PROTO HELO SOURCE PORT
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-ENHANCEDSTATUSCODES
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250-8BITMIME
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 DSN
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-smtp.passthru
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-SIZE 10240000
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-VRFY
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-ETRN
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-XFORWARD NAME ADDR PROTO HELO SOURCE PORT
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-ENHANCEDSTATUSCODES
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250-8BITMIME
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 DSN
Mar 18 18:15:29 alpha postfix/smtp[10792]: server features: 0x49f8b size 10240000
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: XFORWARD NAME=mailserver.domain2.com ADDR=111.111.111.111 PORT=11058
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: XFORWARD NAME=mailserver.domain2.com ADDR=111.111.111.111 PORT=11058
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 2.0.0 Ok
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 2.0.0 Ok
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: XFORWARD PROTO=ESMTP HELO=mailserver.domain2.com SOURCE=REMOTE
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: XFORWARD PROTO=ESMTP HELO=mailserver.domain2.com SOURCE=REMOTE
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 2.0.0 Ok
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 2.0.0 Ok
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: MAIL FROM:<user@domain2.com> SIZE=8313
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: MAIL FROM:<user@domain2.com> SIZE=8313
Mar 18 18:15:29 alpha postfix/smtpd[10794]: extract_addr: input: <user@domain2.com>
Mar 18 18:15:29 alpha postfix/smtpd[10794]: smtpd_check_addr: addr=user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: connect to subsystem private/rewrite
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr request = rewrite
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr rule = local
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr address = user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: rewrite_clnt: local: user@domain2.com -> user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr request = resolve
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr sender =
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr address = user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10776]: disconnect from mailserver.domain2.com[111.111.111.111]
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: transport
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: transport
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: smtp
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: nexthop
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: nexthop
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: recipient
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: recipient
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 4096
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: resolve_clnt: `' -> `user@domain2.com' -> transp=`smtp' host=`domain2.com' rcpt=`user@domain2.com' flags= class=default
Mar 18 18:15:29 alpha postfix/smtpd[10794]: ctable_locate: install entry key user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: extract_addr: in: <user@domain2.com>, result: user@domain2.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: fsspace: .: block size 4096, blocks free 50242419
Mar 18 18:15:29 alpha postfix/smtpd[10794]: smtpd_check_queue: blocks 4096 avail 50242419 min_free 0 msg_size_limit 10240000
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 2.1.0 Ok
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 2.1.0 Ok
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: RCPT TO:<user@domain.com> ORCPT=rfc822;user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: RCPT TO:<user@domain.com> ORCPT=rfc822;user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: extract_addr: input: <user@domain.com>
Mar 18 18:15:29 alpha postfix/smtpd[10794]: smtpd_check_addr: addr=user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr request = rewrite
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr rule = local
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr address = user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: rewrite_clnt: local: user@domain.com -> user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr request = resolve
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr sender =
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr address = user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: transport
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: transport
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: dovecot
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: nexthop
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: nexthop
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: recipient
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: recipient
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 1024
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: resolve_clnt: `' -> `user@domain.com' -> transp=`dovecot' host=`domain.com' rcpt=`user@domain.com' flags= class=virtual
Mar 18 18:15:29 alpha postfix/smtpd[10794]: ctable_locate: install entry key user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: extract_addr: in: <user@domain.com>, result: user@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr request = rewrite
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr rule = local
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr address = double-bounce
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: flags
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: address
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: double-bounce@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: private/rewrite socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: rewrite_clnt: local: double-bounce -> double-bounce@domain.com
Mar 18 18:15:29 alpha postfix/smtpd[10794]: >>> START Recipient address RESTRICTIONS <<<
Mar 18 18:15:29 alpha postfix/smtpd[10794]: generic_checks: name=permit_mynetworks
Mar 18 18:15:29 alpha postfix/smtpd[10794]: permit_mynetworks: localhost 127.0.0.1
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostname: localhost ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostaddr: 127.0.0.1 ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: generic_checks: name=permit_mynetworks status=1
Mar 18 18:15:29 alpha postfix/smtpd[10794]: smtpd_check_rewrite: trying: permit_inet_interfaces
Mar 18 18:15:29 alpha postfix/smtpd[10794]: permit_inet_interfaces: localhost 127.0.0.1
Mar 18 18:15:29 alpha postfix/smtpd[10794]: before input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping enable_milters
Mar 18 18:15:29 alpha postfix/smtpd[10794]: after input_transp_cleanup: cleanup flags = enable_automatic_bcc enable_address_mapping
Mar 18 18:15:29 alpha postfix/smtpd[10794]: connect to subsystem public/cleanup
Mar 18 18:15:29 alpha postfix/smtpd[10794]: public/cleanup socket: wanted attribute: queue_id
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: queue_id
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 21FFE7E0D67
Mar 18 18:15:29 alpha postfix/smtpd[10794]: public/cleanup socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: send attr flags = 176
Mar 18 18:15:29 alpha postfix/smtpd[10794]: 21FFE7E0D67: client=mailserver.domain2.com[111.111.111.111]
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 2.1.5 Ok
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 2.1.5 Ok
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: DATA
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 354 Start mail input; end with <CRLF>.<CRLF>
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: .
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: DATA
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 354 End data with <CR><LF>.<CR><LF>
Mar 18 18:15:29 alpha postfix/cleanup[10790]: 21FFE7E0D67: message-id=<416592E3D0DEFC47BCA8288454A3624E1A75C9DCE0@server.domain2.com>
Mar 18 18:15:29 alpha postfix/smtpd[10794]: public/cleanup socket: wanted attribute: status
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: status
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: 0
Mar 18 18:15:29 alpha postfix/smtpd[10794]: public/cleanup socket: wanted attribute: reason
Mar 18 18:15:29 alpha postfix/qmgr[8472]: 21FFE7E0D67: from=<user@domain2.com>, size=8537, nrcpt=1 (queue active)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: reason
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute value: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: public/cleanup socket: wanted attribute: (list terminator)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: input attribute name: (end)
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 250 2.0.0 Ok: queued as 21FFE7E0D67
Mar 18 18:15:29 alpha postfix/smtpd[10794]: watchdog_pat: 0x7f727196d750
Mar 18 18:15:29 alpha clamsmtpd: 10000A: from=user@domain2.com, to=user@domain.com, status=CLEAN
Mar 18 18:15:29 alpha postfix/smtp[10792]: < 127.0.0.1[127.0.0.1]:10025: 250 2.0.0 Ok: queued as 21FFE7E0D67
Mar 18 18:15:29 alpha postfix/smtp[10792]: C6C187E0D66: to=<user@domain.com>, relay=127.0.0.1[127.0.0.1]:10025, delay=0.46, delays=0.32/0.01/0.05/0.09, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 21FFE7E0D67)
Mar 18 18:15:29 alpha postfix/smtp[10792]: > 127.0.0.1[127.0.0.1]:10025: QUIT
Mar 18 18:15:29 alpha postfix/smtp[10792]: name_mask: resource
Mar 18 18:15:29 alpha postfix/smtp[10792]: name_mask: software
Mar 18 18:15:29 alpha postfix/smtpd[10794]: < localhost[127.0.0.1]: QUIT
Mar 18 18:15:29 alpha postfix/smtpd[10794]: > localhost[127.0.0.1]: 221 2.0.0 Bye
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostname: localhost ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: match_hostaddr: 127.0.0.1 ~? 127.0.0.0/8
Mar 18 18:15:29 alpha postfix/smtpd[10794]: disconnect from localhost[127.0.0.1]
Mar 18 18:15:29 alpha postfix/qmgr[8472]: C6C187E0D66: removed
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_create
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://127.0.0.1/)
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_bind
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_simple_bind
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_sasl_bind
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_new_connection 1 1 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_open_connection
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_connect_to_host: TCP 127.0.0.1:389
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_new_socket: 50
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_prepare_socket: 50
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_connect_to_host: Trying 127.0.0.1:389
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_pvt_connect: fd: 50 tm: -1 async: 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_open_defconn: successful
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_result ld 0x74dd10 msgid -1
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 msgid -1 (timeout 0 usec)
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 1,  origid 1, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 1 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:    Empty
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 1 message type bind
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 0 new referrals
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg:  mark request completed, ld 0x74dd10 msgid 1
Mar 18 18:15:29 alpha dovecot: auth: Error: request done: ld 0x74dd10 msgid 1
Mar 18 18:15:29 alpha dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <>
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_free_request (origid 1, msgid 1)
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_parse_result
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_search
Mar 18 18:15:29 alpha dovecot: auth: Error: put_filter: "(uid=user@domain.com)"
Mar 18 18:15:29 alpha dovecot: auth: Error: put_filter: simple
Mar 18 18:15:29 alpha dovecot: auth: Error: put_simple_filter: "uid=user@domain.com"
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_msgfree
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_result ld 0x74dd10 msgid -1
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 msgid -1 (timeout 0 usec)
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 1 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:    Empty
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_result ld 0x74dd10 msgid -1
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 msgid -1 (timeout 0 usec)
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 1 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:    Empty
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid -1 all 0
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 2 message type search-reference
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/CN=Configuration,DC=domain,DC=com)
Mar 18 18:15:29 alpha dovecot: auth: Error: re_encode_request: new msgid 3, new dn <CN=Configuration,DC=domain,DC=com>
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referral: msgid 2, url "ldap://domain.com/CN=Configuration,DC=domain,DC=com"
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_new_connection 0 1 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_open_connection
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_connect_to_host: TCP domain.com:389
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_new_socket: 51
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_prepare_socket: 51
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_connect_to_host: Trying 127.0.0.1:389
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_pvt_connect: fd: 51 tm: -1 async: 0
Mar 18 18:15:29 alpha dovecot: auth: Error: anonymous rebind via ldap_sasl_bind("")
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_sasl_bind
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_result ld 0x74dd10 msgid 4
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 msgid 4 (timeout 100000 usec)
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: domain.com  port: 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:   rebind in progress
Mar 18 18:15:29 alpha dovecot: auth: Error:     queue is empty
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 3  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 4,  origid 4, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 1, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 2 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:    Empty
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 0
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 2 message type search-reference
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com)
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referrals: queue referral "ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com"
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg:  search ref chased, mark request chasing refs, id = 2
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 0 s 99945 us to go
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: domain.com  port: 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:   rebind in progress
Mar 18 18:15:29 alpha dovecot: auth: Error:     queue 0 entry 0 - ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 3  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 4,  origid 4, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status ChasingRefs
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 1, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 2 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  type 115
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg: ld 0x74dd10 msgid 2 message type search-reference
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/DC=ForestDnsZones,DC=domain,DC=com)
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chase_v3referrals: queue referral "ldap://domain.com/DC=ForestDnsZones,DC=domain,DC=com"
Mar 18 18:15:29 alpha dovecot: auth: Error: read1msg:  search ref chased, mark request chasing refs, id = 2
Mar 18 18:15:29 alpha dovecot: auth: Error: adding response ld 0x74dd10 msgid 2 type 115:
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg ld 0x74dd10 0 s 99882 us to go
Mar 18 18:15:29 alpha dovecot: auth: Error: wait4msg continue ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Connections:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: domain.com  port: 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:   rebind in progress
Mar 18 18:15:29 alpha dovecot: auth: Error:     queue 0 entry 0 - ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com
Mar 18 18:15:29 alpha dovecot: auth: Error:     queue 1 entry 0 - ldap://domain.com/DC=ForestDnsZones,DC=domain,DC=com
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:15:29 alpha dovecot: auth: Error:   refcnt: 3  status: Connected
Mar 18 18:15:29 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:15:29 2014
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error:
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Outstanding Requests:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 4,  origid 4, status InProgress
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status ChasingRefs
Mar 18 18:15:29 alpha dovecot: auth: Error:    outstanding referrals 1, parent count 0
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 request count 2 (abandoned 0)
Mar 18 18:15:29 alpha dovecot: auth: Error: ** ld 0x74dd10 Response Queue:
Mar 18 18:15:29 alpha dovecot: auth: Error:  * msgid 2,  type 115
Mar 18 18:15:29 alpha dovecot: auth: Error:    chained responses:
Mar 18 18:15:29 alpha dovecot: auth: Error:   * msgid 2,  type 115
Mar 18 18:15:29 alpha dovecot: auth: Error:   ld 0x74dd10 response count 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x74dd10 msgid 4 all 1
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x74dd10 NULL
Mar 18 18:15:29 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:18:04 alpha dovecot: lda: Error: userdb lookup(user@domain.com): Request timed out
Mar 18 18:18:04 alpha dovecot: lda: Fatal: Internal error occurred. Refer to server log for more information.
Mar 18 18:18:04 alpha postfix/pipe[10797]: 21FFE7E0D67: to=<user@domain.com>, relay=dovecot, delay=155, delays=0.07/0.01/0/155, dsn=4.3.0, status=deferred (temporary failure)
Mar 18 18:18:49 alpha postfix/anvil[10778]: statistics: max connection rate 2/60s for (smtp:111.111.111.111) at Mar 18 18:12:11
Mar 18 18:18:49 alpha postfix/anvil[10778]: statistics: max connection count 1 for (smtp:111.111.111.111) at Mar 18 18:09:46
Mar 18 18:18:49 alpha postfix/anvil[10778]: statistics: max cache size 1 at Mar 18 18:09:46
Mar 18 18:26:32 alpha postfix/qmgr[8472]: 21FFE7E0D67: from=<user@domain2.com>, size=8537, nrcpt=1 (queue active)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap(user@domain.com): Connection appears to be hanging, reconnecting
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_unbind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_request (origid 2, msgid 6)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_request (origid 2, msgid 5)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_request (origid 2, msgid 3)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_request (origid 2, msgid 2)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_connection 1 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_unbind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_connection: actually freed
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_connection 1 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_unbind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_connection: actually freed
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_create
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://127.0.0.1/)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_bind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_simple_bind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_sasl_bind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_new_connection 1 1 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_open_connection
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_connect_to_host: TCP 127.0.0.1:389
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_new_socket: 50
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_prepare_socket: 50
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_connect_to_host: Trying 127.0.0.1:389
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_pvt_connect: fd: 50 tm: -1 async: 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_open_defconn: successful
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_result ld 0x7513c0 msgid -1
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 msgid -1 (timeout 0 usec)
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Outstanding Requests:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 1,  origid 1, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 request count 1 (abandoned 0)
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Response Queue:
Mar 18 18:26:32 alpha dovecot: auth: Error:    Empty
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 response count 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x7513c0 NULL
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 1 message type bind
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 0 new referrals
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg:  mark request completed, ld 0x7513c0 msgid 1
Mar 18 18:26:32 alpha dovecot: auth: Error: request done: ld 0x7513c0 msgid 1
Mar 18 18:26:32 alpha dovecot: auth: Error: res_errno: 0, res_error: <>, res_matched: <>
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_free_request (origid 1, msgid 1)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_parse_result
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_search
Mar 18 18:26:32 alpha dovecot: auth: Error: put_filter: "(uid=user@domain.com)"
Mar 18 18:26:32 alpha dovecot: auth: Error: put_filter: simple
Mar 18 18:26:32 alpha dovecot: auth: Error: put_simple_filter: "uid=user@domain.com"
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_search
Mar 18 18:26:32 alpha dovecot: auth: Error: put_filter: "(uid=user@domain.com)"
Mar 18 18:26:32 alpha dovecot: auth: Error: put_filter: simple
Mar 18 18:26:32 alpha dovecot: auth: Error: put_simple_filter: "uid=user@domain.com"
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_msgfree
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_result ld 0x7513c0 msgid -1
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 msgid -1 (timeout 0 usec)
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 3  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Outstanding Requests:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 3,  origid 3, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 request count 2 (abandoned 0)
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Response Queue:
Mar 18 18:26:32 alpha dovecot: auth: Error:    Empty
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 response count 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x7513c0 NULL
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_result ld 0x7513c0 msgid -1
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 msgid -1 (timeout 0 usec)
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 3  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Outstanding Requests:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 3,  origid 3, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 request count 2 (abandoned 0)
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Response Queue:
Mar 18 18:26:32 alpha dovecot: auth: Error:    Empty
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 response count 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x7513c0 NULL
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid -1 all 0
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 2 message type search-reference
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/CN=Configuration,DC=domain,DC=com)
Mar 18 18:26:32 alpha dovecot: auth: Error: re_encode_request: new msgid 4, new dn <CN=Configuration,DC=domain,DC=com>
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referral: msgid 2, url "ldap://domain.com/CN=Configuration,DC=domain,DC=com"
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_new_connection 0 1 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_open_connection
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_connect_to_host: TCP domain.com:389
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_new_socket: 51
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_prepare_socket: 51
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_connect_to_host: Trying 127.0.0.1:389
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_pvt_connect: fd: 51 tm: -1 async: 0
Mar 18 18:26:32 alpha dovecot: auth: Error: anonymous rebind via ldap_sasl_bind("")
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_sasl_bind
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_initial_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_send_server_request
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_result ld 0x7513c0 msgid 5
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 msgid 5 (timeout 100000 usec)
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: domain.com  port: 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:   rebind in progress
Mar 18 18:26:32 alpha dovecot: auth: Error:     queue is empty
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 4  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Outstanding Requests:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 5,  origid 5, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 3,  origid 3, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 1, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 request count 3 (abandoned 0)
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Response Queue:
Mar 18 18:26:32 alpha dovecot: auth: Error:    Empty
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 response count 0
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x7513c0 NULL
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 2 message type search-reference
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referrals: queue referral "ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com"
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg:  search ref chased, mark request chasing refs, id = 2
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 0 s 99963 us to go
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: domain.com  port: 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 2  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:   rebind in progress
Mar 18 18:26:32 alpha dovecot: auth: Error:     queue 0 entry 0 - ldap://domain.com/DC=DomainDnsZones,DC=domain,DC=com
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: * host: 127.0.0.1  port: 389  (default)
Mar 18 18:26:32 alpha dovecot: auth: Error:   refcnt: 4  status: Connected
Mar 18 18:26:32 alpha dovecot: auth: Error:   last used: Tue Mar 18 18:26:32 2014
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error:
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Outstanding Requests:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 5,  origid 5, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 3,  origid 3, status InProgress
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 0, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 2,  origid 2, status ChasingRefs
Mar 18 18:26:32 alpha dovecot: auth: Error:    outstanding referrals 1, parent count 0
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 request count 3 (abandoned 0)
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Response Queue:
Mar 18 18:26:32 alpha dovecot: auth: Error:  * msgid 2,  type 115
Mar 18 18:26:32 alpha dovecot: auth: Error:   ld 0x7513c0 response count 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chkResponseList returns ld 0x7513c0 NULL
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_int_select
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg: ld 0x7513c0 msgid 2 message type search-reference
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referrals
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_url_parse_ext(ldap://domain.com/DC=ForestDnsZones,DC=domain,DC=com)
Mar 18 18:26:32 alpha dovecot: auth: Error: ldap_chase_v3referrals: queue referral "ldap://domain.com/DC=ForestDnsZones,DC=domain,DC=com"
Mar 18 18:26:32 alpha dovecot: auth: Error: read1msg:  search ref chased, mark request chasing refs, id = 2
Mar 18 18:26:32 alpha dovecot: auth: Error: adding response ld 0x7513c0 msgid 2 type 115:
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg ld 0x7513c0 0 s 99930 us to go
Mar 18 18:26:32 alpha dovecot: auth: Error: wait4msg continue ld 0x7513c0 msgid 5 all 1
Mar 18 18:26:32 alpha dovecot: auth: Error: ** ld 0x7513c0 Connections:
Mar 18 18:26:32 alpha postfix/pipe[10814]: 21FFE7E0D67: to=<user@domain.com>, relay=dovecot, delay=663, delays=663/0.02/0/0.28, dsn=5.1.1, status=bounced (user unknown)
Mar 18 18:26:32 alpha postfix/cleanup[10817]: 594B27E0D68: message-id=<20140318172632.594B27E0D68@mailserver.domain.com>
Mar 18 18:26:32 alpha postfix/bounce[10816]: 21FFE7E0D67: sender non-delivery notification: 594B27E0D68
Mar 18 18:26:32 alpha postfix/qmgr[8472]: 594B27E0D68: from=<>, size=10338, nrcpt=1 (queue active)
Mar 18 18:26:32 alpha postfix/qmgr[8472]: 21FFE7E0D67: removed
Mar 18 18:26:33 alpha postfix/smtp[10818]: 594B27E0D68: to=<user@domain2.com>, relay=mailserver.domain2.com[111.111.111.111]:25, delay=1.2, delays=0.03/0/0.12/1.1, dsn=2.6.0, status=sent (250 2.6.0 <20140318172632.594B27E0D68@mailserver.domain.com> Queued mail for delivery)
Mar 18 18:26:33 alpha postfix/qmgr[8472]: 594B27E0D68: removed

Подскажете, что я мог пропустить.

2

Я не знаток LDAP и Postfix, но мне кажется у вас  запрос к AD дает имя пользователя, точнее не возвращает Dovecot'у - адрес ящика - user@company.