exit-time debug
[users/jgh/exim.git] / test / stderr / 2201
1 Exim version x.yz ....
2 changed uid/gid: forcing real = effective
3   uid=uuuu gid=CALLER_GID pid=pppp
4 seeking password data for user "CALLER": cache not available
5 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
6 configuration file is TESTSUITE/test-config
7 trusted user
8 admin user
9 dropping to exim gid; retaining priv uid
10 seeking password data for user "CALLER": using cached result
11 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
12 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
13 sender address = CALLER@myhost.test.ex
14 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
15 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
16 Testing test.ex@test.ex
17 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
18 Considering test.ex@test.ex
19 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
20 routing test.ex@test.ex
21 --------> r0 router <--------
22 local_part=test.ex domain=test.ex
23 checking senders
24 address match test: subject=CALLER@myhost.test.ex pattern=a@shorthost.test.ex
25 CALLER@myhost.test.ex in "a@shorthost.test.ex"? no (end of list)
26 r0 router skipped: senders mismatch
27 --------> r1 router <--------
28 local_part=test.ex domain=test.ex
29 checking domains
30 search_open: dnsdb "NULL"
31 search_find: file="NULL"
32   key="test.ex" partial=-1 affix=NULL starflags=0
33 LRU list:
34 internal_search_find: file="NULL"
35   type=dnsdb key="test.ex"
36 database lookup required for test.ex
37 dnsdb key: test.ex
38 DNS lookup of test.ex (TXT) using fakens
39 fresh-exec forking for fakens-search
40 postfork: fakens-search
41 fresh-exec forked for fakens-search: npppp
42 DNS lookup of test.ex (TXT) succeeded
43 lookup yielded: A TXT record for test.ex.
44 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
45 checking local_parts
46 search_open: dnsdb "NULL"
47   cached open
48 search_find: file="NULL"
49   key="test.ex" partial=-1 affix=NULL starflags=0
50 LRU list:
51 internal_search_find: file="NULL"
52   type=dnsdb key="test.ex"
53 cached data used for lookup of test.ex
54 lookup yielded: A TXT record for test.ex.
55 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
56 calling r1 router
57 r1 router called for test.ex@test.ex
58   domain = test.ex
59 set transport local_delivery
60 queued for local_delivery transport: local_part = test.ex
61 domain = test.ex
62   errors_to=NULL
63   domain_data=A TXT record for test.ex. localpart_data=A TXT record for test.ex.
64 routed by r1 router
65   envelope to: test.ex@test.ex
66   transport: local_delivery
67 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
68 Testing unknown@test.ex
69 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
70 Considering unknown@test.ex
71 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
72 routing unknown@test.ex
73 --------> r0 router <--------
74 local_part=unknown domain=test.ex
75 checking senders
76 address match test: subject=CALLER@myhost.test.ex pattern=a@shorthost.test.ex
77 CALLER@myhost.test.ex in "a@shorthost.test.ex"? no (end of list)
78 r0 router skipped: senders mismatch
79 --------> r1 router <--------
80 local_part=unknown domain=test.ex
81 checking domains
82 search_open: dnsdb "NULL"
83   cached open
84 search_find: file="NULL"
85   key="test.ex" partial=-1 affix=NULL starflags=0
86 LRU list:
87 internal_search_find: file="NULL"
88   type=dnsdb key="test.ex"
89 cached data used for lookup of test.ex
90 lookup yielded: A TXT record for test.ex.
91 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
92 checking local_parts
93 search_open: dnsdb "NULL"
94   cached open
95 search_find: file="NULL"
96   key="unknown" partial=-1 affix=NULL starflags=0
97 LRU list:
98 internal_search_find: file="NULL"
99   type=dnsdb key="unknown"
100 database lookup required for unknown
101 dnsdb key: unknown
102 DNS lookup of unknown (TXT) using fakens
103 fresh-exec forking for fakens-search
104 postfork: fakens-search
105 fresh-exec forked for fakens-search: npppp
106 DNS lookup of unknown (TXT) gave HOST_NOT_FOUND
107 returning DNS_NOMATCH
108 faking res_search(TXT) response length as 65535
109  writing neg-cache entry for unknown-TXT-xxxx, ttl 3000
110 lookup failed
111 unknown in "dnsdb;unknown"? no (end of list)
112 r1 router skipped: local_parts mismatch
113 --------> r2 router <--------
114 local_part=unknown domain=test.ex
115 checking domains
116 search_open: dnsdb "NULL"
117   cached open
118 search_find: file="NULL"
119   key="test.ex" partial=-1 affix=NULL starflags=0
120 LRU list:
121 internal_search_find: file="NULL"
122   type=dnsdb key="test.ex"
123 cached data used for lookup of test.ex
124 lookup yielded: A TXT record for test.ex.
125 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
126 checking senders
127 address match test: subject=CALLER@myhost.test.ex pattern=dnsdb;A=myhost.test.ex
128 search_open: dnsdb "NULL"
129   cached open
130 search_find: file="NULL"
131   key="A=myhost.test.ex" partial=-1 affix=NULL starflags=0
132 LRU list:
133 internal_search_find: file="NULL"
134   type=dnsdb key="A=myhost.test.ex"
135 database lookup required for A=myhost.test.ex
136 dnsdb key: myhost.test.ex
137 DNS lookup of myhost.test.ex (A) using fakens
138 fresh-exec forking for fakens-search
139 postfork: fakens-search
140 fresh-exec forked for fakens-search: npppp
141 DNS lookup of myhost.test.ex (A) succeeded
142 lookup yielded: V4NET.10.10.10
143 CALLER@myhost.test.ex in "dnsdb;A=myhost.test.ex"? yes (matched "dnsdb;A=myhost.test.ex")
144 calling r2 router
145 r2 router called for unknown@test.ex
146   domain = test.ex
147 set transport local_delivery
148 queued for local_delivery transport: local_part = unknown
149 domain = test.ex
150   errors_to=NULL
151   domain_data=A TXT record for test.ex. localpart_data=NULL
152 routed by r2 router
153   envelope to: unknown@test.ex
154   transport: local_delivery
155 search_tidyup called
156 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
157 Exim version x.yz ....
158 configuration file is TESTSUITE/test-config
159 trusted user
160 admin user
161 search_tidyup called
162 search_tidyup called
163 search_open: dnsdb "NULL"
164 search_find: file="NULL"
165   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
166 LRU list:
167 internal_search_find: file="NULL"
168   type=dnsdb key="a=shorthost.test.ex"
169 database lookup required for a=shorthost.test.ex
170 dnsdb key: shorthost.test.ex
171 fresh-exec forking for fakens-search
172 postfork: fakens-search
173 fresh-exec forked for fakens-search: npppp
174 lookup yielded: 127.0.0.1
175 search_open: dnsdb "NULL"
176   cached open
177 search_find: file="NULL"
178   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
179 LRU list:
180 internal_search_find: file="NULL"
181   type=dnsdb key="a=shorthost.test.ex"
182 cached data used for lookup of a=shorthost.test.ex
183 lookup yielded: 127.0.0.1
184 search_open: dnsdb "NULL"
185   cached open
186 search_find: file="NULL"
187   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
188 LRU list:
189 internal_search_find: file="NULL"
190   type=dnsdb key="a=shorthost.test.ex"
191 cached data found but past valid time; database lookup required for a=shorthost.test.ex
192 dnsdb key: shorthost.test.ex
193 fresh-exec forking for fakens-search
194 postfork: fakens-search
195 fresh-exec forked for fakens-search: npppp
196 lookup yielded: 127.0.0.1
197 LOG: MAIN
198   <= a@shorthost.test.ex U=CALLER P=local S=sss
199 created log directory TESTSUITE/spool/log
200 search_tidyup called
201 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
202
203 ******** SERVER ********
204 Exim version x.yz ....
205 configuration file is TESTSUITE/test-config
206 trusted user
207 admin user
208 dropping to exim gid; retaining priv uid
209 ppppp daemon_smtp_port overridden by -oX:
210 ppppp   <: 1225
211 ppppp creating notifier socket
212 ppppp  TESTSUITE/spool/exim_daemon_notify
213 ppppp listening on all interfaces (IPv4) port 1225
214 ppppp pid written to TESTSUITE/spool/exim-daemon.pid
215 ppppp LOG: MAIN
216 ppppp   exim x.yz daemon started: pid=pppp, no queue runs, listening for SMTP on port 1225
217 ppppp daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID
218 ppppp Listening...
219 ppppp Connection request from 127.0.0.1 port sssss
220 ppppp daemon forking for daemon-accept
221 ppppp postfork: daemon-accept
222 ppppp Process ppppp is handling incoming connection from [127.0.0.1]
223 ppppp Process ppppp is ready for new message
224 ppppp daemon-accept forking for fakens-search
225 ppppp postfork: fakens-search
226 ppppp daemon forked for daemon-accept: npppp
227 ppppp 1 SMTP accept process running
228 ppppp Listening...
229 ppppp daemon-accept forked for fakens-search: npppp
230 ppppp daemon-accept forking for fakens-search
231 ppppp postfork: fakens-search
232 ppppp daemon-accept forked for fakens-search: npppp
233 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
234 ppppp new DNS lookup for 14.12.11.V4NET.rbl.test.ex
235 ppppp daemon-accept forking for fakens-search
236 ppppp postfork: fakens-search
237 ppppp daemon-accept forked for fakens-search: npppp
238 ppppp dnslists: wrote cache entry, ttl=2
239 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
240 ppppp daemon-accept forking for fakens-search
241 ppppp postfork: fakens-search
242 ppppp daemon-accept forked for fakens-search: npppp
243 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
244 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
245 ppppp dnslists: using result of previous lookup
246 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
247 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
248 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
249 ppppp cached data found but past valid time; new DNS lookup for 14.12.11.V4NET.rbl.test.ex
250 ppppp daemon-accept forking for fakens-search
251 ppppp postfork: fakens-search
252 ppppp daemon-accept forked for fakens-search: npppp
253 ppppp dnslists: wrote cache entry, ttl=2
254 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
255 ppppp daemon-accept forking for fakens-search
256 ppppp postfork: fakens-search
257 ppppp daemon-accept forked for fakens-search: npppp
258 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
259 ppppp LOG: MAIN
260 ppppp   <= a@shorthost.test.ex H=localhost (myhost.test.ex) [127.0.0.1] P=esmtp S=sss id=E10HmaX-0005vi-00@myhost.test.ex
261 ppppp Process ppppp is ready for new message
262 ppppp LOG: smtp_connection MAIN
263 ppppp   SMTP connection from localhost (myhost.test.ex) [127.0.0.1] closed by QUIT
264 ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (daemon-accept) terminating with rc=0 >>>>>>>>>>>>>>>>
265 ppppp child ppppp ended: status=0x0
266 ppppp   normal exit, 0
267 ppppp 0 SMTP accept processes now running
268 ppppp Listening...
269 ppppp daemon forking for daemon-del-pidfile
270 ppppp postfork: daemon-del-pidfile
271 ppppp daemon forked for daemon-del-pidfile: npppp
272 ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>>