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