xM писал(а):Ну а с lc: проверьте по аналогии.
с lc:mime_filename
Код: Выделить всё
12494 Data file written for message 1bnLoZ-0003FW-6D
12494 >>Generated Received: header line
12494 P Received: from astra.domain.ru ([192.168.0.2]:38334)
12494 by astra with esmtpa (Exim 4.82)
12494 (envelope-from <test@domain.ru>)
12494 id 1bnLoZ-0003FW-6D
12494 for asd@domain.ru; Fri, 23 Sep 2016 15:26:35 +0700
12494 Found Content-Type: header - executing acl_smtp_mime.
12494 Found content-type: MIME header, value is 'multipart/mixed'
12494 Found boundary= MIME parameter in content-type: header, value is '------------000407010601020608020305'
12494 using ACL "acl_check_mime"
12494 processing "deny"
12494 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
12494 =
12494 deny: condition test failed in ACL "acl_check_mime"
12494 processing "accept"
12494 accept: condition test succeeded in ACL "acl_check_mime"
12494 Entering multipart recursion, boundary '------------000407010601020608020305'
12494 Next part with boundary ------------000407010601020608020305
12494 Found content-type: MIME header, value is 'text/plain'
12494 Found charset= MIME parameter in content-type: header, value is 'UTF-8'
12494 Found content-transfer-encoding: MIME header, value is '7bit'
12494 using ACL "acl_check_mime"
12494 processing "deny"
12494 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
12494 =
12494 deny: condition test failed in ACL "acl_check_mime"
12494 processing "accept"
12494 accept: condition test succeeded in ACL "acl_check_mime"
12494 Next part with boundary ------------000407010601020608020305
12494 Found content-type: MIME header, value is 'text/plain'
12494 Found charset= MIME parameter in content-type: header, value is 'UTF-8'
12494 Found name= MIME parameter in content-type: header, value is 'секретно.txt'
12494 Found content-transfer-encoding: MIME header, value is 'base64'
12494 Found content-disposition: MIME header, value is 'attachment'
12494 using ACL "acl_check_mime"
12494 processing "deny"
12494 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
12494 = true
12494 check decode = default
12494 deny: condition test succeeded in ACL "acl_check_mime"
12494 unspool_mbox(): unlinking '/var/spool/exim4/scan/1bnLoZ-0003FW-6D/1bnLoZ-0003FW-6D-00000'
12494 unspool_mbox(): unlinking '/var/spool/exim4/scan/1bnLoZ-0003FW-6D/1bnLoZ-0003FW-6D.eml'
12494 SMTP>> 550-Данное сообщение содержит опасное
12494 SMTP>> 550 вложение
12494 LOG: MAIN REJECT
12494 H=astra.domain.ru [192.168.0.2]:38334 I=[192.168.0.2]:25 F=<test@domain.ru> A=dovecot_plain:test rejected during MIME ACL checks: Данное сообщение содержит опасное вложение
12494 SMTP>> 250 OK id=
12494 search_tidyup called
12494 Process 12494 is ready for new message
12494 smtp_setup_msg entered
12494 SMTP>> 421 astra lost input connection
12494 LOG: smtp_connection MAIN
12494 SMTP connection from astra.domain.ru [192.168.0.2]:38334 I=[192.168.0.2]:25 lost
12494 search_tidyup called
12481 child 12494 ended: status=0x100
12481 normal exit, 1
12481 0 SMTP accept processes now running
12481 Listening...
Отправлено спустя 6 минут 59 секунд:
xM писал(а):Ну а с lc: проверьте по аналогии.
вот отладка при отправке файла "СеКрЕтНо.txt"
Код: Выделить всё
Exim version 4.82 uid=0 gid=0 pid=5225 D=fbb95cfd
Berkeley DB: Berkeley DB 5.1.29: (October 25, 2011)
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DKIM Old_Demime
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
Compiler: GCC [4.7.2]
Library version: GnuTLS: Compile: 2.12.20
Runtime: 2.12.20
Library version: Cyrus SASL: Compile: 2.1.25
Runtime: 2.1.25 [Cyrus SASL]
Library version: PCRE: Compile: 8.30
Runtime: 8.30 2012-02-04
Total 18 lookups
Library version: SQLite: Compile: 3.7.13
Runtime: 3.7.13
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
changed uid/gid: forcing real = effective
uid=0 gid=0 pid=5225
auxiliary group list: <none>
seeking password data for user "uucp": cache not available
getpwnam() succeeded uid=10 gid=10
changed uid/gid: calling tls_validate_require_cipher
uid=105 gid=111 pid=5226
auxiliary group list: <none>
tls_validate_require_cipher child 5226 ended: status=0x0
configuration file is /var/lib/exim4/config.autogenerated
log selectors = ffffffff 7fffffff
LOG: MAIN
cwd=/root 3 args: exim -bd -d
trusted user
admin user
seeking password data for user "mail": cache not available
getpwnam() succeeded uid=8 gid=8
user name "root" extracted from gecos field "root"
originator: uid=0 gid=0 login=root name=root
5225 listening on 192.168.0.2 port 25
5225 parsec_fchmac_ign() on listen_socket OK
5225 failed to open pid file /var/run/exim4/exim.pid: No such file or directory
5225 prctl(PR_SET_KEEPCAPS,1) OK
5225 Current caps dropped 2 desired caps (SETMAC, CHMAC)
5225 parsec_cur_caps_set() OK
5225 changed uid/gid: running as a daemon
5225 uid=105 gid=111 pid=5225
5225 auxiliary group list: 111
5225 LOG: MAIN
5225 exim 4.82 daemon started: pid=5225, no queue runs, listening for SMTP on [192.168.0.2]:25
5225 set_process_info: 5225 daemon: no queue runs, listening for SMTP on [192.168.0.2]:25
5225 daemon running with uid=105 gid=111 euid=105 egid=111
5225 Listening...
5225 Connection request from 192.168.0.2 port 58562
5225 LOG: smtp_connection MAIN
5225 SMTP connection from [192.168.0.2]:58562 I=[192.168.0.2]:25 (TCP/IP connection count = 1)
5225 search_tidyup called
5225 1 SMTP accept process running
5225 Listening...
5304 host in rfc1413_hosts? yes (matched "*")
5304 doing ident callback
5304 ident connection to 192.168.0.2 failed: Connection refused
5304 sender_fullhost = [192.168.0.2]:58562
5304 sender_rcvhost = [192.168.0.2] (port=58562)
5304 Process 5304 is handling incoming connection from [192.168.0.2]:58562
5304 parsec_fstatmac() on accept socket OK, lev: 0 cat: 0
5304 parsec_setmac() on current process OK
5304 host in host_lookup? yes (matched "*")
5304 looking up host name for 192.168.0.2
5304 DNS lookup of 2.0.168.192.in-addr.arpa (PTR) succeeded
5304 Reverse DNS security status: unverified
5304 IP address lookup yielded astra.domain.ru
5304 gethostbyname2(af=inet6) returned 1 (HOST_NOT_FOUND)
5304 gethostbyname2 looked up these IP addresses:
5304 name=astra.domain.ru address=192.168.0.2
5304 checking addresses for astra.domain.ru
5304 192.168.0.2 OK
5304 sender_fullhost = astra.domain.ru [192.168.0.2]:58562
5304 sender_rcvhost = astra.domain.ru ([192.168.0.2]:58562)
5304 set_process_info: 5304 handling incoming connection from astra.domain.ru [192.168.0.2]:58562 I=[192.168.0.2]:25
5304 host in host_reject_connection? no (option unset)
5304 host in sender_unqualified_hosts? no (option unset)
5304 host in recipient_unqualified_hosts? no (option unset)
5304 host in helo_verify_hosts? no (option unset)
5304 host in helo_try_verify_hosts? no (option unset)
5304 host in helo_accept_junk_hosts? no (option unset)
5304 SMTP>> 220 astra ESMTP Exim 4.82 Fri, 23 Sep 2016 08:37:45 +0700
5304 Process 5304 is ready for new message
5304 smtp_setup_msg entered
5304 SMTP<< EHLO [192.168.0.2]
5304 sender_fullhost = astra.domain.ru [192.168.0.2]:58562
5304 sender_rcvhost = astra.domain.ru ([192.168.0.2]:58562)
5304 set_process_info: 5304 handling incoming connection from astra.domain.ru [192.168.0.2]:58562 I=[192.168.0.2]:25
5304 host in pipelining_advertise_hosts? yes (matched "*")
5304 host in auth_advertise_hosts? yes (matched "*")
5304 host in tls_advertise_hosts? no (option unset)
5304 SMTP>> 250-astra Hello astra.domain.ru [192.168.0.2]
5304 250-SIZE 52428800
5304 250-8BITMIME
5304 250-PIPELINING
5304 250-AUTH PLAIN
5304 250 HELP
5304 SMTP<< AUTH PLAIN AHRlc3QAMTExMTExMTE=
5304 dovecot authentication
5304 received: VERSION 1 1
5304 received: MECH PLAIN plaintext
5304 received: SPID 5257
5304 received: CUID 8
5304 received: COOKIE ae33dcce850f32e89b93b690dfbfbd38
5304 received: DONE
5304 sent: VERSION 1 0
5304 CPID 5304
5304 AUTH 1 plain service=smtp secured rip=192.168.0.2 lip=192.168.0.2 nologin resp=AHRlc3QAMTExMTExMTE=
5304 received: OK 1 user=test
5304 dovecot_plain authenticator server_condition:
5304 $auth1 = test
5304 $1 = test
5304 parsec_setmac() on current process OK
5304 SMTP>> 235 Authentication succeeded
5304 SMTP<< MAIL FROM:<test@domain.ru> SIZE=859
5304 spool directory space = 14508260K inodes = 1136103 check_space = 0K inodes = 0 msg_size = 5859
5304 using ACL "acl_check_mail"
5304 processing "accept"
5304 accept: condition test succeeded in ACL "acl_check_mail"
5304 SMTP>> 250 OK
5304 SMTP<< RCPT TO:<asd@domain.ru>
5304 using ACL "acl_check_rcpt"
5304 processing "deny"
5304 check hosts = *:+relay_from_hosts
5304 host in "*:+relay_from_hosts"? yes (matched "*")
5304 check !authenticated = *
5304 dovecot_plain in "*"? yes (matched "*")
5304 deny: condition test failed in ACL "acl_check_rcpt"
5304 processing "accept"
5304 check hosts = :
5304 host in ":"? no (end of list)
5304 accept: condition test failed in ACL "acl_check_rcpt"
5304 processing "deny"
5304 check domains = +local_domains
5304 domain.ru in "@:localhost:domain.ru"? yes (matched "domain.ru")
5304 domain.ru in "+local_domains"? yes (matched "+local_domains")
5304 check local_parts = ^[.] : ^.*[@%!/|`#&?]
5304 asd in "^[.] : ^.*[@%!/|`#&?]"? no (end of list)
5304 deny: condition test failed in ACL "acl_check_rcpt"
5304 processing "deny"
5304 check domains = !+local_domains
5304 cached yes match for +local_domains
5304 cached lookup data = NULL
5304 domain.ru in "!+local_domains"? no (matched "!+local_domains" - cached)
5304 deny: condition test failed in ACL "acl_check_rcpt"
5304 processing "accept"
5304 check local_parts = postmaster
5304 asd in "postmaster"? no (end of list)
5304 accept: condition test failed in ACL "acl_check_rcpt"
5304 processing "deny"
5304 check !acl = acl_local_deny_exceptions
5304 using ACL "acl_local_deny_exceptions"
5304 processing "accept"
5304 check hosts = ${if exists{/etc/exim4/host_local_deny_exceptions}{/etc/exim4/host_local_deny_exceptions}{}}
5304 host in ""? no (end of list)
5304 accept: condition test failed in ACL "acl_local_deny_exceptions"
5304 processing "accept"
5304 check senders = ${if exists{/etc/exim4/sender_local_deny_exceptions}{/etc/exim4/sender_local_deny_exceptions}{}}
5304 test@domain.ru in ""? no (end of list)
5304 accept: condition test failed in ACL "acl_local_deny_exceptions"
5304 processing "accept"
5304 check hosts = ${if exists{/etc/exim4/local_host_whitelist}{/etc/exim4/local_host_whitelist}{}}
5304 host in ""? no (end of list)
5304 accept: condition test failed in ACL "acl_local_deny_exceptions"
5304 processing "accept"
5304 check senders = ${if exists{/etc/exim4/local_sender_whitelist}{/etc/exim4/local_sender_whitelist}{}}
5304 test@domain.ru in ""? no (end of list)
5304 accept: condition test failed in ACL "acl_local_deny_exceptions"
5304 end of ACL "acl_local_deny_exceptions": implicit DENY
5304 check senders = ${if exists{/etc/exim4/local_sender_callout}{/etc/exim4/local_sender_callout}{}}
5304 test@domain.ru in ""? no (end of list)
5304 deny: condition test failed in ACL "acl_check_rcpt"
5304 processing "accept"
5304 check hosts = +relay_from_hosts
5304 host in "192.168.0.0/24 : 127.0.0.1 : ::::1"? yes (matched "192.168.0.0/24")
5304 host in "+relay_from_hosts"? yes (matched "+relay_from_hosts")
5304 check control = submission/sender_retain
5304 check control = dkim_disable_verify
5304 accept: condition test succeeded in ACL "acl_check_rcpt"
5304 SMTP>> 250 Accepted
5304 SMTP<< DATA
5304 SMTP>> 354 Enter message, ending with "." on a line by itself
5304 search_tidyup called
5304 host in ignore_fromline_hosts? no (option unset)
5304 >>Headers received:
5304 Message-ID: <57E48769.6050200@domain.ru>
5304 Date: Fri, 23 Sep 2016 08:37:45 +0700
5304 From: test <test@domain.ru>
5304 User-Agent: Mozilla/5.0 (X11; Linux x86_64; rv:24.0) Gecko/20100101 Thunderbird/24.5.0
5304 MIME-Version: 1.0
5304 To: asd@domain.ru
5304 Subject: 1
5304 Content-Type: multipart/mixed;
5304 boundary="------------060503030303050502020009"
5304
5304 address match test: subject=test@domain.ru pattern=*@+local_domains
5304 domain.ru in "@:localhost:domain.ru"? yes (matched "domain.ru")
5304 domain.ru in "+local_domains"? yes (matched "+local_domains")
5304 test@domain.ru in "*@+local_domains"? yes (matched "*@+local_domains")
5304 search_open: lsearch "/etc/email-addresses"
5304 search_find: file="/etc/email-addresses"
5304 key="test" partial=-1 affix=NULL starflags=0
5304 LRU list:
5304 :/etc/email-addresses
5304 End
5304 internal_search_find: file="/etc/email-addresses"
5304 type=lsearch key="test"
5304 file lookup required for test
5304 in /etc/email-addresses
5304 lookup failed
5304 address match test: subject=test@domain.ru pattern=*@domain.ru
5304 domain.ru in "domain.ru"? yes (matched "domain.ru")
5304 test@domain.ru in "*@domain.ru"? yes (matched "*@domain.ru")
5304 search_open: lsearch "/etc/email-addresses"
5304 cached open
5304 search_find: file="/etc/email-addresses"
5304 key="test" partial=-1 affix=NULL starflags=0
5304 LRU list:
5304 :/etc/email-addresses
5304 End
5304 internal_search_find: file="/etc/email-addresses"
5304 type=lsearch key="test"
5304 cached data used for lookup of test
5304 in /etc/email-addresses
5304 lookup failed
5304 rewritten sender = test@domain.ru
5304 rewrite_one_header: type=F:
5304 From: test <test@domain.ru>
5304 address match test: subject=test@domain.ru pattern=*@+local_domains
5304 domain.ru in "@:localhost:domain.ru"? yes (matched "domain.ru")
5304 domain.ru in "+local_domains"? yes (matched "+local_domains")
5304 test@domain.ru in "*@+local_domains"? yes (matched "*@+local_domains")
5304 search_open: lsearch "/etc/email-addresses"
5304 cached open
5304 search_find: file="/etc/email-addresses"
5304 key="test" partial=-1 affix=NULL starflags=0
5304 LRU list:
5304 :/etc/email-addresses
5304 End
5304 internal_search_find: file="/etc/email-addresses"
5304 type=lsearch key="test"
5304 cached data used for lookup of test
5304 in /etc/email-addresses
5304 lookup failed
5304 address match test: subject=test@domain.ru pattern=*@domain.ru
5304 domain.ru in "domain.ru"? yes (matched "domain.ru")
5304 test@domain.ru in "*@domain.ru"? yes (matched "*@domain.ru")
5304 search_open: lsearch "/etc/email-addresses"
5304 cached open
5304 search_find: file="/etc/email-addresses"
5304 key="test" partial=-1 affix=NULL starflags=0
5304 LRU list:
5304 :/etc/email-addresses
5304 End
5304 internal_search_find: file="/etc/email-addresses"
5304 type=lsearch key="test"
5304 cached data used for lookup of test
5304 in /etc/email-addresses
5304 lookup failed
5304 rewrite_one_header: type=T:
5304 To: asd@domain.ru
5304 search_tidyup called
5304 >>Headers after rewriting and local additions:
5304 I Message-ID: <57E48769.6050200@domain.ru>
5304 Date: Fri, 23 Sep 2016 08:37:45 +0700
5304 F From: test <test@domain.ru>
5304 User-Agent: Mozilla/5.0 (X11; Linux x86_64; rv:24.0) Gecko/20100101 Thunderbird/24.5.0
5304 MIME-Version: 1.0
5304 T To: asd@domain.ru
5304 Subject: 1
5304 Content-Type: multipart/mixed;
5304 boundary="------------060503030303050502020009"
5304
5304 Data file written for message 1bnFQw-0001NY-1K
5304 >>Generated Received: header line
5304 P Received: from astra.domain.ru ([192.168.0.2]:58562)
5304 by astra with esmtpa (Exim 4.82)
5304 (envelope-from <test@domain.ru>)
5304 id 1bnFQw-0001NY-1K
5304 for asd@domain.ru; Fri, 23 Sep 2016 08:37:46 +0700
5304 Found Content-Type: header - executing acl_smtp_mime.
5304 Found content-type: MIME header, value is 'multipart/mixed'
5304 Found boundary= MIME parameter in content-type: header, value is '------------060503030303050502020009'
5304 using ACL "acl_check_mime"
5304 processing "deny"
5304 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
5304 =
5304 deny: condition test failed in ACL "acl_check_mime"
5304 processing "accept"
5304 accept: condition test succeeded in ACL "acl_check_mime"
5304 Entering multipart recursion, boundary '------------060503030303050502020009'
5304 Next part with boundary ------------060503030303050502020009
5304 Found content-type: MIME header, value is 'text/plain'
5304 Found charset= MIME parameter in content-type: header, value is 'UTF-8'
5304 Found content-transfer-encoding: MIME header, value is '7bit'
5304 using ACL "acl_check_mime"
5304 processing "deny"
5304 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
5304 =
5304 deny: condition test failed in ACL "acl_check_mime"
5304 processing "accept"
5304 accept: condition test succeeded in ACL "acl_check_mime"
5304 Next part with boundary ------------060503030303050502020009
5304 Found content-type: MIME header, value is 'text/plain'
5304 Found charset= MIME parameter in content-type: header, value is 'UTF-8'
5304 Found name= MIME parameter in content-type: header, value is 'СеКретнО.txt'
5304 Found content-transfer-encoding: MIME header, value is 'base64'
5304 Found content-disposition: MIME header, value is 'attachment'
5304 using ACL "acl_check_mime"
5304 processing "deny"
5304 check condition = ${if match {${lc:$mime_filename}} {\Nсекретно\N}}
5304 =
5304 deny: condition test failed in ACL "acl_check_mime"
5304 processing "accept"
5304 accept: condition test succeeded in ACL "acl_check_mime"
5304 End boundary found ------------060503030303050502020009
5304 using ACL "acl_check_data"
5304 processing "accept"
5304 accept: condition test succeeded in ACL "acl_check_data"
5304 unspool_mbox(): unlinking '/var/spool/exim4/scan/1bnFQw-0001NY-1K/1bnFQw-0001NY-1K.eml'
5304 calling local_scan(); timeout=300
5304 local_scan() returned 0 NULL
5304 Writing spool header file
5304 Size of headers = 515
5304 LOG: MAIN
5304 <= test@domain.ru H=astra.domain.ru [192.168.0.2]:58562 I=[192.168.0.2]:25 P=esmtpa A=dovecot_plain:test S=1026 M8S=0 id=57E48769.6050200@domain.ru T="1"
5304 SMTP>> 250 OK id=1bnFQw-0001NY-1K
5304 search_tidyup called
5304 Sender: test@domain.ru
5304 Recipients:
5304 asd@domain.ru
5304 forked delivery process 5305
5304 Process 5304 is ready for new message
5304 smtp_setup_msg entered
5305 exec /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1bnFQw-0001NY-1K
5305 Exim version 4.82 uid=105 gid=111 pid=5305 D=fbbd5cfd
Berkeley DB: Berkeley DB 5.1.29: (October 25, 2011)
Support for: crypteq iconv() IPv6 PAM Perl Expand_dlfunc GnuTLS move_frozen_messages Content_Scanning DKIM Old_Demime
Lookups (built-in): lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmjz dbmnz dnsdb dsearch ldap ldapdn ldapm nis nis0 passwd pgsql sqlite
Authenticators: cram_md5 cyrus_sasl dovecot plaintext spa
Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
Compiler: GCC [4.7.2]
Library version: GnuTLS: Compile: 2.12.20
Runtime: 2.12.20
Library version: Cyrus SASL: Compile: 2.1.25
Runtime: 2.1.25 [Cyrus SASL]
Library version: PCRE: Compile: 8.30
Runtime: 8.30 2012-02-04
5305 Total 18 lookups
Library version: SQLite: Compile: 3.7.13
Runtime: 3.7.13
WHITELIST_D_MACROS: "OUTGOING"
TRUSTED_CONFIG_LIST: "/etc/exim4/trusted_configs"
5305 changed uid/gid: forcing real = effective
5305 uid=0 gid=111 pid=5305
5305 auxiliary group list: <none>
5305 seeking password data for user "uucp": cache not available
5305 getpwnam() succeeded uid=10 gid=10
5304 SMTP<< QUIT
5304 SMTP>> 221 astra closing connection
5304 LOG: smtp_connection MAIN
5304 SMTP connection from astra.domain.ru [192.168.0.2]:58562 I=[192.168.0.2]:25 closed by QUIT
5304 search_tidyup called
5225 child 5304 ended: status=0x0
5225 normal exit, 0
5225 0 SMTP accept processes now running
5225 Listening...
5306 changed uid/gid: calling tls_validate_require_cipher
5306 uid=105 gid=111 pid=5306
5306 auxiliary group list: <none>
5305 tls_validate_require_cipher child 5306 ended: status=0x0
5305 configuration file is /var/lib/exim4/config.autogenerated
5305 log selectors = ffffffff 7fffffff
5305 LOG: MAIN
5305 cwd=/var/spool/exim4 4 args: /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1bnFQw-0001NY-1K
5305 trusted user
5305 admin user
5305 seeking password data for user "mail": cache not available
5305 getpwnam() succeeded uid=8 gid=8
5305 set_process_info: 5305 delivering specified messages
5305 set_process_info: 5305 delivering 1bnFQw-0001NY-1K
5305 parsec_fstatmac() on deliver_datafile file OK, lev: 0 cat: 0
5305 parsec_setmac() on current process OK
5305 reading spool file 1bnFQw-0001NY-1K-H
5305 user=Debian-exim uid=105 gid=111 sender=test@domain.ru
5305 sender_fullhost = astra.domain.ru [192.168.0.2]:58562
5305 sender_rcvhost = astra.domain.ru ([192.168.0.2]:58562)
5305 sender_local=0 ident=unset
5305 Non-recipients:
5305 Empty Tree
5305 ---- End of tree ----
5305 recipients_count=1
5305 body_linecount=17 message_linecount=14
5305 running system filter
5305 rda_interpret (file): /etc/exim4/systemfilter.sh
5305 expanded: /etc/exim4/systemfilter.sh
5305 1531 bytes read from /etc/exim4/systemfilter.sh
5305 data is an Exim filter program
5305 Filter: start of processing
5305 Filter: end of processing
5305 system filter returned 1
5305 Delivery address list:
5305 asd@domain.ru
5305 locking /var/spool/exim4/db/retry.lockfile
5305 locked /var/spool/exim4/db/retry.lockfile
5305 EXIM_DBOPEN(/var/spool/exim4/db/retry)
5305 returned from EXIM_DBOPEN
5305 opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
5305 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
5305 Considering: asd@domain.ru
5305 unique = asd@domain.ru
5305 dbfn_read: key=R:domain.ru
5305 dbfn_read: key=R:asd@domain.ru
5305 dbfn_read: key=R:asd@domain.ru:<test@domain.ru>
5305 no domain retry record
5305 no address retry record
5305 asd@domain.ru: queued for routing
5305 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
5305 routing asd@domain.ru
5305 --------> hubbed_hosts router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 expansion of "${if exists{/etc/exim4/hubbed_hosts}{partial-lsearch;/etc/exim4/hubbed_hosts}fail}" forced failure: assume not in this list
5305 hubbed_hosts router skipped: domains mismatch
5305 --------> dnslookup_relay_to_domains router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 domain.ru in "@:localhost:domain.ru"? yes (matched "domain.ru")
5305 domain.ru in "! +local_domains : +relay_to_domains"? no (matched "! +local_domains")
5305 dnslookup_relay_to_domains router skipped: domains mismatch
5305 --------> dnslookup router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "! +local_domains"? no (matched "! +local_domains" - cached)
5305 dnslookup router skipped: domains mismatch
5305 --------> real_local router <--------
5305 local_part=asd domain=domain.ru
5305 real_local router skipped: prefix mismatch
5305 --------> system_aliases router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 R: system_aliases for asd@domain.ru
5305 calling system_aliases router
5305 rda_interpret (string): ${lookup{$local_part}lsearch{/etc/aliases}}
5305 search_open: lsearch "/etc/aliases"
5305 search_find: file="/etc/aliases"
5305 key="asd" partial=-1 affix=NULL starflags=0
5305 LRU list:
5305 :/etc/aliases
5305 End
5305 internal_search_find: file="/etc/aliases"
5305 type=lsearch key="asd"
5305 file lookup required for asd
5305 in /etc/aliases
5305 lookup failed
5305 expanded:
5305 file is not a filter file
5305 parse_forward_list:
5305 system_aliases router declined for asd@domain.ru
5305 --------> userforward router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 checking for local user
5305 seeking password data for user "asd": cache not available
5305 getpwnam() succeeded uid=1002 gid=1003
5305 R: userforward for asd@domain.ru
5305 checking require_files
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 check subsequent files for access by asd
5305 file check: $home/.forward
5305 expanded file: /home/asd/.forward
5305 stat() yielded -1
5305 errno = 2
5305 userforward router skipped: file check
5305 --------> procmail router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 checking for local user
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 R: procmail for asd@domain.ru
5305 checking require_files
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 check subsequent files for access by asd
5305 file check: ${if exists{/etc/procmailrc}{/etc/procmailrc}{${home}/.procmailrc}}
5305 expanded file: /home/asd/.procmailrc
5305 stat() yielded -1
5305 errno = 2
5305 procmail router skipped: file check
5305 --------> maildrop router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 checking for local user
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 R: maildrop for asd@domain.ru
5305 checking require_files
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 check subsequent files for access by asd
5305 file check: ${home}/.mailfilter
5305 expanded file: /home/asd/.mailfilter
5305 stat() yielded -1
5305 errno = 2
5305 maildrop router skipped: file check
5305 --------> lowuid_aliases router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 checking for local user
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 R: lowuid_aliases for asd@domain.ru (UID 1002)
5305 checking "condition"
5305 192.168.0.2 in ":@[]"? yes (matched "@[]")
5305 lowuid_aliases router skipped: condition failure
5305 --------> local_user router <--------
5305 local_part=asd domain=domain.ru
5305 checking domains
5305 cached yes match for +local_domains
5305 cached lookup data = NULL
5305 domain.ru in "+local_domains"? yes (matched "+local_domains" - cached)
5305 checking local_parts
5305 asd in "! root"? yes (end of list)
5305 checking for local user
5305 seeking password data for user "asd": using cached result
5305 getpwnam() succeeded uid=1002 gid=1003
5305 R: local_user for asd@domain.ru
5305 calling local_user router
5305 local_user router called for asd@domain.ru
5305 domain = domain.ru
5305 set transport maildir_home
5305 queued for maildir_home transport: local_part = asd
5305 domain = domain.ru
5305 errors_to=NULL
5305 domain_data=NULL localpart_data=NULL
5305 routed by local_user router
5305 envelope to: asd@domain.ru
5305 transport: maildir_home
5305 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
5305 After routing:
5305 Local deliveries:
5305 asd@domain.ru
5305 Remote deliveries:
5305 Failed addresses:
5305 Deferred addresses:
5305 search_tidyup called
5305 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
5305 --------> asd@domain.ru <--------
5305 locking /var/spool/exim4/db/retry.lockfile
5305 locked /var/spool/exim4/db/retry.lockfile
5305 EXIM_DBOPEN(/var/spool/exim4/db/retry)
5305 returned from EXIM_DBOPEN
5305 opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY
5305 dbfn_read: key=T:asd@domain.ru
5305 no retry record exists
5305 search_tidyup called
uid=0(root) gid=111(Debian-exim) РіСЂСѓРїРїС‹=0(root)
5307 changed uid/gid: local delivery to asd <asd@domain.ru> transport=maildir_home
5307 uid=1002 gid=1003 pid=5307
5307 auxiliary group list: <none>
5307 home=/home/asd current=/var/mail/asd
5307 set_process_info: 5307 delivering 1bnFQw-0001NY-1K to asd using maildir_home
5307 T: maildir_home for asd@domain.ru
5307 appendfile transport entered
5307 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
5307 directory=/var/mail/asd format=maildir
5307 message_prefix=null
5307 message_suffix=null
5307 maildir_use_size_file=no
5307 ensuring maildir directories exist in /var/mail/asd
5307 Try to exec astrase-fix-maildir 4 fixing Maildir maclabels in /var/mail/asd
5307 delivering in maildir format in /var/mail/asd
5307 writing to file tmp/1474594666.H121594P5307.astra
5307 writing data block fd=9 size=1130 timeout=0
5307 renaming temporary file
5307 renamed tmp/1474594666.H121594P5307.astra as new/1474594666.H121594P5307.astra
5307 appendfile yields 0 with errno=0 more_errno=0
5307 search_tidyup called
5305 journalling asd@domain.ru
5305 maildir_home transport returned OK for asd@domain.ru
5305 post-process asd@domain.ru (0)
5305 asd@domain.ru delivered
5305 LOG: MAIN
5305 => asd <asd@domain.ru> F=<test@domain.ru> P=<test@domain.ru> R=local_user T=maildir_home S=1130 QT=0s DT=0s
5305 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
5305 changed uid/gid: post-delivery tidying
5305 uid=105 gid=111 pid=5305
5305 auxiliary group list: <none>
5305 set_process_info: 5305 tidying up after delivering 1bnFQw-0001NY-1K
5305 Processing retry items
5305 Succeeded addresses:
5305 asd@domain.ru: no retry items
5305 Failed addresses:
5305 Deferred addresses:
5305 end of retry processing
5305 LOG: MAIN
5305 Completed QT=0s
5305 end delivery of 1bnFQw-0001NY-1K
5305 search_tidyup called
5305 search_tidyup called
5305 >>>>>>>>>>>>>>>> Exim pid=5305 terminating with rc=0 >>>>>>>>>>>>>>>>