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