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