Exim съедает заголовки

EXIM, sendmail, postfix, Dovecot и прочие. Решение проблем связанных с работой электронной почты

Модератор: xM

Правила форума
Убедительная просьба юзать теги [code] при оформлении листингов.
Сообщения не оформленные должным образом имеют все шансы быть незамеченными.
Жека
проходил мимо
Сообщения: 2
Зарегистрирован: 2010-06-04 16:37:06

Exim съедает заголовки

Непрочитанное сообщение Жека » 2010-06-05 10:53:30

Года три назад настроил Exim в связке с PostgreSQL и SpamAssasin. Принцип работы такой, имеется один корпоративный ящик (на mail.ru), все письма уходят через него (драйвер smtp). Плюс ещё почту во внутреннем домене разруливает. С недавних пор у всех писем уходящих на внешние домены стала обрезаться часть заголовка в начале, в итоге до адресата письма доходят, но в нечитаемом виде. Выглядит примерно так:

Код: Выделить всё

id 1OKSWm-0009aH-00

for address@mail.ru; Fri, 04 Jun 2010 12:45:20 +0400

Received: from [192.168.0.1] (helo=Terminal)

by MTS.afsga.muh with smtp (Exim 4.69 (FreeBSD))

(envelope-from <it@afsga.muh>)

id 1OKSjo-0007D5-N6

for address@mail.ru; Fri, 04 Jun 2010 12:58:48 +0400

Message-ID: <67261BAA10D142BA814F277E92999FC3@afsga.muh>

From: =?koi8-r?B?4dPU0sHIwc7YIPPn4SAtIElU?= <address@mail.ru>

To: =?koi8-r?B?4eYg8+fhIC0gSVQ=?= <address@mail.ru>

Subject: f435ws

Date: Fri, 4 Jun 2010 12:43:30 +0400

MIME-Version: 1.0

Content-Type: multipart/alternative;

boundary="----=_NextPart_000_0044_01CB03E3.891B7A50"

X-Priority: 3

X-MSMail-Priority: Normal

X-Mailer: Microsoft Outlook Express 6.00.3790.4657

X-MimeOLE: Produced By Microsoft MimeOLE V6.00.3790.4657

X-Spam-Checked: NO - AFSGA SPAM FILTER!

X-Mras: Ok

X-Spam-Score: 4.4 (++++)

X-Spam-Scannes: Yes

X-Spam-Scanner: SpamAssassin running on mts.afsga.muh



This is a multi-part message in MIME format.



------=_NextPart_000_0044_01CB03E3.891B7A50

Content-Type: text/plain;

charset="koi8-r"

Content-Transfer-Encoding: quoted-printable



sdfsdgfsdg



__________ NOD32 5173 (20100604) Information __________



This message was checked by NOD32 antivirus system.

http://www.eset.com





------=_NextPart_000_0044_01CB03E3.891B7A50

Content-Type: text/html;

charset="koi8-r"

Content-Transfer-Encoding: quoted-printable



<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 Transitional//EN">

<HTML><HEAD>

<META content=3D"text/html; charset=3Dkoi8-r" http-equiv=3DContent-Type>

<META name=3DGENERATOR content=3D"MSHTML 8.00.6001.18904">

<STYLE></STYLE>

</HEAD>

<BODY bgColor=3D#ffffff>

<DIV><FONT size=3D2 face=3DArial>sdfsdgfsdg</FONT></DIV><BR>

<BR>

__________ NOD32 5173 (20100604) Information __________<BR>

<BR>

This message was checked by NOD32 antivirus system.<BR>

<A HREF=3D"http://www.eset.com">http://www.eset.com</A><BR>



</BODY></HTML>



------=_NextPart_000_0044_01CB03E3.891B7A50--

Перенастроил отправку через yandex ящик, всё работает. Отключил спамассасин, не помогло. В чём может быть дело?
Лог отправки

Код: Выделить всё

