Add macro support to -be expansion test mode. Bug 1623
[exim.git] / test / stderr / 5005
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
4 configuration file is TESTSUITE/test-config
5 admin user
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=pppp
8 DSN: r1 propagating DSN
9 seeking password data for user "CALLER": cache not available
10 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
11 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
12 sender address = CALLER@test.ex
13 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
14 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
15 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
16 Sender: CALLER@test.ex
17 Recipients:
18   nofile@test.ex
19 search_tidyup called
20 >>Headers received:
21
22 rewrite_one_header: type=F:
23   From: CALLER_NAME <CALLER@test.ex>
24 search_tidyup called
25 >>Headers after rewriting and local additions:
26 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
27 F From: CALLER_NAME <CALLER@test.ex>
28   Date: Tue, 2 Mar 1999 09:44:33 +0000
29
30 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
31 Data file written for message 10HmaX-0005vi-00
32 >>Generated Received: header line
33 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
34         (envelope-from <CALLER@test.ex>)
35         id 10HmaX-0005vi-00
36         for nofile@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
37 calling local_scan(); timeout=300
38 local_scan() returned 0 NULL
39 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
40 DSN: Write SPOOL :-dsn_envid NULL
41 DSN: Write SPOOL :-dsn_ret 0
42 DSN: Flags :0
43 DSN: **** SPOOL_OUT - address: |nofile@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
44 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
45 Size of headers = sss
46 LOG: MAIN
47   <= CALLER@test.ex U=CALLER P=local S=sss
48 created log directory TESTSUITE/spool/log
49 search_tidyup called
50 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
51 Exim version x.yz ....
52 changed uid/gid: forcing real = effective
53   uid=uuuu gid=EXIM_GID pid=pppp
54 configuration file is TESTSUITE/test-config
55 trusted user
56 admin user
57 DSN: r1 propagating DSN
58 seeking password data for user "CALLER": cache not available
59 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
60 set_process_info: pppp delivering specified messages
61 set_process_info: pppp delivering 10HmaX-0005vi-00
62 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
63 reading spool file 10HmaX-0005vi-00-H
64 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
65 sender_local=1 ident=CALLER
66 Non-recipients:
67 Empty Tree
68 ---- End of tree ----
69 recipients_count=1
70 **** SPOOL_IN - No additional fields
71 body_linecount=1 message_linecount=7
72 DSN: set orcpt: NULL  flags: 0
73 Delivery address list:
74   nofile@test.ex 
75 locking TESTSUITE/spool/db/retry.lockfile
76 locked  TESTSUITE/spool/db/retry.lockfile
77 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
78 returned from EXIM_DBOPEN: (nil)
79 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
80 failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory
81 no retry data available
82 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
83 Considering: nofile@test.ex
84 unique = nofile@test.ex
85 no domain retry record
86 no address retry record
87 nofile@test.ex: queued for routing
88 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
89 routing nofile@test.ex
90 --------> r1 router <--------
91 local_part=nofile domain=test.ex
92 calling r1 router
93 r1 router called for nofile@test.ex
94   domain = test.ex
95 set transport t1
96 queued for t1 transport: local_part = nofile
97 domain = test.ex
98   errors_to=NULL
99   domain_data=NULL localpart_data=NULL
100 routed by r1 router
101   envelope to: nofile@test.ex
102   transport: t1
103 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
104 After routing:
105   Local deliveries:
106     nofile@test.ex
107   Remote deliveries:
108   Failed addresses:
109   Deferred addresses:
110 search_tidyup called
111 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
112 --------> nofile@test.ex <--------
113 locking TESTSUITE/spool/db/retry.lockfile
114 locked  TESTSUITE/spool/db/retry.lockfile
115 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
116 returned from EXIM_DBOPEN: (nil)
117 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
118 no retry data available
119 search_tidyup called
120 changed uid/gid: local delivery to nofile <nofile@test.ex> transport=t1
121   uid=CALLER_UID gid=CALLER_GID pid=pppp
122   home=NULL current=/
123 set_process_info: pppp delivering 10HmaX-0005vi-00 to nofile using t1
124 appendfile transport entered
125 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
126   directory=TESTSUITE/test-mail/nofile format=maildir
127   message_prefix=null
128   message_suffix=null
129   maildir_use_size_file=yes
130 ensuring maildir directories exist in TESTSUITE/test-mail/nofile
131 created directory TESTSUITE/test-mail/nofile
132 created directory TESTSUITE/test-mail/nofile/tmp
133 created directory TESTSUITE/test-mail/nofile/new
134 created directory TESTSUITE/test-mail/nofile/cur
135 using regex for maildir directory selection: ^(?:cur|new|\..*)$
136 looking for maildirsize in TESTSUITE/test-mail/nofile
137 TESTSUITE/test-mail/nofile/maildirsize does not exist: recalculating
138 MUNGED: the check_dir_size lines have been sorted to ensure consistency
139 check_dir_size: dir=TESTSUITE/test-mail/nofile/cur sum=0 count=dd
140 check_dir_size: dir=TESTSUITE/test-mail/nofile/new sum=0 count=dd
141 skipping TESTSUITE/test-mail/nofile/tmp: dir_regex does not match
142 maildir_compute_size: path=TESTSUITE/test-mail/nofile
143   sum=0 filecount=0 timestamp=ddddddd
144 checking subdirectory timestamps
145 MUNGED: the check_dir_size lines have been sorted to ensure consistency
146 skipping TESTSUITE/test-mail/nofile/maildirsize: dir_regex does not match
147 skipping TESTSUITE/test-mail/nofile/tmp: dir_regex does not match
148 maildir_compute_size (timestamp_only): ddddddd
149 returning maildir size=sss filecount=0
150 delivering in maildir format in TESTSUITE/test-mail/nofile
151 writing to tmp/MAILDIR.myhost.test.ex
152 Exim quota = 500 old size = sssss this message = sss (included)
153   file count quota = 0 count = 0
154 cannot use sendfile for body: spoolfile not wireformat
155 writing data block fd=dddd size=sss timeout=0
156 added 'ddd 1' to maildirsize file
157 renaming temporary file
158 renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex
159 appendfile yields 0 with errno=dd more_errno=dd
160 search_tidyup called
161 journalling nofile@test.ex
162 t1 transport returned OK for nofile@test.ex
163 post-process nofile@test.ex (0)
164 nofile@test.ex delivered
165 LOG: MAIN
166   => nofile <nofile@test.ex> R=r1 T=t1
167 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
168 changed uid/gid: post-delivery tidying
169   uid=EXIM_UID gid=EXIM_GID pid=pppp
170 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
171 Processing retry items
172 Succeeded addresses:
173  nofile@test.ex: no retry items
174 Failed addresses:
175 Deferred addresses:
176 end of retry processing
177 DSN: processing router : r1
178 DSN: processing successful delivery address: nofile@test.ex
179 DSN: Sender_address: CALLER@test.ex
180 DSN: orcpt: NULL  flags: 0
181 DSN: envid: NULL  ret: 0
182 DSN: Final recipient: nofile@test.ex
183 DSN: Remote SMTP server supports DSN: 0
184 DSN: not sending DSN success message
185 LOG: MAIN
186   Completed
187 end delivery of 10HmaX-0005vi-00
188 search_tidyup called
189 search_tidyup called
190 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
191 search_tidyup called
192 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
193 Exim version x.yz ....
194 changed uid/gid: forcing real = effective
195   uid=uuuu gid=CALLER_GID pid=pppp
196 configuration file is TESTSUITE/test-config
197 admin user
198 changed uid/gid: privilege not needed
199   uid=EXIM_UID gid=EXIM_GID pid=pppp
200 DSN: r1 propagating DSN
201 seeking password data for user "CALLER": cache not available
202 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
203 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
204 sender address = CALLER@test.ex
205 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
206 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
207 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
208 Sender: CALLER@test.ex
209 Recipients:
210   userx@test.ex
211 search_tidyup called
212 >>Headers received:
213
214 rewrite_one_header: type=F:
215   From: CALLER_NAME <CALLER@test.ex>
216 search_tidyup called
217 >>Headers after rewriting and local additions:
218 I Message-Id: <E10HmaY-0005vi-00@myhost.test.ex>
219 F From: CALLER_NAME <CALLER@test.ex>
220   Date: Tue, 2 Mar 1999 09:44:33 +0000
221
222 Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D
223 Data file written for message 10HmaY-0005vi-00
224 >>Generated Received: header line
225 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
226         (envelope-from <CALLER@test.ex>)
227         id 10HmaY-0005vi-00
228         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
229 calling local_scan(); timeout=300
230 local_scan() returned 0 NULL
231 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
232 DSN: Write SPOOL :-dsn_envid NULL
233 DSN: Write SPOOL :-dsn_ret 0
234 DSN: Flags :0
235 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
236 Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H
237 Size of headers = sss
238 LOG: MAIN
239   <= CALLER@test.ex U=CALLER P=local S=sss
240 search_tidyup called
241 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaY-0005vi-00
242 Exim version x.yz ....
243 changed uid/gid: forcing real = effective
244   uid=uuuu gid=EXIM_GID pid=pppp
245 configuration file is TESTSUITE/test-config
246 trusted user
247 admin user
248 DSN: r1 propagating DSN
249 seeking password data for user "CALLER": cache not available
250 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
251 set_process_info: pppp delivering specified messages
252 set_process_info: pppp delivering 10HmaY-0005vi-00
253 Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D
254 reading spool file 10HmaY-0005vi-00-H
255 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
256 sender_local=1 ident=CALLER
257 Non-recipients:
258 Empty Tree
259 ---- End of tree ----
260 recipients_count=1
261 **** SPOOL_IN - No additional fields
262 body_linecount=1 message_linecount=7
263 DSN: set orcpt: NULL  flags: 0
264 Delivery address list:
265   userx@test.ex 
266 locking TESTSUITE/spool/db/retry.lockfile
267 locked  TESTSUITE/spool/db/retry.lockfile
268 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
269 returned from EXIM_DBOPEN: (nil)
270 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
271 no retry data available
272 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
273 Considering: userx@test.ex
274 unique = userx@test.ex
275 no domain retry record
276 no address retry record
277 userx@test.ex: queued for routing
278 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
279 routing userx@test.ex
280 --------> r1 router <--------
281 local_part=userx domain=test.ex
282 calling r1 router
283 r1 router called for userx@test.ex
284   domain = test.ex
285 set transport t1
286 queued for t1 transport: local_part = userx
287 domain = test.ex
288   errors_to=NULL
289   domain_data=NULL localpart_data=NULL
290 routed by r1 router
291   envelope to: userx@test.ex
292   transport: t1
293 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
294 After routing:
295   Local deliveries:
296     userx@test.ex
297   Remote deliveries:
298   Failed addresses:
299   Deferred addresses:
300 search_tidyup called
301 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
302 --------> userx@test.ex <--------
303 locking TESTSUITE/spool/db/retry.lockfile
304 locked  TESTSUITE/spool/db/retry.lockfile
305 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
306 returned from EXIM_DBOPEN: (nil)
307 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
308 no retry data available
309 search_tidyup called
310 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
311   uid=CALLER_UID gid=CALLER_GID pid=pppp
312   home=NULL current=/
313 set_process_info: pppp delivering 10HmaY-0005vi-00 to userx using t1
314 appendfile transport entered
315 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
316   directory=TESTSUITE/test-mail/userx format=maildir
317   message_prefix=null
318   message_suffix=null
319   maildir_use_size_file=yes
320 ensuring maildir directories exist in TESTSUITE/test-mail/userx
321 created directory TESTSUITE/test-mail/userx/tmp
322 created directory TESTSUITE/test-mail/userx/new
323 created directory TESTSUITE/test-mail/userx/cur
324 using regex for maildir directory selection: ^(?:cur|new|\..*)$
325 looking for maildirsize in TESTSUITE/test-mail/userx
326 reading quota parameters from maildirsize data
327 cached quota is out of date: recalculating
328   quota=500 cached_quota=50 filecount_quota=0 cached_quota_filecount=2
329 MUNGED: the check_dir_size lines have been sorted to ensure consistency
330 check_dir_size: dir=TESTSUITE/test-mail/userx/cur sum=0 count=dd
331 check_dir_size: dir=TESTSUITE/test-mail/userx/new sum=0 count=dd
332 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
333 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
334 maildir_compute_size: path=TESTSUITE/test-mail/userx
335   sum=0 filecount=0 timestamp=ddddddd
336 checking subdirectory timestamps
337 MUNGED: the check_dir_size lines have been sorted to ensure consistency
338 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
339 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
340 maildir_compute_size (timestamp_only): ddddddd
341 returning maildir size=sss filecount=0
342 delivering in maildir format in TESTSUITE/test-mail/userx
343 writing to tmp/MAILDIR.myhost.test.ex
344 Exim quota = 500 old size = sssss this message = sss (included)
345   file count quota = 0 count = 0
346 cannot use sendfile for body: spoolfile not wireformat
347 writing data block fd=dddd size=sss timeout=0
348 added 'ddd 1' to maildirsize file
349 renaming temporary file
350 renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex
351 appendfile yields 0 with errno=dd more_errno=dd
352 search_tidyup called
353 journalling userx@test.ex
354 t1 transport returned OK for userx@test.ex
355 post-process userx@test.ex (0)
356 userx@test.ex delivered
357 LOG: MAIN
358   => userx <userx@test.ex> R=r1 T=t1
359 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
360 changed uid/gid: post-delivery tidying
361   uid=EXIM_UID gid=EXIM_GID pid=pppp
362 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
363 Processing retry items
364 Succeeded addresses:
365  userx@test.ex: no retry items
366 Failed addresses:
367 Deferred addresses:
368 end of retry processing
369 DSN: processing router : r1
370 DSN: processing successful delivery address: userx@test.ex
371 DSN: Sender_address: CALLER@test.ex
372 DSN: orcpt: NULL  flags: 0
373 DSN: envid: NULL  ret: 0
374 DSN: Final recipient: userx@test.ex
375 DSN: Remote SMTP server supports DSN: 0
376 DSN: not sending DSN success message
377 LOG: MAIN
378   Completed
379 end delivery of 10HmaY-0005vi-00
380 search_tidyup called
381 search_tidyup called
382 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
383 search_tidyup called
384 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
385 Exim version x.yz ....
386 changed uid/gid: forcing real = effective
387   uid=uuuu gid=CALLER_GID pid=pppp
388 configuration file is TESTSUITE/test-config
389 admin user
390 changed uid/gid: privilege not needed
391   uid=EXIM_UID gid=EXIM_GID pid=pppp
392 DSN: r1 propagating DSN
393 seeking password data for user "CALLER": cache not available
394 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
395 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
396 sender address = CALLER@test.ex
397 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
398 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
399 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
400 Sender: CALLER@test.ex
401 Recipients:
402   userx@test.ex
403 search_tidyup called
404 >>Headers received:
405
406 rewrite_one_header: type=F:
407   From: CALLER_NAME <CALLER@test.ex>
408 search_tidyup called
409 >>Headers after rewriting and local additions:
410 I Message-Id: <E10HmaZ-0005vi-00@myhost.test.ex>
411 F From: CALLER_NAME <CALLER@test.ex>
412   Date: Tue, 2 Mar 1999 09:44:33 +0000
413
414 Data file name: TESTSUITE/spool//input//10HmaZ-0005vi-00-D
415 Data file written for message 10HmaZ-0005vi-00
416 >>Generated Received: header line
417 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
418         (envelope-from <CALLER@test.ex>)
419         id 10HmaZ-0005vi-00
420         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
421 calling local_scan(); timeout=300
422 local_scan() returned 0 NULL
423 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
424 DSN: Write SPOOL :-dsn_envid NULL
425 DSN: Write SPOOL :-dsn_ret 0
426 DSN: Flags :0
427 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
428 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-H
429 Size of headers = sss
430 LOG: MAIN
431   <= CALLER@test.ex U=CALLER P=local S=sss
432 search_tidyup called
433 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaZ-0005vi-00
434 Exim version x.yz ....
435 changed uid/gid: forcing real = effective
436   uid=uuuu gid=EXIM_GID pid=pppp
437 configuration file is TESTSUITE/test-config
438 trusted user
439 admin user
440 DSN: r1 propagating DSN
441 seeking password data for user "CALLER": cache not available
442 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
443 set_process_info: pppp delivering specified messages
444 set_process_info: pppp delivering 10HmaZ-0005vi-00
445 Trying spool file TESTSUITE/spool//input//10HmaZ-0005vi-00-D
446 reading spool file 10HmaZ-0005vi-00-H
447 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
448 sender_local=1 ident=CALLER
449 Non-recipients:
450 Empty Tree
451 ---- End of tree ----
452 recipients_count=1
453 **** SPOOL_IN - No additional fields
454 body_linecount=1 message_linecount=7
455 DSN: set orcpt: NULL  flags: 0
456 Delivery address list:
457   userx@test.ex 
458 locking TESTSUITE/spool/db/retry.lockfile
459 locked  TESTSUITE/spool/db/retry.lockfile
460 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
461 returned from EXIM_DBOPEN: (nil)
462 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
463 no retry data available
464 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
465 Considering: userx@test.ex
466 unique = userx@test.ex
467 no domain retry record
468 no address retry record
469 userx@test.ex: queued for routing
470 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
471 routing userx@test.ex
472 --------> r1 router <--------
473 local_part=userx domain=test.ex
474 calling r1 router
475 r1 router called for userx@test.ex
476   domain = test.ex
477 set transport t1
478 queued for t1 transport: local_part = userx
479 domain = test.ex
480   errors_to=NULL
481   domain_data=NULL localpart_data=NULL
482 routed by r1 router
483   envelope to: userx@test.ex
484   transport: t1
485 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
486 After routing:
487   Local deliveries:
488     userx@test.ex
489   Remote deliveries:
490   Failed addresses:
491   Deferred addresses:
492 search_tidyup called
493 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
494 --------> userx@test.ex <--------
495 locking TESTSUITE/spool/db/retry.lockfile
496 locked  TESTSUITE/spool/db/retry.lockfile
497 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
498 returned from EXIM_DBOPEN: (nil)
499 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
500 no retry data available
501 search_tidyup called
502 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
503   uid=CALLER_UID gid=CALLER_GID pid=pppp
504   home=NULL current=/
505 set_process_info: pppp delivering 10HmaZ-0005vi-00 to userx using t1
506 appendfile transport entered
507 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
508   directory=TESTSUITE/test-mail/userx format=maildir
509   message_prefix=null
510   message_suffix=null
511   maildir_use_size_file=yes
512 ensuring maildir directories exist in TESTSUITE/test-mail/userx
513 using regex for maildir directory selection: ^(?:cur|new|\..*)$
514 looking for maildirsize in TESTSUITE/test-mail/userx
515 reading quota parameters from maildirsize data
516 computing maildir size from maildirsize data
517 over quota and maildirsize has more than 1 entry: recalculating
518 MUNGED: the check_dir_size lines have been sorted to ensure consistency
519 check_dir_size: dir=TESTSUITE/test-mail/userx/cur sum=0 count=dd
520 check_dir_size: dir=TESTSUITE/test-mail/userx/new sum=dddd count=dd
521 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
522 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
523 maildir_compute_size: path=TESTSUITE/test-mail/userx
524   sum=dddd filecount=1 timestamp=ddddddd
525 checking subdirectory timestamps
526 MUNGED: the check_dir_size lines have been sorted to ensure consistency
527 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
528 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
529 maildir_compute_size (timestamp_only): ddddddd
530 returning maildir size=sss filecount=1
531 delivering in maildir format in TESTSUITE/test-mail/userx
532 writing to tmp/MAILDIR.myhost.test.ex
533 Exim quota = 500 old size = sssss this message = sss (included)
534   file count quota = 0 count = 1
535 mailbox quota exceeded
536 maildir: time since "new" directory modified = 10s
537 Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex
538 appendfile yields 1 with errno=-22 more_errno=dd
539 search_tidyup called
540 t1 transport returned DEFER for userx@test.ex
541 added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0
542 post-process userx@test.ex (1)
543 LOG: MAIN
544   == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
545 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
546 changed uid/gid: post-delivery tidying
547   uid=EXIM_UID gid=EXIM_GID pid=pppp
548 set_process_info: pppp tidying up after delivering 10HmaZ-0005vi-00
549 Processing retry items
550 Succeeded addresses:
551 Failed addresses:
552 Deferred addresses:
553  userx@test.ex
554 locking TESTSUITE/spool/db/retry.lockfile
555 locked  TESTSUITE/spool/db/retry.lockfile
556 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR
557 returned from EXIM_DBOPEN: 0xAAAAAAAA
558 opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
559 address match test: subject=userx@test.ex pattern=*
560 test.ex in "*"? yes (matched "*")
561 userx@test.ex in "*"? yes (matched "*")
562 retry for T:userx@test.ex = * 0 0
563 dbfn_read: key=T:userx@test.ex
564 failing_interval=ttt message_age=ttt
565 Writing retry data for T:userx@test.ex
566   first failed=dddd last try=dddd next try=+86400 expired=0
567   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
568 dbfn_write: key=T:userx@test.ex
569 EXIM_DBCLOSE(0xAAAAAAAA)
570 closed hints database and lockfile
571 end of retry processing
572 delivery deferred: update_spool=1 header_rewritten=0
573 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
574 DSN: Write SPOOL :-dsn_envid NULL
575 DSN: Write SPOOL :-dsn_ret 0
576 DSN: Flags :0
577 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
578 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-H
579 Size of headers = sss
580 end delivery of 10HmaZ-0005vi-00
581 search_tidyup called
582 search_tidyup called
583 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
584 search_tidyup called
585 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
586 Exim version x.yz ....
587 changed uid/gid: forcing real = effective
588   uid=uuuu gid=CALLER_GID pid=pppp
589 configuration file is TESTSUITE/test-config
590 admin user
591 changed uid/gid: privilege not needed
592   uid=EXIM_UID gid=EXIM_GID pid=pppp
593 DSN: r1 propagating DSN
594 seeking password data for user "CALLER": cache not available
595 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
596 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
597 sender address = CALLER@test.ex
598 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
599 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
600 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
601 Sender: CALLER@test.ex
602 Recipients:
603   userx@test.ex
604 search_tidyup called
605 >>Headers received:
606
607 rewrite_one_header: type=F:
608   From: CALLER_NAME <CALLER@test.ex>
609 search_tidyup called
610 >>Headers after rewriting and local additions:
611 I Message-Id: <E10HmbA-0005vi-00@myhost.test.ex>
612 F From: CALLER_NAME <CALLER@test.ex>
613   Date: Tue, 2 Mar 1999 09:44:33 +0000
614
615 Data file name: TESTSUITE/spool//input//10HmbA-0005vi-00-D
616 Data file written for message 10HmbA-0005vi-00
617 >>Generated Received: header line
618 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
619         (envelope-from <CALLER@test.ex>)
620         id 10HmbA-0005vi-00
621         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
622 calling local_scan(); timeout=300
623 local_scan() returned 0 NULL
624 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
625 DSN: Write SPOOL :-dsn_envid NULL
626 DSN: Write SPOOL :-dsn_ret 0
627 DSN: Flags :0
628 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
629 Renaming spool header file: TESTSUITE/spool//input//10HmbA-0005vi-00-H
630 Size of headers = sss
631 LOG: MAIN
632   <= CALLER@test.ex U=CALLER P=local S=sss
633 search_tidyup called
634 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmbA-0005vi-00
635 Exim version x.yz ....
636 changed uid/gid: forcing real = effective
637   uid=uuuu gid=EXIM_GID pid=pppp
638 configuration file is TESTSUITE/test-config
639 trusted user
640 admin user
641 DSN: r1 propagating DSN
642 seeking password data for user "CALLER": cache not available
643 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
644 set_process_info: pppp delivering specified messages
645 set_process_info: pppp delivering 10HmbA-0005vi-00
646 Trying spool file TESTSUITE/spool//input//10HmbA-0005vi-00-D
647 reading spool file 10HmbA-0005vi-00-H
648 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
649 sender_local=1 ident=CALLER
650 Non-recipients:
651 Empty Tree
652 ---- End of tree ----
653 recipients_count=1
654 **** SPOOL_IN - No additional fields
655 body_linecount=1 message_linecount=7
656 DSN: set orcpt: NULL  flags: 0
657 Delivery address list:
658   userx@test.ex 
659 locking TESTSUITE/spool/db/retry.lockfile
660 locked  TESTSUITE/spool/db/retry.lockfile
661 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
662 returned from EXIM_DBOPEN: 0xAAAAAAAA
663 opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY
664 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
665 Considering: userx@test.ex
666 unique = userx@test.ex
667 dbfn_read: key=R:test.ex
668 dbfn_read: key=R:userx@test.ex
669 dbfn_read: key=R:userx@test.ex:<CALLER@test.ex>
670 no domain retry record
671 no address retry record
672 userx@test.ex: queued for routing
673 EXIM_DBCLOSE(0xAAAAAAAA)
674 closed hints database and lockfile
675 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
676 routing userx@test.ex
677 --------> r1 router <--------
678 local_part=userx domain=test.ex
679 calling r1 router
680 r1 router called for userx@test.ex
681   domain = test.ex
682 set transport t1
683 queued for t1 transport: local_part = userx
684 domain = test.ex
685   errors_to=NULL
686   domain_data=NULL localpart_data=NULL
687 routed by r1 router
688   envelope to: userx@test.ex
689   transport: t1
690 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
691 After routing:
692   Local deliveries:
693     userx@test.ex
694   Remote deliveries:
695   Failed addresses:
696   Deferred addresses:
697 search_tidyup called
698 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
699 --------> userx@test.ex <--------
700 locking TESTSUITE/spool/db/retry.lockfile
701 locked  TESTSUITE/spool/db/retry.lockfile
702 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
703 returned from EXIM_DBOPEN: 0xAAAAAAAA
704 opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY
705 dbfn_read: key=T:userx@test.ex
706 retry record exists: age=ttt (max 1w)
707   time to retry = tttt expired = 0
708 EXIM_DBCLOSE(0xAAAAAAAA)
709 closed hints database and lockfile
710 search_tidyup called
711 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
712   uid=CALLER_UID gid=CALLER_GID pid=pppp
713   home=NULL current=/
714 set_process_info: pppp delivering 10HmbA-0005vi-00 to userx using t1
715 appendfile transport entered
716 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
717   directory=TESTSUITE/test-mail/userx format=maildir
718   message_prefix=null
719   message_suffix=null
720   maildir_use_size_file=yes
721 ensuring maildir directories exist in TESTSUITE/test-mail/userx
722 using regex for maildir directory selection: ^(?:cur|new|\..*)$
723 looking for maildirsize in TESTSUITE/test-mail/userx
724 reading quota parameters from maildirsize data
725 computing maildir size from maildirsize data
726 returning maildir size=sss filecount=1
727 delivering in maildir format in TESTSUITE/test-mail/userx
728 writing to tmp/MAILDIR.myhost.test.ex
729 Exim quota = 500 old size = sssss this message = sss (included)
730   file count quota = 0 count = 1
731 mailbox quota exceeded
732 maildir: time since "new" directory modified = 10s
733 Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex
734 appendfile yields 1 with errno=-22 more_errno=dd
735 search_tidyup called
736 t1 transport returned DEFER for userx@test.ex
737 added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0
738 post-process userx@test.ex (1)
739 LOG: MAIN
740   == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
741 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
742 changed uid/gid: post-delivery tidying
743   uid=EXIM_UID gid=EXIM_GID pid=pppp
744 set_process_info: pppp tidying up after delivering 10HmbA-0005vi-00
745 Processing retry items
746 Succeeded addresses:
747 Failed addresses:
748 Deferred addresses:
749  userx@test.ex
750 locking TESTSUITE/spool/db/retry.lockfile
751 locked  TESTSUITE/spool/db/retry.lockfile
752 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR
753 returned from EXIM_DBOPEN: 0xAAAAAAAA
754 opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
755 address match test: subject=userx@test.ex pattern=*
756 test.ex in "*"? yes (matched "*")
757 userx@test.ex in "*"? yes (matched "*")
758 retry for T:userx@test.ex = * 0 0
759 dbfn_read: key=T:userx@test.ex
760 failing_interval=ttt message_age=ttt
761 Writing retry data for T:userx@test.ex
762   first failed=dddd last try=dddd next try=+86400 expired=0
763   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
764 dbfn_write: key=T:userx@test.ex
765 EXIM_DBCLOSE(0xAAAAAAAA)
766 closed hints database and lockfile
767 end of retry processing
768 delivery deferred: update_spool=1 header_rewritten=0
769 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
770 DSN: Write SPOOL :-dsn_envid NULL
771 DSN: Write SPOOL :-dsn_ret 0
772 DSN: Flags :0
773 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
774 Renaming spool header file: TESTSUITE/spool//input//10HmbA-0005vi-00-H
775 Size of headers = sss
776 end delivery of 10HmbA-0005vi-00
777 search_tidyup called
778 search_tidyup called
779 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
780 search_tidyup called
781 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>