-------------------------- 16298 Connection request from 209.85.142.190 port 13483 16298 search_tidyup called 17457 sender_fullhost = [209.85.142.190] 17457 sender_rcvhost = [209.85.142.190] 17457 Process 17457 is handling incoming connection from [209.85.142.190] 17457 host in host_lookup? yes (matched "*") 17457 looking up host name for 209.85.142.190 16298 1 SMTP accept process running 16298 Listening... 17457 DNS lookup of 190.142.85.209.in-addr.arpa (PTR) succeeded 17457 IP address lookup yielded ti-out-0910.google.com 17457 gethostbyname2 looked up these IP addresses: 17457 name=ti-out-0910.google.com address=209.85.142.187 17457 name=ti-out-0910.google.com address=209.85.142.188 17457 name=ti-out-0910.google.com address=209.85.142.189 17457 name=ti-out-0910.google.com address=209.85.142.190 17457 name=ti-out-0910.google.com address=209.85.142.191 17457 name=ti-out-0910.google.com address=209.85.142.184 17457 name=ti-out-0910.google.com address=209.85.142.185 17457 name=ti-out-0910.google.com address=209.85.142.186 17457 checking addresses for ti-out-0910.google.com 17457 209.85.142.187 17457 209.85.142.188 17457 209.85.142.189 17457 209.85.142.190 OK 17457 sender_fullhost = ti-out-0910.google.com [209.85.142.190] 17457 sender_rcvhost = ti-out-0910.google.com ([209.85.142.190]) 17457 set_process_info: 17457 handling incoming connection from ti-out-0910.google.com [209.85.142.190] 17457 host in host_reject_connection? no (option unset) 17457 host in sender_unqualified_hosts? no (option unset) 17457 host in recipient_unqualified_hosts? no (option unset) 17457 host in helo_verify_hosts? no (option unset) 17457 host in helo_try_verify_hosts? yes (end of list) 17457 host in helo_accept_junk_hosts? no (end of list) 17457 SMTP>> 220 mailhost.surestorm.com ESMTP Server Ready @ Fri, 07 Mar 2008 19:54:41 +0100 17457 Process 17457 is ready for new message 17457 smtp_setup_msg entered 17457 SMTP<< EHLO ti-out-0910.google.com 17457 sender_fullhost = ti-out-0910.google.com [209.85.142.190] 17457 sender_rcvhost = ti-out-0910.google.com ([209.85.142.190]) 17457 set_process_info: 17457 handling incoming connection from ti-out-0910.google.com [209.85.142.190] 17457 verifying EHLO/HELO argument "ti-out-0910.google.com" 17457 matched host name 17457 using ACL "acl_check_helo" 17457 processing "accept" 17457 check hosts = : 17457 host in ":"? no (end of list) 17457 accept: condition test failed 17457 processing "accept" 17457 check hosts = +relay_from_hosts 17457 host in "127.0.0.1 : 64.79.209.162"? no (end of list) 17457 host in "+relay_from_hosts"? no (end of list) 17457 accept: condition test failed 17457 processing "deny" 17457 check condition = ${if or{{!def:sender_helo_name}{eq{$sender_helo_name}{}}}{yes}{no}} 17457 = no 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if isip {$sender_helo_name}{true}{false}} 17457 = false 17457 deny: condition test failed 17457 processing "drop" 17457 check condition = ${if match{$sender_helo_name}{\N^\[\N}{no}{yes}} 17457 = yes 17457 check condition = ${if match{$sender_helo_name}{\N\.\N}{no}{yes}} 17457 = no 17457 drop: condition test failed 17457 processing "deny" 17457 check condition = ${if def:sender_helo_name {false}{true}} 17457 = false 17457 deny: condition test failed 17457 processing "drop" 17457 check condition = ${if match{$sender_helo_name}{\N\.$\N}} 17457 = 17457 drop: condition test failed 17457 processing "deny" 17457 check condition = ${if match {$sender_helo_name} {^[0-9]+\.[0-9]+\.[0-9]+\.[0-9]+\$} {yes}{no}} 17457 = no 17457 deny: condition test failed 17457 processing "drop" 17457 check condition = ${if eq{[$interface_address]}{$sender_helo_name}} 17457 = 17457 drop: condition test failed 17457 processing "deny" 17457 ti-out-0910.google.com in "@ : @[] : surestorm.com : tcser.com"? no (end of list) 17457 ti-out-0910.google.com in ""? no (end of list) 17457 ti-out-0910.google.com in "mailhost.surestorm.com:+local_domains:+relay_to_domains"? no (end of list) 17457 check condition = ${if match_domain{$sender_helo_name}{$primary_hostname:+local_domains:+relay_to_domains}{true}{false}} 17457 = false 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if match {$sender_helo_name}{none}{yes}{no}} 17457 = no 17457 deny: condition test failed 17457 processing "accept" 17457 accept: condition test succeeded 17457 host in pipelining_advertise_hosts? no (end of list) 17457 cached no match for +relay_from_hosts 17457 host in auth_advertise_hosts? yes (end of list) 17457 host in tls_advertise_hosts? yes (matched "*") 17457 SMTP>> 250-mailhost.surestorm.com Hello ti-out-0910.google.com [209.85.142.190] 17457 250-SIZE 15728640 17457 250-8BITMIME 17457 250-STARTTLS 17457 250 HELP 17457 SMTP<< MAIL FROM: 17457 using ACL "acl_check_mail" 17457 processing "deny" 17457 check sender_domains = partial1-lsearch;/etc/exim4/list_blacklist.txt 17457 search_open: lsearch "/etc/exim4/list_blacklist.txt" 17457 search_find: file="/etc/exim4/list_blacklist.txt" 17457 key="gmail.com" partial=1 affix=*. starflags=0 17457 LRU list: 17457 :/etc/exim4/list_blacklist.txt 17457 End 17457 internal_search_find: file="/etc/exim4/list_blacklist.txt" 17457 type=lsearch key="gmail.com" 17457 file lookup required for gmail.com 17457 in /etc/exim4/list_blacklist.txt 17457 lookup failed 17457 trying partial match *.gmail.com 17457 internal_search_find: file="/etc/exim4/list_blacklist.txt" 17457 type=lsearch key="*.gmail.com" 17457 file lookup required for *.gmail.com 17457 in /etc/exim4/list_blacklist.txt 17457 lookup failed 17457 trying partial match *.com 17457 internal_search_find: file="/etc/exim4/list_blacklist.txt" 17457 type=lsearch key="*.com" 17457 file lookup required for *.com 17457 in /etc/exim4/list_blacklist.txt 17457 lookup failed 17457 gmail.com in "partial1-lsearch;/etc/exim4/list_blacklist.txt"? no (end of list) 17457 deny: condition test failed 17457 processing "deny" 17457 check senders = lsearch;/etc/exim4/list_blacklist.txt:*@lsearch;/etc/exim4/list_blacklist.txt 17457 address match: subject=jonathangf@gmail.com pattern=lsearch;/etc/exim4/list_blacklist.txt 17457 search_open: lsearch "/etc/exim4/list_blacklist.txt" 17457 cached open 17457 search_find: file="/etc/exim4/list_blacklist.txt" 17457 key="jonathangf@gmail.com" partial=-1 affix=NULL starflags=0 17457 LRU list: 17457 :/etc/exim4/list_blacklist.txt 17457 End 17457 internal_search_find: file="/etc/exim4/list_blacklist.txt" 17457 type=lsearch key="jonathangf@gmail.com" 17457 file lookup required for jonathangf@gmail.com 17457 in /etc/exim4/list_blacklist.txt 17457 lookup failed 17457 address match: subject=jonathangf@gmail.com pattern=*@lsearch;/etc/exim4/list_blacklist.txt 17457 search_open: lsearch "/etc/exim4/list_blacklist.txt" 17457 cached open 17457 search_find: file="/etc/exim4/list_blacklist.txt" 17457 key="gmail.com" partial=-1 affix=NULL starflags=0 17457 LRU list: 17457 :/etc/exim4/list_blacklist.txt 17457 End 17457 internal_search_find: file="/etc/exim4/list_blacklist.txt" 17457 type=lsearch key="gmail.com" 17457 cached data used for lookup of gmail.com 17457 in /etc/exim4/list_blacklist.txt 17457 lookup failed 17457 gmail.com in "lsearch;/etc/exim4/list_blacklist.txt"? no (end of list) 17457 jonathangf@gmail.com in "lsearch;/etc/exim4/list_blacklist.txt:*@lsearch;/etc/exim4/list_blacklist.txt"? no (end of list) 17457 deny: condition test failed 17457 processing "accept" 17457 accept: condition test succeeded 17457 SMTP>> 250 OK 17457 SMTP<< RCPT TO: 17457 using ACL "acl_check_rcpt" 17457 processing "accept" 17457 check hosts = : 17457 host in ":"? no (end of list) 17457 accept: condition test failed 17457 processing "warn" 17457 check local_parts = postmaster:abuse 17457 jonathan in "postmaster:abuse"? no (end of list) 17457 warn: condition test failed 17457 processing "warn" 17457 check senders = +whitelist_senders 17457 address match: subject=jonathangf@gmail.com pattern=lsearch;/etc/exim4/list_whitelist.txt 17457 search_open: lsearch "/etc/exim4/list_whitelist.txt" 17457 search_find: file="/etc/exim4/list_whitelist.txt" 17457 key="jonathangf@gmail.com" partial=-1 affix=NULL starflags=0 17457 LRU list: 17457 :/etc/exim4/list_whitelist.txt 17457 :/etc/exim4/list_blacklist.txt 17457 End 17457 internal_search_find: file="/etc/exim4/list_whitelist.txt" 17457 type=lsearch key="jonathangf@gmail.com" 17457 file lookup required for jonathangf@gmail.com 17457 in /etc/exim4/list_whitelist.txt 17457 lookup yielded: 17457 jonathangf@gmail.com in "lsearch;/etc/exim4/list_whitelist.txt:*@lsearch;/etc/exim4/list_whitelist.txt"? yes (matched "lsearch;/etc/exim4/list_whitelist.txt") 17457 data from lookup saved for cache for +whitelist_senders: 17457 jonathangf@gmail.com in "+whitelist_senders"? yes (matched "+whitelist_senders") 17457 warn: condition test succeeded 17457 processing "accept" 17457 check domains = +local_domains 17457 surestorm.com in "@ : @[] : surestorm.com : tcser.com"? yes (matched "surestorm.com") 17457 surestorm.com in "+local_domains"? yes (matched "+local_domains") 17457 check senders = lsearch;/etc/exim4/list_whitelist.txt:*@lsearch;/etc/exim4/list_whitelist.txt 17457 address match: subject=jonathangf@gmail.com pattern=lsearch;/etc/exim4/list_whitelist.txt 17457 search_open: lsearch "/etc/exim4/list_whitelist.txt" 17457 cached open 17457 search_find: file="/etc/exim4/list_whitelist.txt" 17457 key="jonathangf@gmail.com" partial=-1 affix=NULL starflags=0 17457 LRU list: 17457 :/etc/exim4/list_whitelist.txt 17457 :/etc/exim4/list_blacklist.txt 17457 End 17457 internal_search_find: file="/etc/exim4/list_whitelist.txt" 17457 type=lsearch key="jonathangf@gmail.com" 17457 cached data used for lookup of jonathangf@gmail.com 17457 in /etc/exim4/list_whitelist.txt 17457 lookup yielded: 17457 jonathangf@gmail.com in "lsearch;/etc/exim4/list_whitelist.txt:*@lsearch;/etc/exim4/list_whitelist.txt"? yes (matched "lsearch;/etc/exim4/list_whitelist.txt") 17457 accept: condition test succeeded 17457 SMTP>> 250 Accepted 17457 SMTP<< DATA 17457 SMTP>> 354 Enter message, ending with "." on a line by itself 17457 search_tidyup called 17457 host in ignore_fromline_hosts? no (option unset) 17457 >>Headers received: 17457 Received: by ti-out-0910.google.com with SMTP id 28so584188tif.11 17457 for ; Fri, 07 Mar 2008 10:54:40 -0800 (PST) 17457 DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; 17457 d=gmail.com; s=gamma; 17457 h=domainkey-signature:received:received:message-id:date:from:to:subject:mime-version:content-type; 17457 bh=HzM9KJ/cFAvZ9RgIt9Tp25JWOwzRBCHcuitC8q9Wcic=; 17457 b=VJouwfTFUW1X5aMK7pGNNXsFMEgT4l/OMKOn6dIoitBrz9BJmFWVYlUhOMQZpdT9XONU7NE9e0Xd7vShS/R7JiGeZD1HroaH7bABvyAEv97JH7IwrEKZ/HrDY3Ke1IftOREihum2YKIW0lJk6FrOyA0Sd48Oyv3ZWC2NqXhcUaQ= 17457 DomainKey-Signature: a=rsa-sha1; c=nofws; 17457 d=gmail.com; s=gamma; 17457 h=message-id:date:from:to:subject:mime-version:content-type; 17457 b=DvWR6JcTNH52BiCAiK73xaboPC12QN8w4rjxS+ujXBWjEDsP/dTk8UBMJ0mgJHhjQGyo/UFwbo+7Pi1QjdPCbCLS3nI+v7Ge3Ize01oL0Pbw5UxtgwxtMv3ltMwuGq36spXi6UNOD9Tx3RBxYACgXFKV8hog1/+V9EPBXV14WVA= 17457 Received: by 10.151.149.14 with SMTP id b14mr724894ybo.19.1204916078145; 17457 Fri, 07 Mar 2008 10:54:38 -0800 (PST) 17457 Received: by 10.150.181.14 with HTTP; Fri, 7 Mar 2008 10:54:38 -0800 (PST) 17457 Message-ID: 17457 Date: Fri, 7 Mar 2008 19:54:38 +0100 17457 From: "Jonathan GF" 17457 To: "Jonathan GF" 17457 Subject: test 2 17457 MIME-Version: 1.0 17457 Content-Type: multipart/alternative; 17457 boundary="----=_Part_21103_16740159.1204916078143" 17457 17457 rewrite_one_header: type=F: 17457 From: "Jonathan GF" 17457 rewrite_one_header: type=T: 17457 To: "Jonathan GF" 17457 search_tidyup called 17457 >>Headers after rewriting and local additions: 17457 P Received: by ti-out-0910.google.com with SMTP id 28so584188tif.11 17457 for ; Fri, 07 Mar 2008 10:54:40 -0800 (PST) 17457 DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; 17457 d=gmail.com; s=gamma; 17457 h=domainkey-signature:received:received:message-id:date:from:to:subject:mime-version:content-type; 17457 bh=HzM9KJ/cFAvZ9RgIt9Tp25JWOwzRBCHcuitC8q9Wcic=; 17457 b=VJouwfTFUW1X5aMK7pGNNXsFMEgT4l/OMKOn6dIoitBrz9BJmFWVYlUhOMQZpdT9XONU7NE9e0Xd7vShS/R7JiGeZD1HroaH7bABvyAEv97JH7IwrEKZ/HrDY3Ke1IftOREihum2YKIW0lJk6FrOyA0Sd48Oyv3ZWC2NqXhcUaQ= 17457 DomainKey-Signature: a=rsa-sha1; c=nofws; 17457 d=gmail.com; s=gamma; 17457 h=message-id:date:from:to:subject:mime-version:content-type; 17457 b=DvWR6JcTNH52BiCAiK73xaboPC12QN8w4rjxS+ujXBWjEDsP/dTk8UBMJ0mgJHhjQGyo/UFwbo+7Pi1QjdPCbCLS3nI+v7Ge3Ize01oL0Pbw5UxtgwxtMv3ltMwuGq36spXi6UNOD9Tx3RBxYACgXFKV8hog1/+V9EPBXV14WVA= 17457 P Received: by 10.151.149.14 with SMTP id b14mr724894ybo.19.1204916078145; 17457 Fri, 07 Mar 2008 10:54:38 -0800 (PST) 17457 P Received: by 10.150.181.14 with HTTP; Fri, 7 Mar 2008 10:54:38 -0800 (PST) 17457 I Message-ID: 17457 Date: Fri, 7 Mar 2008 19:54:38 +0100 17457 F From: "Jonathan GF" 17457 T To: "Jonathan GF" 17457 Subject: test 2 17457 MIME-Version: 1.0 17457 Content-Type: multipart/alternative; 17457 boundary="----=_Part_21103_16740159.1204916078143" 17457 17457 Data file written for message 1JXhiL-0004XZ-TF 17457 >>Generated Received: header line 17457 P Received: from ti-out-0910.google.com ([209.85.142.190]) 17457 by mailhost.surestorm.com with esmtp 17457 and serialized ID 1JXhiL-0004XZ-TF 17457 for jonathan@surestorm.com; Fri, 07 Mar 2008 19:54:42 +0100 17457 >>Headers added by MAIL or RCPT ACL: 17457 X-SA-Do-Not-Rej: Yes 17457 >> 17457 using ACL "acl_check_data" 17457 processing "deny" 17457 check senders = : 17457 address match: subject=jonathangf@gmail.com pattern= 17457 gmail.com in ""? no (end of list) 17457 jonathangf@gmail.com in ":"? no (end of list) 17457 deny: condition test failed 17457 processing "deny" 17457 check !verify = header_syntax 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if !def:h_Date: {1}} 17457 = 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if match{$message_body} {105[-_]*51[-_]*86|778[-_]*98[-_]*94} {yes}{no}} 17457 = no 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if <{$message_size}{32k}{1}{0}} 17457 = 1 17457 check demime = * 17457 check condition = ${if >{$demime_errorlevel}{2}{1}{0}} 17457 = 0 17457 deny: condition test failed 17457 processing "deny" 17457 check condition = ${if match {${lc:$mime_filename}} {\N(\.bat|\.com|\.exe|\.pif|\.prf|\.scr|\.vbs)$\N} {1}{0}} 17457 = 0 17457 deny: condition test failed 17457 processing "deny" 17457 check regex = ^(?i)Content-Disposition::(.*?)filename=\\s*"+((\{[a-hA-H0-9-]{25,}\})|((.*?)\\s{10,}(.*?)))"+\$ 17457 = ^(?i)Content-Disposition::(.*?)filename=\s*"+(({[a-hA-H0-9-]{25,}})|((.*?)\s{10,}(.*?)))"+$ 17457 deny: condition test failed 17457 processing "deny" 17457 check regex = [Vv] *[Ii|!] *[Aa4] *[Gg] *[Rr] *[Aa4] : [Mm]ortgage : URGENT BUSINESS PROPOSAL : ^[Cc] *[Ii1!|] *[Aa4] *[Ll] *[Ii1!|] *[Ss5] : [Rr] *[Oo0] *[Ll1!|] *[Ee3] *[Xx] : [Pp] *[Hh] *[Aa4] *[Rr] *[Mm] *[Aa4] *[CcSs] *[YyIi] 17457 deny: condition test failed 17457 processing "accept" 17457 accept: condition test succeeded 17457 unspool_mbox(): unlinking '/var/spool/exim4/scan/1JXhiL-0004XZ-TF/1JXhiL-0004XZ-TF-00002.com' 17457 unspool_mbox(): unlinking '/var/spool/exim4/scan/1JXhiL-0004XZ-TF/1JXhiL-0004XZ-TF.eml' 17457 unspool_mbox(): unlinking '/var/spool/exim4/scan/1JXhiL-0004XZ-TF/1JXhiL-0004XZ-TF-00000.com' 17457 unspool_mbox(): unlinking '/var/spool/exim4/scan/1JXhiL-0004XZ-TF/1JXhiL-0004XZ-TF-00001.com' 17457 calling local_scan(); timeout=300 17457 LOG: MAIN 17457 SA: Debug: SAEximRunCond expand returned: 'true' 17457 LOG: MAIN 17457 SA: Debug: check succeeded, running spamc 17457 LOG: MAIN 17457 SA: Action: scanned but message isn't spam: score=3.2 required=5.5 (scanned in 2/2 secs | Message-Id: a50c1e90803071054n605b5698pbefbfa55c7058d9b@mail.gmail.com). From (host=ti-out-0910.google.com [209.85.142.190]) for jonathan@surestorm.com 17457 local_scan() returned 0 NULL 17457 Writing spool header file 17457 Size of headers = 2024 17457 LOG: MAIN 17457 <= jonathangf@gmail.com H=ti-out-0910.google.com [209.85.142.190] P=esmtp S=2374 id=a50c1e90803071054n605b5698pbefbfa55c7058d9b@mail.gmail.com T="test 2" 17457 SMTP>> 250 OK id=1JXhiL-0004XZ-TF 17457 search_tidyup called 17457 Sender: jonathangf@gmail.com 17457 Recipients: 17457 jonathan@surestorm.com 17476 exec /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1JXhiL-0004XZ-TF 17476 Exim version 4.63 uid=101 gid=65000 pid=17476 D=fbbd5cfd Berkeley DB: Sleepycat Software: Berkeley DB 4.3.29: (September 6, 2005) Support for: crypteq iconv() IPv6 PAM Perl GnuTLS move_frozen_messages Content_Scanning Old_Demime Lookups: lsearch wildlsearch nwildlsearch iplsearch cdb dbm dbmnz dnsdb dsearch ldap ldapdn ldapm mysql nis nis0 passwd pgsql sqlite Authenticators: cram_md5 cyrus_sasl plaintext spa Routers: accept dnslookup ipliteral iplookup manualroute queryprogram redirect Transports: appendfile/maildir/mailstore/mbx autoreply lmtp pipe smtp Fixed never_users: 0 Size of off_t: 8 17476 changed uid/gid: forcing real = effective 17476 uid=0 gid=65000 pid=17476 17476 auxiliary group list: 17476 seeking password data for user "Debian-exim": using cached result 17476 getpwnam() succeeded uid=101 gid=103 17476 seeking password data for user "root": cache not available 17476 getpwnam() succeeded uid=0 gid=0 17476 seeking password data for user "bin": cache not available 17476 getpwnam() succeeded uid=2 gid=2 17476 seeking password data for user "daemon": cache not available 17476 getpwnam() succeeded uid=1 gid=1 17476 seeking password data for user "Debian-exim": cache not available 17476 getpwnam() succeeded uid=101 gid=103 17476 seeking password data for user "nobody": cache not available 17476 getpwnam() succeeded uid=65534 gid=65534 17476 configuration file is /etc/exim4/exim4.conf 17476 log selectors = 00000ffc 001b9001 17476 cwd=/var/spool/exim4 4 args: /usr/sbin/exim4 -d=0xfbbd5cfd -Mc 1JXhiL-0004XZ-TF 17476 trusted user 17476 admin user 17476 skipping ACL configuration - not needed 17476 set_process_info: 17476 delivering specified messages 17476 set_process_info: 17476 delivering 1JXhiL-0004XZ-TF 17476 reading spool file 1JXhiL-0004XZ-TF-H 17476 user=root uid=0 gid=0 sender=jonathangf@gmail.com 17476 sender_fullhost = ti-out-0910.google.com [209.85.142.190] 17476 sender_rcvhost = ti-out-0910.google.com ([209.85.142.190]) 17476 sender_local=0 ident=unset 17476 Non-recipients: 17476 Empty Tree 17476 ---- End of tree ---- 17476 recipients_count=1 17476 body_linecount=15 message_linecount=35 17476 running system filter 17476 rda_interpret (file): /etc/exim4/system_filter 17476 expanded: /etc/exim4/system_filter 17476 search_tidyup called 17477 changed uid/gid: system filter 17477 uid=101 gid=65000 pid=17477 17477 auxiliary group list: 17477 80 bytes read from /etc/exim4/system_filter 17477 data is an Exim filter program 17477 Filter: start of processing 17477 Filter: end of processing 17477 search_tidyup called 17476 rda_interpret: subprocess yield=1 error=NULL 17476 system filter returned 1 17476 Delivery address list: 17476 jonathan@surestorm.com 17476 locking /var/spool/exim4/db/retry.lockfile 17476 locked /var/spool/exim4/db/retry.lockfile 17476 EXIM_DBOPEN(/var/spool/exim4/db/retry) 17476 returned from EXIM_DBOPEN 17476 opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY 17476 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> 17476 Considering: jonathan@surestorm.com 17476 unique = jonathan@surestorm.com 17476 dbfn_read: key=R:surestorm.com 17457 forked delivery process 17476 17457 Process 17457 is ready for new message 17457 smtp_setup_msg entered 17476 dbfn_read: key=R:jonathan@surestorm.com 17476 no domain retry record 17476 no address retry record 17476 jonathan@surestorm.com: queued for routing 17476 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> 17476 routing jonathan@surestorm.com 17476 --------> send_to_mailserver router <-------- 17476 local_part=jonathan domain=surestorm.com 17476 calling send_to_mailserver router 17476 send_to_mailserver router called for jonathan@surestorm.com 17476 domain = surestorm.com 17476 route_item = +local_domains mail.surestorm.com::587 byname 17476 surestorm.com in "@ : @[] : surestorm.com : tcser.com"? yes (matched "surestorm.com") 17476 surestorm.com in "+local_domains"? yes (matched "+local_domains") 17476 original list of hosts = "mail.surestorm.com::587" options = byname 17476 expanded list of hosts = "mail.surestorm.com::587" options = byname 17476 set transport remote_smtp 17476 finding IP address for mail.surestorm.com:587 17476 host=mail.surestorm.com port=587 17476 calling host_find_byname 17476 fully qualified name = mail.surestorm.com 17476 gethostbyname2 looked up these IP addresses: 17476 name=mail.surestorm.com address=89.128.3.108 17476 queued for remote_smtp transport: local_part = jonathan 17476 domain = surestorm.com 17476 errors_to=NULL 17476 domain_data=NULL localpart_data=NULL 17476 routed by send_to_mailserver router 17476 envelope to: jonathan@surestorm.com 17476 transport: remote_smtp 17476 host mail.surestorm.com [89.128.3.108] port=587 17476 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> 17476 After routing: 17476 Local deliveries: 17476 Remote deliveries: 17476 jonathan@surestorm.com 17476 Failed addresses: 17476 Deferred addresses: 17476 search_tidyup called 17476 >>>>>>>>>>>>>>>> Remote deliveries >>>>>>>>>>>>>>>> 17476 --------> jonathan@surestorm.com <-------- 17476 search_tidyup called 17478 changed uid/gid: remote delivery to jonathan@surestorm.com with transport=remote_smtp 17478 uid=101 gid=65000 pid=17478 17478 auxiliary group list: 17478 set_process_info: 17478 delivering 1JXhiL-0004XZ-TF using remote_smtp 17478 remote_smtp transport entered 17478 jonathan@surestorm.com 17478 surestorm.com in queue_smtp_domains? no (option unset) 17478 checking status of mail.surestorm.com 17478 locking /var/spool/exim4/db/retry.lockfile 17478 locked /var/spool/exim4/db/retry.lockfile 17478 EXIM_DBOPEN(/var/spool/exim4/db/retry) 17478 returned from EXIM_DBOPEN 17478 opened hints database /var/spool/exim4/db/retry: flags=O_RDONLY 17478 dbfn_read: key=T:mail.surestorm.com:89.128.3.108:587 17478 dbfn_read: key=T:mail.surestorm.com:89.128.3.108:587:1JXhiL-0004XZ-TF 17478 no host retry record 17478 no message retry record 17478 mail.surestorm.com [89.128.3.108]:587 status = usable 17478 89.128.3.108 in serialize_hosts? no (option unset) 17478 delivering 1JXhiL-0004XZ-TF to mail.surestorm.com [89.128.3.108] (jonathan@surestorm.com) 17478 set_process_info: 17478 delivering 1JXhiL-0004XZ-TF to mail.surestorm.com [89.128.3.108] (jonathan@surestorm.com) 17478 Transport port=25 replaced by host-specific port=587 17476 set_process_info: 17476 delivering 1JXhiL-0004XZ-TF: waiting for a remote delivery subprocess to finish 17476 selecting on subprocess pipes 17478 Connecting to mail.surestorm.com [89.128.3.108]:587 ... connected 17478 waiting for data on socket 17478 read response data: size=77 17478 SMTP<< 220 mail.surestorm.com ESMTP Server Ready @ Fri, 07 Mar 2008 19:54:45 +0100 17478 89.128.3.108 in hosts_avoid_esmtp? no (option unset) 17478 SMTP>> EHLO mailhost.surestorm.com 17478 waiting for data on socket 17478 read response data: size=151 17478 SMTP<< 250-mail.surestorm.com Hello mailhost.surestorm.com [64.79.209.162] 17478 250-SIZE 15728640 17478 250-8BITMIME 17478 250-AUTH CRAM-MD5 LOGIN 17478 250-STARTTLS 17478 250 HELP 17478 89.128.3.108 in hosts_avoid_tls? no (option unset) 17478 SMTP>> STARTTLS 17478 waiting for data on socket 17478 read response data: size=18 17478 SMTP<< 220 TLS go ahead 17478 initializing GnuTLS as a client 17478 read D-H parameters from file 17478 initialized D-H parameters 17478 no TLS client certificate is specified 17478 initialized certificate stuff 17478 initialized GnuTLS session 17478 cipher: TLS-1.0:RSA_AES_256_CBC_SHA1:32 17478 SMTP>> EHLO mailhost.surestorm.com 17478 tls_do_write(bfa123ec, 29) 17478 gnutls_record_send(SSL, bfa123ec, 29) 17478 outbytes=29 17478 waiting for data on socket 17478 Calling gnutls_record_recv(8145638, bfa103ec, 4096) 17478 read response data: size=137 17478 SMTP<< 250-mail.surestorm.com Hello mailhost.surestorm.com [64.79.209.162] 17478 250-SIZE 15728640 17478 250-8BITMIME 17478 250-AUTH CRAM-MD5 LOGIN 17478 250 HELP 17478 not using PIPELINING 17478 89.128.3.108 in hosts_require_auth? no (option unset) 17478 89.128.3.108 in hosts_try_auth? no (option unset) 17478 SMTP>> MAIL FROM: SIZE=3448 17478 tls_do_write(bfa123ec, 44) 17478 gnutls_record_send(SSL, bfa123ec, 44) 17478 outbytes=44 17478 waiting for data on socket 17478 Calling gnutls_record_recv(8145638, bfa103ec, 4096) 17478 read response data: size=8 17478 SMTP<< 250 OK 17478 SMTP>> RCPT TO: 17478 tls_do_write(bfa123ec, 34) 17478 gnutls_record_send(SSL, bfa123ec, 34) 17478 outbytes=34 17478 waiting for data on socket 17478 Calling gnutls_record_recv(8145638, bfa103ec, 4096) 17478 read response data: size=14 17478 SMTP<< 250 Accepted 17478 SMTP>> DATA 17478 tls_do_write(bfa123ec, 6) 17478 gnutls_record_send(SSL, bfa123ec, 6) 17478 outbytes=6 17478 waiting for data on socket 17478 Calling gnutls_record_recv(8145638, bfa103ec, 4096) 17478 read response data: size=56 17478 SMTP<< 354 Enter message, ending with "." on a line by itself 17478 SMTP>> writing message and terminating "." 17478 writing data block fd=7 size=2428 timeout=300 17478 tls_do_write(8126c68, 2428) 17478 gnutls_record_send(SSL, 8126c68, 2428) 17478 outbytes=2428 17478 waiting for data on socket 17478 Calling gnutls_record_recv(8145638, bfa103ec, 4096) 17478 read response data: size=28 17478 SMTP<< 250 OK id=1JXhiR-0008Sp-Ps 17478 journalling jonathan@surestorm.com 17478 ok=1 send_quit=1 send_rset=0 continue_more=0 yield=0 first_address is NULL 17478 89.128.3.108 in hosts_nopass_tls? no (option unset) 17478 transport_check_waiting entered 17478 sequence=1 local_max=500 global_max=-1 17478 locking /var/spool/exim4/db/wait-remote_smtp.lockfile 17478 locked /var/spool/exim4/db/wait-remote_smtp.lockfile 17478 EXIM_DBOPEN(/var/spool/exim4/db/wait-remote_smtp) 17478 returned from EXIM_DBOPEN 17478 opened hints database /var/spool/exim4/db/wait-remote_smtp: flags=O_RDWR 17478 dbfn_read: key=mail.surestorm.com 17478 no messages waiting for mail.surestorm.com 17478 SMTP>> QUIT 17478 tls_do_write(bfa123ec, 6) 17478 gnutls_record_send(SSL, bfa123ec, 6) 17478 outbytes=6 17478 tls_close(): shutting down TLS 17478 set_process_info: 17478 delivering 1JXhiL-0004XZ-TF: just tried mail.surestorm.com [89.128.3.108] for jonathan@surestorm.com: result OK 17478 Leaving remote_smtp transport 17478 set_process_info: 17478 delivering 1JXhiL-0004XZ-TF (just run remote_smtp for jonathan@surestorm.com in subprocess) 17478 search_tidyup called 17476 reading pipe for subprocess 17478 (not ended) 17476 read() yielded 188 17476 Z0 item read 17476 remote delivery process 17478 ended 17476 set_process_info: 17476 delivering 1JXhiL-0004XZ-TF 17476 post-process jonathan@surestorm.com (0) 17476 jonathan@surestorm.com delivered 17476 LOG: MAIN 17476 => jonathan@surestorm.com R=send_to_mailserver T=remote_smtp H=mail.surestorm.com [89.128.3.108] X=TLS-1.0:RSA_AES_256_CBC_SHA1:32 DN="C=ES,ST=Asturias,L=Gijon,O=SURESTORM,OU=Security,CN=mail.surestorm.com" C="250 OK id=1JXhiR-0008Sp-Ps" 17476 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> 17476 changed uid/gid: post-delivery tidying 17476 uid=101 gid=65000 pid=17476 17476 auxiliary group list: 17476 set_process_info: 17476 tidying up after delivering 1JXhiL-0004XZ-TF 17476 Processing retry items 17476 Succeeded addresses: 17476 jonathan@surestorm.com: no retry items 17476 Failed addresses: 17476 Deferred addresses: 17476 end of retry processing 17476 LOG: MAIN 17476 Completed 17476 end delivery of 1JXhiL-0004XZ-TF 17476 search_tidyup called 17476 search_tidyup called 17476 >>>>>>>>>>>>>>>> Exim pid=17476 terminating with rc=0 >>>>>>>>>>>>>>>>