exim -bd -d+all
11:46:39  4220 Exim version 4.69 (FreeBSD 6.3) uid=0 gid=0 pid=4220 D=fffdffff
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq iconv() IPv6 use_setclassresources PAM Perl Expand_dlfunc OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch nis nis0 passwd pgsql
Authenticators: cram_md5 dovecot plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
11:46:39  4220 changed uid/gid: forcing real = effective
11:46:39  4220   uid=0 gid=0 pid=4220
11:46:39  4220   auxiliary group list: 0
11:46:39  4220 configuration file is /usr/local/etc/exim/configure
11:46:39  4220 log selectors = 00000ffc 00212001
11:46:39  4220 cwd=/usr/local/etc/exim 3 args: exim -bd -d+all
11:46:39  4220 trusted user
11:46:39  4220 admin user
11:46:39  4220 seeking password data for user "mailnull": using cached result
11:46:39  4220 getpwnam() succeeded uid=26 gid=26
11:46:39  4220 originator: uid=0 gid=0 login=root name=Charlie Root
11:46:39  4220 listening on all interfaces (IPv6) port 25
11:46:39  4220 listening on all interfaces (IPv4) port 25
11:46:39  4220 pid written to /var/run/exim.pid
11:46:39  4220 changed uid/gid: running as a daemon
11:46:39  4220   uid=26 gid=6 pid=4220
11:46:39  4220   auxiliary group list: 6 6
11:46:39  4220 LOG: MAIN
11:46:39  4220   exim 4.69 daemon started: pid=4220, no queue runs, listening for SMTP on port 25 (IPv6 and IPv4)
11:46:39  4220 set_process_info:  4220 daemon: no queue runs, listening for SMTP on port 25 (IPv6 and IPv4)
11:46:39  4220 daemon running with uid=26 gid=6 euid=26 egid=6
11:46:39  4220 Listening...
11:46:52  4220 Connection request from 192.168.0.14 port 3042
11:46:52  4220 interface address=192.168.0.9 port=25
11:46:52  4220 search_tidyup called
11:46:52  4220 1 SMTP accept process running
11:46:52  4220 Listening...
11:46:52  4221 host in rfc1413_hosts? yes (matched "*")
11:46:52  4221 doing ident callback
11:46:52  4221 ident connection to 192.168.0.14 failed: Connection refused
11:46:52  4221 sender_fullhost = [192.168.0.14]
11:46:52  4221 sender_rcvhost = [192.168.0.14]
11:46:52  4221 Process 4221 is handling incoming connection from [192.168.0.14]
11:46:52  4221 host in host_lookup? no (option unset)
11:46:52  4221 set_process_info:  4221 handling incoming connection from [192.168.0.14]
11:46:52  4221 host in host_reject_connection? no (option unset)
11:46:52  4221 host in sender_unqualified_hosts? no (option unset)
11:46:52  4221 host in recipient_unqualified_hosts? no (option unset)
11:46:52  4221 host in helo_verify_hosts? no (option unset)
11:46:52  4221 host in helo_try_verify_hosts? no (option unset)
11:46:52  4221 host in helo_accept_junk_hosts? no (option unset)
11:46:52  4221 expanding: $smtp_active_hostname ESMTP Exim $version_number $tod_full
11:46:52  4221    result: MTS.afsga.muh ESMTP Exim 4.69 Sat, 05 Jun 2010 11:46:52 +0400
11:46:52  4221 SMTP>> 220 MTS.afsga.muh ESMTP Exim 4.69 Sat, 05 Jun 2010 11:46:52 +0400
11:46:52  4221 Process 4221 is ready for new message
11:46:52  4221 smtp_setup_msg entered
11:46:52  4221 SMTP<< EHLO homepc
11:46:52  4221 homepc in helo_lookup_domains? no (end of list)
11:46:52  4221 sender_fullhost = (homepc) [192.168.0.14]
11:46:52  4221 sender_rcvhost = [192.168.0.14] (helo=homepc)
11:46:52  4221 set_process_info:  4221 handling incoming connection from (homepc) [192.168.0.14]
11:46:52  4221 host in pipelining_advertise_hosts? yes (matched "*")
11:46:52  4221 host in auth_advertise_hosts? yes (matched "*")
11:46:52  4221 host in tls_advertise_hosts? no (option unset)
11:46:52  4221 SMTP>> 250-MTS.afsga.muh Hello homepc [192.168.0.14]
11:46:52  4221 250-SIZE 52428800
11:46:52  4221 250-PIPELINING
11:46:52  4221 250 HELP
11:46:52  4221 SMTP<< MAIL FROM: <admin@afsga.muh>
11:46:52  4221 using ACL "acl_mail_from"
11:46:52  4221 processing "accept"
11:46:52  4221 expanding: $sender_address
11:46:52  4221    result: admin@afsga.muh
11:46:52  4221 expanding: 
11:46:52  4221    result: 
11:46:52  4221 condition: !eq{$sender_address}{}
11:46:52  4221    result: true
11:46:52  4221 expanding: ${if !eq{$sender_address}{} }
11:46:52  4221    result: true
11:46:52  4221 check condition = ${if !eq{$sender_address}{} }
11:46:52  4221                 = true
11:46:52  4221 accept: condition test succeeded
11:46:52  4221 SMTP>> 250 OK
11:46:52  4221 SMTP<< RCPT TO: <address@yandex.ru>
11:46:52  4221 using ACL "my_recive_acl"
11:46:52  4221 processing "accept"
11:46:52  4221 check domains = +my_local_domains
11:46:52  4221 yandex.ru in "afsga.muh : *.afsga.muh"? no (end of list)
11:46:52  4221 yandex.ru in "+my_local_domains"? no (end of list)
11:46:52  4221 accept: condition test failed
11:46:52  4221 processing "accept"
11:46:52  4221 expanding: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)
11:46:52  4221    result: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@yandex.ru' or a.address ilike 'yandex.ru' or acc.fullaccess=TRUE)
11:46:52  4221 search_open: pgsql "NULL"
11:46:52  4221 search_find: file="NULL"
11:46:52  4221   key="SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@yandex.ru' or a.address ilike 'yandex.ru' or acc.fullaccess=TRUE)" partial=-1 affix=NULL starflags=0
11:46:52  4221 LRU list:
11:46:52  4221 internal_search_find: file="NULL"
11:46:52  4221   type=pgsql key="SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@yandex.ru' or a.address ilike 'yandex.ru' or acc.fullaccess=TRUE)"
11:46:52  4221 database lookup required for SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@yandex.ru' or a.address ilike 'yandex.ru' or acc.fullaccess=TRUE)
11:46:52  4221 PostgreSQL query: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@yandex.ru' or a.address ilike 'yandex.ru' or acc.fullaccess=TRUE)
11:46:52  4221 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:52  4221 lookup yielded: 1
11:46:52  4221 expanding: yes
11:46:52  4221    result: yes
11:46:52  4221 expanding: no
11:46:52  4221    result: no
11:46:52  4221 skipping: result is not used
11:46:52  4221 expanding: ${lookup pgsql{SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)}{yes}{no}}
11:46:52  4221    result: yes
11:46:52  4221 check condition = ${lookup pgsql{SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)}{yes}{no}}
11:46:52  4221                 = yes
11:46:52  4221 expanding: ${acl_c1}${local_part}@$domain\;
11:46:52  4221    result: address@yandex.ru;
11:46:52  4221 check set acl_c1 = ${acl_c1}${local_part}@$domain\;
11:46:52  4221                  = address@yandex.ru;
11:46:52  4221 accept: condition test succeeded
11:46:52  4221 SMTP>> 250 Accepted
11:46:52  4221 SMTP<< DATA
11:46:52  4221 SMTP>> 354 Enter message, ending with "." on a line by itself
11:46:52  4221 search_tidyup called
11:46:52  4221 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4221 host in ignore_fromline_hosts? no (option unset)
11:46:52  4221 >>Headers received:
11:46:52  4221 From: "Astrakhan SGA #1" <admin@afsga.muh>
11:46:52  4221 To: <address@yandex.ru>
11:46:52  4221 Subject: asfasfasfasfasfasdf
11:46:52  4221 Date: Sat, 5 Jun 2010 11:31:47 +0400
11:46:52  4221 MIME-Version: 1.0
11:46:52  4221 Content-Type: multipart/alternative;
11:46:52  4221 	boundary="----=_NextPart_000_0009_01CB04A2.AEFADBC0"
11:46:52  4221 X-Mailer: Microsoft Office Outlook, Build 11.0.5510
11:46:52  4221 Thread-Index: AcsEgSfT8a3cQZAFSNO4kxGU2QvaIw==
11:46:52  4221 X-MimeOLE: Produced By Microsoft MimeOLE V6.00.2900.5512
11:46:52  4221 
11:46:52  4221 rewrite_one_header: type=F:
11:46:52  4221   From: "Astrakhan SGA #1" <admin@afsga.muh>
11:46:52  4221 rewrite_one_header: type=T:
11:46:52  4221   To: <address@yandex.ru>
11:46:52  4221 search_tidyup called
11:46:52  4221 >>Headers after rewriting and local additions:
11:46:52  4221 F From: "Astrakhan SGA #1" <admin@afsga.muh>
11:46:52  4221 T To: <address@yandex.ru>
11:46:52  4221   Subject: asfasfasfasfasfasdf
11:46:52  4221   Date: Sat, 5 Jun 2010 11:31:47 +0400
11:46:52  4221   MIME-Version: 1.0
11:46:52  4221   Content-Type: multipart/alternative;
11:46:52  4221 	boundary="----=_NextPart_000_0009_01CB04A2.AEFADBC0"
11:46:52  4221   X-Mailer: Microsoft Office Outlook, Build 11.0.5510
11:46:52  4221   Thread-Index: AcsEgSfT8a3cQZAFSNO4kxGU2QvaIw==
11:46:52  4221   X-MimeOLE: Produced By Microsoft MimeOLE V6.00.2900.5512
11:46:52  4221 
11:46:52  4221 Data file written for message 1OKo5k-000165-H6
11:46:52  4221 expanding: ${tod_full}
11:46:52  4221    result: Sat, 05 Jun 2010 11:46:52 +0400
11:46:52  4221 condition: def:sender_rcvhost
11:46:52  4221    result: true
11:46:52  4221 expanding: from $sender_rcvhost
11:46:52  4221 	
11:46:52  4221    result: from [192.168.0.14] (helo=homepc)
11:46:52  4221 	
11:46:52  4221 condition: def:sender_ident
11:46:52  4221    result: false
11:46:52  4221 expanding: $sender_ident
11:46:52  4221    result: 
11:46:52  4221 skipping: result is not used
11:46:52  4221 expanding: from ${quote_local_part:$sender_ident} 
11:46:52  4221    result: from  
11:46:52  4221 skipping: result is not used
11:46:52  4221 condition: def:sender_helo_name
11:46:52  4221    result: false
11:46:52  4221 expanding: (helo=$sender_helo_name)
11:46:52  4221 	
11:46:52  4221    result: (helo=)
11:46:52  4221 	
11:46:52  4221 skipping: result is not used
11:46:52  4221 expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
11:46:52  4221 	}}
11:46:52  4221    result: 
11:46:52  4221 skipping: result is not used
11:46:52  4221 condition: def:received_protocol
11:46:52  4221    result: true
11:46:52  4221 expanding: with $received_protocol
11:46:52  4221    result: with esmtp
11:46:52  4221 condition: def:tls_cipher
11:46:52  4221    result: false
11:46:52  4221 expanding: ($tls_cipher)
11:46:52  4221 	
11:46:52  4221    result: ()
11:46:52  4221 	
11:46:52  4221 skipping: result is not used
11:46:52  4221 condition: def:sender_address
11:46:52  4221    result: true
11:46:52  4221 expanding: (envelope-from <$sender_address>)
11:46:52  4221 	
11:46:52  4221    result: (envelope-from <admin@afsga.muh>)
11:46:52  4221 	
11:46:52  4221 condition: def:received_for
11:46:52  4221    result: true
11:46:52  4221 expanding: 
11:46:52  4221 	for $received_for
11:46:52  4221    result: 
11:46:52  4221 	for address@yandex.ru
11:46:52  4221 expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
11:46:52  4221 	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
11:46:52  4221 	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
11:46:52  4221 	}}(Exim $version_number (FreeBSD))
11:46:52  4221 	${if def:sender_address {(envelope-from <$sender_address>)
11:46:52  4221 	}}id $message_exim_id${if def:received_for {
11:46:52  4221 	for $received_for}}
11:46:52  4221    result: Received: from [192.168.0.14] (helo=homepc)
11:46:52  4221 	by MTS.afsga.muh with esmtp (Exim 4.69 (FreeBSD))
11:46:52  4221 	(envelope-from <admin@afsga.muh>)
11:46:52  4221 	id 1OKo5k-000165-H6
11:46:52  4221 	for address@yandex.ru
11:46:52  4221 >>Generated Received: header line
11:46:52  4221 P Received: from [192.168.0.14] (helo=homepc)
11:46:52  4221 	by MTS.afsga.muh with esmtp (Exim 4.69 (FreeBSD))
11:46:52  4221 	(envelope-from <admin@afsga.muh>)
11:46:52  4221 	id 1OKo5k-000165-H6
11:46:52  4221 	for address@yandex.ru; Sat, 05 Jun 2010 11:46:52 +0400
11:46:52  4221 using ACL "acl_check_data"
11:46:52  4221 processing "warn"
11:46:52  4221 expanding: $h_message-id:
11:46:52  4221    result: 
11:46:52  4221 expanding: 
11:46:52  4221    result: 
11:46:52  4221 condition: !eq{$h_message-id:}{}
11:46:52  4221    result: false
11:46:52  4221 expanding: ${if !eq{$h_message-id:}{}}
11:46:52  4221    result: 
11:46:52  4221 check condition = ${if !eq{$h_message-id:}{}}
11:46:52  4221                 = 
11:46:52  4221 warn: condition test failed
11:46:52  4221 processing "accept"
11:46:52  4221 expanding: $message_size
11:46:52  4221    result: 4058
11:46:52  4221 expanding: 200k
11:46:52  4221    result: 200k
11:46:52  4221 expanding: $sender_address
11:46:52  4221    result: admin@afsga.muh
11:46:52  4221 expanding: .@afsga.muh
11:46:52  4221    result: .@afsga.muh
11:46:52  4221 condition: or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}
11:46:52  4221    result: true
11:46:52  4221 expanding: ${if or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}}
11:46:52  4221    result: true
11:46:52  4221 check condition = ${if or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}}
11:46:52  4221                 = true
11:46:52  4221 check add_header = X-Spam-Checked: NO - AFSGA SPAM FILTER!
11:46:52  4221 accept: condition test succeeded
11:46:52  4221 >>Headers added by DATA ACL:
11:46:52  4221   X-Spam-Checked: NO - AFSGA SPAM FILTER!
11:46:52  4221 >>
11:46:52  4221 calling local_scan(); timeout=300
11:46:52  4221 local_scan() returned 0 NULL
11:46:52  4221 expanding: ${tod_full}
11:46:52  4221    result: Sat, 05 Jun 2010 11:46:52 +0400
11:46:52  4221 Writing spool header file
11:46:52  4221 Size of headers = 645
11:46:52  4221 LOG: MAIN
11:46:52  4221   <= admin@afsga.muh H=(homepc) [192.168.0.14] P=esmtp S=4305
11:46:52  4221 SMTP>> 250 OK id=1OKo5k-000165-H6
11:46:52  4221 search_tidyup called
11:46:52  4221 Sender: admin@afsga.muh
11:46:52  4221 Recipients:
11:46:52  4221   address@yandex.ru
11:46:52  4221 forked delivery process 4223
11:46:52  4223 exec /usr/local/sbin/exim -d=0xfffdffff -Mc 1OKo5k-000165-H6
11:46:52  4221 Process 4221 is ready for new message
11:46:52  4223 Exim version 4.69 (FreeBSD 6.3) uid=26 gid=6 pid=4223 D=fffdffff
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq iconv() IPv6 use_setclassresources PAM Perl Expand_dlfunc OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch nis nis0 passwd pgsql
Authenticators: cram_md5 dovecot plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
11:46:52  4223 changed uid/gid: forcing real = effective
11:46:52  4223   uid=0 gid=6 pid=4223
11:46:52  4223   auxiliary group list: 6
11:46:52  4223 configuration file is /usr/local/etc/exim/configure
11:46:52  4223 log selectors = 00000ffc 00212001
11:46:52  4223 cwd=/var/spool/exim 4 args: /usr/local/sbin/exim -d=0xfffdffff -Mc 1OKo5k-000165-H6
11:46:52  4223 trusted user
11:46:52  4223 admin user
11:46:52  4223 skipping ACL configuration - not needed
11:46:52  4223 seeking password data for user "mailnull": using cached result
11:46:52  4223 getpwnam() succeeded uid=26 gid=26
11:46:52  4223 set_process_info:  4223 delivering specified messages
11:46:52  4223 set_process_info:  4223 delivering 1OKo5k-000165-H6
11:46:52  4223 reading spool file 1OKo5k-000165-H6-H
11:46:52  4223 user=mailnull uid=26 gid=6 sender=admin@afsga.muh
11:46:52  4223 sender_fullhost = (homepc) [192.168.0.14]
11:46:52  4223 sender_rcvhost = [192.168.0.14] (helo=homepc)
11:46:52  4223 sender_local=0 ident=unset
11:46:52  4223 Non-recipients:
11:46:52  4223 Empty Tree
11:46:52  4223 ---- End of tree ----
11:46:52  4223 recipients_count=1
11:46:52  4223 body_linecount=118 message_linecount=16
11:46:52  4223 Delivery address list:
11:46:52  4223   address@yandex.ru 
11:46:52  4223 locking /var/spool/exim/db/retry.lockfile
11:46:52  4223 locked /var/spool/exim/db/retry.lockfile
11:46:52  4223 EXIM_DBOPEN(/var/spool/exim/db/retry)
11:46:52  4221 smtp_setup_msg entered
11:46:52  4223 returned from EXIM_DBOPEN
11:46:52  4223 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 Considering: address@yandex.ru
11:46:52  4223 unique = address@yandex.ru
11:46:52  4223 dbfn_read: key=R:yandex.ru
11:46:52  4223 dbfn_read: key=R:address@yandex.ru
11:46:52  4223 dbfn_read: key=R:address@yandex.ru:<admin@afsga.muh>
11:46:52  4223 no domain retry record
11:46:52  4223 no address retry record
11:46:52  4223 address@yandex.ru: queued for routing
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 routing address@yandex.ru
11:46:52  4223 --------> archive_out router <--------
11:46:52  4223 local_part=tnzheka domain=yandex.ru
11:46:52  4223 checking domains
11:46:52  4223 yandex.ru in "afsga.muh : *.afsga.muh"? no (end of list)
11:46:52  4223 yandex.ru in "!+my_local_domains"? yes (end of list)
11:46:52  4223 calling archive_out router
11:46:52  4223 rda_interpret (string): archive-out@afsga.muh
11:46:52  4223 expanded: archive-out@afsga.muh
11:46:52  4223 file is not a filter file
11:46:52  4223 parse_forward_list: archive-out@afsga.muh
11:46:52  4223 extract item: archive-out@afsga.muh
11:46:52  4223 archive_out router generated archive-out@afsga.muh
11:46:52  4223   errors_to=NULL transport=NULL
11:46:52  4223   uid=unset gid=unset home=NULL
11:46:52  4223 routed by archive_out router (unseen)
11:46:52  4223   envelope to: address@yandex.ru
11:46:52  4223   transport: <none>
11:46:52  4223 "unseen" set: replicated address@yandex.ru
11:46:52  4223 locking /var/spool/exim/db/retry.lockfile
11:46:52  4223 locked /var/spool/exim/db/retry.lockfile
11:46:52  4223 EXIM_DBOPEN(/var/spool/exim/db/retry)
11:46:52  4223 returned from EXIM_DBOPEN
11:46:52  4223 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 Considering: address@yandex.ru
11:46:52  4223 unique = \0\address@yandex.ru
11:46:52  4223 dbfn_read: key=R:yandex.ru
11:46:52  4223 dbfn_read: key=R:address@yandex.ru
11:46:52  4223 dbfn_read: key=R:address@yandex.ru:<admin@afsga.muh>
11:46:52  4223 no domain retry record
11:46:52  4223 no address retry record
11:46:52  4223 address@yandex.ru: queued for routing
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 Considering: archive-out@afsga.muh
11:46:52  4223 unique = archive-out@afsga.muh
11:46:52  4223 dbfn_read: key=R:afsga.muh
11:46:52  4223 dbfn_read: key=R:archive-out@afsga.muh
11:46:52  4223 dbfn_read: key=R:archive-out@afsga.muh:<admin@afsga.muh>
11:46:52  4223 no domain retry record
11:46:52  4223 no address retry record
11:46:52  4223 archive-out@afsga.muh: queued for routing
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 routing archive-out@afsga.muh
11:46:52  4223 --------> archive_out router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking domains
11:46:52  4223 afsga.muh in "afsga.muh : *.afsga.muh"? yes (matched "afsga.muh")
11:46:52  4223 afsga.muh in "!+my_local_domains"? no (matched "!+my_local_domains")
11:46:52  4223 archive_out router skipped: domains mismatch
11:46:52  4223 --------> archive_dsn_in router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking local_parts
11:46:52  4223 archive-out in "!archive-dsn-in"? yes (end of list)
11:46:52  4223 checking "condition"
11:46:52  4223 expanding: $acl_c3
11:46:52  4223    result: 
11:46:52  4223 empty string cast to zero for numerical comparison
11:46:52  4223 expanding: 0
11:46:52  4223    result: 0
11:46:52  4223 condition: >{$acl_c3}{0}
11:46:52  4223    result: false
11:46:52  4223 expanding: ${if >{$acl_c3}{0}}
11:46:52  4223    result: 
11:46:52  4223 archive_dsn_in router skipped: condition failure
11:46:52  4223 --------> send_to_mail_muh_ru router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking domains
11:46:52  4223 afsga.muh in "muh.ru : campus.muh.ru : sgutv.ru"? no (end of list)
11:46:52  4223 afsga.muh in "+domain_muh"? no (end of list)
11:46:52  4223 send_to_mail_muh_ru router skipped: domains mismatch
11:46:52  4223 --------> send_to_gate_muh_ru router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking domains
11:46:52  4223 afsga.muh in "filial.sga"? no (end of list)
11:46:52  4223 send_to_gate_muh_ru router skipped: domains mismatch
11:46:52  4223 --------> send_to_gateway router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking domains
11:46:52  4223 cached yes match for +my_local_domains
11:46:52  4223 cached lookup data = NULL
11:46:52  4223 afsga.muh in "!+my_local_domains"? no (matched "!+my_local_domains" - cached)
11:46:52  4223 send_to_gateway router skipped: domains mismatch
11:46:52  4223 --------> from_inet_to_procmail router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking local_parts
11:46:52  4223 archive-out in "!archive-dsn-in"? yes (end of list)
11:46:52  4223 checking "condition"
11:46:52  4223 expanding: $sender_address
11:46:52  4223    result: admin@afsga.muh
11:46:52  4223 expanding: .@afsga.muh
11:46:52  4223    result: .@afsga.muh
11:46:52  4223 expanding: $sender_address
11:46:52  4223    result: 
11:46:52  4223 skipping: result is not used
11:46:52  4223 expanding: 
11:46:52  4223    result: 
11:46:52  4223 skipping: result is not used
11:46:52  4223 condition: and{ {!match{$sender_address}{.@afsga.muh}}{!eq{$sender_address}{}}}
11:46:52  4223    result: false
11:46:52  4223 expanding: 1
11:46:52  4223    result: 1
11:46:52  4223 skipping: result is not used
11:46:52  4223 expanding: 0
11:46:52  4223    result: 0
11:46:52  4223 expanding: ${if and{ {!match{$sender_address}{.@afsga.muh}}{!eq{$sender_address}{}}} {1} {0} }
11:46:52  4223    result: 0
11:46:52  4223 from_inet_to_procmail router skipped: condition failure
11:46:52  4223 --------> my_local_domains_router router <--------
11:46:52  4223 local_part=archive-out domain=afsga.muh
11:46:52  4223 checking "condition"
11:46:52  4223 expanding: select uid from accounts where login = '$local_part@$domain'
11:46:52  4223    result: select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 search_open: pgsql "NULL"
11:46:52  4223 search_find: file="NULL"
11:46:52  4223   key="select uid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:52  4223 LRU list:
11:46:52  4223 internal_search_find: file="NULL"
11:46:52  4223   type=pgsql key="select uid from accounts where login = 'archive-out@afsga.muh'"
11:46:52  4223 database lookup required for select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PostgreSQL query: select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:52  4223 lookup yielded: 18
11:46:52  4223 expanding: yes
11:46:52  4223    result: yes
11:46:52  4223 expanding: no
11:46:52  4223    result: no
11:46:52  4223 skipping: result is not used
11:46:52  4223 expanding: ${lookup pgsql{select uid from accounts where login = '$local_part@$domain'}{yes}{no}}
11:46:52  4223    result: yes
11:46:52  4223 calling my_local_domains_router router
11:46:52  4223 my_local_domains_router router called for archive-out@afsga.muh
11:46:52  4223   domain = afsga.muh
11:46:52  4223 set transport my_local_delivery_transport
11:46:52  4223 queued for my_local_delivery_transport transport: local_part = archive-out
11:46:52  4223 domain = afsga.muh
11:46:52  4223   errors_to=NULL
11:46:52  4223   domain_data=NULL localpart_data=NULL
11:46:52  4223 routed by my_local_domains_router router
11:46:52  4223   envelope to: archive-out@afsga.muh
11:46:52  4223   transport: my_local_delivery_transport
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 routing address@yandex.ru
11:46:52  4223 --------> archive_dsn_in router <--------
11:46:52  4223 local_part=tnzheka domain=yandex.ru
11:46:52  4223 checking local_parts
11:46:52  4223 tnzheka in "!archive-dsn-in"? yes (end of list)
11:46:52  4223 checking "condition"
11:46:52  4223 expanding: $acl_c3
11:46:52  4223    result: 
11:46:52  4223 empty string cast to zero for numerical comparison
11:46:52  4223 expanding: 0
11:46:52  4223    result: 0
11:46:52  4223 condition: >{$acl_c3}{0}
11:46:52  4223    result: false
11:46:52  4223 expanding: ${if >{$acl_c3}{0}}
11:46:52  4223    result: 
11:46:52  4223 archive_dsn_in router skipped: condition failure
11:46:52  4223 --------> send_to_mail_muh_ru router <--------
11:46:52  4223 local_part=tnzheka domain=yandex.ru
11:46:52  4223 checking domains
11:46:52  4223 yandex.ru in "muh.ru : campus.muh.ru : sgutv.ru"? no (end of list)
11:46:52  4223 yandex.ru in "+domain_muh"? no (end of list)
11:46:52  4223 send_to_mail_muh_ru router skipped: domains mismatch
11:46:52  4223 --------> send_to_gate_muh_ru router <--------
11:46:52  4223 local_part=tnzheka domain=yandex.ru
11:46:52  4223 checking domains
11:46:52  4223 yandex.ru in "filial.sga"? no (end of list)
11:46:52  4223 send_to_gate_muh_ru router skipped: domains mismatch
11:46:52  4223 --------> send_to_gateway router <--------
11:46:52  4223 local_part=tnzheka domain=yandex.ru
11:46:52  4223 checking domains
11:46:52  4223 yandex.ru in "afsga.muh : *.afsga.muh"? no (end of list)
11:46:52  4223 yandex.ru in "!+my_local_domains"? yes (end of list)
11:46:52  4223 calling send_to_gateway router
11:46:52  4223 send_to_gateway router called for address@yandex.ru
11:46:52  4223   domain = yandex.ru
11:46:52  4223 route_item = * smtp.yandex.ru
11:46:52  4223 yandex.ru in "*"? yes (matched "*")
11:46:52  4223 original list of hosts = "smtp.yandex.ru" options = 
11:46:52  4223 expanded list of hosts = "smtp.yandex.ru" options = 
11:46:52  4223 set transport remote_smtp
11:46:52  4223 finding IP address for smtp.yandex.ru
11:46:52  4223 doing DNS lookup
;; res_nquerydomain(smtp.yandex.ru, <Nil>, 1, 28)
;; res_query(smtp.yandex.ru, 1, 28)
;; res_nmkquery(QUERY, smtp.yandex.ru, IN, AAAA)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13596
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = AAAA, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13596
;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;;	smtp.yandex.ru, type = AAAA, class = IN
yandex.ru.		14m2s IN SOA	ns1.yandex.ru. sysadmin.yandex-team.ru. (
					2010060411	; serial
					30M		; refresh
					15M		; retry
					4w2d		; expiry
					15M )		; minimum

