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