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