;; rcode = (NOERROR), counts = an:0 ns:1 ar:0
11:46:52  4223 DNS lookup of smtp.yandex.ru (AAAA) gave NO_DATA
11:46:52  4223 returning DNS_NODATA
;; res_nquerydomain(smtp.yandex.ru, <Nil>, 1, 1)
;; res_query(smtp.yandex.ru, 1, 1)
;; res_nmkquery(QUERY, smtp.yandex.ru, IN, A)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13597
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = A, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13597
;; flags: qr rd ra; QUERY: 1, ANSWER: 3, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = A, class = IN
smtp.yandex.ru.		3m2s IN A	77.88.21.38
smtp.yandex.ru.		3m2s IN A	93.158.134.38
smtp.yandex.ru.		3m2s IN A	213.180.204.38
11:46:52  4223 DNS lookup of smtp.yandex.ru (A) succeeded
11:46:52  4223 77.88.21.38 in "0.0.0.0 : 127.0.0.0.8"? no (malformed IPv4 address or address mask)
11:46:52  4223 93.158.134.38 in "0.0.0.0 : 127.0.0.0.8"? no (malformed IPv4 address or address mask)
11:46:52  4223 213.180.204.38 in "0.0.0.0 : 127.0.0.0.8"? no (malformed IPv4 address or address mask)
11:46:52  4223 Actual local interface address is 192.168.0.9 (xl0)
11:46:52  4223 Actual local interface address is 10.30.30.9 (xl0)
11:46:52  4223 Actual local interface address is 192.168.50.9 (xl0)
11:46:52  4223 Actual local interface address is 91.211.142.18 (rl0)
11:46:52  4223 Actual local interface address is fe80:4::1 (lo0)
11:46:52  4223 Actual local interface address is ::1 (lo0)
11:46:52  4223 Actual local interface address is 127.0.0.1 (lo0)
11:46:52  4223 fully qualified name = smtp.yandex.ru
11:46:52  4223 smtp.yandex.ru 77.88.21.38 mx=-1 sort=-329 
11:46:52  4223 smtp.yandex.ru 93.158.134.38 mx=-1 sort=-194 
11:46:52  4223 smtp.yandex.ru 213.180.204.38 mx=-1 sort=-169 
11:46:52  4223 queued for remote_smtp transport: local_part = tnzheka
11:46:52  4223 domain = yandex.ru
11:46:52  4223   errors_to=NULL
11:46:52  4223   domain_data=NULL localpart_data=NULL
11:46:52  4223 routed by send_to_gateway router
11:46:52  4223   envelope to: address@yandex.ru
11:46:52  4223   transport: remote_smtp
11:46:52  4223   host smtp.yandex.ru [77.88.21.38]
11:46:52  4223   host smtp.yandex.ru [93.158.134.38]
11:46:52  4223   host smtp.yandex.ru [213.180.204.38]
11:46:52  4223 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
11:46:52  4223 After routing:
11:46:52  4223   Local deliveries:
11:46:52  4223     archive-out@afsga.muh
11:46:52  4223   Remote deliveries:
11:46:52  4223     address@yandex.ru
11:46:52  4223   Failed addresses:
11:46:52  4223   Deferred addresses:
11:46:52  4223 search_tidyup called
11:46:52  4223 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4223 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
11:46:52  4223 --------> archive-out@afsga.muh <--------
11:46:52  4223 locking /var/spool/exim/db/retry.lockfile
11:46:52  4223 locked /var/spool/exim/db/retry.lockfile
11:46:52  4223 EXIM_DBOPEN(/var/spool/exim/db/retry)
11:46:52  4223 returned from EXIM_DBOPEN
11:46:52  4223 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
11:46:52  4223 dbfn_read: key=T:archive-out@afsga.muh
11:46:52  4223 no retry record exists
11:46:52  4223 expanding: select gid from accounts where login = '$local_part@$domain'
11:46:52  4223    result: select gid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 search_open: pgsql "NULL"
11:46:52  4223 search_find: file="NULL"
11:46:52  4223   key="select gid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:52  4223 LRU list:
11:46:52  4223 internal_search_find: file="NULL"
11:46:52  4223   type=pgsql key="select gid from accounts where login = 'archive-out@afsga.muh'"
11:46:52  4223 database lookup required for select gid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PostgreSQL query: select gid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:52  4223 lookup yielded: 6
11:46:52  4223 expanding: $value
11:46:52  4223    result: 6
11:46:52  4223 expanding: ${lookup pgsql{select gid from accounts where login = '$local_part@$domain'}{$value}fail}
11:46:52  4223    result: 6
11:46:52  4223 expanding: select uid from accounts where login = '$local_part@$domain'
11:46:52  4223    result: select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 search_open: pgsql "NULL"
11:46:52  4223   cached open
11:46:52  4223 search_find: file="NULL"
11:46:52  4223   key="select uid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:52  4223 LRU list:
11:46:52  4223 internal_search_find: file="NULL"
11:46:52  4223   type=pgsql key="select uid from accounts where login = 'archive-out@afsga.muh'"
11:46:52  4223 database lookup required for select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PostgreSQL query: select uid from accounts where login = 'archive-out@afsga.muh'
11:46:52  4223 PGSQL using cached connection for (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4223 lookup yielded: 18
11:46:52  4223 expanding: $value
11:46:52  4223    result: 18
11:46:52  4223 expanding: ${lookup pgsql{select uid from accounts where login = '$local_part@$domain'}{$value}fail}
11:46:52  4223    result: 18
11:46:52  4223 seeking password data for user "18": cache not available
11:46:52  4223 search_tidyup called
11:46:52  4223 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4226 expanding: select mailquota from accounts where login = '$local_part@$domain'
11:46:52  4226    result: select mailquota from accounts where login = 'archive-out@afsga.muh'
11:46:52  4226 search_open: pgsql "NULL"
11:46:52  4226 search_find: file="NULL"
11:46:52  4226   key="select mailquota from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:52  4226 LRU list:
11:46:52  4226 internal_search_find: file="NULL"
11:46:52  4226   type=pgsql key="select mailquota from accounts where login = 'archive-out@afsga.muh'"
11:46:52  4226 database lookup required for select mailquota from accounts where login = 'archive-out@afsga.muh'
11:46:52  4226 PostgreSQL query: select mailquota from accounts where login = 'archive-out@afsga.muh'
11:46:52  4226 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:52  4226 lookup yielded: 1000000000
11:46:52  4226 expanding: $value
11:46:52  4226    result: 1000000000
11:46:52  4226 expanding: ${lookup pgsql{select mailquota from accounts where login = '$local_part@$domain'}{$value}fail}
11:46:52  4226    result: 1000000000
11:46:52  4226 changed uid/gid: local delivery to archive-out <archive-out@afsga.muh> transport=my_local_delivery_transport
11:46:52  4226   uid=18 gid=6 pid=4226
11:46:52  4226   auxiliary group list: 6
11:46:52  4226   home=NULL current=/
11:46:52  4226 set_process_info:  4226 delivering 1OKo5k-000165-H6 to archive-out using my_local_delivery_transport
11:46:52  4226 appendfile transport entered
11:46:52  4226 expanding: /var/mail/$local_part@$domain
11:46:52  4226    result: /var/mail/archive-out@afsga.muh
11:46:52  4226 appendfile: mode=660 notify_comsat=0 quota=1000000000 warning=75%
11:46:52  4226   file=/var/mail/archive-out@afsga.muh format=unix
11:46:52  4226   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
11:46:52  4226   message_suffix=\n
11:46:52  4226   maildir_use_size_file=no
11:46:52  4226   locking by lockfile fcntl 
11:46:52  4226 lock name: /var/mail/archive-out@afsga.muh.lock
11:46:52  4226 hitch name: /var/mail/archive-out@afsga.muh.lock.MTS.afsga.muh.4c0a00ec.00001082
11:46:52  4226 lock file created
11:46:52  4226 mailbox /var/mail/archive-out@afsga.muh is locked
11:46:52  4226 writing to file /var/mail/archive-out@afsga.muh
11:46:52  4226 Exim quota = 1000000000 old size = 264819253 this message = 4305 (included)
11:46:52  4226   file count quota = 0 count = 0
11:46:52  4226 condition: def:return_path
11:46:52  4226    result: true
11:46:52  4226 expanding: $return_path
11:46:52  4226    result: admin@afsga.muh
11:46:52  4226 expanding: MAILER-DAEMON
11:46:52  4226    result: MAILER-DAEMON
11:46:52  4226 skipping: result is not used
11:46:52  4226 expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
11:46:52  4226 
11:46:52  4226    result: From admin@afsga.muh Sat Jun 05 11:46:52 2010
11:46:52  4226 
11:46:52  4226 writing data block fd=7 size=46 timeout=0
11:46:52  4226 writing data block fd=7 size=4414 timeout=0
11:46:52  4226 writing data block fd=7 size=1 timeout=0
11:46:52  4226 quota = 1000000000 threshold = 750000000 old size = 264819253 message size = 4461
11:46:52  4226 appendfile yields 0 with errno=0 more_errno=0
11:46:52  4223 journalling archive-out@afsga.muh
11:46:52  4226 search_tidyup called
11:46:52  4226 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4223 my_local_delivery_transport transport returned OK for archive-out@afsga.muh
11:46:52  4223 post-process archive-out@afsga.muh (0)
11:46:52  4223 archive-out@afsga.muh delivered
11:46:52  4223 LOG: MAIN
11:46:52  4223   => archive-out <address@yandex.ru> R=my_local_domains_router T=my_local_delivery_transport
11:46:52  4223 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
11:46:52  4223 --------> address@yandex.ru <--------
11:46:52  4223 expanding: select extmail from accounts where login = '$sender_address'
11:46:52  4223    result: select extmail from accounts where login = 'admin@afsga.muh'
11:46:52  4223 search_open: pgsql "NULL"
11:46:52  4223 search_find: file="NULL"
11:46:52  4223   key="select extmail from accounts where login = 'admin@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:52  4223 LRU list:
11:46:52  4223 internal_search_find: file="NULL"
11:46:52  4223   type=pgsql key="select extmail from accounts where login = 'admin@afsga.muh'"
11:46:52  4223 database lookup required for select extmail from accounts where login = 'admin@afsga.muh'
11:46:52  4223 PostgreSQL query: select extmail from accounts where login = 'admin@afsga.muh'
11:46:52  4223 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:52  4223 lookup yielded: address@yandex.ru
11:46:52  4223 expanding: $value
11:46:52  4223    result: address@yandex.ru
11:46:52  4223 expanding: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail}
11:46:52  4223    result: address@yandex.ru
11:46:52  4223 search_tidyup called
11:46:52  4223 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:52  4223 set_process_info:  4223 delivering 1OKo5k-000165-H6: waiting for a remote delivery subprocess to finish
11:46:52  4229 changed uid/gid: remote delivery to address@yandex.ru with transport=remote_smtp
11:46:52  4229   uid=26 gid=6 pid=4229
11:46:52  4223 selecting on subprocess pipes
11:46:52  4229   auxiliary group list: 6
11:46:52  4229 set_process_info:  4229 delivering 1OKo5k-000165-H6 using remote_smtp
11:46:52  4229 remote_smtp transport entered
11:46:52  4229   address@yandex.ru
11:46:52  4229 yandex.ru in queue_smtp_domains? no (option unset)
11:46:52  4229 checking status of smtp.yandex.ru
11:46:52  4229 locking /var/spool/exim/db/retry.lockfile
11:46:52  4229 locked /var/spool/exim/db/retry.lockfile
11:46:52  4229 EXIM_DBOPEN(/var/spool/exim/db/retry)
11:46:52  4229 returned from EXIM_DBOPEN
11:46:52  4229 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
11:46:52  4229 dbfn_read: key=T:smtp.yandex.ru:77.88.21.38
11:46:52  4229 dbfn_read: key=T:smtp.yandex.ru:77.88.21.38:1OKo5k-000165-H6
11:46:52  4229 no host retry record
11:46:52  4229 no message retry record
11:46:52  4229 smtp.yandex.ru [77.88.21.38] status = usable
11:46:52  4229 77.88.21.38 in serialize_hosts? no (option unset)
11:46:52  4229 delivering 1OKo5k-000165-H6 to smtp.yandex.ru [77.88.21.38] (address@yandex.ru)
11:46:52  4229 set_process_info:  4229 delivering 1OKo5k-000165-H6 to smtp.yandex.ru [77.88.21.38] (address@yandex.ru)
11:46:52  4229 Connecting to smtp.yandex.ru [77.88.21.38]:25 ... connected
11:46:52  4229 expanding: $primary_hostname
11:46:52  4229    result: MTS.afsga.muh
11:46:52  4229 waiting for data on socket
11:46:52  4229 read response data: size=97
11:46:52  4229   SMTP<< 220 smtp1.mail.yandex.net (Want to use Yandex.Mail for your domain? Visit http://pdd.yandex.ru)
11:46:52  4229 77.88.21.38 in hosts_avoid_esmtp? no (option unset)
11:46:52  4229   SMTP>> EHLO MTS.afsga.muh
11:46:52  4229 waiting for data on socket
11:46:53  4229 read response data: size=166
11:46:53  4229   SMTP<< 250-smtp1.mail.yandex.net
11:46:53  4229          250-PIPELINING
11:46:53  4229          250-SIZE 42991616
11:46:53  4229          250-VRFY
11:46:53  4229          250-ETRN
11:46:53  4229          250-STARTTLS
11:46:53  4229          250-AUTH PLAIN LOGIN
11:46:53  4229          250-ENHANCEDSTATUSCODES
11:46:53  4229          250-8BITMIME
11:46:53  4229          250 DSN
11:46:53  4229 77.88.21.38 in hosts_avoid_tls? no (option unset)
11:46:53  4229   SMTP>> STARTTLS
11:46:53  4229 waiting for data on socket
11:46:53  4229 read response data: size=30
11:46:53  4229   SMTP<< 220 2.0.0 Ready to start TLS
11:46:53  4229 Initialized TLS
11:46:53  4229 Calling SSL_connect
11:46:53  4229 SSL info: before/connect initialization
11:46:53  4229 SSL info: before/connect initialization
11:46:53  4229 SSL info: SSLv2/v3 write client hello A
11:46:53  4229 SSL info: SSLv3 read server hello A
11:46:53  4229 SSL info: SSLv3 read server certificate A
11:46:53  4229 SSL info: SSLv3 read server key exchange A
11:46:53  4229 SSL info: SSLv3 read server done A
11:46:53  4229 SSL info: SSLv3 write client key exchange A
11:46:53  4229 SSL info: SSLv3 write change cipher spec A
11:46:53  4229 SSL info: SSLv3 write finished A
11:46:53  4229 SSL info: SSLv3 flush data
11:46:53  4229 SSL info: SSLv3 read finished A
11:46:53  4229 SSL info: SSL negotiation finished successfully
11:46:53  4229 SSL info: SSL negotiation finished successfully
11:46:53  4229 SSL_connect succeeded
11:46:53  4229 Cipher: TLSv1:DHE-RSA-AES256-SHA:256
11:46:53  4229   SMTP>> EHLO MTS.afsga.muh
11:46:53  4229 tls_do_write(bfbfbe40, 20)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 20)
11:46:53  4229 outbytes=20 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=152
11:46:53  4229   SMTP<< 250-smtp1.mail.yandex.net
11:46:53  4229          250-PIPELINING
11:46:53  4229          250-SIZE 42991616
11:46:53  4229          250-VRFY
11:46:53  4229          250-ETRN
11:46:53  4229          250-AUTH PLAIN LOGIN
11:46:53  4229          250-ENHANCEDSTATUSCODES
11:46:53  4229          250-8BITMIME
11:46:53  4229          250 DSN
11:46:53  4229 77.88.21.38 in hosts_avoid_pipelining? no (option unset)
11:46:53  4229 using PIPELINING
;; res_nquerydomain(smtp.yandex.ru, <Nil>, 1, 28)
;; res_query(smtp.yandex.ru, 1, 28)
;; res_nmkquery(QUERY, smtp.yandex.ru, IN, AAAA)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13598
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = AAAA, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13598
;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;;	smtp.yandex.ru, type = AAAA, class = IN
yandex.ru.		14m1s IN SOA	ns1.yandex.ru. sysadmin.yandex-team.ru. (
					2010060411	; serial
					30M		; refresh
					15M		; retry
					4w2d		; expiry
					15M )		; minimum

