Debug: indent DNS ops
[exim.git] / test / stderr / 5005
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=p1234
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=p1234
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 qualify & rewrite recipients list
22 rewrite rules on sender address
23 qualify and rewrite headers
24  rewrite_one_header: type=F:
25    From: CALLER_NAME <CALLER@test.ex>
26 search_tidyup called
27 >>Headers after rewriting and local additions:
28  I Message-Id: <E10HmaX-000000005vi-0000@myhost.test.ex>
29  F From: CALLER_NAME <CALLER@test.ex>
30    Date: Tue, 2 Mar 1999 09:44:33 +0000
31
32 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
33 Data file written for message 10HmaX-000000005vi-0000
34 >>Generated Received: header line
35 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
36         (envelope-from <CALLER@test.ex>)
37         id 10HmaX-000000005vi-0000
38         for nofile@test.ex;
39         Tue, 2 Mar 1999 09:44:33 +0000
40 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-000000005vi-0000
41 DSN: **** SPOOL_OUT - address: <nofile@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
42 Renaming spool header file: TESTSUITE/spool//input//10HmaX-000000005vi-0000-H
43 Size of headers = sss
44 LOG: MAIN
45   <= CALLER@test.ex U=CALLER P=local S=sss
46 created log directory TESTSUITE/spool/log
47 search_tidyup called
48 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-000000005vi-0000
49 Exim version x.yz ....
50 changed uid/gid: forcing real = effective
51   uid=uuuu gid=EXIM_GID pid=p1235
52 configuration file is TESTSUITE/test-config
53 trusted user
54 admin user
55 dropping to exim gid; retaining priv uid
56 seeking password data for user "CALLER": cache not available
57 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
58 set_process_info: pppp delivering specified messages
59 set_process_info: pppp delivering 10HmaX-000000005vi-0000
60 Trying spool file TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
61 reading spool file 10HmaX-000000005vi-0000-H
62 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
63 sender_local=1 ident=CALLER
64 Non-recipients:
65  Empty Tree
66 ---- End of tree ----
67 recipients_count=1
68 **** SPOOL_IN - No additional fields
69 body_linecount=1 message_linecount=8
70 DSN: set orcpt:   flags: 0x0
71 Delivery address list:
72   nofile@test.ex 
73  locking TESTSUITE/spool/db/retry.lockfile
74  locked  TESTSUITE/spool/db/retry.lockfile
75  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
76  returned from EXIM_DBOPEN: (nil)
77  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
78 no retry data available
79 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
80 Considering: nofile@test.ex
81 unique = nofile@test.ex
82 no   domain  retry record
83 no   address retry record
84 nofile@test.ex: queued for routing
85 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
86 routing nofile@test.ex
87 --------> r1 router <--------
88 local_part=nofile domain=test.ex
89 calling r1 router
90 r1 router called for nofile@test.ex
91   domain = test.ex
92 set transport t1
93 queued for t1 transport: local_part = nofile
94 domain = test.ex
95   errors_to=NULL
96   domain_data=NULL local_part_data=NULL
97 routed by r1 router
98   envelope to: nofile@test.ex
99   transport: t1
100 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
101 After routing:
102   Local deliveries:
103     nofile@test.ex
104   Remote deliveries:
105   Failed addresses:
106   Deferred addresses:
107 search_tidyup called
108 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
109 --------> nofile@test.ex <--------
110  locking TESTSUITE/spool/db/retry.lockfile
111  locked  TESTSUITE/spool/db/retry.lockfile
112  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
113  returned from EXIM_DBOPEN: (nil)
114  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
115 no retry data available
116 search_tidyup called
117 changed uid/gid: local delivery to nofile <nofile@test.ex> transport=t1
118   uid=CALLER_UID gid=CALLER_GID pid=p1236
119   home=NULL current=/
120 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to nofile using t1
121 appendfile transport entered
122 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
123   directory=TESTSUITE/test-mail/nofile format=maildir
124   message_prefix=null
125   message_suffix=null
126   maildir_use_size_file=yes
127 below-home: de-tainting path 'TESTSUITE/test-mail/nofile'
128 ensuring maildir directories exist in TESTSUITE/test-mail/nofile
129 created directory TESTSUITE/test-mail/nofile
130 created directory TESTSUITE/test-mail/nofile/tmp
131 created directory TESTSUITE/test-mail/nofile/new
132 created directory TESTSUITE/test-mail/nofile/cur
133 compiling RE '^(?:cur|new|\..*)$'
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 cannot use sendfile for body: spoolfile not wireformat
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=p1235
169 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
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: 0x0
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-000000005vi-0000
187 search_tidyup called
188 search_tidyup called
189 >>>>>>>>>>>>>>>> Exim pid=p1235 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
190 search_tidyup called
191 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
192 Exim version x.yz ....
193 changed uid/gid: forcing real = effective
194   uid=uuuu gid=CALLER_GID pid=p1237
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=p1237
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 qualify & rewrite recipients list
213 rewrite rules on sender address
214 qualify and rewrite headers
215  rewrite_one_header: type=F:
216    From: CALLER_NAME <CALLER@test.ex>
217 search_tidyup called
218 >>Headers after rewriting and local additions:
219  I Message-Id: <E10HmaY-000000005vi-0000@myhost.test.ex>
220  F From: CALLER_NAME <CALLER@test.ex>
221    Date: Tue, 2 Mar 1999 09:44:33 +0000
222
223 Data file name: TESTSUITE/spool//input//10HmaY-000000005vi-0000-D
224 Data file written for message 10HmaY-000000005vi-0000
225 >>Generated Received: header line
226 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
227         (envelope-from <CALLER@test.ex>)
228         id 10HmaY-000000005vi-0000
229         for userx@test.ex;
230         Tue, 2 Mar 1999 09:44:33 +0000
231 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-000000005vi-0000
232 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
233 Renaming spool header file: TESTSUITE/spool//input//10HmaY-000000005vi-0000-H
234 Size of headers = sss
235 LOG: MAIN
236   <= CALLER@test.ex U=CALLER P=local S=sss
237 search_tidyup called
238 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaY-000000005vi-0000
239 Exim version x.yz ....
240 changed uid/gid: forcing real = effective
241   uid=uuuu gid=EXIM_GID pid=p1238
242 configuration file is TESTSUITE/test-config
243 trusted user
244 admin user
245 dropping to exim gid; retaining priv uid
246 seeking password data for user "CALLER": cache not available
247 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
248 set_process_info: pppp delivering specified messages
249 set_process_info: pppp delivering 10HmaY-000000005vi-0000
250 Trying spool file TESTSUITE/spool//input//10HmaY-000000005vi-0000-D
251 reading spool file 10HmaY-000000005vi-0000-H
252 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
253 sender_local=1 ident=CALLER
254 Non-recipients:
255  Empty Tree
256 ---- End of tree ----
257 recipients_count=1
258 **** SPOOL_IN - No additional fields
259 body_linecount=1 message_linecount=8
260 DSN: set orcpt:   flags: 0x0
261 Delivery address list:
262   userx@test.ex 
263  locking TESTSUITE/spool/db/retry.lockfile
264  locked  TESTSUITE/spool/db/retry.lockfile
265  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
266  returned from EXIM_DBOPEN: (nil)
267  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
268 no retry data available
269 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
270 Considering: userx@test.ex
271 unique = userx@test.ex
272 no   domain  retry record
273 no   address retry record
274 userx@test.ex: queued for routing
275 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
276 routing userx@test.ex
277 --------> r1 router <--------
278 local_part=userx domain=test.ex
279 calling r1 router
280 r1 router called for userx@test.ex
281   domain = test.ex
282 set transport t1
283 queued for t1 transport: local_part = userx
284 domain = test.ex
285   errors_to=NULL
286   domain_data=NULL local_part_data=NULL
287 routed by r1 router
288   envelope to: userx@test.ex
289   transport: t1
290 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
291 After routing:
292   Local deliveries:
293     userx@test.ex
294   Remote deliveries:
295   Failed addresses:
296   Deferred addresses:
297 search_tidyup called
298 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
299 --------> userx@test.ex <--------
300  locking TESTSUITE/spool/db/retry.lockfile
301  locked  TESTSUITE/spool/db/retry.lockfile
302  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
303  returned from EXIM_DBOPEN: (nil)
304  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
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=p1239
309   home=NULL current=/
310 set_process_info: pppp delivering 10HmaY-000000005vi-0000 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 below-home: de-tainting path 'TESTSUITE/test-mail/userx'
318 ensuring maildir directories exist in TESTSUITE/test-mail/userx
319 created directory TESTSUITE/test-mail/userx/tmp
320 created directory TESTSUITE/test-mail/userx/new
321 created directory TESTSUITE/test-mail/userx/cur
322 compiling RE '^(?:cur|new|\..*)$'
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 cannot use sendfile for body: spoolfile not wireformat
346 writing data block fd=dddd size=sss timeout=0
347 added 'ddd 1' to maildirsize file
348 renaming temporary file
349 renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex
350 appendfile yields 0 with errno=dd more_errno=dd
351 search_tidyup called
352 journalling userx@test.ex
353 t1 transport returned OK for userx@test.ex
354 post-process userx@test.ex (0)
355 userx@test.ex delivered
356 LOG: MAIN
357   => userx <userx@test.ex> R=r1 T=t1
358 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
359 changed uid/gid: post-delivery tidying
360   uid=EXIM_UID gid=EXIM_GID pid=p1238
361 set_process_info: pppp tidying up after delivering 10HmaY-000000005vi-0000
362 Processing retry items
363 Succeeded addresses:
364  userx@test.ex: no retry items
365 Failed addresses:
366 Deferred addresses:
367 end of retry processing
368 DSN: processing router : r1
369 DSN: processing successful delivery address: userx@test.ex
370 DSN: Sender_address: CALLER@test.ex
371 DSN: orcpt: NULL  flags: 0x0
372 DSN: envid: NULL  ret: 0
373 DSN: Final recipient: userx@test.ex
374 DSN: Remote SMTP server supports DSN: 0
375 DSN: not sending DSN success message
376 LOG: MAIN
377   Completed
378 end delivery of 10HmaY-000000005vi-0000
379 search_tidyup called
380 search_tidyup called
381 >>>>>>>>>>>>>>>> Exim pid=p1238 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
382 search_tidyup called
383 >>>>>>>>>>>>>>>> Exim pid=p1237 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
384 Exim version x.yz ....
385 changed uid/gid: forcing real = effective
386   uid=uuuu gid=CALLER_GID pid=p1240
387 configuration file is TESTSUITE/test-config
388 admin user
389 changed uid/gid: privilege not needed
390   uid=EXIM_UID gid=EXIM_GID pid=p1240
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 qualify & rewrite recipients list
405 rewrite rules on sender address
406 qualify and rewrite headers
407  rewrite_one_header: type=F:
408    From: CALLER_NAME <CALLER@test.ex>
409 search_tidyup called
410 >>Headers after rewriting and local additions:
411  I Message-Id: <E10HmaZ-000000005vi-0000@myhost.test.ex>
412  F From: CALLER_NAME <CALLER@test.ex>
413    Date: Tue, 2 Mar 1999 09:44:33 +0000
414
415 Data file name: TESTSUITE/spool//input//10HmaZ-000000005vi-0000-D
416 Data file written for message 10HmaZ-000000005vi-0000
417 >>Generated Received: header line
418 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
419         (envelope-from <CALLER@test.ex>)
420         id 10HmaZ-000000005vi-0000
421         for userx@test.ex;
422         Tue, 2 Mar 1999 09:44:33 +0000
423 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-000000005vi-0000
424 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
425 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-000000005vi-0000-H
426 Size of headers = sss
427 LOG: MAIN
428   <= CALLER@test.ex U=CALLER P=local S=sss
429 search_tidyup called
430 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaZ-000000005vi-0000
431 Exim version x.yz ....
432 changed uid/gid: forcing real = effective
433   uid=uuuu gid=EXIM_GID pid=p1241
434 configuration file is TESTSUITE/test-config
435 trusted user
436 admin user
437 dropping to exim gid; retaining priv uid
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-000000005vi-0000
442 Trying spool file TESTSUITE/spool//input//10HmaZ-000000005vi-0000-D
443 reading spool file 10HmaZ-000000005vi-0000-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=8
452 DSN: set orcpt:   flags: 0x0
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: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
458  returned from EXIM_DBOPEN: (nil)
459  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
460 no retry data available
461 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
462 Considering: userx@test.ex
463 unique = userx@test.ex
464 no   domain  retry record
465 no   address retry record
466 userx@test.ex: queued for routing
467 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
468 routing userx@test.ex
469 --------> r1 router <--------
470 local_part=userx domain=test.ex
471 calling r1 router
472 r1 router called for userx@test.ex
473   domain = test.ex
474 set transport t1
475 queued for t1 transport: local_part = userx
476 domain = test.ex
477   errors_to=NULL
478   domain_data=NULL local_part_data=NULL
479 routed by r1 router
480   envelope to: userx@test.ex
481   transport: t1
482 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
483 After routing:
484   Local deliveries:
485     userx@test.ex
486   Remote deliveries:
487   Failed addresses:
488   Deferred addresses:
489 search_tidyup called
490 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
491 --------> userx@test.ex <--------
492  locking TESTSUITE/spool/db/retry.lockfile
493  locked  TESTSUITE/spool/db/retry.lockfile
494  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
495  returned from EXIM_DBOPEN: (nil)
496  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
497 no retry data available
498 search_tidyup called
499 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
500   uid=CALLER_UID gid=CALLER_GID pid=p1242
501   home=NULL current=/
502 set_process_info: pppp delivering 10HmaZ-000000005vi-0000 to userx using t1
503 appendfile transport entered
504 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
505   directory=TESTSUITE/test-mail/userx format=maildir
506   message_prefix=null
507   message_suffix=null
508   maildir_use_size_file=yes
509 below-home: de-tainting path 'TESTSUITE/test-mail/userx'
510 ensuring maildir directories exist in TESTSUITE/test-mail/userx
511 compiling RE '^(?:cur|new|\..*)$'
512 using regex for maildir directory selection: ^(?:cur|new|\..*)$
513 looking for maildirsize in TESTSUITE/test-mail/userx
514 reading quota parameters from maildirsize data
515 computing maildir size from maildirsize data
516 over quota and maildirsize has more than 1 entry: recalculating
517 MUNGED: the check_dir_size lines have been sorted to ensure consistency
518 check_dir_size: dir=TESTSUITE/test-mail/userx/cur sum=0 count=dd
519 check_dir_size: dir=TESTSUITE/test-mail/userx/new sum=dddd count=dd
520 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
521 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
522 maildir_compute_size: path=TESTSUITE/test-mail/userx
523   sum=dddd filecount=1 timestamp=ddddddd
524 checking subdirectory timestamps
525 MUNGED: the check_dir_size lines have been sorted to ensure consistency
526 skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match
527 skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match
528 maildir_compute_size (timestamp_only): ddddddd
529 returning maildir size=sss filecount=1
530 delivering in maildir format in TESTSUITE/test-mail/userx
531 writing to tmp/MAILDIR.myhost.test.ex
532 Exim quota = 500 old size = sssss this message = sss (included)
533   file count quota = 0 count = 1
534 mailbox quota exceeded
535 maildir: time since "new" directory modified = 10s
536 Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex
537 appendfile yields 1 with errno=-22 more_errno=dd
538 search_tidyup called
539 t1 transport returned DEFER for userx@test.ex
540 added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0
541 post-process userx@test.ex (1)
542 LOG: MAIN
543   == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
544 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
545 changed uid/gid: post-delivery tidying
546   uid=EXIM_UID gid=EXIM_GID pid=p1241
547 set_process_info: pppp tidying up after delivering 10HmaZ-000000005vi-0000
548 Processing retry items
549 Succeeded addresses:
550 Failed addresses:
551 Deferred addresses:
552  userx@test.ex
553  locking TESTSUITE/spool/db/retry.lockfile
554  locked  TESTSUITE/spool/db/retry.lockfile
555  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR
556  returned from EXIM_DBOPEN: 0xAAAAAAAA
557  opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
558  userx@test.ex in "*"?
559   list element: *
560   address match test: subject=userx@test.ex pattern=*
561   test.ex in "*"?
562    list element: *
563    test.ex in "*"? yes (matched "*")
564   userx@test.ex in "*"? yes (matched "*")
565 retry for T:userx@test.ex = * 0 0
566  dbfn_read: key=T:userx@test.ex
567 failing_interval=ttt message_age=ttt
568 Writing retry data for T:userx@test.ex
569   first failed=dddd last try=dddd next try=+86400 expired=0
570   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
571  dbfn_write: key=T:userx@test.ex
572  EXIM_DBCLOSE(0xAAAAAAAA)
573  closed hints database and lockfile
574 end of retry processing
575 delivery deferred: update_spool=1 header_rewritten=0
576 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-000000005vi-0000
577 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
578 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-000000005vi-0000-H
579 Size of headers = sss
580 end delivery of 10HmaZ-000000005vi-0000
581 search_tidyup called
582 search_tidyup called
583 >>>>>>>>>>>>>>>> Exim pid=p1241 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
584 search_tidyup called
585 >>>>>>>>>>>>>>>> Exim pid=p1240 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
586 Exim version x.yz ....
587 changed uid/gid: forcing real = effective
588   uid=uuuu gid=CALLER_GID pid=p1243
589 configuration file is TESTSUITE/test-config
590 admin user
591 changed uid/gid: privilege not needed
592   uid=EXIM_UID gid=EXIM_GID pid=p1243
593 seeking password data for user "CALLER": cache not available
594 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
595 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
596 sender address = CALLER@test.ex
597 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
598 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
599 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
600 Sender: CALLER@test.ex
601 Recipients:
602   userx@test.ex
603 search_tidyup called
604 >>Headers received:
605
606 qualify & rewrite recipients list
607 rewrite rules on sender address
608 qualify and rewrite headers
609  rewrite_one_header: type=F:
610    From: CALLER_NAME <CALLER@test.ex>
611 search_tidyup called
612 >>Headers after rewriting and local additions:
613  I Message-Id: <E10HmbA-000000005vi-0000@myhost.test.ex>
614  F From: CALLER_NAME <CALLER@test.ex>
615    Date: Tue, 2 Mar 1999 09:44:33 +0000
616
617 Data file name: TESTSUITE/spool//input//10HmbA-000000005vi-0000-D
618 Data file written for message 10HmbA-000000005vi-0000
619 >>Generated Received: header line
620 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
621         (envelope-from <CALLER@test.ex>)
622         id 10HmbA-000000005vi-0000
623         for userx@test.ex;
624         Tue, 2 Mar 1999 09:44:33 +0000
625 Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-000000005vi-0000
626 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
627 Renaming spool header file: TESTSUITE/spool//input//10HmbA-000000005vi-0000-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=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmbA-000000005vi-0000
633 Exim version x.yz ....
634 changed uid/gid: forcing real = effective
635   uid=uuuu gid=EXIM_GID pid=p1244
636 configuration file is TESTSUITE/test-config
637 trusted user
638 admin user
639 dropping to exim gid; retaining priv uid
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-000000005vi-0000
644 Trying spool file TESTSUITE/spool//input//10HmbA-000000005vi-0000-D
645 reading spool file 10HmbA-000000005vi-0000-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=8
654 DSN: set orcpt:   flags: 0x0
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=O_RDONLY
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 local_part_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=O_RDONLY
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=p1245
711   home=NULL current=/
712 set_process_info: pppp delivering 10HmbA-000000005vi-0000 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 below-home: de-tainting path 'TESTSUITE/test-mail/userx'
720 ensuring maildir directories exist in TESTSUITE/test-mail/userx
721 compiling RE '^(?:cur|new|\..*)$'
722 using regex for maildir directory selection: ^(?:cur|new|\..*)$
723 looking for maildirsize in TESTSUITE/test-mail/userx
724 reading quota parameters from maildirsize data
725 computing maildir size from maildirsize data
726 returning maildir size=sss filecount=1
727 delivering in maildir format in TESTSUITE/test-mail/userx
728 writing to tmp/MAILDIR.myhost.test.ex
729 Exim quota = 500 old size = sssss this message = sss (included)
730   file count quota = 0 count = 1
731 mailbox quota exceeded
732 maildir: time since "new" directory modified = 10s
733 Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex
734 appendfile yields 1 with errno=-22 more_errno=dd
735 search_tidyup called
736 t1 transport returned DEFER for userx@test.ex
737 added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0
738 post-process userx@test.ex (1)
739 LOG: MAIN
740   == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
741 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
742 changed uid/gid: post-delivery tidying
743   uid=EXIM_UID gid=EXIM_GID pid=p1244
744 set_process_info: pppp tidying up after delivering 10HmbA-000000005vi-0000
745 Processing retry items
746 Succeeded addresses:
747 Failed addresses:
748 Deferred addresses:
749  userx@test.ex
750  locking TESTSUITE/spool/db/retry.lockfile
751  locked  TESTSUITE/spool/db/retry.lockfile
752  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR
753  returned from EXIM_DBOPEN: 0xAAAAAAAA
754  opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
755  userx@test.ex in "*"?
756   list element: *
757   address match test: subject=userx@test.ex pattern=*
758   test.ex in "*"?
759    list element: *
760    test.ex in "*"? yes (matched "*")
761   userx@test.ex in "*"? yes (matched "*")
762 retry for T:userx@test.ex = * 0 0
763  dbfn_read: key=T:userx@test.ex
764 failing_interval=ttt message_age=ttt
765 Writing retry data for T:userx@test.ex
766   first failed=dddd last try=dddd next try=+86400 expired=0
767   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
768  dbfn_write: key=T:userx@test.ex
769  EXIM_DBCLOSE(0xAAAAAAAA)
770  closed hints database and lockfile
771 end of retry processing
772 delivery deferred: update_spool=1 header_rewritten=0
773 Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-000000005vi-0000
774 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
775 Renaming spool header file: TESTSUITE/spool//input//10HmbA-000000005vi-0000-H
776 Size of headers = sss
777 end delivery of 10HmbA-000000005vi-0000
778 search_tidyup called
779 search_tidyup called
780 >>>>>>>>>>>>>>>> Exim pid=p1244 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
781 search_tidyup called
782 >>>>>>>>>>>>>>>> Exim pid=p1243 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>