Fix callouts connection fallback from TLS to cleartext. Bug 1897
[users/heiko/exim.git] / test / stderr / 0402
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
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=pppp
8 DSN: r1 propagating DSN
9 DSN: r2 propagating DSN
10 DSN: r3 propagating DSN
11 DSN: r4 propagating DSN
12 DSN: r5 propagating DSN
13 seeking password data for user "CALLER": cache not available
14 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
15 seeking password data for user "CALLER": using cached result
16 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
17 seeking password data for user "CALLER": using cached result
18 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
19 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
20 sender address = CALLER@test.ex
21 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
22 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
23 log directory space = -1K inodes = -1 check_space = 10240K inodes = 100
24 Sender: CALLER@test.ex
25 Recipients:
26   CALLER@test.ex
27   usery@test.ex
28   userz
29   rd+CALLER
30   rd+usery
31 search_tidyup called
32 >>Headers received:
33
34 rewrite_one_header: type=F:
35   From: CALLER_NAME <CALLER@test.ex>
36 search_tidyup called
37 >>Headers after rewriting and local additions:
38 I Message-Id: <E10HmaX-0005vi-00@mail.test.ex>
39 F From: CALLER_NAME <CALLER@test.ex>
40   Date: Tue, 2 Mar 1999 09:44:33 +0000
41
42 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
43 Data file written for message 10HmaX-0005vi-00
44 considering: ${tod_full}
45   expanding: ${tod_full}
46      result: Tue, 2 Mar 1999 09:44:33 +0000
47 considering: Received: ${if def:sender_rcvhost {from $sender_rcvhost
48         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
49         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
50         }}(Exim $version_number)
51         ${if def:sender_address {(envelope-from <$sender_address>)
52         }}id $message_exim_id${if def:received_for {
53         for $received_for}}
54   condition: def:sender_rcvhost
55      result: false
56    scanning: from $sender_rcvhost
57         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
58         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
59         }}(Exim $version_number)
60         ${if def:sender_address {(envelope-from <$sender_address>)
61         }}id $message_exim_id${if def:received_for {
62         for $received_for}}
63   expanding: from $sender_rcvhost
64         
65      result: from 
66         
67    skipping: result is not used
68 considering: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
69         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
70         }}(Exim $version_number)
71         ${if def:sender_address {(envelope-from <$sender_address>)
72         }}id $message_exim_id${if def:received_for {
73         for $received_for}}
74   condition: def:sender_ident
75      result: true
76 considering: from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
77         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
78         }}(Exim $version_number)
79         ${if def:sender_address {(envelope-from <$sender_address>)
80         }}id $message_exim_id${if def:received_for {
81         for $received_for}}
82 considering: $sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
83         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
84         }}(Exim $version_number)
85         ${if def:sender_address {(envelope-from <$sender_address>)
86         }}id $message_exim_id${if def:received_for {
87         for $received_for}}
88   expanding: $sender_ident
89      result: CALLER
90   expanding: from ${quote_local_part:$sender_ident} 
91      result: from CALLER 
92   condition: def:sender_helo_name
93      result: false
94    scanning: (helo=$sender_helo_name)
95         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
96         }}(Exim $version_number)
97         ${if def:sender_address {(envelope-from <$sender_address>)
98         }}id $message_exim_id${if def:received_for {
99         for $received_for}}
100   expanding: (helo=$sender_helo_name)
101         
102      result: (helo=)
103         
104    skipping: result is not used
105   expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
106         }}
107      result: from CALLER 
108   condition: def:received_protocol
109      result: true
110 considering: with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
111         }}(Exim $version_number)
112         ${if def:sender_address {(envelope-from <$sender_address>)
113         }}id $message_exim_id${if def:received_for {
114         for $received_for}}
115   expanding: with $received_protocol
116      result: with local
117   condition: def:tls_cipher
118      result: false
119    scanning: ($tls_cipher)
120         }}(Exim $version_number)
121         ${if def:sender_address {(envelope-from <$sender_address>)
122         }}id $message_exim_id${if def:received_for {
123         for $received_for}}
124   expanding: ($tls_cipher)
125         
126      result: ()
127         
128    skipping: result is not used
129   condition: def:sender_address
130      result: true
131 considering: (envelope-from <$sender_address>)
132         }}id $message_exim_id${if def:received_for {
133         for $received_for}}
134   expanding: (envelope-from <$sender_address>)
135         
136      result: (envelope-from <CALLER@test.ex>)
137         
138   condition: def:received_for
139      result: false
140    scanning: 
141         for $received_for}}
142   expanding: 
143         for $received_for
144      result: 
145         for 
146    skipping: result is not used
147   expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
148         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
149         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol}} ${if def:tls_cipher {($tls_cipher)
150         }}(Exim $version_number)
151         ${if def:sender_address {(envelope-from <$sender_address>)
152         }}id $message_exim_id${if def:received_for {
153         for $received_for}}
154      result: Received: from CALLER by mail.test.ex with local (Exim x.yz)
155         (envelope-from <CALLER@test.ex>)
156         id 10HmaX-0005vi-00
157 >>Generated Received: header line
158 P Received: from CALLER by mail.test.ex with local (Exim x.yz)
159         (envelope-from <CALLER@test.ex>)
160         id 10HmaX-0005vi-00; Tue, 2 Mar 1999 09:44:33 +0000
161 calling local_scan(); timeout=300
162 local_scan() returned 0 NULL
163 considering: ${tod_full}
164   expanding: ${tod_full}
165      result: Tue, 2 Mar 1999 09:44:33 +0000
166 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
167 DSN: Write SPOOL :-dsn_envid NULL
168 DSN: Write SPOOL :-dsn_ret 0
169 DSN: Flags :0
170 DSN: **** SPOOL_OUT - address: |CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
171 DSN: Flags :0
172 DSN: **** SPOOL_OUT - address: |usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
173 DSN: Flags :0
174 DSN: **** SPOOL_OUT - address: |userz@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
175 DSN: Flags :0
176 DSN: **** SPOOL_OUT - address: |rd+CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
177 DSN: Flags :0
178 DSN: **** SPOOL_OUT - address: |rd+usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
179 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
180 Size of headers = sss
181 LOG: MAIN
182   <= CALLER@test.ex U=CALLER P=local S=sss
183 created log directory TESTSUITE/spool/log
184 search_tidyup called
185 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95dfd -odi -Mc 10HmaX-0005vi-00
186 Exim version x.yz ....
187 changed uid/gid: forcing real = effective
188   uid=uuuu gid=EXIM_GID pid=pppp
189 configuration file is TESTSUITE/test-config
190 trusted user
191 admin user
192 DSN: r1 propagating DSN
193 DSN: r2 propagating DSN
194 DSN: r3 propagating DSN
195 DSN: r4 propagating DSN
196 DSN: r5 propagating DSN
197 seeking password data for user "CALLER": cache not available
198 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
199 seeking password data for user "CALLER": using cached result
200 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
201 seeking password data for user "CALLER": using cached result
202 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
203 set_process_info: pppp delivering specified messages
204 set_process_info: pppp delivering 10HmaX-0005vi-00
205 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
206 reading spool file 10HmaX-0005vi-00-H
207 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
208 sender_local=1 ident=CALLER
209 Non-recipients:
210 Empty Tree
211 ---- End of tree ----
212 recipients_count=5
213 **** SPOOL_IN - No additional fields
214 **** SPOOL_IN - No additional fields
215 **** SPOOL_IN - No additional fields
216 **** SPOOL_IN - No additional fields
217 **** SPOOL_IN - No additional fields
218 body_linecount=0 message_linecount=6
219 DSN: set orcpt: NULL  flags: 0
220 DSN: set orcpt: NULL  flags: 0
221 DSN: set orcpt: NULL  flags: 0
222 DSN: set orcpt: NULL  flags: 0
223 DSN: set orcpt: NULL  flags: 0
224 Delivery address list:
225   CALLER@test.ex 
226   usery@test.ex 
227   userz@test.ex 
228   rd+CALLER@test.ex 
229   rd+usery@test.ex 
230 locking TESTSUITE/spool/db/retry.lockfile
231 locked  TESTSUITE/spool/db/retry.lockfile
232 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
233 returned from EXIM_DBOPEN
234 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
235 no retry data available
236 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
237 Considering: CALLER@test.ex
238 unique = CALLER@test.ex
239 no domain retry record
240 no address retry record
241 CALLER@test.ex: queued for routing
242 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
243 Considering: usery@test.ex
244 unique = usery@test.ex
245 no domain retry record
246 no address retry record
247 usery@test.ex: queued for routing
248 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
249 Considering: userz@test.ex
250 unique = userz@test.ex
251 no domain retry record
252 no address retry record
253 userz@test.ex: queued for routing
254 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
255 Considering: rd+CALLER@test.ex
256 unique = rd+CALLER@test.ex
257 no domain retry record
258 no address retry record
259 rd+CALLER@test.ex: queued for routing
260 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
261 Considering: rd+usery@test.ex
262 unique = rd+usery@test.ex
263 no domain retry record
264 no address retry record
265 rd+usery@test.ex: queued for routing
266 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
267 routing rd+usery@test.ex
268 --------> r1 router <--------
269 local_part=rd+usery domain=test.ex
270 checking local_parts
271 rd+usery in "CALLER"? no (end of list)
272 r1 router skipped: local_parts mismatch
273 --------> r2 router <--------
274 local_part=rd+usery domain=test.ex
275 checking local_parts
276 rd+usery in "usery"? no (end of list)
277 r2 router skipped: local_parts mismatch
278 --------> r3 router <--------
279 local_part=rd+usery domain=test.ex
280 checking local_parts
281 rd+usery in "userz"? no (end of list)
282 r3 router skipped: local_parts mismatch
283 --------> r4 router <--------
284 local_part=rd+usery domain=test.ex
285 stripped prefix rd+
286 checking local_parts
287 usery in "CALLER"? no (end of list)
288 r4 router skipped: local_parts mismatch
289 --------> r5 router <--------
290 local_part=rd+usery domain=test.ex
291 stripped prefix rd+
292 checking local_parts
293 usery in "usery"? yes (matched "usery")
294 considering: /non-exist/$domain
295   expanding: /non-exist/$domain
296      result: /non-exist/test.ex
297 calling r5 router
298 rda_interpret (string): TESTSUITE/test-mail/junk
299 expanded: TESTSUITE/test-mail/junk
300 file is not a filter file
301 parse_forward_list: TESTSUITE/test-mail/junk
302 extract item: TESTSUITE/test-mail/junk
303 set transport ft1
304 r5 router generated TESTSUITE/test-mail/junk
305   pipe, file, or autoreply
306   errors_to=NULL transport=ft1
307   uid=unset gid=unset home=/non-exist/$local_part
308 routed by r5 router
309   envelope to: rd+usery@test.ex
310   transport: <none>
311 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
312 routing rd+CALLER@test.ex
313 --------> r1 router <--------
314 local_part=rd+CALLER domain=test.ex
315 checking local_parts
316 rd+CALLER in "CALLER"? no (end of list)
317 r1 router skipped: local_parts mismatch
318 --------> r2 router <--------
319 local_part=rd+CALLER domain=test.ex
320 checking local_parts
321 rd+CALLER in "usery"? no (end of list)
322 r2 router skipped: local_parts mismatch
323 --------> r3 router <--------
324 local_part=rd+CALLER domain=test.ex
325 checking local_parts
326 rd+CALLER in "userz"? no (end of list)
327 r3 router skipped: local_parts mismatch
328 --------> r4 router <--------
329 local_part=rd+CALLER domain=test.ex
330 stripped prefix rd+
331 checking local_parts
332 CALLER in "CALLER"? yes (matched "CALLER")
333 considering: /non-exist/$local_part
334   expanding: /non-exist/$local_part
335      result: /non-exist/CALLER
336 calling r4 router
337 rda_interpret (string): TESTSUITE/test-mail/junk
338 expanded: TESTSUITE/test-mail/junk
339 file is not a filter file
340 parse_forward_list: TESTSUITE/test-mail/junk
341 extract item: TESTSUITE/test-mail/junk
342 set transport ft1
343 r4 router generated TESTSUITE/test-mail/junk
344   pipe, file, or autoreply
345   errors_to=NULL transport=ft1
346   uid=unset gid=unset home=/non-exist/CALLER
347 routed by r4 router
348   envelope to: rd+CALLER@test.ex
349   transport: <none>
350 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
351 routing userz@test.ex
352 --------> r1 router <--------
353 local_part=userz domain=test.ex
354 checking local_parts
355 userz in "CALLER"? no (end of list)
356 r1 router skipped: local_parts mismatch
357 --------> r2 router <--------
358 local_part=userz domain=test.ex
359 checking local_parts
360 userz in "usery"? no (end of list)
361 r2 router skipped: local_parts mismatch
362 --------> r3 router <--------
363 local_part=userz domain=test.ex
364 checking local_parts
365 userz in "userz"? yes (matched "userz")
366 considering: /non-exist/$domain
367   expanding: /non-exist/$domain
368      result: /non-exist/test.ex
369 calling r3 router
370 r3 router called for userz@test.ex
371   domain = test.ex
372 set transport t2
373 queued for t2 transport: local_part = userz
374 domain = test.ex
375   errors_to=NULL
376   domain_data=NULL localpart_data=NULL
377 routed by r3 router
378   envelope to: userz@test.ex
379   transport: t2
380 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
381 routing usery@test.ex
382 --------> r1 router <--------
383 local_part=usery domain=test.ex
384 checking local_parts
385 usery in "CALLER"? no (end of list)
386 r1 router skipped: local_parts mismatch
387 --------> r2 router <--------
388 local_part=usery domain=test.ex
389 checking local_parts
390 usery in "usery"? yes (matched "usery")
391 considering: /non-exist/$domain
392   expanding: /non-exist/$domain
393      result: /non-exist/test.ex
394 calling r2 router
395 r2 router called for usery@test.ex
396   domain = test.ex
397 set transport t1
398 queued for t1 transport: local_part = usery
399 domain = test.ex
400   errors_to=NULL
401   domain_data=NULL localpart_data=NULL
402 routed by r2 router
403   envelope to: usery@test.ex
404   transport: t1
405 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
406 routing CALLER@test.ex
407 --------> r1 router <--------
408 local_part=CALLER domain=test.ex
409 checking local_parts
410 CALLER in "CALLER"? yes (matched "CALLER")
411 considering: /non-exist/$local_part
412   expanding: /non-exist/$local_part
413      result: /non-exist/CALLER
414 calling r1 router
415 r1 router called for CALLER@test.ex
416   domain = test.ex
417 set transport t1
418 queued for t1 transport: local_part = CALLER
419 domain = test.ex
420   errors_to=NULL
421   domain_data=NULL localpart_data=NULL
422 routed by r1 router
423   envelope to: CALLER@test.ex
424   transport: t1
425 locking TESTSUITE/spool/db/retry.lockfile
426 locked  TESTSUITE/spool/db/retry.lockfile
427 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
428 returned from EXIM_DBOPEN
429 no retry data available
430 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
431 Considering: TESTSUITE/test-mail/junk
432 unique = TESTSUITE/test-mail/junk:rd+CALLER@test.ex
433 queued for ft1 transport
434 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
435 Considering: TESTSUITE/test-mail/junk
436 unique = TESTSUITE/test-mail/junk:rd+usery@test.ex
437 queued for ft1 transport
438 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
439 After routing:
440   Local deliveries:
441     TESTSUITE/test-mail/junk
442     TESTSUITE/test-mail/junk
443     CALLER@test.ex
444     usery@test.ex
445     userz@test.ex
446   Remote deliveries:
447   Failed addresses:
448   Deferred addresses:
449 search_tidyup called
450 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
451 --------> TESTSUITE/test-mail/junk <--------
452 locking TESTSUITE/spool/db/retry.lockfile
453 locked  TESTSUITE/spool/db/retry.lockfile
454 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
455 returned from EXIM_DBOPEN
456 no retry data available
457 considering: /non-exist/$local_part
458   expanding: /non-exist/$local_part
459      result: /non-exist/usery
460 search_tidyup called
461 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
462   uid=CALLER_UID gid=CALLER_GID pid=pppp
463   home=/non-exist/usery current=/
464 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
465 appendfile transport entered
466 considering: $address_file
467   expanding: $address_file
468      result: TESTSUITE/test-mail/junk
469 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
470   file=TESTSUITE/test-mail/junk format=unix
471   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
472   message_suffix=\n
473   maildir_use_size_file=no
474   locking by lockfile fcntl 
475 lock name: TESTSUITE/test-mail/junk.lock
476 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
477 lock file created
478 mailbox TESTSUITE/test-mail/junk is locked
479 writing to file TESTSUITE/test-mail/junk
480 considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
481
482   condition: def:return_path
483      result: true
484 considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
485
486   expanding: $return_path
487      result: CALLER@test.ex
488    scanning: MAILER-DAEMON}} ${tod_bsdinbox}
489
490   expanding: MAILER-DAEMON
491      result: MAILER-DAEMON
492    skipping: result is not used
493   expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
494
495      result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
496
497 writing data block fd=dddd size=sss timeout=0
498 writing data block fd=dddd size=sss timeout=0
499 writing data block fd=dddd size=sss timeout=0
500 appendfile yields 0 with errno=dd more_errno=dd
501 search_tidyup called
502 journalling TESTSUITE/test-mail/junk:rd+usery@test.ex
503 ft1 transport returned OK for TESTSUITE/test-mail/junk
504 post-process TESTSUITE/test-mail/junk (0)
505 TESTSUITE/test-mail/junk delivered
506 rd+usery@test.ex: children all complete
507 LOG: MAIN
508   => TESTSUITE/test-mail/junk <rd+usery@test.ex> R=r5 T=ft1
509 --------> TESTSUITE/test-mail/junk <--------
510 locking TESTSUITE/spool/db/retry.lockfile
511 locked  TESTSUITE/spool/db/retry.lockfile
512 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
513 returned from EXIM_DBOPEN
514 no retry data available
515 search_tidyup called
516 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
517   uid=CALLER_UID gid=CALLER_GID pid=pppp
518   home=/non-exist/CALLER current=/
519 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
520 appendfile transport entered
521 considering: $address_file
522   expanding: $address_file
523      result: TESTSUITE/test-mail/junk
524 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
525   file=TESTSUITE/test-mail/junk format=unix
526   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
527   message_suffix=\n
528   maildir_use_size_file=no
529   locking by lockfile fcntl 
530 lock name: TESTSUITE/test-mail/junk.lock
531 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
532 lock file created
533 mailbox TESTSUITE/test-mail/junk is locked
534 writing to file TESTSUITE/test-mail/junk
535 considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
536
537   condition: def:return_path
538      result: true
539 considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
540
541   expanding: $return_path
542      result: CALLER@test.ex
543    scanning: MAILER-DAEMON}} ${tod_bsdinbox}
544
545   expanding: MAILER-DAEMON
546      result: MAILER-DAEMON
547    skipping: result is not used
548   expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
549
550      result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
551
552 writing data block fd=dddd size=sss timeout=0
553 writing data block fd=dddd size=sss timeout=0
554 writing data block fd=dddd size=sss timeout=0
555 appendfile yields 0 with errno=dd more_errno=dd
556 search_tidyup called
557 journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex
558 ft1 transport returned OK for TESTSUITE/test-mail/junk
559 post-process TESTSUITE/test-mail/junk (0)
560 TESTSUITE/test-mail/junk delivered
561 rd+CALLER@test.ex: children all complete
562 LOG: MAIN
563   => TESTSUITE/test-mail/junk <rd+CALLER@test.ex> R=r4 T=ft1
564 --------> CALLER@test.ex <--------
565 locking TESTSUITE/spool/db/retry.lockfile
566 locked  TESTSUITE/spool/db/retry.lockfile
567 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
568 returned from EXIM_DBOPEN
569 no retry data available
570 search_tidyup called
571 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
572   uid=CALLER_UID gid=CALLER_GID pid=pppp
573   home=/non-exist/CALLER current=/
574 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
575 appendfile transport entered
576 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
577   file=/dev/null format=unix
578   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
579   message_suffix=\n
580   maildir_use_size_file=no
581   locking by lockfile fcntl 
582 search_tidyup called
583 journalling CALLER@test.ex
584 t1 transport returned OK for CALLER@test.ex
585 post-process CALLER@test.ex (0)
586 CALLER@test.ex delivered
587 LOG: MAIN
588   => CALLER <CALLER@test.ex> R=r1 T=t1
589 --------> usery@test.ex <--------
590 locking TESTSUITE/spool/db/retry.lockfile
591 locked  TESTSUITE/spool/db/retry.lockfile
592 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
593 returned from EXIM_DBOPEN
594 no retry data available
595 considering: /non-exist/$local_part
596   expanding: /non-exist/$local_part
597      result: /non-exist/usery
598 search_tidyup called
599 changed uid/gid: local delivery to usery <usery@test.ex> transport=t1
600   uid=CALLER_UID gid=CALLER_GID pid=pppp
601   home=/non-exist/usery current=/
602 set_process_info: pppp delivering 10HmaX-0005vi-00 to usery using t1
603 appendfile transport entered
604 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
605   file=/dev/null format=unix
606   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
607   message_suffix=\n
608   maildir_use_size_file=no
609   locking by lockfile fcntl 
610 search_tidyup called
611 journalling usery@test.ex
612 t1 transport returned OK for usery@test.ex
613 post-process usery@test.ex (0)
614 usery@test.ex delivered
615 LOG: MAIN
616   => usery <usery@test.ex> R=r2 T=t1
617 --------> userz@test.ex <--------
618 locking TESTSUITE/spool/db/retry.lockfile
619 locked  TESTSUITE/spool/db/retry.lockfile
620 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
621 returned from EXIM_DBOPEN
622 no retry data available
623 considering: /$local_part
624   expanding: /$local_part
625      result: /userz
626 search_tidyup called
627 changed uid/gid: local delivery to userz <userz@test.ex> transport=t2
628   uid=CALLER_UID gid=CALLER_GID pid=pppp
629   home=/userz current=/
630 set_process_info: pppp delivering 10HmaX-0005vi-00 to userz using t2
631 appendfile transport entered
632 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
633   file=/dev/null format=unix
634   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
635   message_suffix=\n
636   maildir_use_size_file=no
637   locking by lockfile fcntl 
638 search_tidyup called
639 journalling userz@test.ex
640 t2 transport returned OK for userz@test.ex
641 post-process userz@test.ex (0)
642 userz@test.ex delivered
643 LOG: MAIN
644   => userz <userz@test.ex> R=r3 T=t2
645 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
646 changed uid/gid: post-delivery tidying
647   uid=EXIM_UID gid=EXIM_GID pid=pppp
648 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
649 Processing retry items
650 Succeeded addresses:
651  userz@test.ex: no retry items
652  usery@test.ex: no retry items
653  CALLER@test.ex: no retry items
654  TESTSUITE/test-mail/junk: no retry items
655  rd+CALLER@test.ex: no retry items
656  TESTSUITE/test-mail/junk: no retry items
657  rd+usery@test.ex: no retry items
658  rd+CALLER@test.ex: no retry items
659  rd+usery@test.ex: no retry items
660 Failed addresses:
661 Deferred addresses:
662 end of retry processing
663 DSN: processing router : r3
664 DSN: processing successful delivery address: userz@test.ex
665 DSN: Sender_address: CALLER@test.ex
666 DSN: orcpt: NULL  flags: 0
667 DSN: envid: NULL  ret: 0
668 DSN: Final recipient: userz@test.ex
669 DSN: Remote SMTP server supports DSN: 0
670 DSN: not sending DSN success message
671 DSN: processing router : r2
672 DSN: processing successful delivery address: usery@test.ex
673 DSN: Sender_address: CALLER@test.ex
674 DSN: orcpt: NULL  flags: 0
675 DSN: envid: NULL  ret: 0
676 DSN: Final recipient: usery@test.ex
677 DSN: Remote SMTP server supports DSN: 0
678 DSN: not sending DSN success message
679 DSN: processing router : r1
680 DSN: processing successful delivery address: CALLER@test.ex
681 DSN: Sender_address: CALLER@test.ex
682 DSN: orcpt: NULL  flags: 0
683 DSN: envid: NULL  ret: 0
684 DSN: Final recipient: CALLER@test.ex
685 DSN: Remote SMTP server supports DSN: 0
686 DSN: not sending DSN success message
687 DSN: processing router : r4
688 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
689 DSN: Sender_address: CALLER@test.ex
690 DSN: orcpt: NULL  flags: 0
691 DSN: envid: NULL  ret: 0
692 DSN: Final recipient: TESTSUITE/test-mail/junk
693 DSN: Remote SMTP server supports DSN: 0
694 DSN: not sending DSN success message
695 DSN: processing router : r5
696 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
697 DSN: Sender_address: CALLER@test.ex
698 DSN: orcpt: NULL  flags: 0
699 DSN: envid: NULL  ret: 0
700 DSN: Final recipient: TESTSUITE/test-mail/junk
701 DSN: Remote SMTP server supports DSN: 0
702 DSN: not sending DSN success message
703 DSN: processing router : r4
704 DSN: processing successful delivery address: rd+CALLER@test.ex
705 DSN: Sender_address: CALLER@test.ex
706 DSN: orcpt: NULL  flags: 0
707 DSN: envid: NULL  ret: 0
708 DSN: Final recipient: rd+CALLER@test.ex
709 DSN: Remote SMTP server supports DSN: 0
710 DSN: not sending DSN success message
711 DSN: processing router : r5
712 DSN: processing successful delivery address: rd+usery@test.ex
713 DSN: Sender_address: CALLER@test.ex
714 DSN: orcpt: NULL  flags: 0
715 DSN: envid: NULL  ret: 0
716 DSN: Final recipient: rd+usery@test.ex
717 DSN: Remote SMTP server supports DSN: 0
718 DSN: not sending DSN success message
719 LOG: MAIN
720   Completed
721 end delivery of 10HmaX-0005vi-00
722 search_tidyup called
723 search_tidyup called
724 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
725 search_tidyup called
726 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>