;; rcode = (NOERROR), counts = an:0 ns:1 ar:0
res_nsearch failed (-1)
11:46:53  4229 gethostbyname2(af=inet6) returned 4 (NO_DATA)
;; res_nquerydomain(smtp.yandex.ru, <Nil>, 1, 1)
;; res_query(smtp.yandex.ru, 1, 1)
;; res_nmkquery(QUERY, smtp.yandex.ru, IN, A)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13599
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = A, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 13599
;; flags: qr rd ra; QUERY: 1, ANSWER: 3, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.yandex.ru, type = A, class = IN
smtp.yandex.ru.		3m1s IN A	93.158.134.38
smtp.yandex.ru.		3m1s IN A	213.180.204.38
smtp.yandex.ru.		3m1s IN A	77.88.21.38
11:46:53  4229 gethostbyname2 looked up these IP addresses:
11:46:53  4229   name=smtp.yandex.ru address=93.158.134.38
11:46:53  4229   name=smtp.yandex.ru address=213.180.204.38
11:46:53  4229   name=smtp.yandex.ru address=77.88.21.38
11:46:53  4229 77.88.21.38 in hosts_require_auth? yes (matched "smtp.yandex.ru")
11:46:53  4229 scanning authentication mechanisms
11:46:53  4229   SMTP>> AUTH LOGIN
11:46:53  4229 tls_do_write(bfbfbe40, 12)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 12)
11:46:53  4229 outbytes=12 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=18
11:46:53  4229   SMTP<< 334 VXNlcm5hbWU6
11:46:53  4229 expanding: select extmail from accounts where login = '$sender_address'
11:46:53  4229    result: select extmail from accounts where login = 'admin@afsga.muh'
11:46:53  4229 search_open: pgsql "NULL"
11:46:53  4229 search_find: file="NULL"
11:46:53  4229   key="select extmail from accounts where login = 'admin@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:53  4229 LRU list:
11:46:53  4229 internal_search_find: file="NULL"
11:46:53  4229   type=pgsql key="select extmail from accounts where login = 'admin@afsga.muh'"
11:46:53  4229 database lookup required for select extmail from accounts where login = 'admin@afsga.muh'
11:46:53  4229 PostgreSQL query: select extmail from accounts where login = 'admin@afsga.muh'
11:46:53  4229 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
11:46:53  4229 lookup yielded: address@yandex.ru
11:46:53  4229 expanding: $value
11:46:53  4229    result: address@yandex.ru
11:46:53  4229 expanding: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail}
11:46:53  4229    result: address@yandex.ru
11:46:53  4229   SMTP>> ************************
11:46:53  4229 tls_do_write(bfbfbe40, 26)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 26)
11:46:53  4229 outbytes=26 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=18
11:46:53  4229   SMTP<< 334 UGFzc3dvcmQ6
11:46:53  4229 expanding: select extmailpwd from accounts where login = '$sender_address'
11:46:53  4229    result: select extmailpwd from accounts where login = 'admin@afsga.muh'
11:46:53  4229 search_open: pgsql "NULL"
11:46:53  4229   cached open
11:46:53  4229 search_find: file="NULL"
11:46:53  4229   key="select extmailpwd from accounts where login = 'admin@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:53  4229 LRU list:
11:46:53  4229 internal_search_find: file="NULL"
11:46:53  4229   type=pgsql key="select extmailpwd from accounts where login = 'admin@afsga.muh'"
11:46:53  4229 database lookup required for select extmailpwd from accounts where login = 'admin@afsga.muh'
11:46:53  4229 PostgreSQL query: select extmailpwd from accounts where login = 'admin@afsga.muh'
11:46:53  4229 PGSQL using cached connection for (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:53  4229 lookup yielded: tnzheka7
11:46:53  4229 expanding: $value
11:46:53  4229    result: tnzheka7
11:46:53  4229 expanding: ${lookup pgsql{select extmailpwd from accounts where login = '$sender_address'}{$value}fail}
11:46:53  4229    result: tnzheka7
11:46:53  4229   SMTP>> ************
11:46:53  4229 tls_do_write(bfbfbe40, 14)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 14)
11:46:53  4229 outbytes=14 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=37
11:46:53  4229   SMTP<< 235 2.7.0 Authentication successful
11:46:53  4229 mail_login authenticator yielded 0
11:46:53  4229   SMTP>> MAIL FROM:<address@yandex.ru> SIZE=5463
11:46:53  4229   SMTP>> RCPT TO:<address@yandex.ru>
11:46:53  4229   SMTP>> DATA
11:46:53  4229 tls_do_write(bfbfbe40, 76)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 76)
11:46:53  4229 outbytes=76 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=65
11:46:53  4229   SMTP<< 250 2.1.0 Ok
11:46:53  4229   SMTP<< 250 2.1.5 Ok
11:46:53  4229   SMTP<< 354 End data with <CR><LF>.<CR><LF>
11:46:53  4229   SMTP>> writing message and terminating "."
11:46:53  4229 condition: def:h_Disposition-Notification-To:
11:46:53  4229    result: false
11:46:53  4229 expanding: Disposition-Notification-To
11:46:53  4229    result: Disposition-Notification-To
11:46:53  4229 skipping: result is not used
11:46:53  4229 expanding: ${if def:h_Disposition-Notification-To: {Disposition-Notification-To}}
11:46:53  4229    result: 
11:46:53  4229 rewrite_one_header: type=F:
11:46:53  4229   From: "Astrakhan SGA #1" <admin@afsga.muh>
11:46:53  4229 address match: subject=admin@afsga.muh pattern=*@afsga.muh
11:46:53  4229 afsga.muh in "afsga.muh"? yes (matched "afsga.muh")
11:46:53  4229 admin@afsga.muh in "*@afsga.muh"? yes (matched "*@afsga.muh")
11:46:53  4229 expanding: select extmail from accounts where login = '$sender_address'
11:46:53  4229    result: select extmail from accounts where login = 'admin@afsga.muh'
11:46:53  4229 search_open: pgsql "NULL"
11:46:53  4229   cached open
11:46:53  4229 search_find: file="NULL"
11:46:53  4229   key="select extmail from accounts where login = 'admin@afsga.muh'" partial=-1 affix=NULL starflags=0
11:46:53  4229 LRU list:
11:46:53  4229 internal_search_find: file="NULL"
11:46:53  4229   type=pgsql key="select extmail from accounts where login = 'admin@afsga.muh'"
11:46:53  4229 cached data used for lookup of select extmail from accounts where login = 'admin@afsga.muh'
11:46:53  4229 lookup yielded: address@yandex.ru
11:46:53  4229 expanding: $value
11:46:53  4229    result: address@yandex.ru
11:46:53  4229 expanding: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail}
11:46:53  4229    result: address@yandex.ru
11:46:53  4229 LOG: address_rewrite MAIN
11:46:53  4229   "admin@afsga.muh" from from: rewritten as "address@yandex.ru" by rule 1
11:46:53  4229 newlen=45 newtype=F newtext:
11:46:53  4229 From: "Astrakhan SGA #1" <address@yandex.ru>
11:46:53  4229 remainder: 
11:46:53  4229 rewrite_one_header: type=T:
11:46:53  4229   To: <address@yandex.ru>
11:46:53  4229 address match: subject=address@yandex.ru pattern=*@afsga.muh
11:46:53  4229 yandex.ru in "afsga.muh"? no (end of list)
11:46:53  4229 address@yandex.ru in "*@afsga.muh"? no (end of list)
11:46:53  4229 condition: def:h_Disposition-Notification-To:
11:46:53  4229    result: false
11:46:53  4229 expanding: select extmail from accounts where login = '$sender_address'
11:46:53  4229    result: select extmail from accounts where login = ''
11:46:53  4229 skipping: result is not used
11:46:53  4229 expanding: $value
11:46:53  4229    result: 
11:46:53  4229 skipping: result is not used
11:46:53  4229 expanding: Disposition-Notification-To: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail} 
11:46:53  4229    result: Disposition-Notification-To:  
11:46:53  4229 skipping: result is not used
11:46:53  4229 expanding: ${if def:h_Disposition-Notification-To: {Disposition-Notification-To: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail} } }
11:46:53  4229    result: 
11:46:53  4229 writing data block fd=7 size=4445 timeout=300
11:46:53  4229 tls_do_write(812f000, 4445)
11:46:53  4229 SSL_write(SSL, 812f000, 4445)
11:46:53  4229 outbytes=4445 error=0
11:46:53  4229 waiting for data on socket
11:46:53  4229 Calling SSL_read(8116200, bfbfc240, 4096)
11:46:53  4229 read response data: size=62
11:46:53  4229   SMTP<< 250 2.0.0 Ok: queued on smtp1.mail.yandex.net as BB3D9290058
11:46:53  4229 journalling address@yandex.ru/remote_smtp
11:46:53  4229 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL
11:46:53  4229 77.88.21.38 in hosts_nopass_tls? no (option unset)
11:46:53  4229 transport_check_waiting entered
11:46:53  4229   sequence=1 local_max=500 global_max=-1
11:46:53  4229 locking /var/spool/exim/db/wait-remote_smtp.lockfile
11:46:53  4229 locked /var/spool/exim/db/wait-remote_smtp.lockfile
11:46:53  4229 EXIM_DBOPEN(/var/spool/exim/db/wait-remote_smtp)
11:46:53  4229 returned from EXIM_DBOPEN
11:46:53  4229 opened hints database /var/spool/exim/db/wait-remote_smtp: flags=O_RDWR
11:46:53  4229 dbfn_read: key=smtp.yandex.ru
11:46:53  4229 no messages waiting for smtp.yandex.ru
11:46:53  4229   SMTP>> QUIT
11:46:53  4229 tls_do_write(bfbfbe40, 6)
11:46:53  4229 SSL_write(SSL, bfbfbe40, 6)
11:46:53  4229 outbytes=6 error=0
11:46:53  4229 tls_close(): shutting down SSL
11:46:53  4229 SSL info: SSL negotiation finished successfully
11:46:53  4229 set_process_info:  4229 delivering 1OKo5k-000165-H6: just tried smtp.yandex.ru [77.88.21.38] for address@yandex.ru: result OK
11:46:53  4229 Leaving remote_smtp transport
11:46:53  4229 set_process_info:  4229 delivering 1OKo5k-000165-H6 (just run remote_smtp for address@yandex.ru in subprocess)
11:46:53  4229 search_tidyup called
11:46:53  4229 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
11:46:53  4223 reading pipe for subprocess 4229 (not ended)
11:46:53  4223 read() yielded 187
11:46:53  4223 Z0 item read
11:46:53  4223 remote delivery process 4229 ended
11:46:53  4223 set_process_info:  4223 delivering 1OKo5k-000165-H6
11:46:53  4223 post-process address@yandex.ru (0)
11:46:53  4223 address@yandex.ru delivered
11:46:53  4223 address@yandex.ru: children all complete
11:46:53  4223 LOG: MAIN
11:46:53  4223   => address@yandex.ru R=send_to_gateway T=remote_smtp H=smtp.yandex.ru [77.88.21.38] X=TLSv1:DHE-RSA-AES256-SHA:256
11:46:53  4223 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
11:46:53  4223 changed uid/gid: post-delivery tidying
11:46:53  4223   uid=26 gid=6 pid=4223
11:46:53  4223   auxiliary group list: 6
11:46:53  4223 set_process_info:  4223 tidying up after delivering 1OKo5k-000165-H6
11:46:53  4223 Processing retry items
11:46:53  4223 Succeeded addresses:
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 archive-out@afsga.muh: no retry items
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 address@yandex.ru: no retry items
11:46:53  4223 Failed addresses:
11:46:53  4223 Deferred addresses:
11:46:53  4223 end of retry processing
11:46:53  4223 LOG: MAIN
11:46:53  4223   Completed
11:46:53  4223 end delivery of 1OKo5k-000165-H6
11:46:53  4223 search_tidyup called
11:46:53  4223 search_tidyup called
11:46:53  4223 >>>>>>>>>>>>>>>> Exim pid=4223 terminating with rc=0 >>>>>>>>>>>>>>>>
11:46:55  4221 SMTP<< QUIT
11:46:55  4221 SMTP>> 221 MTS.afsga.muh closing connection
11:46:55  4221 LOG: smtp_connection MAIN
11:46:55  4221   SMTP connection from (homepc) [192.168.0.14] closed by QUIT
11:46:55  4221 search_tidyup called
11:46:55  4220 child 4221 ended: status=0x0
11:46:55  4220 0 SMTP accept processes now running
11:46:55  4220 Listening...
Комментарий к логу, всех исходящие письма попадают в архив и вносится запись в базу, также перед отправкой проверяется можно ли юзеру отправлять почту на данный адрес/домен.

