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