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