Хостинговая компания Host-Food.ru
Хостинг HostFood.ru
 

Услуги хостинговой компании Host-Food.ru

Хостинг HostFood.ru

Тарифы на хостинг в России, от 12 рублей: https://www.host-food.ru/tariffs/hosting/
Тарифы на виртуальные сервера (VPS/VDS/KVM) в РФ, от 189 руб.: https://www.host-food.ru/tariffs/virtualny-server-vps/
Выделенные сервера, Россия, Москва, от 2000 рублей (HP Proliant G5, Intel Xeon E5430 (2.66GHz, Quad-Core, 12Mb), 8Gb RAM, 2x300Gb SAS HDD, P400i, 512Mb, BBU):
https://www.host-food.ru/tariffs/vydelennyi-server-ds/
Недорогие домены в популярных зонах: https://www.host-food.ru/domains/

Жека
проходил мимо
Сообщения: 2
Зарегистрирован: 2010-06-04 16:37:06

Re: Exim съедает заголовки

Непрочитанное сообщение Жека » 2010-06-05 11:00:34

случайно привёл лог отправки через yandex'овскую почту, вот через mail

Код: Выделить всё

exim -bd -d+all
12:09:46  4310 Exim version 4.69 (FreeBSD 6.3) uid=0 gid=0 pid=4310 D=fffdffff
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq iconv() IPv6 use_setclassresources PAM Perl Expand_dlfunc OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch nis nis0 passwd pgsql
Authenticators: cram_md5 dovecot plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
12:09:46  4310 changed uid/gid: forcing real = effective
12:09:46  4310   uid=0 gid=0 pid=4310
12:09:46  4310   auxiliary group list: 0
12:09:46  4310 configuration file is /usr/local/etc/exim/configure
12:09:46  4310 log selectors = 00000ffc 00212001
12:09:46  4310 cwd=/usr/local/etc/exim 3 args: exim -bd -d+all
12:09:46  4310 trusted user
12:09:46  4310 admin user
12:09:46  4310 seeking password data for user "mailnull": using cached result
12:09:46  4310 getpwnam() succeeded uid=26 gid=26
12:09:46  4310 originator: uid=0 gid=0 login=root name=Charlie Root
12:09:46  4310 listening on all interfaces (IPv6) port 25
12:09:46  4310 listening on all interfaces (IPv4) port 25
12:09:46  4310 pid written to /var/run/exim.pid
12:09:46  4310 changed uid/gid: running as a daemon
12:09:46  4310   uid=26 gid=6 pid=4310
12:09:46  4310   auxiliary group list: 6 6
12:09:46  4310 LOG: MAIN
12:09:46  4310   exim 4.69 daemon started: pid=4310, no queue runs, listening for SMTP on port 25 (IPv6 and IPv4)
12:09:46  4310 set_process_info:  4310 daemon: no queue runs, listening for SMTP on port 25 (IPv6 and IPv4)
12:09:46  4310 daemon running with uid=26 gid=6 euid=26 egid=6
12:09:46  4310 Listening...
12:09:50  4310 Connection request from 192.168.0.14 port 3082
12:09:50  4310 interface address=192.168.0.9 port=25
12:09:50  4310 search_tidyup called
12:09:50  4310 1 SMTP accept process running
12:09:50  4310 Listening...
12:09:50  4311 host in rfc1413_hosts? yes (matched "*")
12:09:50  4311 doing ident callback
12:09:50  4311 ident connection to 192.168.0.14 failed: Connection refused
12:09:50  4311 sender_fullhost = [192.168.0.14]
12:09:50  4311 sender_rcvhost = [192.168.0.14]
12:09:50  4311 Process 4311 is handling incoming connection from [192.168.0.14]
12:09:50  4311 host in host_lookup? no (option unset)
12:09:50  4311 set_process_info:  4311 handling incoming connection from [192.168.0.14]
12:09:50  4311 host in host_reject_connection? no (option unset)
12:09:50  4311 host in sender_unqualified_hosts? no (option unset)
12:09:50  4311 host in recipient_unqualified_hosts? no (option unset)
12:09:50  4311 host in helo_verify_hosts? no (option unset)
12:09:50  4311 host in helo_try_verify_hosts? no (option unset)
12:09:50  4311 host in helo_accept_junk_hosts? no (option unset)
12:09:50  4311 expanding: $smtp_active_hostname ESMTP Exim $version_number $tod_full
12:09:50  4311    result: MTS.afsga.muh ESMTP Exim 4.69 Sat, 05 Jun 2010 12:09:50 +0400
12:09:50  4311 SMTP>> 220 MTS.afsga.muh ESMTP Exim 4.69 Sat, 05 Jun 2010 12:09:50 +0400
12:09:50  4311 Process 4311 is ready for new message
12:09:50  4311 smtp_setup_msg entered
12:09:50  4311 SMTP<< EHLO homepc
12:09:50  4311 homepc in helo_lookup_domains? no (end of list)
12:09:50  4311 sender_fullhost = (homepc) [192.168.0.14]
12:09:50  4311 sender_rcvhost = [192.168.0.14] (helo=homepc)
12:09:50  4311 set_process_info:  4311 handling incoming connection from (homepc) [192.168.0.14]
12:09:50  4311 host in pipelining_advertise_hosts? yes (matched "*")
12:09:50  4311 host in auth_advertise_hosts? yes (matched "*")
12:09:50  4311 host in tls_advertise_hosts? no (option unset)
12:09:50  4311 SMTP>> 250-MTS.afsga.muh Hello homepc [192.168.0.14]
12:09:50  4311 250-SIZE 52428800
12:09:50  4311 250-PIPELINING
12:09:50  4311 250 HELP
12:09:50  4311 SMTP<< MAIL FROM: <admin@afsga.muh>
12:09:50  4311 using ACL "acl_mail_from"
12:09:50  4311 processing "accept"
12:09:50  4311 expanding: $sender_address
12:09:50  4311    result: admin@afsga.muh
12:09:50  4311 expanding: 
12:09:50  4311    result: 
12:09:50  4311 condition: !eq{$sender_address}{}
12:09:50  4311    result: true
12:09:50  4311 expanding: ${if !eq{$sender_address}{} }
12:09:50  4311    result: true
12:09:50  4311 check condition = ${if !eq{$sender_address}{} }
12:09:50  4311                 = true
12:09:50  4311 accept: condition test succeeded
12:09:50  4311 SMTP>> 250 OK
12:09:50  4311 SMTP<< RCPT TO: <address@mail.ru>
12:09:50  4311 using ACL "my_recive_acl"
12:09:50  4311 processing "accept"
12:09:50  4311 check domains = +my_local_domains
12:09:50  4311 mail.ru in "afsga.muh : *.afsga.muh"? no (end of list)
12:09:50  4311 mail.ru in "+my_local_domains"? no (end of list)
12:09:50  4311 accept: condition test failed
12:09:50  4311 processing "accept"
12:09:50  4311 expanding: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)
12:09:50  4311    result: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@mail.ru' or a.address ilike 'mail.ru' or acc.fullaccess=TRUE)
12:09:50  4311 search_open: pgsql "NULL"
12:09:50  4311 search_find: file="NULL"
12:09:50  4311   key="SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@mail.ru' or a.address ilike 'mail.ru' or acc.fullaccess=TRUE)" partial=-1 affix=NULL starflags=0
12:09:50  4311 LRU list:
12:09:50  4311 internal_search_find: file="NULL"
12:09:50  4311   type=pgsql key="SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@mail.ru' or a.address ilike 'mail.ru' or acc.fullaccess=TRUE)"
12:09:50  4311 database lookup required for SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@mail.ru' or a.address ilike 'mail.ru' or acc.fullaccess=TRUE)
12:09:50  4311 PostgreSQL query: SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='admin@afsga.muh') and (a.address ilike 'address@mail.ru' or a.address ilike 'mail.ru' or acc.fullaccess=TRUE)
12:09:50  4311 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
12:09:50  4311 lookup yielded: 1
12:09:50  4311 expanding: yes
12:09:50  4311    result: yes
12:09:50  4311 expanding: no
12:09:50  4311    result: no
12:09:50  4311 skipping: result is not used
12:09:50  4311 expanding: ${lookup pgsql{SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)}{yes}{no}}
12:09:50  4311    result: yes
12:09:50  4311 check condition = ${lookup pgsql{SELECT 1 FROM allowaddress a RIGHT OUTER JOIN accounts acc ON a.uid=acc.uid  WHERE (acc.login='$sender_address') and (a.address ilike '$local_part@$domain' or a.address ilike '$domain' or acc.fullaccess=TRUE)}{yes}{no}}
12:09:50  4311                 = yes
12:09:50  4311 expanding: ${acl_c1}${local_part}@$domain\;
12:09:50  4311    result: address@mail.ru;
12:09:50  4311 check set acl_c1 = ${acl_c1}${local_part}@$domain\;
12:09:50  4311                  = address@mail.ru;
12:09:50  4311 accept: condition test succeeded
12:09:50  4311 SMTP>> 250 Accepted
12:09:50  4311 SMTP<< DATA
12:09:50  4311 SMTP>> 354 Enter message, ending with "." on a line by itself
12:09:50  4311 search_tidyup called
12:09:50  4311 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4311 host in ignore_fromline_hosts? no (option unset)
12:09:50  4311 >>Headers received:
12:09:50  4311 From: "Astrakhan SGA #1" <admin@afsga.muh>
12:09:50  4311 To: <address@mail.ru>
12:09:50  4311 Subject: afsdfasfasf
12:09:50  4311 Date: Sat, 5 Jun 2010 11:54:45 +0400
12:09:50  4311 MIME-Version: 1.0
12:09:50  4311 Content-Type: multipart/alternative;
12:09:50  4311 	boundary="----=_NextPart_000_0011_01CB04A5.E42CD750"
12:09:50  4311 X-Mailer: Microsoft Office Outlook, Build 11.0.5510
12:09:50  4311 Thread-Index: AcsEhFz3vWOXX682S+qyvdj2uyKuSA==
12:09:50  4311 X-MimeOLE: Produced By Microsoft MimeOLE V6.00.2900.5512
12:09:50  4311 
12:09:50  4311 rewrite_one_header: type=F:
12:09:50  4311   From: "Astrakhan SGA #1" <admin@afsga.muh>
12:09:50  4311 rewrite_one_header: type=T:
12:09:50  4311   To: <address@mail.ru>
12:09:50  4311 search_tidyup called
12:09:50  4311 >>Headers after rewriting and local additions:
12:09:50  4311 F From: "Astrakhan SGA #1" <admin@afsga.muh>
12:09:50  4311 T To: <address@mail.ru>
12:09:50  4311   Subject: afsdfasfasf
12:09:50  4311   Date: Sat, 5 Jun 2010 11:54:45 +0400
12:09:50  4311   MIME-Version: 1.0
12:09:50  4311   Content-Type: multipart/alternative;
12:09:50  4311 	boundary="----=_NextPart_000_0011_01CB04A5.E42CD750"
12:09:50  4311   X-Mailer: Microsoft Office Outlook, Build 11.0.5510
12:09:50  4311   Thread-Index: AcsEhFz3vWOXX682S+qyvdj2uyKuSA==
12:09:50  4311   X-MimeOLE: Produced By Microsoft MimeOLE V6.00.2900.5512
12:09:50  4311 
12:09:50  4311 Data file written for message 1OKoRy-00017X-D7
12:09:50  4311 expanding: ${tod_full}
12:09:50  4311    result: Sat, 05 Jun 2010 12:09:50 +0400
12:09:50  4311 condition: def:sender_rcvhost
12:09:50  4311    result: true
12:09:50  4311 expanding: from $sender_rcvhost
12:09:50  4311 	
12:09:50  4311    result: from [192.168.0.14] (helo=homepc)
12:09:50  4311 	
12:09:50  4311 condition: def:sender_ident
12:09:50  4311    result: false
12:09:50  4311 expanding: $sender_ident
12:09:50  4311    result: 
12:09:50  4311 skipping: result is not used
12:09:50  4311 expanding: from ${quote_local_part:$sender_ident} 
12:09:50  4311    result: from  
12:09:50  4311 skipping: result is not used
12:09:50  4311 condition: def:sender_helo_name
12:09:50  4311    result: false
12:09:50  4311 expanding: (helo=$sender_helo_name)
12:09:50  4311 	
12:09:50  4311    result: (helo=)
12:09:50  4311 	
12:09:50  4311 skipping: result is not used
12:09:50  4311 expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
12:09:50  4311 	}}
12:09:50  4311    result: 
12:09:50  4311 skipping: result is not used
12:09:50  4311 condition: def:received_protocol
12:09:50  4311    result: true
12:09:50  4311 expanding: with $received_protocol
12:09:50  4311    result: with esmtp
12:09:50  4311 condition: def:tls_cipher
12:09:50  4311    result: false
12:09:50  4311 expanding: ($tls_cipher)
12:09:50  4311 	
12:09:50  4311    result: ()
12:09:50  4311 	
12:09:50  4311 skipping: result is not used
12:09:50  4311 condition: def:sender_address
12:09:50  4311    result: true
12:09:50  4311 expanding: (envelope-from <$sender_address>)
12:09:50  4311 	
12:09:50  4311    result: (envelope-from <admin@afsga.muh>)
12:09:50  4311 	
12:09:50  4311 condition: def:received_for
12:09:50  4311    result: true
12:09:50  4311 expanding: 
12:09:50  4311 	for $received_for
12:09:50  4311    result: 
12:09:50  4311 	for address@mail.ru
12:09:50  4311 expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
12:09:50  4311 	}{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
12:09:50  4311 	}}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
12:09:50  4311 	}}(Exim $version_number (FreeBSD))
12:09:50  4311 	${if def:sender_address {(envelope-from <$sender_address>)
12:09:50  4311 	}}id $message_exim_id${if def:received_for {
12:09:50  4311 	for $received_for}}
12:09:50  4311    result: Received: from [192.168.0.14] (helo=homepc)
12:09:50  4311 	by MTS.afsga.muh with esmtp (Exim 4.69 (FreeBSD))
12:09:50  4311 	(envelope-from <admin@afsga.muh>)
12:09:50  4311 	id 1OKoRy-00017X-D7
12:09:50  4311 	for address@mail.ru
12:09:50  4311 >>Generated Received: header line
12:09:50  4311 P Received: from [192.168.0.14] (helo=homepc)
12:09:50  4311 	by MTS.afsga.muh with esmtp (Exim 4.69 (FreeBSD))
12:09:50  4311 	(envelope-from <admin@afsga.muh>)
12:09:50  4311 	id 1OKoRy-00017X-D7
12:09:50  4311 	for address@mail.ru; Sat, 05 Jun 2010 12:09:50 +0400
12:09:50  4311 using ACL "acl_check_data"
12:09:50  4311 processing "warn"
12:09:50  4311 expanding: $h_message-id:
12:09:50  4311    result: 
12:09:50  4311 expanding: 
12:09:50  4311    result: 
12:09:50  4311 condition: !eq{$h_message-id:}{}
12:09:50  4311    result: false
12:09:50  4311 expanding: ${if !eq{$h_message-id:}{}}
12:09:50  4311    result: 
12:09:50  4311 check condition = ${if !eq{$h_message-id:}{}}
12:09:50  4311                 = 
12:09:50  4311 warn: condition test failed
12:09:50  4311 processing "accept"
12:09:50  4311 expanding: $message_size
12:09:50  4311    result: 3717
12:09:50  4311 expanding: 200k
12:09:50  4311    result: 200k
12:09:50  4311 expanding: $sender_address
12:09:50  4311    result: admin@afsga.muh
12:09:50  4311 expanding: .@afsga.muh
12:09:50  4311    result: .@afsga.muh
12:09:50  4311 condition: or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}
12:09:50  4311    result: true
12:09:50  4311 expanding: ${if or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}}
12:09:50  4311    result: true
12:09:50  4311 check condition = ${if or{{>{$message_size}{200k}}{match{$sender_address}{.@afsga.muh}}}}
12:09:50  4311                 = true
12:09:50  4311 check add_header = X-Spam-Checked: NO - AFSGA SPAM FILTER!
12:09:50  4311 accept: condition test succeeded
12:09:50  4311 >>Headers added by DATA ACL:
12:09:50  4311   X-Spam-Checked: NO - AFSGA SPAM FILTER!
12:09:50  4311 >>
12:09:50  4311 calling local_scan(); timeout=300
12:09:50  4311 local_scan() returned 0 NULL
12:09:50  4311 expanding: ${tod_full}
12:09:50  4311    result: Sat, 05 Jun 2010 12:09:50 +0400
12:09:50  4311 Writing spool header file
12:09:50  4311 Size of headers = 643
12:09:50  4311 LOG: MAIN
12:09:50  4311   <= admin@afsga.muh H=(homepc) [192.168.0.14] P=esmtp S=3967
12:09:50  4311 SMTP>> 250 OK id=1OKoRy-00017X-D7
12:09:50  4311 search_tidyup called
12:09:50  4311 Sender: admin@afsga.muh
12:09:50  4311 Recipients:
12:09:50  4311   address@mail.ru
12:09:50  4311 forked delivery process 4313
12:09:50  4311 Process 4311 is ready for new message
12:09:50  4311 smtp_setup_msg entered
12:09:50  4313 exec /usr/local/sbin/exim -d=0xfffdffff -Mc 1OKoRy-00017X-D7
12:09:50  4313 Exim version 4.69 (FreeBSD 6.3) uid=26 gid=6 pid=4313 D=fffdffff
Probably Berkeley DB version 1.8x (native mode)
Support for: crypteq iconv() IPv6 use_setclassresources PAM Perl Expand_dlfunc OpenSSL Content_Scanning Old_Demime
Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch nis nis0 passwd pgsql
Authenticators: cram_md5 dovecot plaintext spa
Routers: accept dnslookup ipliteral manualroute queryprogram redirect
Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp
Fixed never_users: 0
Size of off_t: 8
12:09:50  4313 changed uid/gid: forcing real = effective
12:09:50  4313   uid=0 gid=6 pid=4313
12:09:50  4313   auxiliary group list: 6
12:09:50  4313 configuration file is /usr/local/etc/exim/configure
12:09:50  4313 log selectors = 00000ffc 00212001
12:09:50  4313 cwd=/var/spool/exim 4 args: /usr/local/sbin/exim -d=0xfffdffff -Mc 1OKoRy-00017X-D7
12:09:50  4313 trusted user
12:09:50  4313 admin user
12:09:50  4313 skipping ACL configuration - not needed
12:09:50  4313 seeking password data for user "mailnull": using cached result
12:09:50  4313 getpwnam() succeeded uid=26 gid=26
12:09:50  4313 set_process_info:  4313 delivering specified messages
12:09:50  4313 set_process_info:  4313 delivering 1OKoRy-00017X-D7
12:09:50  4313 reading spool file 1OKoRy-00017X-D7-H
12:09:50  4313 user=mailnull uid=26 gid=6 sender=admin@afsga.muh
12:09:50  4313 sender_fullhost = (homepc) [192.168.0.14]
12:09:50  4313 sender_rcvhost = [192.168.0.14] (helo=homepc)
12:09:50  4313 sender_local=0 ident=unset
12:09:50  4313 Non-recipients:
12:09:50  4313 Empty Tree
12:09:50  4313 ---- End of tree ----
12:09:50  4313 recipients_count=1
12:09:50  4313 body_linecount=107 message_linecount=16
12:09:50  4313 Delivery address list:
12:09:50  4313   address@mail.ru 
12:09:50  4313 locking /var/spool/exim/db/retry.lockfile
12:09:50  4313 locked /var/spool/exim/db/retry.lockfile
12:09:50  4313 EXIM_DBOPEN(/var/spool/exim/db/retry)
12:09:50  4313 returned from EXIM_DBOPEN
12:09:50  4313 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 Considering: address@mail.ru
12:09:50  4313 unique = address@mail.ru
12:09:50  4313 dbfn_read: key=R:mail.ru
12:09:50  4313 dbfn_read: key=R:address@mail.ru
12:09:50  4313 dbfn_read: key=R:address@mail.ru:<admin@afsga.muh>
12:09:50  4313 no domain retry record
12:09:50  4313 no address retry record
12:09:50  4313 address@mail.ru: queued for routing
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 routing address@mail.ru
12:09:50  4313 --------> archive_out router <--------
12:09:50  4313 local_part=address domain=mail.ru
12:09:50  4313 checking domains
12:09:50  4313 mail.ru in "afsga.muh : *.afsga.muh"? no (end of list)
12:09:50  4313 mail.ru in "!+my_local_domains"? yes (end of list)
12:09:50  4313 calling archive_out router
12:09:50  4313 rda_interpret (string): archive-out@afsga.muh
12:09:50  4313 expanded: archive-out@afsga.muh
12:09:50  4313 file is not a filter file
12:09:50  4313 parse_forward_list: archive-out@afsga.muh
12:09:50  4313 extract item: archive-out@afsga.muh
12:09:50  4313 archive_out router generated archive-out@afsga.muh
12:09:50  4313   errors_to=NULL transport=NULL
12:09:50  4313   uid=unset gid=unset home=NULL
12:09:50  4313 routed by archive_out router (unseen)
12:09:50  4313   envelope to: address@mail.ru
12:09:50  4313   transport: <none>
12:09:50  4313 "unseen" set: replicated address@mail.ru
12:09:50  4313 locking /var/spool/exim/db/retry.lockfile
12:09:50  4313 locked /var/spool/exim/db/retry.lockfile
12:09:50  4313 EXIM_DBOPEN(/var/spool/exim/db/retry)
12:09:50  4313 returned from EXIM_DBOPEN
12:09:50  4313 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 Considering: address@mail.ru
12:09:50  4313 unique = \0\address@mail.ru
12:09:50  4313 dbfn_read: key=R:mail.ru
12:09:50  4313 dbfn_read: key=R:address@mail.ru
12:09:50  4313 dbfn_read: key=R:address@mail.ru:<admin@afsga.muh>
12:09:50  4313 no domain retry record
12:09:50  4313 no address retry record
12:09:50  4313 address@mail.ru: queued for routing
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 Considering: archive-out@afsga.muh
12:09:50  4313 unique = archive-out@afsga.muh
12:09:50  4313 dbfn_read: key=R:afsga.muh
12:09:50  4313 dbfn_read: key=R:archive-out@afsga.muh
12:09:50  4313 dbfn_read: key=R:archive-out@afsga.muh:<admin@afsga.muh>
12:09:50  4313 no domain retry record
12:09:50  4313 no address retry record
12:09:50  4313 archive-out@afsga.muh: queued for routing
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 routing archive-out@afsga.muh
12:09:50  4313 --------> archive_out router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking domains
12:09:50  4313 afsga.muh in "afsga.muh : *.afsga.muh"? yes (matched "afsga.muh")
12:09:50  4313 afsga.muh in "!+my_local_domains"? no (matched "!+my_local_domains")
12:09:50  4313 archive_out router skipped: domains mismatch
12:09:50  4313 --------> archive_dsn_in router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking local_parts
12:09:50  4313 archive-out in "!archive-dsn-in"? yes (end of list)
12:09:50  4313 checking "condition"
12:09:50  4313 expanding: $acl_c3
12:09:50  4313    result: 
12:09:50  4313 empty string cast to zero for numerical comparison
12:09:50  4313 expanding: 0
12:09:50  4313    result: 0
12:09:50  4313 condition: >{$acl_c3}{0}
12:09:50  4313    result: false
12:09:50  4313 expanding: ${if >{$acl_c3}{0}}
12:09:50  4313    result: 
12:09:50  4313 archive_dsn_in router skipped: condition failure
12:09:50  4313 --------> send_to_mail_muh_ru router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking domains
12:09:50  4313 afsga.muh in "muh.ru : campus.muh.ru : sgutv.ru"? no (end of list)
12:09:50  4313 afsga.muh in "+domain_muh"? no (end of list)
12:09:50  4313 send_to_mail_muh_ru router skipped: domains mismatch
12:09:50  4313 --------> send_to_gate_muh_ru router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking domains
12:09:50  4313 afsga.muh in "filial.sga"? no (end of list)
12:09:50  4313 send_to_gate_muh_ru router skipped: domains mismatch
12:09:50  4313 --------> send_to_gateway router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking domains
12:09:50  4313 cached yes match for +my_local_domains
12:09:50  4313 cached lookup data = NULL
12:09:50  4313 afsga.muh in "!+my_local_domains"? no (matched "!+my_local_domains" - cached)
12:09:50  4313 send_to_gateway router skipped: domains mismatch
12:09:50  4313 --------> from_inet_to_procmail router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking local_parts
12:09:50  4313 archive-out in "!archive-dsn-in"? yes (end of list)
12:09:50  4313 checking "condition"
12:09:50  4313 expanding: $sender_address
12:09:50  4313    result: admin@afsga.muh
12:09:50  4313 expanding: .@afsga.muh
12:09:50  4313    result: .@afsga.muh
12:09:50  4313 expanding: $sender_address
12:09:50  4313    result: 
12:09:50  4313 skipping: result is not used
12:09:50  4313 expanding: 
12:09:50  4313    result: 
12:09:50  4313 skipping: result is not used
12:09:50  4313 condition: and{ {!match{$sender_address}{.@afsga.muh}}{!eq{$sender_address}{}}}
12:09:50  4313    result: false
12:09:50  4313 expanding: 1
12:09:50  4313    result: 1
12:09:50  4313 skipping: result is not used
12:09:50  4313 expanding: 0
12:09:50  4313    result: 0
12:09:50  4313 expanding: ${if and{ {!match{$sender_address}{.@afsga.muh}}{!eq{$sender_address}{}}} {1} {0} }
12:09:50  4313    result: 0
12:09:50  4313 from_inet_to_procmail router skipped: condition failure
12:09:50  4313 --------> my_local_domains_router router <--------
12:09:50  4313 local_part=archive-out domain=afsga.muh
12:09:50  4313 checking "condition"
12:09:50  4313 expanding: select uid from accounts where login = '$local_part@$domain'
12:09:50  4313    result: select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 search_open: pgsql "NULL"
12:09:50  4313 search_find: file="NULL"
12:09:50  4313   key="select uid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
12:09:50  4313 LRU list:
12:09:50  4313 internal_search_find: file="NULL"
12:09:50  4313   type=pgsql key="select uid from accounts where login = 'archive-out@afsga.muh'"
12:09:50  4313 database lookup required for select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PostgreSQL query: select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
12:09:50  4313 lookup yielded: 18
12:09:50  4313 expanding: yes
12:09:50  4313    result: yes
12:09:50  4313 expanding: no
12:09:50  4313    result: no
12:09:50  4313 skipping: result is not used
12:09:50  4313 expanding: ${lookup pgsql{select uid from accounts where login = '$local_part@$domain'}{yes}{no}}
12:09:50  4313    result: yes
12:09:50  4313 calling my_local_domains_router router
12:09:50  4313 my_local_domains_router router called for archive-out@afsga.muh
12:09:50  4313   domain = afsga.muh
12:09:50  4313 set transport my_local_delivery_transport
12:09:50  4313 queued for my_local_delivery_transport transport: local_part = archive-out
12:09:50  4313 domain = afsga.muh
12:09:50  4313   errors_to=NULL
12:09:50  4313   domain_data=NULL localpart_data=NULL
12:09:50  4313 routed by my_local_domains_router router
12:09:50  4313   envelope to: archive-out@afsga.muh
12:09:50  4313   transport: my_local_delivery_transport
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 routing address@mail.ru
12:09:50  4313 --------> archive_dsn_in router <--------
12:09:50  4313 local_part=address domain=mail.ru
12:09:50  4313 checking local_parts
12:09:50  4313 address in "!archive-dsn-in"? yes (end of list)
12:09:50  4313 checking "condition"
12:09:50  4313 expanding: $acl_c3
12:09:50  4313    result: 
12:09:50  4313 empty string cast to zero for numerical comparison
12:09:50  4313 expanding: 0
12:09:50  4313    result: 0
12:09:50  4313 condition: >{$acl_c3}{0}
12:09:50  4313    result: false
12:09:50  4313 expanding: ${if >{$acl_c3}{0}}
12:09:50  4313    result: 
12:09:50  4313 archive_dsn_in router skipped: condition failure
12:09:50  4313 --------> send_to_mail_muh_ru router <--------
12:09:50  4313 local_part=address domain=mail.ru
12:09:50  4313 checking domains
12:09:50  4313 mail.ru in "muh.ru : campus.muh.ru : sgutv.ru"? no (end of list)
12:09:50  4313 mail.ru in "+domain_muh"? no (end of list)
12:09:50  4313 send_to_mail_muh_ru router skipped: domains mismatch
12:09:50  4313 --------> send_to_gate_muh_ru router <--------
12:09:50  4313 local_part=address domain=mail.ru
12:09:50  4313 checking domains
12:09:50  4313 mail.ru in "filial.sga"? no (end of list)
12:09:50  4313 send_to_gate_muh_ru router skipped: domains mismatch
12:09:50  4313 --------> send_to_gateway router <--------
12:09:50  4313 local_part=address domain=mail.ru
12:09:50  4313 checking domains
12:09:50  4313 mail.ru in "afsga.muh : *.afsga.muh"? no (end of list)
12:09:50  4313 mail.ru in "!+my_local_domains"? yes (end of list)
12:09:50  4313 calling send_to_gateway router
12:09:50  4313 send_to_gateway router called for address@mail.ru
12:09:50  4313   domain = mail.ru
12:09:50  4313 route_item = * smtp.mail.ru
12:09:50  4313 mail.ru in "*"? yes (matched "*")
12:09:50  4313 original list of hosts = "smtp.mail.ru" options = 
12:09:50  4313 expanded list of hosts = "smtp.mail.ru" options = 
12:09:50  4313 set transport remote_smtp
12:09:50  4313 finding IP address for smtp.mail.ru
12:09:50  4313 doing DNS lookup
;; res_nquerydomain(smtp.mail.ru, <Nil>, 1, 28)
;; res_query(smtp.mail.ru, 1, 28)
;; res_nmkquery(QUERY, smtp.mail.ru, IN, AAAA)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17120
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.mail.ru, type = AAAA, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17120
;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;;	smtp.mail.ru, type = AAAA, class = IN
mail.ru.		4m17s IN SOA	ns.mail.ru. hostmaster.mail.ru. (
					3209018308	; serial
					5M		; refresh
					15M		; retry
					2W		; expiry
					5M )		; minimum

