Logging: Add "D=" to more connection closure log lines. Bug 2434
[exim.git] / test / stderr / 0092
1 >>> host in hosts_connection_nolog? no (option unset)
2 >>> host in host_lookup? no (option unset)
3 >>> host in host_reject_connection? no (option unset)
4 >>> host in sender_unqualified_hosts? no (option unset)
5 >>> host in recipient_unqualified_hosts? no (option unset)
6 >>> host in helo_verify_hosts? no (option unset)
7 >>> host in helo_try_verify_hosts? no (option unset)
8 >>> host in helo_accept_junk_hosts? no (option unset)
9 LOG: SMTP command timeout on connection from [V4NET.0.0.1] D=qqs
10 >>> host in hosts_connection_nolog? no (option unset)
11 >>> host in host_lookup? no (option unset)
12 >>> host in host_reject_connection? no (option unset)
13 >>> host in sender_unqualified_hosts? no (option unset)
14 >>> host in recipient_unqualified_hosts? no (option unset)
15 >>> host in helo_verify_hosts? no (option unset)
16 >>> host in helo_try_verify_hosts? no (option unset)
17 >>> host in helo_accept_junk_hosts? no (option unset)
18 >>> test in helo_lookup_domains?
19 >>>  list element: @
20 >>>  list element: @[]
21 >>> test in helo_lookup_domains? no (end of list)
22 >>> using ACL "check_recipient"
23 >>> processing "accept" (TESTSUITE/test-config 27)
24 >>> check hosts = :
25 >>> host in ":"?
26 >>>  list element: 
27 >>> host in ":"? no (end of list)
28 >>> accept: condition test failed in ACL "check_recipient"
29 >>> processing "deny" (TESTSUITE/test-config 28)
30 >>>   message: unrouteable address
31 >>> check recipients = verify@test.ex
32 >>> userx@test.ex in "verify@test.ex"?
33 >>>  list element: verify@test.ex
34 >>> userx@test.ex in "verify@test.ex"? no (end of list)
35 >>> deny: condition test failed in ACL "check_recipient"
36 >>> processing "accept" (TESTSUITE/test-config 31)
37 >>> check domains = +local_domains
38 >>> test.ex in "+local_domains"?
39 >>>  list element: +local_domains
40 >>>  test.ex in "test.ex : *.test.ex"?
41 >>>   list element: test.ex
42 >>>   test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
43 >>>  test.ex in "+local_domains"? yes (matched "+local_domains")
44 >>> accept: condition test succeeded in ACL "check_recipient"
45 >>> end of ACL "check_recipient": ACCEPT
46 LOG: SMTP data timeout (message abandoned) on connection from (test) [V4NET.0.0.1] F=<userx@test.ex> D=qqs
47 Exim version x.yz ....
48 changed uid/gid: forcing real = effective
49   uid=uuuu gid=CALLER_GID pid=p1234
50 environment after trimming:
51  PATH=<munged>
52 adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys
53 configuration file is TESTSUITE/test-config
54 admin user
55 changed uid/gid: privilege not needed
56   uid=EXIM_UID gid=EXIM_GID pid=p1234
57 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
58 sender address = CALLER@myhost.test.ex
59 sender_fullhost = [V4NET.0.0.1]
60 sender_rcvhost = [V4NET.0.0.1]
61 host in hosts_connection_nolog? no (option unset)
62 LOG: smtp_connection MAIN
63   SMTP connection from [V4NET.0.0.1]
64 host in host_lookup? no (option unset)
65 set_process_info: pppp handling incoming connection from [V4NET.0.0.1]
66  ╭considering: ${if eq {V4NET.0.0.1} {$sender_host_address} {2} {30}}s
67   ╭considering: V4NET.0.0.1} {$sender_host_address} {2} {30}}s
68   ├───────text: V4NET.0.0.1
69   ├considering: } {$sender_host_address} {2} {30}}s
70   ├──expanding: V4NET.0.0.1
71   ╰─────result: V4NET.0.0.1
72   ╭considering: $sender_host_address} {2} {30}}s
73   ├considering: } {2} {30}}s
74   ├──expanding: $sender_host_address
75   ╰─────result: V4NET.0.0.1
76  ├──condition: eq {V4NET.0.0.1} {$sender_host_address}
77  ├─────result: true
78   ╭considering: 2} {30}}s
79   ├───────text: 2
80   ├considering: } {30}}s
81   ├──expanding: 2
82   ╰─────result: 2
83   ╭───scanning: 30}}s
84   ├───────text: 30
85   ├───scanning: }}s
86   ├──expanding: 30
87   ├─────result: 30
88   ╰───skipping: result is not used
89  ├───item-res: 2
90  ├considering: s
91  ├───────text: s
92  ├──expanding: ${if eq {V4NET.0.0.1} {$sender_host_address} {2} {30}}s
93  ╰─────result: 2s
94 host in host_reject_connection? no (option unset)
95 host in sender_unqualified_hosts? no (option unset)
96 host in recipient_unqualified_hosts? no (option unset)
97 host in helo_verify_hosts? no (option unset)
98 host in helo_try_verify_hosts? no (option unset)
99 host in helo_accept_junk_hosts? no (option unset)
100  ╭considering: $smtp_active_hostname ESMTP Exim $version_number $tod_full
101  ├considering:  ESMTP Exim $version_number $tod_full
102  ├───────text:  ESMTP Exim 
103  ├considering: $version_number $tod_full
104  ├considering:  $tod_full
105  ├───────text:  
106  ├considering: $tod_full
107  ├──expanding: $smtp_active_hostname ESMTP Exim $version_number $tod_full
108  ╰─────result: myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
109 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
110 smtp_setup_msg entered
111 SMTP<< helo test
112 test in helo_lookup_domains?
113  list element: @
114  list element: @[]
115 test in helo_lookup_domains? no (end of list)
116 sender_fullhost = (test) [V4NET.0.0.1]
117 sender_rcvhost = [V4NET.0.0.1] (helo=test)
118 set_process_info: pppp handling incoming connection from (test) [V4NET.0.0.1]
119 SMTP>> 250 myhost.test.ex Hello test [V4NET.0.0.1]
120 SMTP<< mail from:userx@test.ex
121 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
122 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
123 SMTP>> 250 OK
124 SMTP<< rcpt to:userx@test.ex
125 using ACL "check_recipient"
126 processing "accept" (TESTSUITE/test-config 27)
127 check hosts = :
128 host in ":"?
129  list element: 
130 host in ":"? no (end of list)
131 accept: condition test failed in ACL "check_recipient"
132 processing "deny" (TESTSUITE/test-config 28)
133   message: unrouteable address
134 check recipients = verify@test.ex
135 userx@test.ex in "verify@test.ex"?
136  list element: verify@test.ex
137  address match test: subject=userx@test.ex pattern=verify@test.ex
138 userx@test.ex in "verify@test.ex"? no (end of list)
139 deny: condition test failed in ACL "check_recipient"
140 processing "accept" (TESTSUITE/test-config 31)
141 check domains = +local_domains
142 test.ex in "+local_domains"?
143  list element: +local_domains
144   start sublist local_domains
145    test.ex in "test.ex : *.test.ex"?
146    ╎list element: test.ex
147    ╎test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
148   end sublist local_domains
149  data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex'
150  test.ex in "+local_domains"? yes (matched "+local_domains")
151 accept: condition test succeeded in ACL "check_recipient"
152 end of ACL "check_recipient": ACCEPT
153 SMTP>> 250 Accepted
154 SMTP<< data
155 SMTP>> 354 Enter message, ending with "." on a line by itself
156 search_tidyup called
157 LOG: lost_incoming_connection MAIN
158   SMTP data timeout (message abandoned) on connection from (test) [V4NET.0.0.1] F=<userx@test.ex> D=qqs
159 SMTP>> 421 myhost.test.ex SMTP incoming data timeout - closing connection.
160 search_tidyup called
161 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=1 >>>>>>>>>>>>>>>>
162 exim: timed out while reading - message abandoned
163 exim: timed out while reading - message abandoned
164 >>> host in hosts_connection_nolog? no (option unset)
165 >>> host in host_lookup? no (option unset)
166 >>> host in host_reject_connection? no (option unset)
167 >>> host in sender_unqualified_hosts? no (option unset)
168 >>> host in recipient_unqualified_hosts? no (option unset)
169 >>> host in helo_verify_hosts? no (option unset)
170 >>> host in helo_try_verify_hosts? no (option unset)
171 >>> host in helo_accept_junk_hosts? no (option unset)
172 >>> test in helo_lookup_domains?
173 >>>  list element: @
174 >>>  list element: @[]
175 >>> test in helo_lookup_domains? no (end of list)
176 >>> using ACL "check_recipient"
177 >>> processing "accept" (TESTSUITE/test-config 27)
178 >>> check hosts = :
179 >>> host in ":"?
180 >>>  list element: 
181 >>> host in ":"? no (end of list)
182 >>> accept: condition test failed in ACL "check_recipient"
183 >>> processing "deny" (TESTSUITE/test-config 28)
184 >>>   message: unrouteable address
185 >>> check recipients = verify@test.ex
186 >>> verify@test.ex in "verify@test.ex"?
187 >>>  list element: verify@test.ex
188 >>>  test.ex in "test.ex"?
189 >>>   list element: test.ex
190 >>>   test.ex in "test.ex"? yes (matched "test.ex")
191 >>>  verify@test.ex in "verify@test.ex"? yes (matched "verify@test.ex")
192 >>> check !verify = recipient
193 >>> >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
194 >>> routing verify@test.ex
195 >>> test.ex in "! +local_domains"?
196 >>>  list element: ! +local_domains
197 >>>  test.ex in "test.ex : *.test.ex"?
198 >>>   list element: test.ex
199 >>>   test.ex in "test.ex : *.test.ex"? yes (matched "test.ex")
200 >>>  test.ex in "! +local_domains"? no (matched "! +local_domains")
201 >>> calling forward router
202 >>> forward router declined for verify@test.ex
203 >>> no more routers
204 >>> ----------- end verify ------------
205 >>> deny: condition test succeeded in ACL "check_recipient"
206 >>> end of ACL "check_recipient": DENY
207 LOG: H=(test) [V4NET.0.0.1] F=<userx@test.ex> rejected RCPT verify@test.ex: Unrouteable address
208 LOG: SMTP command timeout on connection from (test) [V4NET.0.0.1] D=qqs
209 An error was detected while processing a file of BSMTP input.
210 The error message was:
211
212   421 SMTP command timeout
213
214 The SMTP transaction started in line 0.
215 The error was detected in line 0.
216 0 previous messages were successfully processed.
217 The rest of the batch was abandoned.
218 An error was detected while processing a file of BSMTP input.
219 The error message was:
220
221   421 SMTP incoming data timeout - message abandoned
222
223 The SMTP transaction started in line 0.
224 The error was detected in line 3.
225 0 previous messages were successfully processed.
226 The rest of the batch was abandoned.
227 exim: timed out while reading - message abandoned