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