;; rcode = (NOERROR), counts = an:0 ns:1 ar:0
12:09:50  4313 DNS lookup of smtp.mail.ru (AAAA) gave NO_DATA
12:09:50  4313 returning DNS_NODATA
;; res_nquerydomain(smtp.mail.ru, <Nil>, 1, 1)
;; res_query(smtp.mail.ru, 1, 1)
;; res_nmkquery(QUERY, smtp.mail.ru, IN, A)
;; res_send()
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17121
;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.mail.ru, type = A, class = IN
;; Querying server (# 1) address = 192.168.0.11
;; new DG socket
;; got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 17121
;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 0
;;	smtp.mail.ru, type = A, class = IN
smtp.mail.ru.		49m48s IN A	94.100.177.1
12:09:50  4313 DNS lookup of smtp.mail.ru (A) succeeded
12:09:50  4313 94.100.177.1 in "0.0.0.0 : 127.0.0.0.8"? no (malformed IPv4 address or address mask)
12:09:50  4313 Actual local interface address is 192.168.0.9 (xl0)
12:09:50  4313 Actual local interface address is 10.30.30.9 (xl0)
12:09:50  4313 Actual local interface address is 192.168.50.9 (xl0)
12:09:50  4313 Actual local interface address is 91.211.142.18 (rl0)
12:09:50  4313 Actual local interface address is fe80:4::1 (lo0)
12:09:50  4313 Actual local interface address is ::1 (lo0)
12:09:50  4313 Actual local interface address is 127.0.0.1 (lo0)
12:09:50  4313 fully qualified name = smtp.mail.ru
12:09:50  4313 smtp.mail.ru 94.100.177.1 mx=-1 sort=-364 
12:09:50  4313 queued for remote_smtp transport: local_part = address
12:09:50  4313 domain = mail.ru
12:09:50  4313   errors_to=NULL
12:09:50  4313   domain_data=NULL localpart_data=NULL
12:09:50  4313 routed by send_to_gateway router
12:09:50  4313   envelope to: address@mail.ru
12:09:50  4313   transport: remote_smtp
12:09:50  4313   host smtp.mail.ru [94.100.177.1]
12:09:50  4313 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
12:09:50  4313 After routing:
12:09:50  4313   Local deliveries:
12:09:50  4313     archive-out@afsga.muh
12:09:50  4313   Remote deliveries:
12:09:50  4313     address@mail.ru
12:09:50  4313   Failed addresses:
12:09:50  4313   Deferred addresses:
12:09:50  4313 search_tidyup called
12:09:50  4313 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4313 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
12:09:50  4313 --------> archive-out@afsga.muh <--------
12:09:50  4313 locking /var/spool/exim/db/retry.lockfile
12:09:50  4313 locked /var/spool/exim/db/retry.lockfile
12:09:50  4313 EXIM_DBOPEN(/var/spool/exim/db/retry)
12:09:50  4313 returned from EXIM_DBOPEN
12:09:50  4313 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
12:09:50  4313 dbfn_read: key=T:archive-out@afsga.muh
12:09:50  4313 no retry record exists
12:09:50  4313 expanding: select gid from accounts where login = '$local_part@$domain'
12:09:50  4313    result: select gid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 search_open: pgsql "NULL"
12:09:50  4313 search_find: file="NULL"
12:09:50  4313   key="select gid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
12:09:50  4313 LRU list:
12:09:50  4313 internal_search_find: file="NULL"
12:09:50  4313   type=pgsql key="select gid from accounts where login = 'archive-out@afsga.muh'"
12:09:50  4313 database lookup required for select gid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PostgreSQL query: select gid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
12:09:50  4313 lookup yielded: 6
12:09:50  4313 expanding: $value
12:09:50  4313    result: 6
12:09:50  4313 expanding: ${lookup pgsql{select gid from accounts where login = '$local_part@$domain'}{$value}fail}
12:09:50  4313    result: 6
12:09:50  4313 expanding: select uid from accounts where login = '$local_part@$domain'
12:09:50  4313    result: select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 search_open: pgsql "NULL"
12:09:50  4313   cached open
12:09:50  4313 search_find: file="NULL"
12:09:50  4313   key="select uid from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
12:09:50  4313 LRU list:
12:09:50  4313 internal_search_find: file="NULL"
12:09:50  4313   type=pgsql key="select uid from accounts where login = 'archive-out@afsga.muh'"
12:09:50  4313 database lookup required for select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PostgreSQL query: select uid from accounts where login = 'archive-out@afsga.muh'
12:09:50  4313 PGSQL using cached connection for (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4313 lookup yielded: 18
12:09:50  4313 expanding: $value
12:09:50  4313    result: 18
12:09:50  4313 expanding: ${lookup pgsql{select uid from accounts where login = '$local_part@$domain'}{$value}fail}
12:09:50  4313    result: 18
12:09:50  4313 seeking password data for user "18": cache not available
12:09:50  4313 search_tidyup called
12:09:50  4313 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4316 expanding: select mailquota from accounts where login = '$local_part@$domain'
12:09:50  4316    result: select mailquota from accounts where login = 'archive-out@afsga.muh'
12:09:50  4316 search_open: pgsql "NULL"
12:09:50  4316 search_find: file="NULL"
12:09:50  4316   key="select mailquota from accounts where login = 'archive-out@afsga.muh'" partial=-1 affix=NULL starflags=0
12:09:50  4316 LRU list:
12:09:50  4316 internal_search_find: file="NULL"
12:09:50  4316   type=pgsql key="select mailquota from accounts where login = 'archive-out@afsga.muh'"
12:09:50  4316 database lookup required for select mailquota from accounts where login = 'archive-out@afsga.muh'
12:09:50  4316 PostgreSQL query: select mailquota from accounts where login = 'archive-out@afsga.muh'
12:09:50  4316 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
12:09:50  4316 lookup yielded: 1000000000
12:09:50  4316 expanding: $value
12:09:50  4316    result: 1000000000
12:09:50  4316 expanding: ${lookup pgsql{select mailquota from accounts where login = '$local_part@$domain'}{$value}fail}
12:09:50  4316    result: 1000000000
12:09:50  4316 changed uid/gid: local delivery to archive-out <archive-out@afsga.muh> transport=my_local_delivery_transport
12:09:50  4316   uid=18 gid=6 pid=4316
12:09:50  4316   auxiliary group list: 6
12:09:50  4316   home=NULL current=/
12:09:50  4316 set_process_info:  4316 delivering 1OKoRy-00017X-D7 to archive-out using my_local_delivery_transport
12:09:50  4316 appendfile transport entered
12:09:50  4316 expanding: /var/mail/$local_part@$domain
12:09:50  4316    result: /var/mail/archive-out@afsga.muh
12:09:50  4316 appendfile: mode=660 notify_comsat=0 quota=1000000000 warning=75%
12:09:50  4316   file=/var/mail/archive-out@afsga.muh format=unix
12:09:50  4316   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
12:09:50  4316   message_suffix=\n
12:09:50  4316   maildir_use_size_file=no
12:09:50  4316   locking by lockfile fcntl 
12:09:50  4316 lock name: /var/mail/archive-out@afsga.muh.lock
12:09:50  4316 hitch name: /var/mail/archive-out@afsga.muh.lock.MTS.afsga.muh.4c0a064e.000010dc
12:09:50  4316 lock file created
12:09:50  4316 mailbox /var/mail/archive-out@afsga.muh is locked
12:09:50  4316 writing to file /var/mail/archive-out@afsga.muh
12:09:50  4316 Exim quota = 1000000000 old size = 264827838 this message = 3967 (included)
12:09:50  4316   file count quota = 0 count = 0
12:09:50  4316 condition: def:return_path
12:09:50  4316    result: true
12:09:50  4316 expanding: $return_path
12:09:50  4316    result: admin@afsga.muh
12:09:50  4316 expanding: MAILER-DAEMON
12:09:50  4316    result: MAILER-DAEMON
12:09:50  4316 skipping: result is not used
12:09:50  4316 expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
12:09:50  4316 
12:09:50  4316    result: From admin@afsga.muh Sat Jun 05 12:09:50 2010
12:09:50  4316 
12:09:50  4316 writing data block fd=7 size=46 timeout=0
12:09:50  4316 writing data block fd=7 size=4079 timeout=0
12:09:50  4316 writing data block fd=7 size=1 timeout=0
12:09:50  4316 quota = 1000000000 threshold = 750000000 old size = 264827838 message size = 4126
12:09:50  4316 appendfile yields 0 with errno=0 more_errno=0
12:09:50  4313 journalling archive-out@afsga.muh
12:09:50  4316 search_tidyup called
12:09:50  4316 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4313 my_local_delivery_transport transport returned OK for archive-out@afsga.muh
12:09:50  4313 post-process archive-out@afsga.muh (0)
12:09:50  4313 archive-out@afsga.muh delivered
12:09:50  4313 LOG: MAIN
12:09:50  4313   => archive-out <address@mail.ru> R=my_local_domains_router T=my_local_delivery_transport
12:09:50  4313 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>>
12:09:50  4313 --------> address@mail.ru <--------
12:09:50  4313 expanding: select extmail from accounts where login = '$sender_address'
12:09:50  4313    result: select extmail from accounts where login = 'admin@afsga.muh'
12:09:50  4313 search_open: pgsql "NULL"
12:09:50  4313 search_find: file="NULL"
12:09:50  4313   key="select extmail from accounts where login = 'admin@afsga.muh'" partial=-1 affix=NULL starflags=0
12:09:50  4313 LRU list:
12:09:50  4313 internal_search_find: file="NULL"
12:09:50  4313   type=pgsql key="select extmail from accounts where login = 'admin@afsga.muh'"
12:09:50  4313 database lookup required for select extmail from accounts where login = 'admin@afsga.muh'
12:09:50  4313 PostgreSQL query: select extmail from accounts where login = 'admin@afsga.muh'
12:09:50  4313 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=users user=pgsql
12:09:50  4313 lookup yielded: address@mail.ru
12:09:50  4313 expanding: $value
12:09:50  4313    result: address@mail.ru
12:09:50  4313 expanding: ${lookup pgsql{select extmail from accounts where login = '$sender_address'}{$value}fail}
12:09:50  4313    result: address@mail.ru
12:09:50  4313 search_tidyup called
12:09:50  4313 close PGSQL connection: (/tmp/.s.PGSQL.5432)/users/pgsql
12:09:50  4319 changed uid/gid: remote delivery to address@mail.ru with transport=remote_smtp
12:09:50  4319   uid=26 gid=6 pid=4319
12:09:50  4319   auxiliary group list: 6
12:09:50  4319 set_process_info:  4319 delivering 1OKoRy-00017X-D7 using remote_smtp
12:09:50  4319 remote_smtp transport entered
12:09:50  4319   address@mail.ru
12:09:50  4313 set_process_info:  4313 delivering 1OKoRy-00017X-D7: waiting for a remote delivery subprocess to finish
12:09:50  4319 mail.ru in queue_smtp_domains? no (option unset)
12:09:50  4313 selecting on subprocess pipes
12:09:50  4319 checking status of smtp.mail.ru
12:09:50  4319 locking /var/spool/exim/db/retry.lockfile
12:09:50  4319 locked /var/spool/exim/db/retry.lockfile
12:09:50  4319 EXIM_DBOPEN(/var/spool/exim/db/retry)
12:09:50  4319 returned from EXIM_DBOPEN
12:09:50  4319 opened hints database /var/spool/exim/db/retry: flags=O_RDONLY
12:09:50  4319 dbfn_read: key=T:smtp.mail.ru:94.100.177.1
12:09:50  4319 dbfn_read: key=T:smtp.mail.ru:94.100.177.1:1OKoRy-00017X-D7
12:09:50  4319 no message retry record
12:09:50  4319 host retry time not reached: checking ultimate address timeout
12:09:50  4319   now=1275725390 first_failed=1275725348 next_try=1275725948 expired=0
12:09:50  4319 address match: subject=*@smtp.mail.ru pattern=*
12:09:50  4319 smtp.mail.ru in "*"? yes (matched "*")
12:09:50  4319 *@smtp.mail.ru in "*"? yes (matched "*")
12:09:50  4319   received_time=1275725390 diff=0 timeout=86400
12:09:50  4319 smtp.mail.ru [94.100.177.1] status = unusable
12:09:50  4319 all IP addresses skipped or deferred at least one address
12:09:50  4319 updating wait-remote_smtp database
12:09:50  4319 locking /var/spool/exim/db/wait-remote_smtp.lockfile
12:09:50  4319 locked /var/spool/exim/db/wait-remote_smtp.lockfile
12:09:50  4319 EXIM_DBOPEN(/var/spool/exim/db/wait-remote_smtp)
12:09:50  4319 returned from EXIM_DBOPEN
12:09:50  4319 opened hints database /var/spool/exim/db/wait-remote_smtp: flags=O_RDWR
12:09:50  4319 dbfn_read: key=smtp.mail.ru
12:09:50  4319 dbfn_write: key=smtp.mail.ru
12:09:50  4319 added to list for smtp.mail.ru
12:09:50  4319 Leaving remote_smtp transport
12:09:50  4319 set_process_info:  4319 delivering 1OKoRy-00017X-D7 (just run remote_smtp for address@mail.ru in subprocess)
12:09:50  4319 search_tidyup called
12:09:50  4313 reading pipe for subprocess 4319 (not ended)
12:09:50  4313 read() yielded 74
12:09:50  4313 Z0 item read
12:09:50  4313 remote delivery process 4319 ended
12:09:50  4313 set_process_info:  4313 delivering 1OKoRy-00017X-D7
12:09:50  4313 post-process address@mail.ru (1)
12:09:50  4313 LOG: retry_defer MAIN
12:09:50  4313   == address@mail.ru R=send_to_gateway T=remote_smtp defer (-53): retry time not reached for any host
12:09:50  4313 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
12:09:50  4313 changed uid/gid: post-delivery tidying
12:09:50  4313   uid=26 gid=6 pid=4313
12:09:50  4313   auxiliary group list: 6
12:09:50  4313 set_process_info:  4313 tidying up after delivering 1OKoRy-00017X-D7
12:09:50  4313 Processing retry items
12:09:50  4313 Succeeded addresses:
12:09:50  4313 archive-out@afsga.muh: no retry items
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 Failed addresses:
12:09:50  4313 Deferred addresses:
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 address@mail.ru: no retry items
12:09:50  4313 end of retry processing
12:09:50  4313 delivery deferred: update_spool=1 header_rewritten=0
12:09:50  4313 Writing spool header file
12:09:50  4313 Size of headers = 643
12:09:50  4313 end delivery of 1OKoRy-00017X-D7
12:09:50  4313 search_tidyup called
12:09:50  4313 search_tidyup called
12:09:50  4313 >>>>>>>>>>>>>>>> Exim pid=4313 terminating with rc=0 >>>>>>>>>>>>>>>>
12:09:52  4311 SMTP<< QUIT
12:09:52  4311 SMTP>> 221 MTS.afsga.muh closing connection
12:09:52  4311 LOG: smtp_connection MAIN
12:09:52  4311   SMTP connection from (homepc) [192.168.0.14] closed by QUIT
12:09:52  4311 search_tidyup called
12:09:52  4310 child 4311 ended: status=0x0
12:09:52  4310 0 SMTP accept processes now running
12:09:52  4310 Listening...