Logging: Add "D=" to more connection closure log lines. Bug 2434
[exim.git] / test / stderr / 2202
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=p1234
4 configuration file is TESTSUITE/test-config
5 admin user
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=p1234
8 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
9 sender address = CALLER@myhost.test.ex
10 sender_fullhost = [ip4.ip4.ip4.ip4]
11 sender_rcvhost = [ip4.ip4.ip4.ip4]
12 host in hosts_connection_nolog? no (option unset)
13 LOG: smtp_connection MAIN
14   SMTP connection from [ip4.ip4.ip4.ip4]
15 host in host_lookup? no (option unset)
16 set_process_info: pppp handling incoming connection from [ip4.ip4.ip4.ip4]
17 host in host_reject_connection? no (option unset)
18 host in sender_unqualified_hosts? no (option unset)
19 host in recipient_unqualified_hosts? no (option unset)
20 host in helo_verify_hosts? no (option unset)
21 host in helo_try_verify_hosts? no (option unset)
22 host in helo_accept_junk_hosts? no (option unset)
23 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
24 smtp_setup_msg entered
25 SMTP<< helo test
26 test in helo_lookup_domains?
27  list element: @
28  list element: @[]
29 test in helo_lookup_domains? no (end of list)
30 sender_fullhost = (test) [ip4.ip4.ip4.ip4]
31 sender_rcvhost = [ip4.ip4.ip4.ip4] (helo=test)
32 set_process_info: pppp handling incoming connection from (test) [ip4.ip4.ip4.ip4]
33 SMTP>> 250 myhost.test.ex Hello test [ip4.ip4.ip4.ip4]
34 SMTP<< mail from:<xx@cioce.test.again.dns>
35 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
36 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
37 SMTP>> 250 OK
38 SMTP<< rcpt to:<a@b>
39 using ACL "rcpt"
40 processing "accept" (TESTSUITE/test-config 35)
41 check hosts = +ignore_unknown : *.$sender_address_domain : $sender_address_domain : ${lookup dnsdb{>:defer_never,mxh=$sender_address_domain}}
42  search_open: dnsdb "NULL"
43  search_find: file="NULL"
44    key=">:defer_never,mxh=cioce.test.again.dns" partial=-1 affix=NULL starflags=0 opts=NULL
45  LRU list:
46  internal_search_find: file="NULL"
47    type=dnsdb key=">:defer_never,mxh=cioce.test.again.dns" opts=NULL
48  database lookup required for >:defer_never,mxh=cioce.test.again.dns
49                               (tainted)
50  dnsdb key: cioce.test.again.dns
51 DNS lookup of cioce.test.again.dns (MX) using fakens
52 DNS lookup of cioce.test.again.dns (MX) gave TRY_AGAIN
53  cioce.test.again.dns in dns_again_means_nonexist?
54   list element: *
55   cioce.test.again.dns in dns_again_means_nonexist? yes (matched "*")
56 cioce.test.again.dns is in dns_again_means_nonexist: returning DNS_NOMATCH
57 DNS: couldn't fake dnsa len
58 DNS: no SOA record found for neg-TTL
59  writing neg-cache entry for cioce.test.again.dns-MX-xxxx, ttl -1
60  creating new cache entry
61  lookup failed
62 host in "+ignore_unknown : *.cioce.test.again.dns : cioce.test.again.dns : "?
63  list element: +ignore_unknown
64  list element: *.cioce.test.again.dns
65 sender host name required, to match against *.cioce.test.again.dns
66 looking up host name for ip4.ip4.ip4.ip4
67 DNS lookup of ip4-reverse.in-addr.arpa (PTR) using fakens
68 DNS lookup of ip4-reverse.in-addr.arpa (PTR) succeeded
69 IP address lookup yielded "the.local.host.name"
70 DNS lookup of the.local.host.name (A) using fakens
71 DNS lookup of the.local.host.name (A) succeeded
72 local host found for non-MX address
73 the.local.host.name ip4.ip4.ip4.ip4 mx=-1 sort=xx 
74 checking addresses for the.local.host.name
75 Forward DNS security status: unverified
76   ip4.ip4.ip4.ip4 OK
77 sender_fullhost = the.local.host.name (test) [ip4.ip4.ip4.ip4]
78 sender_rcvhost = the.local.host.name ([ip4.ip4.ip4.ip4] helo=test)
79  list element: cioce.test.again.dns
80 using host_fake_gethostbyname for cioce.test.again.dns (IPv4)
81 DNS lookup of cioce.test.again.dns (A) using fakens
82 DNS lookup of cioce.test.again.dns (A) gave TRY_AGAIN
83  cioce.test.again.dns in dns_again_means_nonexist?
84   list element: *
85   cioce.test.again.dns in dns_again_means_nonexist? yes (matched "*")
86 cioce.test.again.dns is in dns_again_means_nonexist: returning DNS_NOMATCH
87 DNS: couldn't fake dnsa len
88 DNS: no SOA record found for neg-TTL
89  writing neg-cache entry for cioce.test.again.dns-A-xxxx, ttl -1
90 host_fake_gethostbyname(af=inet) returned 1 (HOST_NOT_FOUND)
91 no IP address found for host cioce.test.again.dns (during SMTP connection from the.local.host.name (test) [ip4.ip4.ip4.ip4])
92 LOG: host_lookup_failed MAIN
93   no IP address found for host cioce.test.again.dns (during SMTP connection from the.local.host.name (test) [ip4.ip4.ip4.ip4])
94  failed to find IP address for cioce.test.again.dns: item ignored by +ignore_unknown
95 host in "+ignore_unknown : *.cioce.test.again.dns : cioce.test.again.dns : "? no (end of list)
96 accept: condition test failed in ACL "rcpt"
97 end of ACL "rcpt": implicit DENY
98 SMTP>> 550 Administrative prohibition
99 LOG: MAIN REJECT
100   H=the.local.host.name (test) [ip4.ip4.ip4.ip4] F=<xx@cioce.test.again.dns> rejected RCPT <a@b>
101 SMTP<< quit
102 SMTP>> 221 myhost.test.ex closing connection
103 LOG: smtp_connection MAIN
104   SMTP connection from the.local.host.name (test) [ip4.ip4.ip4.ip4] D=qqs closed by QUIT
105 search_tidyup called
106 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
107 Exim version x.yz ....
108 changed uid/gid: forcing real = effective
109   uid=uuuu gid=CALLER_GID pid=p1235
110 configuration file is TESTSUITE/test-config
111 admin user
112 changed uid/gid: privilege not needed
113   uid=EXIM_UID gid=EXIM_GID pid=p1235
114 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
115 sender address = CALLER@myhost.test.ex
116 sender_fullhost = [ip4.ip4.ip4.ip4]
117 sender_rcvhost = [ip4.ip4.ip4.ip4]
118 host in hosts_connection_nolog? no (option unset)
119 LOG: smtp_connection MAIN
120   SMTP connection from [ip4.ip4.ip4.ip4]
121 host in host_lookup? no (option unset)
122 set_process_info: pppp handling incoming connection from [ip4.ip4.ip4.ip4]
123 host in host_reject_connection? no (option unset)
124 host in sender_unqualified_hosts? no (option unset)
125 host in recipient_unqualified_hosts? no (option unset)
126 host in helo_verify_hosts? no (option unset)
127 host in helo_try_verify_hosts? no (option unset)
128 host in helo_accept_junk_hosts? no (option unset)
129 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
130 smtp_setup_msg entered
131 SMTP<< vrfy a@test.again.dns
132 host in smtp_accept_max_nonmail_hosts?
133  list element: *
134   host in smtp_accept_max_nonmail_hosts? yes (matched "*")
135 using ACL "vrfy"
136 processing "warn" (TESTSUITE/test-config 28)
137 check domains = +try_again_dns_list
138 test.again.dns in "+try_again_dns_list"?
139  list element: +try_again_dns_list
140   start sublist try_again_dns_list
141    test.again.dns in "@mx_any"?
142    ╎list element: @mx_any
143 DNS lookup of test.again.dns (MX) using fakens
144 DNS lookup of test.again.dns (MX) gave TRY_AGAIN
145    ╎test.again.dns in dns_again_means_nonexist?
146    ╎ list element: !+try_again_dns_list
147    ╎  start sublist try_again_dns_list
148    ╎   test.again.dns in "@mx_any"?
149    ╎   ╎list element: @mx_any
150 DNS lookup of test.again.dns (MX) using fakens
151 DNS lookup of test.again.dns (MX) gave TRY_AGAIN
152 LOG: MAIN PANIC
153   dns_again_means_nonexist recursion seen for test.again.dns (assuming nonexist)
154 DNS: couldn't fake dnsa len
155 DNS: no SOA record found for neg-TTL
156  writing neg-cache entry for test.again.dns-MX-xxxx, ttl -1
157    ╎   test.again.dns in "@mx_any"? no (end of list)
158    ╎  end sublist try_again_dns_list
159    ╎test.again.dns in dns_again_means_nonexist? yes (end of list)
160 test.again.dns is in dns_again_means_nonexist: returning DNS_NOMATCH
161 DNS: couldn't fake dnsa len
162 DNS: no SOA record found for neg-TTL
163  update neg-cache entry for test.again.dns-MX-xxxx, ttl -1
164    test.again.dns in "@mx_any"? no (end of list)
165   end sublist try_again_dns_list
166 test.again.dns in "+try_again_dns_list"? no (end of list)
167 warn: condition test failed in ACL "vrfy"
168 end of ACL "vrfy": implicit DENY
169 SMTP>> 252 Administrative prohibition
170 LOG: MAIN REJECT
171   H=[ip4.ip4.ip4.ip4] rejected VRFY a@test.again.dns
172 SMTP>> 421 myhost.test.ex lost input connection
173 LOG: smtp_connection MAIN
174   SMTP connection from [ip4.ip4.ip4.ip4] lost D=qqs
175 search_tidyup called
176 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>