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