Event for auth fail: client side
[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 global rewrite rules
23 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-0005vi-00@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-0005vi-00-D
33 Data file written for message 10HmaX-0005vi-00
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-0005vi-00
38         for nofile@test.ex;
39         Tue, 2 Mar 1999 09:44:33 +0000
40 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
41 DSN: **** SPOOL_OUT - address: <nofile@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
42 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-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-0005vi-00
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-0005vi-00
60 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
61 reading spool file 10HmaX-0005vi-00-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-0005vi-00 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 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-0005vi-00
170 Processing retry items
171 Succeeded addresses:
172  nofile@test.ex: no retry items
173 Failed addresses:
174 Deferred addresses:
175 end of retry processing
176 DSN: processing router : r1
177 DSN: processing successful delivery address: nofile@test.ex
178 DSN: Sender_address: CALLER@test.ex
179 DSN: orcpt: NULL  flags: 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-0005vi-00
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 global rewrite rules
214 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-0005vi-00@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-0005vi-00-D
224 Data file written for message 10HmaY-0005vi-00
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-0005vi-00
229         for userx@test.ex;
230         Tue, 2 Mar 1999 09:44:33 +0000
231 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-0005vi-00
232 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
233 Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-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-0005vi-00
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-0005vi-00
250 Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D
251 reading spool file 10HmaY-0005vi-00-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-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 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-0005vi-00
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-0005vi-00
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 global rewrite rules
406 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-0005vi-00@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-0005vi-00-D
416 Data file written for message 10HmaZ-0005vi-00
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-0005vi-00
421         for userx@test.ex;
422         Tue, 2 Mar 1999 09:44:33 +0000
423 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-0005vi-00
424 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
425 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-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-0005vi-00
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-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=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-0005vi-00 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 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-0005vi-00
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  address match test: subject=userx@test.ex pattern=*
559  test.ex in "*"? yes (matched "*")
560  userx@test.ex in "*"? yes (matched "*")
561 retry for T:userx@test.ex = * 0 0
562  dbfn_read: key=T:userx@test.ex
563 failing_interval=ttt message_age=ttt
564 Writing retry data for T:userx@test.ex
565   first failed=dddd last try=dddd next try=+86400 expired=0
566   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
567  dbfn_write: key=T:userx@test.ex
568  EXIM_DBCLOSE(0xAAAAAAAA)
569  closed hints database and lockfile
570 end of retry processing
571 delivery deferred: update_spool=1 header_rewritten=0
572 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-0005vi-00
573 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
574 Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-H
575 Size of headers = sss
576 end delivery of 10HmaZ-0005vi-00
577 search_tidyup called
578 search_tidyup called
579 >>>>>>>>>>>>>>>> Exim pid=p1241 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
580 search_tidyup called
581 >>>>>>>>>>>>>>>> Exim pid=p1240 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
582 Exim version x.yz ....
583 changed uid/gid: forcing real = effective
584   uid=uuuu gid=CALLER_GID pid=p1243
585 configuration file is TESTSUITE/test-config
586 admin user
587 changed uid/gid: privilege not needed
588   uid=EXIM_UID gid=EXIM_GID pid=p1243
589 seeking password data for user "CALLER": cache not available
590 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
591 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
592 sender address = CALLER@test.ex
593 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
594 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
595 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
596 Sender: CALLER@test.ex
597 Recipients:
598   userx@test.ex
599 search_tidyup called
600 >>Headers received:
601
602 qualify & rewrite recipients list
603 global rewrite rules
604 rewrite headers
605  rewrite_one_header: type=F:
606    From: CALLER_NAME <CALLER@test.ex>
607 search_tidyup called
608 >>Headers after rewriting and local additions:
609 I Message-Id: <E10HmbA-0005vi-00@myhost.test.ex>
610 F From: CALLER_NAME <CALLER@test.ex>
611   Date: Tue, 2 Mar 1999 09:44:33 +0000
612
613 Data file name: TESTSUITE/spool//input//10HmbA-0005vi-00-D
614 Data file written for message 10HmbA-0005vi-00
615 >>Generated Received: header line
616 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
617         (envelope-from <CALLER@test.ex>)
618         id 10HmbA-0005vi-00
619         for userx@test.ex;
620         Tue, 2 Mar 1999 09:44:33 +0000
621 Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-0005vi-00
622 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
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 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmbA-0005vi-00
629 Exim version x.yz ....
630 changed uid/gid: forcing real = effective
631   uid=uuuu gid=EXIM_GID pid=p1244
632 configuration file is TESTSUITE/test-config
633 trusted user
634 admin user
635 dropping to exim gid; retaining priv uid
636 seeking password data for user "CALLER": cache not available
637 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
638 set_process_info: pppp delivering specified messages
639 set_process_info: pppp delivering 10HmbA-0005vi-00
640 Trying spool file TESTSUITE/spool//input//10HmbA-0005vi-00-D
641 reading spool file 10HmbA-0005vi-00-H
642 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
643 sender_local=1 ident=CALLER
644 Non-recipients:
645  Empty Tree
646 ---- End of tree ----
647 recipients_count=1
648 **** SPOOL_IN - No additional fields
649 body_linecount=1 message_linecount=8
650 DSN: set orcpt:   flags: 0x0
651 Delivery address list:
652   userx@test.ex 
653  locking TESTSUITE/spool/db/retry.lockfile
654  locked  TESTSUITE/spool/db/retry.lockfile
655  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
656  returned from EXIM_DBOPEN: 0xAAAAAAAA
657  opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY
658 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
659 Considering: userx@test.ex
660 unique = userx@test.ex
661  dbfn_read: key=R:test.ex
662  dbfn_read: key=R:userx@test.ex
663  dbfn_read: key=R:userx@test.ex:<CALLER@test.ex>
664 no   domain  retry record
665 no   address retry record
666 userx@test.ex: queued for routing
667  EXIM_DBCLOSE(0xAAAAAAAA)
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 local_part_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: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
697  returned from EXIM_DBOPEN: 0xAAAAAAAA
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  EXIM_DBCLOSE(0xAAAAAAAA)
703  closed hints database and lockfile
704 search_tidyup called
705 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
706   uid=CALLER_UID gid=CALLER_GID pid=p1245
707   home=NULL current=/
708 set_process_info: pppp delivering 10HmbA-0005vi-00 to userx using t1
709 appendfile transport entered
710 appendfile: mode=600 notify_comsat=0 quota=500 warning=0
711   directory=TESTSUITE/test-mail/userx format=maildir
712   message_prefix=null
713   message_suffix=null
714   maildir_use_size_file=yes
715 de-tainting path 'TESTSUITE/test-mail/userx'
716 ensuring maildir directories exist in TESTSUITE/test-mail/userx
717 compiling RE '^(?:cur|new|\..*)$'
718 using regex for maildir directory selection: ^(?:cur|new|\..*)$
719 looking for maildirsize in TESTSUITE/test-mail/userx
720 reading quota parameters from maildirsize data
721 computing maildir size from maildirsize data
722 returning maildir size=sss filecount=1
723 delivering in maildir format in TESTSUITE/test-mail/userx
724 writing to tmp/MAILDIR.myhost.test.ex
725 Exim quota = 500 old size = sssss this message = sss (included)
726   file count quota = 0 count = 1
727 mailbox quota exceeded
728 maildir: time since "new" directory modified = 10s
729 Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex
730 appendfile yields 1 with errno=-22 more_errno=dd
731 search_tidyup called
732 t1 transport returned DEFER for userx@test.ex
733 added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0
734 post-process userx@test.ex (1)
735 LOG: MAIN
736   == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
737 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
738 changed uid/gid: post-delivery tidying
739   uid=EXIM_UID gid=EXIM_GID pid=p1244
740 set_process_info: pppp tidying up after delivering 10HmbA-0005vi-00
741 Processing retry items
742 Succeeded addresses:
743 Failed addresses:
744 Deferred addresses:
745  userx@test.ex
746  locking TESTSUITE/spool/db/retry.lockfile
747  locked  TESTSUITE/spool/db/retry.lockfile
748  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR
749  returned from EXIM_DBOPEN: 0xAAAAAAAA
750  opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR
751  address match test: subject=userx@test.ex pattern=*
752  test.ex in "*"? yes (matched "*")
753  userx@test.ex in "*"? yes (matched "*")
754 retry for T:userx@test.ex = * 0 0
755  dbfn_read: key=T:userx@test.ex
756 failing_interval=ttt message_age=ttt
757 Writing retry data for T:userx@test.ex
758   first failed=dddd last try=dddd next try=+86400 expired=0
759   errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex)
760  dbfn_write: key=T:userx@test.ex
761  EXIM_DBCLOSE(0xAAAAAAAA)
762  closed hints database and lockfile
763 end of retry processing
764 delivery deferred: update_spool=1 header_rewritten=0
765 Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-0005vi-00
766 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
767 Renaming spool header file: TESTSUITE/spool//input//10HmbA-0005vi-00-H
768 Size of headers = sss
769 end delivery of 10HmbA-0005vi-00
770 search_tidyup called
771 search_tidyup called
772 >>>>>>>>>>>>>>>> Exim pid=p1244 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
773 search_tidyup called
774 >>>>>>>>>>>>>>>> Exim pid=p1243 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>