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