ACL: Ensure that acl_smtp_notquit is called for a conndrop between data-go-ahead...
[users/jgh/exim.git] / test / stderr / 5004
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
6 changed uid/gid: privilege not needed
7   uid=EXIM_UID gid=EXIM_GID pid=pppp
8 seeking password data for user "CALLER": cache not available
9 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
10 DSN: r1 propagating DSN
11 seeking password data for user "CALLER": using cached result
12 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
13 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
14 sender address = CALLER@test.ex
15 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
16 Sender: CALLER@test.ex
17 Recipients:
18   userx@test.ex
19 search_tidyup called
20 >>Headers received:
21
22 rewrite_one_header: type=F:
23   From: CALLER_NAME <CALLER@test.ex>
24 search_tidyup called
25 >>Headers after rewriting and local additions:
26 I Message-Id: <E10HmaX-0005vi-00@mail.test.ex>
27 F From: CALLER_NAME <CALLER@test.ex>
28   Date: Tue, 2 Mar 1999 09:44:33 +0000
29
30 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
31 Data file written for message 10HmaX-0005vi-00
32 >>Generated Received: header line
33 P Received: from CALLER by mail.test.ex with local (Exim x.yz)
34         (envelope-from <CALLER@test.ex>)
35         id 10HmaX-0005vi-00
36         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
37 calling local_scan(); timeout=300
38 local_scan() returned 0 NULL
39 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
40 DSN: Write SPOOL :-dsn_envid NULL
41 DSN: Write SPOOL :-dsn_ret 0
42 DSN: Flags :0
43 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
44 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
45 Size of headers = sss
46 LOG: MAIN
47   <= CALLER@test.ex U=CALLER P=local S=sss
48 created log directory TESTSUITE/spool/log
49 search_tidyup called
50 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
51 Exim version x.yz ....
52 changed uid/gid: forcing real = effective
53   uid=uuuu gid=EXIM_GID pid=pppp
54 configuration file is TESTSUITE/test-config
55 trusted user
56 admin user
57 seeking password data for user "CALLER": cache not available
58 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
59 DSN: r1 propagating DSN
60 seeking password data for user "CALLER": using cached result
61 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
62 set_process_info: pppp delivering specified messages
63 set_process_info: pppp delivering 10HmaX-0005vi-00
64 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
65 reading spool file 10HmaX-0005vi-00-H
66 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
67 sender_local=1 ident=CALLER
68 Non-recipients:
69 Empty Tree
70 ---- End of tree ----
71 recipients_count=1
72 **** SPOOL_IN - No additional fields
73 body_linecount=1 message_linecount=7
74 DSN: set orcpt: NULL  flags: 0
75 Delivery address list:
76   userx@test.ex 
77 locking TESTSUITE/spool/db/retry.lockfile
78 locked TESTSUITE/spool/db/retry.lockfile
79 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
80 returned from EXIM_DBOPEN
81 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
82 no retry data available
83 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
84 Considering: userx@test.ex
85 unique = userx@test.ex
86 no domain retry record
87 no address retry record
88 userx@test.ex: queued for routing
89 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
90 routing userx@test.ex
91 --------> r1 router <--------
92 local_part=userx domain=test.ex
93 calling r1 router
94 rda_interpret (string): # Exim filter
95 save TESTSUITE/test-mail
96 expanded: # Exim filter
97 save TESTSUITE/test-mail
98 search_tidyup called
99 changed uid/gid: r1 router (recipient is userx@test.ex)
100   uid=CALLER_UID gid=CALLER_GID pid=pppp
101 turned off address rewrite logging (not root or exim in this process)
102 data is an Exim filter program
103 Filter: start of processing
104 Filter: end of processing
105 search_tidyup called
106 rda_interpret: subprocess yield=0 error=NULL
107 set transport t1
108 r1 router generated TESTSUITE/test-mail
109   pipe, file, or autoreply
110   errors_to=NULL transport=t1
111   uid=CALLER_UID gid=CALLER_GID home=NULL
112 routed by r1 router
113   envelope to: userx@test.ex
114   transport: <none>
115 locking TESTSUITE/spool/db/retry.lockfile
116 locked TESTSUITE/spool/db/retry.lockfile
117 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
118 returned from EXIM_DBOPEN
119 no retry data available
120 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
121 Considering: TESTSUITE/test-mail
122 unique = TESTSUITE/test-mail:userx@test.ex
123 queued for t1 transport
124 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
125 After routing:
126   Local deliveries:
127     TESTSUITE/test-mail
128   Remote deliveries:
129   Failed addresses:
130   Deferred addresses:
131 search_tidyup called
132 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
133 --------> TESTSUITE/test-mail <--------
134 locking TESTSUITE/spool/db/retry.lockfile
135 locked TESTSUITE/spool/db/retry.lockfile
136 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
137 returned from EXIM_DBOPEN
138 no retry data available
139 search_tidyup called
140 changed uid/gid: local delivery to TESTSUITE/test-mail <TESTSUITE/test-mail> transport=t1
141   uid=CALLER_UID gid=CALLER_GID pid=pppp
142   home=NULL current=/
143 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail using t1
144 appendfile transport entered
145 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
146   directory=TESTSUITE/test-mail format=maildir
147   message_prefix=
148   message_suffix=
149   maildir_use_size_file=no
150 ensuring maildir directories exist in TESTSUITE/test-mail
151 created directory TESTSUITE/test-mail/tmp
152 created directory TESTSUITE/test-mail/new
153 created directory TESTSUITE/test-mail/cur
154 delivering in maildir format in TESTSUITE/test-mail
155 writing to tmp/MAILDIR.mail.test.ex
156 writing data block fd=dddd size=sss timeout=0
157 renaming temporary file
158 renamed tmp/MAILDIR.mail.test.ex as new/MAILDIR.mail.test.ex
159 appendfile yields 0 with errno=dd more_errno=dd
160 search_tidyup called
161 journalling TESTSUITE/test-mail:userx@test.ex
162 t1 transport returned OK for TESTSUITE/test-mail
163 post-process TESTSUITE/test-mail (0)
164 TESTSUITE/test-mail delivered
165 userx@test.ex: children all complete
166 LOG: MAIN
167   => TESTSUITE/test-mail <userx@test.ex> R=r1 T=t1
168 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
169 changed uid/gid: post-delivery tidying
170   uid=EXIM_UID gid=EXIM_GID pid=pppp
171 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
172 Processing retry items
173 Succeeded addresses:
174 TESTSUITE/test-mail: no retry items
175 userx@test.ex: no retry items
176 userx@test.ex: no retry items
177 Failed addresses:
178 Deferred addresses:
179 end of retry processing
180 DSN: processing router : r1
181 DSN: processing successful delivery address: TESTSUITE/test-mail
182 DSN: Sender_address: CALLER@test.ex
183 DSN: orcpt: NULL  flags: 0
184 DSN: envid: NULL  ret: 0
185 DSN: Final recipient: TESTSUITE/test-mail
186 DSN: Remote SMTP server supports DSN: 0
187 DSN: not sending DSN success message
188 DSN: processing router : r1
189 DSN: processing successful delivery address: userx@test.ex
190 DSN: Sender_address: CALLER@test.ex
191 DSN: orcpt: NULL  flags: 0
192 DSN: envid: NULL  ret: 0
193 DSN: Final recipient: userx@test.ex
194 DSN: Remote SMTP server supports DSN: 0
195 DSN: not sending DSN success message
196 LOG: MAIN
197   Completed
198 end delivery of 10HmaX-0005vi-00
199 search_tidyup called
200 search_tidyup called
201 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
202 search_tidyup called
203 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>