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