Apply timeout consistently to all malware scanner types
[users/jgh/exim.git] / test / stderr / 0361
1 LOG: MAIN
2   <= CALLER@test.ex U=CALLER P=local S=sss
3 delivering 10HmaX-0005vi-00
4 LOG: MAIN
5   *> miles <miles@thishost.test.ex> R=r4 T=t2
6 LOG: MAIN
7   Completed
8 Exim version x.yz ....
9 changed uid/gid: forcing real = effective
10   uid=uuuu gid=CALLER_GID pid=pppp
11 configuration file is TESTSUITE/test-config
12 admin user
13 changed uid/gid: privilege not needed
14   uid=EXIM_UID gid=EXIM_GID pid=pppp
15 DSN: r1 propagating DSN
16 DSN: r2 propagating DSN
17 DSN: r3 propagating DSN
18 DSN: r4 propagating DSN
19 seeking password data for user "CALLER": cache not available
20 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
21 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
22 sender address = CALLER@test.ex
23 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
24 Sender: CALLER@test.ex
25 Recipients:
26   kilos@recurse.test.ex
27 search_tidyup called
28 >>Headers received:
29
30 rewrite_one_header: type=F:
31   From: CALLER_NAME <CALLER@test.ex>
32 search_tidyup called
33 >>Headers after rewriting and local additions:
34 I Message-Id: <E10HmaY-0005vi-00@the.local.host.name>
35 F From: CALLER_NAME <CALLER@test.ex>
36   Date: Tue, 2 Mar 1999 09:44:33 +0000
37
38 Data file written for message 10HmaY-0005vi-00
39 >>Generated Received: header line
40 P Received: from CALLER by the.local.host.name with local (Exim x.yz)
41         (envelope-from <CALLER@test.ex>)
42         id 10HmaY-0005vi-00
43         for kilos@recurse.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
44 calling local_scan(); timeout=300
45 local_scan() returned 0 NULL
46 Writing spool header file
47 DSN: Write SPOOL :-dsn_envid NULL
48 DSN: Write SPOOL :-dsn_ret 0
49 DSN: Flags :0
50 DSN: **** SPOOL_OUT - address: |kilos@recurse.test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
51 Size of headers = sss
52 LOG: MAIN
53   <= CALLER@test.ex U=CALLER P=local S=sss
54 search_tidyup called
55 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -N -odi -Mc 10HmaY-0005vi-00
56 Exim version x.yz ....
57 changed uid/gid: forcing real = effective
58   uid=uuuu gid=EXIM_GID pid=pppp
59 configuration file is TESTSUITE/test-config
60 trusted user
61 admin user
62 DSN: r1 propagating DSN
63 DSN: r2 propagating DSN
64 DSN: r3 propagating DSN
65 DSN: r4 propagating DSN
66 seeking password data for user "CALLER": cache not available
67 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
68 set_process_info: pppp delivering specified messages
69 set_process_info: pppp delivering 10HmaY-0005vi-00
70 reading spool file 10HmaY-0005vi-00-H
71 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
72 sender_local=1 ident=CALLER
73 Non-recipients:
74 Empty Tree
75 ---- End of tree ----
76 recipients_count=1
77 **** SPOOL_IN - No additional fields
78 body_linecount=0 message_linecount=7
79 DSN: set orcpt: NULL  flags: 0
80 Delivery address list:
81   kilos@recurse.test.ex 
82 locking TESTSUITE/spool/db/retry.lockfile
83 locked TESTSUITE/spool/db/retry.lockfile
84 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
85 returned from EXIM_DBOPEN
86 no retry data available
87 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
88 Considering: kilos@recurse.test.ex
89 unique = kilos@recurse.test.ex
90 no domain retry record
91 no address retry record
92 kilos@recurse.test.ex: queued for routing
93 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
94 routing kilos@recurse.test.ex
95 --------> r1 router <--------
96 local_part=kilos domain=recurse.test.ex
97 checking domains
98 recurse.test.ex in "!thishost.test.ex : !recurse.test.ex.test.ex"? yes (end of list)
99 calling r1 router
100 r1 router called for kilos@recurse.test.ex
101   domain = recurse.test.ex
102 DNS lookup of recurse.test.ex (MX) using fakens
103 DNS lookup of recurse.test.ex (MX) gave HOST_NOT_FOUND
104 returning DNS_NOMATCH
105 r1 router widened recurse.test.ex to recurse.test.ex.test.ex
106 DNS lookup of recurse.test.ex.test.ex (MX) using fakens
107 DNS lookup of recurse.test.ex.test.ex (MX) gave NO_DATA
108 returning DNS_NODATA
109 DNS lookup of recurse.test.ex.test.ex (A) using fakens
110 DNS lookup of recurse.test.ex.test.ex (A) succeeded
111 fully qualified name = recurse.test.ex.test.ex
112 recurse.test.ex.test.ex V4NET.99.0.2 mx=-1 sort=xx 
113 domain changed to recurse.test.ex.test.ex
114 rewriting header lines
115 rewrite_one_header: type=F:
116   From: CALLER_NAME <CALLER@test.ex>
117 re-routed to kilos@recurse.test.ex.test.ex
118 locking TESTSUITE/spool/db/retry.lockfile
119 locked TESTSUITE/spool/db/retry.lockfile
120 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
121 returned from EXIM_DBOPEN
122 no retry data available
123 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
124 Considering: kilos@recurse.test.ex.test.ex
125 unique = kilos@recurse.test.ex.test.ex
126 no domain retry record
127 no address retry record
128 kilos@recurse.test.ex.test.ex: queued for routing
129 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
130 routing kilos@recurse.test.ex.test.ex
131 --------> r1 router <--------
132 local_part=kilos domain=recurse.test.ex.test.ex
133 checking domains
134 recurse.test.ex.test.ex in "!thishost.test.ex : !recurse.test.ex.test.ex"? no (matched "!recurse.test.ex.test.ex")
135 r1 router skipped: domains mismatch
136 --------> r2 router <--------
137 local_part=kilos domain=recurse.test.ex.test.ex
138 checking local_parts
139 kilos in "miles"? no (end of list)
140 r2 router skipped: local_parts mismatch
141 --------> r3 router <--------
142 local_part=kilos domain=recurse.test.ex.test.ex
143 checking local_parts
144 kilos in "kilos"? yes (matched "kilos")
145 calling r3 router
146 rda_interpret (string): $local_part@$domain
147 expanded: kilos@recurse.test.ex.test.ex
148 file is not a filter file
149 parse_forward_list: kilos@recurse.test.ex.test.ex
150 extract item: kilos@recurse.test.ex.test.ex
151 r3 router generated kilos@recurse.test.ex.test.ex
152   errors_to=NULL transport=NULL
153   uid=unset gid=unset home=NULL
154 routed by r3 router
155   envelope to: kilos@recurse.test.ex.test.ex
156   transport: <none>
157 locking TESTSUITE/spool/db/retry.lockfile
158 locked TESTSUITE/spool/db/retry.lockfile
159 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
160 returned from EXIM_DBOPEN
161 no retry data available
162 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
163 Considering: kilos@recurse.test.ex.test.ex
164 unique = \0\kilos@recurse.test.ex.test.ex
165 no domain retry record
166 no address retry record
167 kilos@recurse.test.ex.test.ex: queued for routing
168 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
169 routing kilos@recurse.test.ex.test.ex
170 --------> r1 router <--------
171 local_part=kilos domain=recurse.test.ex.test.ex
172 checking domains
173 recurse.test.ex.test.ex in "!thishost.test.ex : !recurse.test.ex.test.ex"? no (matched "!recurse.test.ex.test.ex")
174 r1 router skipped: domains mismatch
175 --------> r2 router <--------
176 local_part=kilos domain=recurse.test.ex.test.ex
177 checking local_parts
178 kilos in "miles"? no (end of list)
179 r2 router skipped: local_parts mismatch
180 --------> r3 router <--------
181 r3 router skipped: previously routed kilos@recurse.test.ex.test.ex
182 --------> r4 router <--------
183 local_part=kilos domain=recurse.test.ex.test.ex
184 calling r4 router
185 r4 router called for kilos@recurse.test.ex.test.ex
186   domain = recurse.test.ex.test.ex
187 set transport t2
188 queued for t2 transport: local_part = kilos
189 domain = recurse.test.ex.test.ex
190   errors_to=NULL
191   domain_data=NULL localpart_data=NULL
192 routed by r4 router
193   envelope to: kilos@recurse.test.ex.test.ex
194   transport: t2
195 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
196 After routing:
197   Local deliveries:
198     kilos@recurse.test.ex.test.ex
199   Remote deliveries:
200   Failed addresses:
201   Deferred addresses:
202 search_tidyup called
203 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
204 --------> kilos@recurse.test.ex.test.ex <--------
205 locking TESTSUITE/spool/db/retry.lockfile
206 locked TESTSUITE/spool/db/retry.lockfile
207 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
208 returned from EXIM_DBOPEN
209 no retry data available
210 search_tidyup called
211 changed uid/gid: local delivery to kilos <kilos@recurse.test.ex.test.ex> transport=t2
212   uid=CALLER_UID gid=CALLER_GID pid=pppp
213   home=NULL current=/
214 set_process_info: pppp delivering 10HmaY-0005vi-00 to kilos using t2
215 appendfile transport entered
216 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
217   file=/dev/null format=unix
218   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
219   message_suffix=\n
220   maildir_use_size_file=no
221   locking by lockfile fcntl 
222 *** delivery by t2 transport bypassed by -N option
223 search_tidyup called
224 journalling kilos@recurse.test.ex.test.ex/t2
225 t2 transport returned OK for kilos@recurse.test.ex.test.ex
226 post-process kilos@recurse.test.ex.test.ex (0)
227 kilos@recurse.test.ex.test.ex delivered
228 kilos@recurse.test.ex.test.ex: children all complete
229 kilos@recurse.test.ex: children all complete
230 LOG: MAIN
231   *> kilos <kilos@recurse.test.ex> R=r4 T=t2
232 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
233 changed uid/gid: post-delivery tidying
234   uid=EXIM_UID gid=EXIM_GID pid=pppp
235 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
236 DSN: processing router : r4
237 DSN: processing successful delivery address: kilos@recurse.test.ex.test.ex
238 DSN: Sender_address: CALLER@test.ex
239 DSN: orcpt: NULL  flags: 0
240 DSN: envid: NULL  ret: 0
241 DSN: Final recipient: kilos@recurse.test.ex.test.ex
242 DSN: Remote SMTP server supports DSN: 0
243 DSN: *** NOT SENDING DSN SUCCESS Message ***
244 DSN: processing router : r3
245 DSN: processing successful delivery address: kilos@recurse.test.ex.test.ex
246 DSN: Sender_address: CALLER@test.ex
247 DSN: orcpt: NULL  flags: 0
248 DSN: envid: NULL  ret: 0
249 DSN: Final recipient: kilos@recurse.test.ex.test.ex
250 DSN: Remote SMTP server supports DSN: 0
251 DSN: *** NOT SENDING DSN SUCCESS Message ***
252 LOG: MAIN
253   Completed
254 end delivery of 10HmaY-0005vi-00
255 search_tidyup called
256 search_tidyup called
257 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
258 search_tidyup called
259 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>