Debug: more info for string-expansion troubles
[users/heiko/exim.git] / test / stderr / 0487
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 changed uid/gid: privilege not needed
10   uid=EXIM_UID gid=EXIM_GID pid=pppp
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 = NULL
15 set_process_info: pppp accepting a local SMTP message from <CALLER>
16  in hosts_connection_nolog? no (option unset)
17 LOG: smtp_connection MAIN
18   SMTP connection from CALLER
19 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
20 smtp_setup_msg entered
21 SMTP<< ehlo x.y
22  in dsn_advertise_hosts? no (option unset)
23  in pipelining_advertise_hosts? yes (matched "*")
24  in chunking_advertise_hosts? no (end of list)
25 SMTP>> 250-myhost.test.ex Hello CALLER at x.y
26 250-SIZE 52428800
27 250-8BITMIME
28 250-PIPELINING
29 250 HELP
30 SMTP<< mail from:<x@y>
31 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
32 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
33 SMTP>> 250 OK
34 SMTP<< rcpt to:<userx@test.ex>
35 processing "accept"
36 accept: condition test succeeded in inline ACL
37 end of inline ACL: ACCEPT
38 SMTP>> 250 Accepted
39 DSN: orcpt: NULL  flags: 0
40 SMTP<< data
41 SMTP>> 354 Enter message, ending with "." on a line by itself
42 search_tidyup called
43 >>Headers received:
44 From: unqualified
45
46 rewrite_one_header: type=F:
47   From: unqualified
48 search_tidyup called
49 >>Headers after rewriting and local additions:
50 F From: unqualified
51 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
52   Date: Tue, 2 Mar 1999 09:44:33 +0000
53
54 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
55 Data file written for message 10HmaX-0005vi-00
56 >>Generated Received: header line
57 P Received: from CALLER (helo=x.y)
58         by myhost.test.ex with local-esmtp (Exim x.yz)
59         (envelope-from <x@y>)
60         id 10HmaX-0005vi-00
61         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
62 calling local_scan(); timeout=300
63 local_scan() returned 0 NULL
64 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
65 DSN: Write SPOOL :-dsn_envid NULL
66 DSN: Write SPOOL :-dsn_ret 0
67 DSN: Flags :0
68 DSN: **** SPOOL_OUT - address: |userx@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
69 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
70 Size of headers = sss
71 LOG: MAIN
72   <= x@y U=CALLER P=local-esmtp S=sss
73 created log directory TESTSUITE/spool/log
74 SMTP>> 250 OK id=10HmaX-0005vi-00
75 search_tidyup called
76 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
77 Exim version x.yz ....
78 changed uid/gid: forcing real = effective
79   uid=uuuu gid=EXIM_GID pid=pppp
80 seeking password data for user "CALLER": cache not available
81 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
82 configuration file is TESTSUITE/test-config
83 trusted user
84 admin user
85 seeking password data for user "CALLER": using cached result
86 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
87 set_process_info: pppp delivering specified messages
88 set_process_info: pppp delivering 10HmaX-0005vi-00
89 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
90 reading spool file 10HmaX-0005vi-00-H
91 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
92 sender_local=0 ident=CALLER
93 Non-recipients:
94 Empty Tree
95 ---- End of tree ----
96 recipients_count=1
97 **** SPOOL_IN - No additional fields
98 body_linecount=1 message_linecount=8
99 DSN: set orcpt:   flags: 0
100 Delivery address list:
101   userx@test.ex 
102 locking TESTSUITE/spool/db/retry.lockfile
103 locked  TESTSUITE/spool/db/retry.lockfile
104 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
105 returned from EXIM_DBOPEN: (nil)
106 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
107 failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory
108 no retry data available
109 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
110 Considering: userx@test.ex
111 unique = userx@test.ex
112 no domain retry record
113 no address retry record
114 userx@test.ex: queued for routing
115 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
116 routing userx@test.ex
117 --------> r1 router <--------
118 local_part=userx domain=test.ex
119 calling r1 router
120 r1 router called for userx@test.ex
121   domain = test.ex
122 set transport t1
123 queued for t1 transport: local_part = userx
124 domain = test.ex
125   errors_to=NULL
126   domain_data=NULL localpart_data=NULL
127 routed by r1 router
128   envelope to: userx@test.ex
129   transport: t1
130 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
131 After routing:
132   Local deliveries:
133     userx@test.ex
134   Remote deliveries:
135   Failed addresses:
136   Deferred addresses:
137 search_tidyup called
138 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
139 --------> userx@test.ex <--------
140 locking TESTSUITE/spool/db/retry.lockfile
141 locked  TESTSUITE/spool/db/retry.lockfile
142 EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
143 returned from EXIM_DBOPEN: (nil)
144 failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
145 no retry data available
146 search_tidyup called
147 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
148   uid=CALLER_UID gid=CALLER_GID pid=pppp
149   home=NULL current=/
150 set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1
151 appendfile transport entered
152 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
153   file=TESTSUITE/test-mail/userx format=unix
154   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
155   message_suffix=\n
156   maildir_use_size_file=no
157   locking by lockfile fcntl 
158 lock name: TESTSUITE/test-mail/userx.lock
159 hitch name: TESTSUITE/test-mail/userx.lock.test.ex.dddddddd.pppppppp
160 lock file created
161 mailbox TESTSUITE/test-mail/userx is locked
162 writing to file TESTSUITE/test-mail/userx
163 writing data block fd=dddd size=sss timeout=0
164 rewrite_one_header: type=F:
165   From: unqualified
166 cannot use sendfile for body: spoolfile not wireformat
167 writing data block fd=dddd size=sss timeout=0
168 writing data block fd=dddd size=sss timeout=0
169 appendfile yields 0 with errno=dd more_errno=dd
170 search_tidyup called
171 journalling userx@test.ex
172 t1 transport returned OK for userx@test.ex
173 post-process userx@test.ex (0)
174 userx@test.ex delivered
175 LOG: MAIN
176   => userx <userx@test.ex> R=r1 T=t1
177 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
178 changed uid/gid: post-delivery tidying
179   uid=EXIM_UID gid=EXIM_GID pid=pppp
180 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
181 Processing retry items
182 Succeeded addresses:
183  userx@test.ex: no retry items
184 Failed addresses:
185 Deferred addresses:
186 end of retry processing
187 DSN: processing router : r1
188 DSN: processing successful delivery address: userx@test.ex
189 DSN: Sender_address: x@y
190 DSN: orcpt: NULL  flags: 0
191 DSN: envid: NULL  ret: 0
192 DSN: Final recipient: userx@test.ex
193 DSN: Remote SMTP server supports DSN: 0
194 DSN: not sending DSN success message
195 LOG: MAIN
196   Completed
197 end delivery of 10HmaX-0005vi-00
198 search_tidyup called
199 search_tidyup called
200 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
201 smtp_setup_msg entered
202 SMTP<< quit
203 SMTP>> 221 myhost.test.ex closing connection
204 LOG: smtp_connection MAIN
205   SMTP connection from CALLER closed by QUIT
206 search_tidyup called
207 >>>>>>>>>>>>>>>> Exim pid=pppp (msg setup toplevel) terminating with rc=0 >>>>>>>>>>>>>>>>