de5ffabc723c12503eedd3d7075c230ab572aa43
[exim.git] / test / stderr / 0403
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   userx@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@mail.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 mail.test.ex with local (Exim x.yz)
36         (envelope-from <CALLER@test.ex>)
37         id 10HmaX-000000005vi-0000
38         for userx@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: <userx@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 -N -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=0 message_linecount=8
70 DSN: set orcpt:   flags: 0x0
71 Delivery address list:
72   userx@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: userx@test.ex
81 unique = userx@test.ex
82 no   domain  retry record
83 no   address retry record
84 userx@test.ex: queued for routing
85 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
86 routing userx@test.ex
87 --------> r1 router <--------
88 local_part=userx domain=test.ex
89 checking domains
90   search_open: lsearch "TESTSUITE/aux-fixed/0403.accountfile"
91   search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
92     key="userx@test.ex" partial=-1 affix=NULL starflags=0 opts="ret=key"
93   LRU list:
94     0TESTSUITE/aux-fixed/0403.accountfile
95     End
96   internal_search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
97     type=lsearch key="userx@test.ex" opts=NULL
98   file lookup required for userx@test.ex
99     in TESTSUITE/aux-fixed/0403.accountfile
100   creating new cache entry
101   lookup failed
102 test.ex in domains?
103 test.ex in domains? no (end of list)
104 r1 router skipped: domains mismatch
105 --------> r2 router <--------
106 local_part=userx domain=test.ex
107 checking domains
108 test.ex in domains?
109  list element: lsearch;TESTSUITE/aux-fixed/0403.data
110  search_open: lsearch "TESTSUITE/aux-fixed/0403.data"
111  search_find: file="TESTSUITE/aux-fixed/0403.data"
112    key="test.ex" partial=-1 affix=NULL starflags=0 opts=NULL
113  LRU list:
114    0TESTSUITE/aux-fixed/0403.data
115    0TESTSUITE/aux-fixed/0403.accountfile
116    End
117  internal_search_find: file="TESTSUITE/aux-fixed/0403.data"
118    type=lsearch key="test.ex" opts=NULL
119  file lookup required for test.ex
120    in TESTSUITE/aux-fixed/0403.data
121  creating new cache entry
122  lookup yielded: [DOMAINDATA_test.ex]
123  test.ex in domains? yes (matched "lsearch;TESTSUITE/aux-fixed/0403.data")
124 checking local_parts
125 userx in local_parts?
126  list element: lsearch;TESTSUITE/aux-fixed/0403.data
127  search_open: lsearch "TESTSUITE/aux-fixed/0403.data"
128    cached open
129  search_find: file="TESTSUITE/aux-fixed/0403.data"
130    key="userx" partial=-1 affix=NULL starflags=0 opts=NULL
131  LRU list:
132    0TESTSUITE/aux-fixed/0403.data
133    0TESTSUITE/aux-fixed/0403.accountfile
134    End
135  internal_search_find: file="TESTSUITE/aux-fixed/0403.data"
136    type=lsearch key="userx" opts=NULL
137  file lookup required for userx
138    in TESTSUITE/aux-fixed/0403.data
139  creating new cache entry
140  lookup yielded: [LOCALPARTDATA_userx]
141  userx in local_parts? yes (matched "lsearch;TESTSUITE/aux-fixed/0403.data")
142 +++ROUTER:
143 +++domain_data=[DOMAINDATA_test.ex]
144 +++local_part_data=[LOCALPARTDATA_userx]
145 +++address_data=
146 +++home=/usr
147 processing address_data
148 calling r2 router
149 rda_interpret (string): 'TESTSUITE/test-mail/junk'
150 expanded: 'TESTSUITE/test-mail/junk'
151 file is not a filter file
152 parse_forward_list: TESTSUITE/test-mail/junk
153 extract item: TESTSUITE/test-mail/junk
154 set transport t1
155 r2 router generated TESTSUITE/test-mail/junk
156   pipe, file, or autoreply
157   errors_to=NULL transport=t1
158   uid=unset gid=unset home=/usr
159 routed by r2 router
160   envelope to: userx@test.ex
161   transport: <none>
162  locking TESTSUITE/spool/db/retry.lockfile
163  locked  TESTSUITE/spool/db/retry.lockfile
164  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
165  returned from EXIM_DBOPEN: (nil)
166  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
167 no retry data available
168 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
169 Considering: TESTSUITE/test-mail/junk
170 unique = TESTSUITE/test-mail/junk:userx@test.ex
171 queued for t1 transport
172 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
173 After routing:
174   Local deliveries:
175     TESTSUITE/test-mail/junk
176   Remote deliveries:
177   Failed addresses:
178   Deferred addresses:
179 search_tidyup called
180 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
181 --------> TESTSUITE/test-mail/junk <--------
182  locking TESTSUITE/spool/db/retry.lockfile
183  locked  TESTSUITE/spool/db/retry.lockfile
184  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
185  returned from EXIM_DBOPEN: (nil)
186  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
187 no retry data available
188 search_tidyup called
189 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=t1
190   uid=CALLER_UID gid=CALLER_GID pid=p1236
191   home=/usr current=/usr
192 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to TESTSUITE/test-mail/junk using t1
193 +++TRANSPORT:
194 +++domain_data=[DOMAINDATA_test.ex]
195 +++local_part_data=[LOCALPARTDATA_userx]
196 +++address_data=ADDRESSDATA
197 +++home=/usr
198 appendfile transport entered
199 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
200   file=TESTSUITE/test-mail/junk format=unix
201   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
202   message_suffix=\n
203   maildir_use_size_file=no
204   locking by lockfile fcntl 
205 *** delivery by t1 transport bypassed by -N option
206 search_tidyup called
207 journalling TESTSUITE/test-mail/junk:userx@test.ex
208 t1 transport returned OK for TESTSUITE/test-mail/junk
209 post-process TESTSUITE/test-mail/junk (0)
210 TESTSUITE/test-mail/junk delivered
211 userx@test.ex: children all complete
212 LOG: MAIN
213   *> TESTSUITE/test-mail/junk <userx@test.ex> R=r2 T=t1
214 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
215 changed uid/gid: post-delivery tidying
216   uid=EXIM_UID gid=EXIM_GID pid=p1235
217 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
218 DSN: processing router : r2
219 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
220 DSN: Sender_address: CALLER@test.ex
221 DSN: orcpt: NULL  flags: 0x0
222 DSN: envid: NULL  ret: 0
223 DSN: Final recipient: TESTSUITE/test-mail/junk
224 DSN: Remote SMTP server supports DSN: 0
225 DSN: not sending DSN success message
226 DSN: processing router : r2
227 DSN: processing successful delivery address: userx@test.ex
228 DSN: Sender_address: CALLER@test.ex
229 DSN: orcpt: NULL  flags: 0x0
230 DSN: envid: NULL  ret: 0
231 DSN: Final recipient: userx@test.ex
232 DSN: Remote SMTP server supports DSN: 0
233 DSN: not sending DSN success message
234 LOG: MAIN
235   Completed
236 end delivery of 10HmaX-000000005vi-0000
237 search_tidyup called
238 search_tidyup called
239 >>>>>>>>>>>>>>>> Exim pid=p1235 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
240 search_tidyup called
241 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
242 ### _data from a multi-step expansion
243 Exim version x.yz ....
244 changed uid/gid: forcing real = effective
245   uid=uuuu gid=CALLER_GID pid=p1237
246 configuration file is TESTSUITE/test-config
247 admin user
248 changed uid/gid: privilege not needed
249   uid=EXIM_UID gid=EXIM_GID pid=p1237
250 seeking password data for user "CALLER": cache not available
251 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
252 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
253 sender address = CALLER@test.ex
254 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
255 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
256 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
257 Sender: CALLER@test.ex
258 Recipients:
259   charlie@dom1.ain
260 search_tidyup called
261 >>Headers received:
262
263 qualify & rewrite recipients list
264 rewrite rules on sender address
265 qualify and rewrite headers
266  rewrite_one_header: type=F:
267    From: CALLER_NAME <CALLER@test.ex>
268 search_tidyup called
269 >>Headers after rewriting and local additions:
270  I Message-Id: <E10HmaY-000000005vi-0000@mail.test.ex>
271  F From: CALLER_NAME <CALLER@test.ex>
272    Date: Tue, 2 Mar 1999 09:44:33 +0000
273
274 Data file name: TESTSUITE/spool//input//10HmaY-000000005vi-0000-D
275 Data file written for message 10HmaY-000000005vi-0000
276 >>Generated Received: header line
277 P Received: from CALLER by mail.test.ex with local (Exim x.yz)
278         (envelope-from <CALLER@test.ex>)
279         id 10HmaY-000000005vi-0000
280         for charlie@dom1.ain;
281         Tue, 2 Mar 1999 09:44:33 +0000
282 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-000000005vi-0000
283 DSN: **** SPOOL_OUT - address: <charlie@dom1.ain> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
284 Renaming spool header file: TESTSUITE/spool//input//10HmaY-000000005vi-0000-H
285 Size of headers = sss
286 LOG: MAIN
287   <= CALLER@test.ex U=CALLER P=local S=sss
288 search_tidyup called
289 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -N -odi -Mc 10HmaY-000000005vi-0000
290 Exim version x.yz ....
291 changed uid/gid: forcing real = effective
292   uid=uuuu gid=EXIM_GID pid=p1238
293 configuration file is TESTSUITE/test-config
294 trusted user
295 admin user
296 dropping to exim gid; retaining priv uid
297 seeking password data for user "CALLER": cache not available
298 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
299 set_process_info: pppp delivering specified messages
300 set_process_info: pppp delivering 10HmaY-000000005vi-0000
301 Trying spool file TESTSUITE/spool//input//10HmaY-000000005vi-0000-D
302 reading spool file 10HmaY-000000005vi-0000-H
303 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
304 sender_local=1 ident=CALLER
305 Non-recipients:
306  Empty Tree
307 ---- End of tree ----
308 recipients_count=1
309 **** SPOOL_IN - No additional fields
310 body_linecount=0 message_linecount=8
311 DSN: set orcpt:   flags: 0x0
312 Delivery address list:
313   charlie@dom1.ain 
314  locking TESTSUITE/spool/db/retry.lockfile
315  locked  TESTSUITE/spool/db/retry.lockfile
316  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
317  returned from EXIM_DBOPEN: (nil)
318  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
319 no retry data available
320 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
321 Considering: charlie@dom1.ain
322 unique = charlie@dom1.ain
323 no   domain  retry record
324 no   address retry record
325 charlie@dom1.ain: queued for routing
326 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
327 routing charlie@dom1.ain
328 --------> r1 router <--------
329 local_part=charlie domain=dom1.ain
330 checking domains
331   search_open: lsearch "TESTSUITE/aux-fixed/0403.accountfile"
332   search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
333     key="charlie@dom1.ain" partial=-1 affix=NULL starflags=0 opts="ret=key"
334   LRU list:
335     0TESTSUITE/aux-fixed/0403.accountfile
336     End
337   internal_search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
338     type=lsearch key="charlie@dom1.ain" opts=NULL
339   file lookup required for charlie@dom1.ain
340     in TESTSUITE/aux-fixed/0403.accountfile
341   creating new cache entry
342   lookup yielded: 
343   lookup yield replace by key: charlie@dom1.ain
344 dom1.ain in domains?
345  list element: dom1.ain
346  dom1.ain in domains? yes (matched "dom1.ain")
347 checking local_parts
348   search_open: lsearch "TESTSUITE/aux-fixed/0403.accountfile"
349     cached open
350   search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
351     key="charlie@dom1.ain" partial=-1 affix=NULL starflags=0 opts="ret=key"
352   LRU list:
353     0TESTSUITE/aux-fixed/0403.accountfile
354     End
355   internal_search_find: file="TESTSUITE/aux-fixed/0403.accountfile"
356     type=lsearch key="charlie@dom1.ain" opts=NULL
357   cached data used for lookup of charlie@dom1.ain
358     in TESTSUITE/aux-fixed/0403.accountfile
359   lookup yielded: 
360   lookup yield replace by key: charlie@dom1.ain
361 charlie in local_parts?
362  list element: charlie
363  charlie in local_parts? yes (matched "charlie")
364 +++ROUTER:
365 +++domain_data=dom1.ain
366 +++local_part_data=charlie
367 calling r1 router
368 rda_interpret (string): 'TESTSUITE/test-mail/junk'
369 expanded: 'TESTSUITE/test-mail/junk'
370 file is not a filter file
371 parse_forward_list: TESTSUITE/test-mail/junk
372 extract item: TESTSUITE/test-mail/junk
373 set transport t1
374 r1 router generated TESTSUITE/test-mail/junk
375   pipe, file, or autoreply
376   errors_to=NULL transport=t1
377   uid=unset gid=unset home=NULL
378 routed by r1 router
379   envelope to: charlie@dom1.ain
380   transport: <none>
381  locking TESTSUITE/spool/db/retry.lockfile
382  locked  TESTSUITE/spool/db/retry.lockfile
383  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
384  returned from EXIM_DBOPEN: (nil)
385  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
386 no retry data available
387 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
388 Considering: TESTSUITE/test-mail/junk
389 unique = TESTSUITE/test-mail/junk:charlie@dom1.ain
390 queued for t1 transport
391 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
392 After routing:
393   Local deliveries:
394     TESTSUITE/test-mail/junk
395   Remote deliveries:
396   Failed addresses:
397   Deferred addresses:
398 search_tidyup called
399 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
400 --------> TESTSUITE/test-mail/junk <--------
401  locking TESTSUITE/spool/db/retry.lockfile
402  locked  TESTSUITE/spool/db/retry.lockfile
403  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
404  returned from EXIM_DBOPEN: (nil)
405  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
406 no retry data available
407 search_tidyup called
408 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=t1
409   uid=CALLER_UID gid=CALLER_GID pid=p1239
410   home=NULL current=/
411 set_process_info: pppp delivering 10HmaY-000000005vi-0000 to TESTSUITE/test-mail/junk using t1
412 +++TRANSPORT:
413 +++domain_data=dom1.ain
414 +++local_part_data=charlie
415 +++address_data=
416 +++home=
417 appendfile transport entered
418 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
419   file=TESTSUITE/test-mail/junk format=unix
420   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
421   message_suffix=\n
422   maildir_use_size_file=no
423   locking by lockfile fcntl 
424 *** delivery by t1 transport bypassed by -N option
425 search_tidyup called
426 journalling TESTSUITE/test-mail/junk:charlie@dom1.ain
427 t1 transport returned OK for TESTSUITE/test-mail/junk
428 post-process TESTSUITE/test-mail/junk (0)
429 TESTSUITE/test-mail/junk delivered
430 charlie@dom1.ain: children all complete
431 LOG: MAIN
432   *> TESTSUITE/test-mail/junk <charlie@dom1.ain> R=r1 T=t1
433 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
434 changed uid/gid: post-delivery tidying
435   uid=EXIM_UID gid=EXIM_GID pid=p1238
436 set_process_info: pppp tidying up after delivering 10HmaY-000000005vi-0000
437 DSN: processing router : r1
438 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
439 DSN: Sender_address: CALLER@test.ex
440 DSN: orcpt: NULL  flags: 0x0
441 DSN: envid: NULL  ret: 0
442 DSN: Final recipient: TESTSUITE/test-mail/junk
443 DSN: Remote SMTP server supports DSN: 0
444 DSN: not sending DSN success message
445 DSN: processing router : r1
446 DSN: processing successful delivery address: charlie@dom1.ain
447 DSN: Sender_address: CALLER@test.ex
448 DSN: orcpt: NULL  flags: 0x0
449 DSN: envid: NULL  ret: 0
450 DSN: Final recipient: charlie@dom1.ain
451 DSN: Remote SMTP server supports DSN: 0
452 DSN: not sending DSN success message
453 LOG: MAIN
454   Completed
455 end delivery of 10HmaY-000000005vi-0000
456 search_tidyup called
457 search_tidyup called
458 >>>>>>>>>>>>>>>> Exim pid=p1238 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
459 search_tidyup called
460 >>>>>>>>>>>>>>>> Exim pid=p1237 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
461
462 ******** SERVER ********
463 ### _data from a multi-step expansion