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