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