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