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