Commit | Line | Data |
---|---|---|
54c5ebb1 PH |
1 | Exim version x.yz .... |
2 | changed uid/gid: forcing real = effective | |
3 | uid=uuuu gid=CALLER_GID pid=pppp | |
4 | configuration file is TESTSUITE/test-config | |
5 | admin user | |
4b424e0d | 6 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
7 | seeking password data for user "CALLER": cache not available |
8 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
9 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
10 | sender address = CALLER@test.ex | |
11 | Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID | |
12 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
13 | Testing userx@test.ex | |
14 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
15 | Considering userx@test.ex | |
16 | test.ex in "! *.ex"? no (matched "! *.ex") | |
17 | test.ex in "test.ex"? yes (matched "test.ex") | |
18 | test.ex in percent_hack_domains? yes (matched "+not_queue_domains") | |
19 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
20 | routing userx@test.ex | |
21 | --------> r00 router <-------- | |
22 | local_part=userx domain=test.ex | |
23 | checking domains | |
24 | test.ex in "userx"? no (end of list) | |
25 | test.ex in "+nocache"? no (end of list) | |
26 | r00 router skipped: domains mismatch | |
27 | --------> r01 router <-------- | |
28 | local_part=userx domain=test.ex | |
29 | checking domains | |
30 | test.ex in "userx"? no (end of list) | |
31 | test.ex in "+nocache"? no (end of list) | |
32 | r01 router skipped: domains mismatch | |
33 | --------> r02 router <-------- | |
34 | local_part=userx domain=test.ex | |
35 | checking domains | |
36 | test.ex in "userx"? no (end of list) | |
37 | test.ex in "+nocache"? no (end of list) | |
38 | test.ex in "+nocache2"? no (end of list) | |
39 | r02 router skipped: domains mismatch | |
40 | --------> r03 router <-------- | |
41 | local_part=userx domain=test.ex | |
42 | checking domains | |
43 | test.ex in "userx"? no (end of list) | |
44 | test.ex in "+nocache"? no (end of list) | |
45 | test.ex in "+nocache2"? no (end of list) | |
46 | r03 router skipped: domains mismatch | |
47 | --------> r04 router <-------- | |
48 | local_part=userx domain=test.ex | |
49 | checking domains | |
50 | test.ex in "userx"? no (end of list) | |
51 | test.ex in "+forcecache"? no (end of list) | |
52 | r04 router skipped: domains mismatch | |
53 | --------> r05 router <-------- | |
54 | local_part=userx domain=test.ex | |
55 | checking domains | |
56 | cached no match for +forcecache | |
57 | cached lookup data = NULL | |
58 | test.ex in "+forcecache"? no (end of list) | |
59 | r05 router skipped: domains mismatch | |
60 | --------> r1 router <-------- | |
61 | local_part=userx domain=test.ex | |
62 | checking domains | |
63 | test.ex in "never.ex"? no (end of list) | |
64 | test.ex in "never1.ex"? no (end of list) | |
65 | test.ex in "test.ex"? yes (matched "test.ex") | |
a368cc11 | 66 | data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex' |
54c5ebb1 PH |
67 | test.ex in "+never_domains : +n1_domains : ! +local_domains"? no (matched "! +local_domains") |
68 | r1 router skipped: domains mismatch | |
69 | --------> r2 router <-------- | |
70 | local_part=userx domain=test.ex | |
71 | checking domains | |
72 | cached no match for +never_domains | |
73 | cached lookup data = NULL | |
74 | cached no match for +n1_domains | |
75 | cached lookup data = NULL | |
76 | test.ex in "<; never2.ex ; +n1_domains"? no (end of list) | |
77 | cached yes match for +local_domains | |
824ac956 | 78 | cached lookup data = test.ex |
54c5ebb1 PH |
79 | test.ex in "+never_domains : +n2_domains : !+local_domains"? no (matched "!+local_domains" - cached) |
80 | r2 router skipped: domains mismatch | |
81 | --------> r3 router <-------- | |
82 | local_part=userx domain=test.ex | |
83 | checking domains | |
84 | cached yes match for +local_domains | |
824ac956 | 85 | cached lookup data = test.ex |
54c5ebb1 PH |
86 | test.ex in "+local_domains"? yes (matched "+local_domains" - cached) |
87 | checking local_parts | |
88 | userx in "userx"? yes (matched "userx") | |
89 | calling r3 router | |
90 | r3 router called for userx@test.ex | |
91 | domain = test.ex | |
92 | set transport t1 | |
93 | queued for t1 transport: local_part = userx | |
94 | domain = test.ex | |
95 | errors_to=NULL | |
824ac956 | 96 | domain_data=test.ex localpart_data=userx |
54c5ebb1 PH |
97 | routed by r3 router |
98 | envelope to: userx@test.ex | |
99 | transport: t1 | |
100 | search_tidyup called | |
81022793 | 101 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 PH |
102 | Exim version x.yz .... |
103 | changed uid/gid: forcing real = effective | |
104 | uid=uuuu gid=CALLER_GID pid=pppp | |
105 | configuration file is TESTSUITE/test-config | |
106 | admin user | |
107 | changed uid/gid: privilege not needed | |
108 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
d8fe1c03 PH |
109 | seeking password data for user "CALLER": cache not available |
110 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
111 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
112 | sender address = CALLER@test.ex | |
113 | set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex> | |
ddf1b11a | 114 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
ad424056 | 115 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
54c5ebb1 PH |
116 | Sender: CALLER@test.ex |
117 | Recipients: | |
118 | userx@test.ex | |
119 | search_tidyup called | |
120 | >>Headers received: | |
121 | ||
122 | rewrite_one_header: type=F: | |
123 | From: CALLER_NAME <CALLER@test.ex> | |
124 | search_tidyup called | |
125 | >>Headers after rewriting and local additions: | |
126 | I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex> | |
127 | F From: CALLER_NAME <CALLER@test.ex> | |
b3f43fa0 | 128 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
54c5ebb1 | 129 | |
0971ec06 | 130 | Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
131 | Data file written for message 10HmaX-0005vi-00 |
132 | >>Generated Received: header line | |
133 | P Received: from CALLER by myhost.test.ex with local (Exim x.yz) | |
134 | (envelope-from <CALLER@test.ex>) | |
135 | id 10HmaX-0005vi-00 | |
136 | for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000 | |
ced52486 | 137 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00 |
df98a6ff JH |
138 | DSN: Write SPOOL: -dsn_envid NULL |
139 | DSN: Write SPOOL :-dsn_ret 0 | |
140 | DSN: Flags: 0x0 | |
141 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 | |
0971ec06 | 142 | Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H |
54c5ebb1 PH |
143 | Size of headers = sss |
144 | LOG: MAIN | |
145 | <= CALLER@test.ex U=CALLER P=local S=sss | |
146 | created log directory TESTSUITE/spool/log | |
147 | search_tidyup called | |
836c3e41 | 148 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00 |
54c5ebb1 PH |
149 | Exim version x.yz .... |
150 | changed uid/gid: forcing real = effective | |
151 | uid=uuuu gid=EXIM_GID pid=pppp | |
152 | configuration file is TESTSUITE/test-config | |
153 | trusted user | |
154 | admin user | |
4b424e0d | 155 | dropping to exim gid; retaining priv uid |
d8fe1c03 PH |
156 | seeking password data for user "CALLER": cache not available |
157 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
54c5ebb1 PH |
158 | set_process_info: pppp delivering specified messages |
159 | set_process_info: pppp delivering 10HmaX-0005vi-00 | |
0971ec06 | 160 | Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D |
54c5ebb1 PH |
161 | reading spool file 10HmaX-0005vi-00-H |
162 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex | |
163 | sender_local=1 ident=CALLER | |
164 | Non-recipients: | |
165 | Empty Tree | |
166 | ---- End of tree ---- | |
167 | recipients_count=1 | |
50dc7409 | 168 | **** SPOOL_IN - No additional fields |
54c5ebb1 | 169 | body_linecount=0 message_linecount=7 |
df98a6ff | 170 | DSN: set orcpt: flags: 0x0 |
54c5ebb1 PH |
171 | Delivery address list: |
172 | userx@test.ex | |
966e829c JH |
173 | locking TESTSUITE/spool/db/retry.lockfile |
174 | locked TESTSUITE/spool/db/retry.lockfile | |
175 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
176 | returned from EXIM_DBOPEN: (nil) | |
177 | ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim | |
178 | failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory | |
54c5ebb1 PH |
179 | no retry data available |
180 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
181 | Considering: userx@test.ex | |
182 | test.ex in "! *.ex"? no (matched "! *.ex") | |
183 | test.ex in "test.ex"? yes (matched "test.ex") | |
184 | test.ex in percent_hack_domains? yes (matched "+not_queue_domains") | |
185 | cached no match for +hold_domains | |
186 | test.ex in hold_domains? no (end of list) | |
187 | unique = userx@test.ex | |
de6f74f2 JH |
188 | no domain retry record |
189 | no address retry record | |
54c5ebb1 PH |
190 | userx@test.ex: queued for routing |
191 | cached yes match for +not_queue_domains | |
192 | test.ex in queue_domains? no (matched "!+not_queue_domains" - cached) | |
193 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
194 | routing userx@test.ex | |
195 | --------> r00 router <-------- | |
196 | local_part=userx domain=test.ex | |
197 | checking domains | |
198 | test.ex in "userx"? no (end of list) | |
199 | test.ex in "+nocache"? no (end of list) | |
200 | r00 router skipped: domains mismatch | |
201 | --------> r01 router <-------- | |
202 | local_part=userx domain=test.ex | |
203 | checking domains | |
204 | test.ex in "userx"? no (end of list) | |
205 | test.ex in "+nocache"? no (end of list) | |
206 | r01 router skipped: domains mismatch | |
207 | --------> r02 router <-------- | |
208 | local_part=userx domain=test.ex | |
209 | checking domains | |
210 | test.ex in "userx"? no (end of list) | |
211 | test.ex in "+nocache"? no (end of list) | |
212 | test.ex in "+nocache2"? no (end of list) | |
213 | r02 router skipped: domains mismatch | |
214 | --------> r03 router <-------- | |
215 | local_part=userx domain=test.ex | |
216 | checking domains | |
217 | test.ex in "userx"? no (end of list) | |
218 | test.ex in "+nocache"? no (end of list) | |
219 | test.ex in "+nocache2"? no (end of list) | |
220 | r03 router skipped: domains mismatch | |
221 | --------> r04 router <-------- | |
222 | local_part=userx domain=test.ex | |
223 | checking domains | |
224 | test.ex in "userx"? no (end of list) | |
225 | test.ex in "+forcecache"? no (end of list) | |
226 | r04 router skipped: domains mismatch | |
227 | --------> r05 router <-------- | |
228 | local_part=userx domain=test.ex | |
229 | checking domains | |
230 | cached no match for +forcecache | |
231 | cached lookup data = NULL | |
232 | test.ex in "+forcecache"? no (end of list) | |
233 | r05 router skipped: domains mismatch | |
234 | --------> r1 router <-------- | |
235 | local_part=userx domain=test.ex | |
236 | checking domains | |
237 | test.ex in "never.ex"? no (end of list) | |
238 | test.ex in "never1.ex"? no (end of list) | |
239 | test.ex in "test.ex"? yes (matched "test.ex") | |
a368cc11 | 240 | data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex' |
54c5ebb1 PH |
241 | test.ex in "+never_domains : +n1_domains : ! +local_domains"? no (matched "! +local_domains") |
242 | r1 router skipped: domains mismatch | |
243 | --------> r2 router <-------- | |
244 | local_part=userx domain=test.ex | |
245 | checking domains | |
246 | cached no match for +never_domains | |
247 | cached lookup data = NULL | |
248 | cached no match for +n1_domains | |
249 | cached lookup data = NULL | |
250 | test.ex in "<; never2.ex ; +n1_domains"? no (end of list) | |
251 | cached yes match for +local_domains | |
824ac956 | 252 | cached lookup data = test.ex |
54c5ebb1 PH |
253 | test.ex in "+never_domains : +n2_domains : !+local_domains"? no (matched "!+local_domains" - cached) |
254 | r2 router skipped: domains mismatch | |
255 | --------> r3 router <-------- | |
256 | local_part=userx domain=test.ex | |
257 | checking domains | |
258 | cached yes match for +local_domains | |
824ac956 | 259 | cached lookup data = test.ex |
54c5ebb1 PH |
260 | test.ex in "+local_domains"? yes (matched "+local_domains" - cached) |
261 | checking local_parts | |
262 | userx in "userx"? yes (matched "userx") | |
263 | calling r3 router | |
264 | r3 router called for userx@test.ex | |
265 | domain = test.ex | |
266 | set transport t1 | |
267 | queued for t1 transport: local_part = userx | |
268 | domain = test.ex | |
269 | errors_to=NULL | |
824ac956 | 270 | domain_data=test.ex localpart_data=userx |
54c5ebb1 PH |
271 | routed by r3 router |
272 | envelope to: userx@test.ex | |
273 | transport: t1 | |
274 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
275 | After routing: | |
276 | Local deliveries: | |
277 | userx@test.ex | |
278 | Remote deliveries: | |
279 | Failed addresses: | |
280 | Deferred addresses: | |
281 | search_tidyup called | |
282 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> | |
283 | --------> userx@test.ex <-------- | |
966e829c JH |
284 | locking TESTSUITE/spool/db/retry.lockfile |
285 | locked TESTSUITE/spool/db/retry.lockfile | |
286 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY | |
287 | returned from EXIM_DBOPEN: (nil) | |
288 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory | |
54c5ebb1 PH |
289 | no retry data available |
290 | search_tidyup called | |
291 | changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 | |
292 | uid=CALLER_UID gid=CALLER_GID pid=pppp | |
293 | home=NULL current=/ | |
294 | set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1 | |
295 | appendfile transport entered | |
296 | appendfile: mode=600 notify_comsat=0 quota=0 warning=0 | |
297 | file=/dev/null format=unix | |
298 | message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n | |
299 | message_suffix=\n | |
300 | maildir_use_size_file=no | |
301 | locking by lockfile fcntl | |
302 | search_tidyup called | |
303 | journalling userx@test.ex | |
304 | t1 transport returned OK for userx@test.ex | |
305 | post-process userx@test.ex (0) | |
306 | userx@test.ex delivered | |
307 | LOG: MAIN | |
308 | => userx <userx@test.ex> R=r3 T=t1 | |
309 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> | |
310 | changed uid/gid: post-delivery tidying | |
311 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
312 | set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 | |
313 | Processing retry items | |
314 | Succeeded addresses: | |
7b4c8c1f | 315 | userx@test.ex: no retry items |
54c5ebb1 PH |
316 | Failed addresses: |
317 | Deferred addresses: | |
318 | end of retry processing | |
50dc7409 JH |
319 | DSN: processing router : r3 |
320 | DSN: processing successful delivery address: userx@test.ex | |
321 | DSN: Sender_address: CALLER@test.ex | |
df98a6ff | 322 | DSN: orcpt: NULL flags: 0x0 |
50dc7409 JH |
323 | DSN: envid: NULL ret: 0 |
324 | DSN: Final recipient: userx@test.ex | |
325 | DSN: Remote SMTP server supports DSN: 0 | |
9671784a | 326 | DSN: not sending DSN success message |
54c5ebb1 PH |
327 | LOG: MAIN |
328 | Completed | |
329 | end delivery of 10HmaX-0005vi-00 | |
330 | search_tidyup called | |
331 | search_tidyup called | |
81022793 | 332 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
54c5ebb1 | 333 | search_tidyup called |
81022793 | 334 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
72934ba7 JH |
335 | Exim version x.yz .... |
336 | changed uid/gid: forcing real = effective | |
337 | uid=uuuu gid=CALLER_GID pid=pppp | |
338 | configuration file is TESTSUITE/test-config | |
339 | admin user | |
340 | changed uid/gid: privilege not needed | |
341 | uid=EXIM_UID gid=EXIM_GID pid=pppp | |
342 | seeking password data for user "CALLER": cache not available | |
343 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID | |
72934ba7 JH |
344 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
345 | sender address = CALLER@test.ex | |
346 | sender_fullhost = [127.0.0.1] | |
347 | sender_rcvhost = [127.0.0.1] | |
348 | host in hosts_connection_nolog? no (option unset) | |
349 | LOG: smtp_connection MAIN | |
350 | SMTP connection from [127.0.0.1] | |
351 | host in host_lookup? no (option unset) | |
352 | set_process_info: pppp handling incoming connection from [127.0.0.1] | |
353 | host in host_reject_connection? no (option unset) | |
354 | host in sender_unqualified_hosts? no (option unset) | |
355 | host in recipient_unqualified_hosts? no (option unset) | |
356 | host in helo_verify_hosts? no (option unset) | |
357 | host in helo_try_verify_hosts? no (option unset) | |
358 | host in helo_accept_junk_hosts? no (option unset) | |
359 | SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000 | |
360 | smtp_setup_msg entered | |
361 | SMTP<< HELO test | |
362 | test in helo_lookup_domains? no (end of list) | |
363 | sender_fullhost = (test) [127.0.0.1] | |
364 | sender_rcvhost = [127.0.0.1] (helo=test) | |
365 | set_process_info: pppp handling incoming connection from (test) [127.0.0.1] | |
366 | SMTP>> 250 myhost.test.ex Hello test [127.0.0.1] | |
367 | SMTP<< MAIL FROM:<test@test.ex> | |
368 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 | |
369 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 | |
370 | SMTP>> 250 OK | |
371 | SMTP<< RCPT TO:<error@test.ex> | |
372 | test.ex in "! *.ex"? no (matched "! *.ex") | |
373 | test.ex in "test.ex"? yes (matched "test.ex") | |
374 | test.ex in percent_hack_domains? yes (matched "+not_queue_domains") | |
897024f1 | 375 | processing "accept" (TESTSUITE/test-config 102) |
72934ba7 JH |
376 | check verify = recipient |
377 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
378 | Verifying error@test.ex | |
379 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
380 | Considering error@test.ex | |
381 | cached no match for +hold_domains | |
382 | cached yes match for +not_queue_domains | |
383 | test.ex in percent_hack_domains? yes (matched "+not_queue_domains" - cached) | |
384 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> | |
385 | routing error@test.ex | |
386 | --------> r0f router <-------- | |
387 | local_part=error domain=test.ex | |
388 | checking domains | |
389 | LOG: MAIN PANIC | |
390 | unknown named domain list "+no_such_list" | |
391 | domains check lookup or other defer | |
392 | ----------- end verify ------------ | |
393 | accept: condition test deferred in inline ACL | |
394 | SMTP>> 451 Temporary local problem - please try later | |
395 | LOG: MAIN REJECT | |
396 | H=(test) [127.0.0.1] F=<test@test.ex> temporarily rejected RCPT <error@test.ex>: domains check lookup or other defer | |
397 | SMTP<< QUIT | |
398 | SMTP>> 221 myhost.test.ex closing connection | |
399 | LOG: smtp_connection MAIN | |
400 | SMTP connection from (test) [127.0.0.1] closed by QUIT | |
401 | search_tidyup called | |
81022793 | 402 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |