exit-time debug
[exim.git] / test / stderr / 0378
1 Exim version x.yz ....
2 configuration file is TESTSUITE/test-config
3 admin user
4 LOG: MAIN
5   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
6 created log directory TESTSUITE/spool/log
7 fresh-exec forking for local-accept-delivery
8 postfork: local-accept-delivery
9 fresh-exec forked for local-accept-delivery: npppp
10 Exim version x.yz ....
11 configuration file is TESTSUITE/test-config
12 trusted user
13 admin user
14 dropping to exim gid; retaining priv uid
15 locking TESTSUITE/spool/db/retry.lockfile
16 no retry data available
17 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
18 Considering: aaaa@myhost.test.ex
19 unique = aaaa@myhost.test.ex
20 aaaa@myhost.test.ex: queued for routing
21 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
22 routing aaaa@myhost.test.ex
23 --------> bounce router <--------
24 local_part=aaaa domain=myhost.test.ex
25 checking senders
26 bounce router skipped: senders mismatch
27 --------> defer router <--------
28 local_part=aaaa domain=myhost.test.ex
29 checking local_parts
30 defer router skipped: local_parts mismatch
31 --------> aaaa_2nd_time router <--------
32 local_part=aaaa domain=myhost.test.ex
33 checking local_parts
34 checking "condition" "${if first_delivery{no}{yes}}"...
35 aaaa_2nd_time router skipped: condition failure
36 --------> aaaa router <--------
37 local_part=aaaa domain=myhost.test.ex
38 checking local_parts
39 calling aaaa router
40 rda_interpret (string): '# Exim filter\ndeliver defer_aaaa@$domain\nsave TESTSUITE/test-mail/file\npipe "/bin/sh -c exit"\nmail subject autoreply\ntext "This is an autoreply"'
41 expanded: '# Exim filter
42 deliver defer_aaaa@myhost.test.ex
43 save TESTSUITE/test-mail/file
44 pipe "/bin/sh -c exit"
45 mail subject autoreply
46 text "This is an autoreply"' (tainted)
47 local-accept-delivery forking for router-interpret
48 postfork: router-interpret
49 data is an Exim filter program
50 Filter: start of processing
51 Filter: end of processing
52 >>>>>>>>>>>>>>>> Exim pid=pppp (router-interpret) terminating with rc=0 >>>>>>>>>>>>>>>>
53 local-accept-delivery forked for router-interpret: npppp
54 rda_interpret: subprocess yield=0 error=NULL
55 set transport t3
56 aaaa router generated >CALLER@myhost.test.ex
57   pipe, file, or autoreply
58   errors_to=NULL transport=t3
59   uid=CALLER_UID gid=CALLER_GID home=NULL
60 set transport t2
61 aaaa router generated |/bin/sh -c exit
62   pipe, file, or autoreply
63   errors_to=NULL transport=t2
64   uid=CALLER_UID gid=CALLER_GID home=NULL
65 set transport t1
66 aaaa router generated TESTSUITE/test-mail/file
67   pipe, file, or autoreply
68   errors_to=NULL transport=t1
69   uid=CALLER_UID gid=CALLER_GID home=NULL
70 aaaa router generated defer_aaaa@myhost.test.ex
71   errors_to=NULL transport=NULL
72   uid=unset gid=unset home=NULL
73 routed by aaaa router
74   envelope to: aaaa@myhost.test.ex
75   transport: <none>
76 locking TESTSUITE/spool/db/retry.lockfile
77 no retry data available
78 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
79 Considering: defer_aaaa@myhost.test.ex
80 unique = defer_aaaa@myhost.test.ex
81 defer_aaaa@myhost.test.ex: queued for routing
82 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
83 Considering: TESTSUITE/test-mail/file
84 unique = TESTSUITE/test-mail/file:aaaa@myhost.test.ex
85 queued for t1 transport
86 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
87 Considering: |/bin/sh -c exit
88 unique = |/bin/sh -c exit:aaaa@myhost.test.ex
89 queued for t2 transport
90 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
91 Considering: >CALLER@myhost.test.ex
92 unique = >CALLER@myhost.test.ex:aaaa@myhost.test.ex
93 queued for t3 transport
94 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
95 routing defer_aaaa@myhost.test.ex
96 --------> bounce router <--------
97 local_part=defer_aaaa domain=myhost.test.ex
98 checking senders
99 bounce router skipped: senders mismatch
100 --------> defer router <--------
101 local_part=defer_aaaa domain=myhost.test.ex
102 checking local_parts
103 calling defer router
104 rda_interpret (string): ':defer: forced defer'
105 expanded: ':defer: forced defer'
106 file is not a filter file
107 parse_forward_list: :defer: forced defer
108 extract item: :defer: forced defer
109 defer router: defer for defer_aaaa@myhost.test.ex
110   message: forced defer
111 LOG: MAIN
112   == defer_aaaa@myhost.test.ex <aaaa@myhost.test.ex> R=defer defer (-1): forced defer
113 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
114 After routing:
115   Local deliveries:
116     >CALLER@myhost.test.ex
117     |/bin/sh -c exit
118     TESTSUITE/test-mail/file
119   Remote deliveries:
120   Failed addresses:
121   Deferred addresses:
122     defer_aaaa@myhost.test.ex
123 locking TESTSUITE/spool/db/retry.lockfile
124 local-accept-delivery forking for delivery-local
125 postfork: delivery-local
126 delivery-local forking for autoreply
127 postfork: autoreply
128 local-accept-delivery forked for delivery-local: npppp
129 delivery-local forked for autoreply: npppp
130 Exim version x.yz ....
131 configuration file is TESTSUITE/test-config
132 admin user
133 LOG: MAIN
134   <= <> R=10HmaX-0005vi-00 U=CALLER P=local S=sss
135 autoreply forking for local-accept-delivery
136 postfork: local-accept-delivery
137 autoreply forked for local-accept-delivery: npppp
138 Exim version x.yz ....
139 configuration file is TESTSUITE/test-config
140 trusted user
141 admin user
142 dropping to exim gid; retaining priv uid
143 locking TESTSUITE/spool/db/retry.lockfile
144 no retry data available
145 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
146 Considering: CALLER@myhost.test.ex
147 unique = CALLER@myhost.test.ex
148 CALLER@myhost.test.ex: queued for routing
149 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
150 routing CALLER@myhost.test.ex
151 --------> bounce router <--------
152 local_part=CALLER domain=myhost.test.ex
153 checking senders
154 calling bounce router
155 rda_interpret (string): ':blackhole:'
156 expanded: ':blackhole:'
157 file is not a filter file
158 parse_forward_list: :blackhole:
159 extract item: :blackhole:
160 address :blackhole:d
161 LOG: MAIN
162   => :blackhole: <CALLER@myhost.test.ex> R=bounce
163 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
164 After routing:
165   Local deliveries:
166   Remote deliveries:
167   Failed addresses:
168   Deferred addresses:
169 LOG: MAIN
170   Completed
171 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
172 >>>>>>>>>>>>>>>> Exim pid=pppp (autoreply) terminating with rc=0 >>>>>>>>>>>>>>>>
173 LOG: MAIN
174   => >CALLER@myhost.test.ex <aaaa@myhost.test.ex> R=aaaa T=t3
175 locking TESTSUITE/spool/db/retry.lockfile
176 local-accept-delivery forking for delivery-local
177 postfork: delivery-local
178 delivery-local forking for pipe-tpt-cmd
179 postfork: pipe-tpt-cmd
180 local-accept-delivery forked for delivery-local: npppp
181 delivery-local forked for pipe-tpt-cmd: npppp
182 delivery-local forking for pipe-tpt-output
183 postfork: pipe-tpt-output
184 delivery-local forked for pipe-tpt-output: npppp
185 transport error EPIPE ignored
186 LOG: MAIN
187   => |/bin/sh -c exit <aaaa@myhost.test.ex> R=aaaa T=t2
188 locking TESTSUITE/spool/db/retry.lockfile
189 local-accept-delivery forking for delivery-local
190 postfork: delivery-local
191 local-accept-delivery forked for delivery-local: npppp
192 LOG: MAIN
193   => TESTSUITE/test-mail/file <aaaa@myhost.test.ex> R=aaaa T=t1
194 locking TESTSUITE/spool/db/retry.lockfile
195 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
196 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
197 Exim version x.yz ....
198 configuration file is TESTSUITE/test-config
199 admin user
200 dropping to exim gid; retaining priv uid
201 LOG: queue_run MAIN
202   Start queue run: pid=pppp -qf
203 fresh-exec forking for qrun-delivery
204 postfork: qrun-delivery
205 locking TESTSUITE/spool/db/retry.lockfile
206 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
207 Considering: aaaa@myhost.test.ex
208 unique = aaaa@myhost.test.ex
209 aaaa@myhost.test.ex: queued for routing
210 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
211 routing aaaa@myhost.test.ex
212 --------> bounce router <--------
213 local_part=aaaa domain=myhost.test.ex
214 checking senders
215 bounce router skipped: senders mismatch
216 --------> defer router <--------
217 local_part=aaaa domain=myhost.test.ex
218 checking local_parts
219 defer router skipped: local_parts mismatch
220 --------> aaaa_2nd_time router <--------
221 local_part=aaaa domain=myhost.test.ex
222 checking local_parts
223 checking "condition" "${if first_delivery{no}{yes}}"...
224 calling aaaa_2nd_time router
225 rda_interpret (string): 'aaaa@$domain'
226 expanded: 'aaaa@myhost.test.ex' (tainted)
227 file is not a filter file
228 parse_forward_list: aaaa@myhost.test.ex
229 extract item: aaaa@myhost.test.ex
230 aaaa_2nd_time router generated aaaa@myhost.test.ex
231   errors_to=NULL transport=NULL
232   uid=unset gid=unset home=NULL
233 routed by aaaa_2nd_time router
234   envelope to: aaaa@myhost.test.ex
235   transport: <none>
236 locking TESTSUITE/spool/db/retry.lockfile
237 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
238 Considering: aaaa@myhost.test.ex
239 unique = \0\aaaa@myhost.test.ex
240 aaaa@myhost.test.ex: queued for routing
241 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
242 routing aaaa@myhost.test.ex
243 --------> bounce router <--------
244 local_part=aaaa domain=myhost.test.ex
245 checking senders
246 bounce router skipped: senders mismatch
247 --------> defer router <--------
248 local_part=aaaa domain=myhost.test.ex
249 checking local_parts
250 defer router skipped: local_parts mismatch
251 --------> aaaa_2nd_time router <--------
252 aaaa_2nd_time router skipped: previously routed aaaa@myhost.test.ex
253 --------> aaaa router <--------
254 local_part=aaaa domain=myhost.test.ex
255 checking local_parts
256 calling aaaa router
257 rda_interpret (string): '# Exim filter\ndeliver defer_aaaa@$domain\nsave TESTSUITE/test-mail/file\npipe "/bin/sh -c exit"\nmail subject autoreply\ntext "This is an autoreply"'
258 expanded: '# Exim filter
259 deliver defer_aaaa@myhost.test.ex
260 save TESTSUITE/test-mail/file
261 pipe "/bin/sh -c exit"
262 mail subject autoreply
263 text "This is an autoreply"' (tainted)
264 qrun-delivery forking for router-interpret
265 postfork: router-interpret
266 data is an Exim filter program
267 Filter: start of processing
268 Filter: end of processing
269 >>>>>>>>>>>>>>>> Exim pid=pppp (router-interpret) terminating with rc=0 >>>>>>>>>>>>>>>>
270 fresh-exec forked for qrun-delivery: npppp
271 qrun-delivery forked for router-interpret: npppp
272 rda_interpret: subprocess yield=0 error=NULL
273 set transport t3
274 aaaa router generated >CALLER@myhost.test.ex
275   pipe, file, or autoreply
276   errors_to=NULL transport=t3
277   uid=CALLER_UID gid=CALLER_GID home=NULL
278 set transport t2
279 aaaa router generated |/bin/sh -c exit
280   pipe, file, or autoreply
281   errors_to=NULL transport=t2
282   uid=CALLER_UID gid=CALLER_GID home=NULL
283 set transport t1
284 aaaa router generated TESTSUITE/test-mail/file
285   pipe, file, or autoreply
286   errors_to=NULL transport=t1
287   uid=CALLER_UID gid=CALLER_GID home=NULL
288 aaaa router generated defer_aaaa@myhost.test.ex
289   errors_to=NULL transport=NULL
290   uid=unset gid=unset home=NULL
291 routed by aaaa router
292   envelope to: aaaa@myhost.test.ex
293   transport: <none>
294 locking TESTSUITE/spool/db/retry.lockfile
295 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
296 Considering: defer_aaaa@myhost.test.ex
297 unique = defer_aaaa@myhost.test.ex
298 defer_aaaa@myhost.test.ex: queued for routing
299 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
300 Considering: TESTSUITE/test-mail/file
301 unique = TESTSUITE/test-mail/file:aaaa@myhost.test.ex
302 TESTSUITE/test-mail/file was previously delivered: discarded
303 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
304 Considering: |/bin/sh -c exit
305 unique = |/bin/sh -c exit:aaaa@myhost.test.ex
306 |/bin/sh -c exit was previously delivered: discarded
307 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
308 Considering: >CALLER@myhost.test.ex
309 unique = >CALLER@myhost.test.ex:aaaa@myhost.test.ex
310 >CALLER@myhost.test.ex was previously delivered: discarded
311 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
312 routing defer_aaaa@myhost.test.ex
313 --------> bounce router <--------
314 local_part=defer_aaaa domain=myhost.test.ex
315 checking senders
316 bounce router skipped: senders mismatch
317 --------> defer router <--------
318 local_part=defer_aaaa domain=myhost.test.ex
319 checking local_parts
320 calling defer router
321 rda_interpret (string): ':defer: forced defer'
322 expanded: ':defer: forced defer'
323 file is not a filter file
324 parse_forward_list: :defer: forced defer
325 extract item: :defer: forced defer
326 defer router: defer for defer_aaaa@myhost.test.ex
327   message: forced defer
328 LOG: MAIN
329   == defer_aaaa@myhost.test.ex <aaaa@myhost.test.ex> R=defer defer (-1): forced defer
330 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
331 After routing:
332   Local deliveries:
333   Remote deliveries:
334   Failed addresses:
335   Deferred addresses:
336     defer_aaaa@myhost.test.ex
337 locking TESTSUITE/spool/db/retry.lockfile
338 >>>>>>>>>>>>>>>> Exim pid=pppp (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
339 LOG: queue_run MAIN
340   End queue run: pid=pppp -qf
341 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>