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