802d98a7185745d2338dc232352733b9943418ea
[exim.git] / test / stderr / 0628
1 01:01:01 p1237  warn: condition test succeeded in ACL "chk_data"
2 01:01:01 p1237  processing "accept" (TESTSUITE/test-config 28)
3 01:01:01 p1237  accept: condition test succeeded in ACL "chk_data"
4 01:01:01 p1237  end of ACL "chk_data": ACCEPT
5 01:01:01 p1237   ╭considering: ${tod_full}
6 01:01:01 p1237   ├───expanded: ${tod_full}
7 01:01:01 p1237   ╰─────result: Tue,░2░Mar░1999░09:44:33░+0000
8 01:01:01 p1237  Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-000000005vi-0000
9 01:01:01 p1237  DSN: **** SPOOL_OUT - address: <dest@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
10 01:01:01 p1237  Renaming spool header file: TESTSUITE/spool//input//10HmaX-000000005vi-0000-H
11 01:01:01 p1237  Size of headers = sss
12 01:01:01 p1237  LOG: MAIN
13 01:01:01 p1237    <= tester@test.ex H=(test.ex) [127.0.0.1] P=esmtp S=sss
14 01:01:01 p1237  SMTP>> 250 OK id=10HmaX-000000005vi-0000
15 01:01:01 p1237  search_tidyup called
16 01:01:01 p1237  Sender: tester@test.ex
17 01:01:01 p1237  Recipients:
18 01:01:01 p1237    dest@test.ex
19 01:01:01 p1237  forked delivery processp1238 
20 01:01:01 p1237  Process p1237 is ready for new message
21 01:01:01 p1237  smtp_setup_msg entered
22 01:01:01 p1237  SMTP<< QUIT
23 01:01:01 p1237  try option acl_smtp_quit
24 01:01:01 p1237  SMTP>> 221 myhost.test.ex closing connection
25 01:01:01 p1237  LOG: smtp_connection MAIN
26 01:01:01 p1237    SMTP connection from (test.ex) [127.0.0.1] D=qqs closed by QUIT
27 01:01:01 p1239  Exim version x.yz uid=EXIM_UID gid=EXIM_GID pid=p1239 D=fff9ffff
28 01:01:01 p1239  Hints DB:
29 01:01:01 p1239  macros_trusted overridden to true by whitelisting
30 01:01:01 p1239  changed uid/gid: forcing real = effective
31 01:01:01 p1239    uid=uuuu gid=EXIM_GID pid=p1239
32 01:01:01 p1239  environment after trimming:
33 01:01:01 p1239   PATH=<munged>
34 01:01:01 p1239  adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys
35 01:01:01 p1239  configuration file is TESTSUITE/test-config
36 01:01:01 p1239  trusted user
37 01:01:01 p1239  admin user
38 01:01:01 p1239  dropping to exim gid; retaining priv uid
39 01:01:01 p1239  set_process_info: pppp delivering specified messages
40 01:01:01 p1239  set_process_info: pppp delivering 10HmaX-000000005vi-0000
41 01:01:01 p1239  Trying spool file TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
42 01:01:01 p1239  reading spool file 10HmaX-000000005vi-0000-H
43 01:01:01 p1239  user=EXIMUSER uid=EXIM_UID gid=EXIM_GID sender=tester@test.ex
44 01:01:01 p1239  sender_fullhost = (test.ex) [127.0.0.1]
45 01:01:01 p1239  sender_rcvhost = [127.0.0.1] (helo=test.ex)
46 01:01:01 p1239  sender_local=0 ident=unset
47 01:01:01 p1239  Non-recipients:
48 01:01:01 p1239   Empty Tree
49 01:01:01 p1239  ---- End of tree ----
50 01:01:01 p1239  recipients_count=1
51 01:01:01 p1239  **** SPOOL_IN - No additional fields
52 01:01:01 p1239  body_linecount=1 message_linecount=7
53 01:01:01 p1239  DSN: set orcpt:   flags: 0x0
54 01:01:01 p1239  Delivery address list:
55 01:01:01 p1239    dest@test.ex 
56 01:01:01 p1239   locking TESTSUITE/spool/db/retry.lockfile
57 01:01:01 p1239   locked  TESTSUITE/spool/db/retry.lockfile
58 01:01:01 p1239   EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
59 01:01:01 p1239   returned from EXIM_DBOPEN: (nil)
60 01:01:01 p1239   failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
61 01:01:01 p1239  no retry data available
62 01:01:01 p1239  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
63 01:01:01 p1239  Considering: dest@test.ex
64 01:01:01 p1239  unique = dest@test.ex
65 01:01:01 p1239  no   domain  retry record
66 01:01:01 p1239  no   address retry record
67 01:01:01 p1239  dest@test.ex: queued for routing
68 01:01:01 p1239  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
69 01:01:01 p1239  routing dest@test.ex
70 01:01:01 p1239  --------> r1 router <--------
71 01:01:01 p1239  local_part=dest domain=test.ex
72 01:01:01 p1239  try option router_home_directory
73 01:01:01 p1239  try option set
74 01:01:01 p1239  calling r1 router
75 01:01:01 p1239  try option qualify_domain
76 01:01:01 p1239  rda_interpret (string): ':blackhole:'
77 01:01:01 p1239  expanded: ':blackhole:'
78 01:01:01 p1239  file is not a filter file
79 01:01:01 p1239  parse_forward_list: :blackhole:
80 01:01:01 p1239  extract item: :blackhole:
81 01:01:01 p1239  address :blackhole:d
82 01:01:01 p1239  LOG: MAIN
83 01:01:01 p1239    => :blackhole: <dest@test.ex> R=r1
84 01:01:01 p1239  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
85 01:01:01 p1239  After routing:
86 01:01:01 p1239    Local deliveries:
87 01:01:01 p1239    Remote deliveries:
88 01:01:01 p1239    Failed addresses:
89 01:01:01 p1239    Deferred addresses:
90 01:01:01 p1239  search_tidyup called
91 01:01:01 p1239  >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
92 01:01:01 p1239  changed uid/gid: post-delivery tidying
93 01:01:01 p1239    uid=EXIM_UID gid=EXIM_GID pid=p1239
94 01:01:01 p1239  set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
95 01:01:01 p1239  Processing retry items
96 01:01:01 p1239  Succeeded addresses:
97 01:01:01 p1239   dest@test.ex: no retry items
98 01:01:01 p1239  Failed addresses:
99 01:01:01 p1239  Deferred addresses:
100 01:01:01 p1239  end of retry processing
101 01:01:01 p1239  DSN: processing router : r1
102 01:01:01 p1239  DSN: processing successful delivery address: dest@test.ex
103 01:01:01 p1239  DSN: Sender_address: tester@test.ex
104 01:01:01 p1239  DSN: orcpt: NULL  flags: 0x0
105 01:01:01 p1239  DSN: envid: NULL  ret: 0
106 01:01:01 p1239  DSN: Final recipient: dest@test.ex
107 01:01:01 p1239  DSN: Remote SMTP server supports DSN: 0
108 01:01:01 p1239  DSN: not sending DSN success message
109 01:01:01 p1239  LOG: MAIN
110 01:01:01 p1239    Completed
111 01:01:01 p1239  end delivery of 10HmaX-000000005vi-0000
112 01:01:01 p1239  search_tidyup called
113 01:01:01 p1239  search_tidyup called
114 01:01:01 p1239  >>>>>>>>>>>>>>>> Exim pid=p1239 (daemon-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
115 01:01:01 p1237  search_tidyup called
116 01:01:01 p1237  SMTP>>(close on process exit)
117 01:01:01 p1237  >>>>>>>>>>>>>>>> Exim pid=p1237 (daemon-accept) terminating with rc=0 >>>>>>>>>>>>>>>>
118 01:01:01 p1240  check control = queue_only
119 01:01:01 p1240  warn: condition test succeeded in ACL "chk_data"
120 01:01:01 p1240  processing "accept" (TESTSUITE/test-config 28)
121 01:01:01 p1240  accept: condition test succeeded in ACL "chk_data"
122 01:01:01 p1240  end of ACL "chk_data": ACCEPT
123 01:01:01 p1240   ╭considering: ${tod_full}
124 01:01:01 p1240   ├───expanded: ${tod_full}
125 01:01:01 p1240   ╰─────result: Tue,░2░Mar░1999░09:44:33░+0000
126 01:01:01 p1240  Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-000000005vi-0000
127 01:01:01 p1240  DSN: **** SPOOL_OUT - address: <dest2@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
128 01:01:01 p1240  Renaming spool header file: TESTSUITE/spool//input//10HmaY-000000005vi-0000-H
129 01:01:01 p1240  Size of headers = sss
130 01:01:01 p1240  LOG: MAIN
131 01:01:01 p1240    <= tester2@test.ex H=(test.ex) [127.0.0.1] P=esmtp S=sss
132 01:01:01 p1240  LOG: delay_delivery MAIN
133 01:01:01 p1240    no immediate delivery: queued by ACL
134 01:01:01 p1240  SMTP>> 250 OK id=10HmaY-000000005vi-0000
135 01:01:01 p1240  search_tidyup called
136 01:01:01 p1240  Sender: tester2@test.ex
137 01:01:01 p1240  Recipients:
138 01:01:01 p1240    dest2@test.ex
139 01:01:01 p1240  Process p1240 is ready for new message
140 01:01:01 p1240  smtp_setup_msg entered
141 01:01:01 p1240  SMTP<< QUIT
142 01:01:01 p1240  try option acl_smtp_quit
143 01:01:01 p1240  SMTP>> 221 myhost.test.ex closing connection
144 01:01:01 p1240  LOG: smtp_connection MAIN
145 01:01:01 p1240    SMTP connection from (test.ex) [127.0.0.1] D=qqs closed by QUIT
146 01:01:01 p1240  search_tidyup called
147 01:01:01 p1240  SMTP>>(close on process exit)
148 01:01:01 p1240  >>>>>>>>>>>>>>>> Exim pid=p1240 (daemon-accept) terminating with rc=0 >>>>>>>>>>>>>>>>
149 01:01:01 p1241  debug enabled by spoolfile
150 01:01:01 p1241  sender_fullhost = (test.ex) [127.0.0.1]
151 01:01:01 p1241  sender_rcvhost = [127.0.0.1] (helo=test.ex)
152 01:01:01 p1241  sender_local=0 ident=unset
153 01:01:01 p1241  Non-recipients:
154 01:01:01 p1241   Empty Tree
155 01:01:01 p1241  ---- End of tree ----
156 01:01:01 p1241  recipients_count=1
157 01:01:01 p1241  **** SPOOL_IN - No additional fields
158 01:01:01 p1241  body_linecount=1 message_linecount=7
159 01:01:01 p1241  DSN: set orcpt:   flags: 0x0
160 01:01:01 p1241  Delivery address list:
161 01:01:01 p1241    dest2@test.ex 
162 01:01:01 p1241   locking TESTSUITE/spool/db/retry.lockfile
163 01:01:01 p1241   locked  TESTSUITE/spool/db/retry.lockfile
164 01:01:01 p1241   EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
165 01:01:01 p1241   returned from EXIM_DBOPEN: (nil)
166 01:01:01 p1241   failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
167 01:01:01 p1241  no retry data available
168 01:01:01 p1241  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
169 01:01:01 p1241  Considering: dest2@test.ex
170 01:01:01 p1241  unique = dest2@test.ex
171 01:01:01 p1241  no   domain  retry record
172 01:01:01 p1241  no   address retry record
173 01:01:01 p1241  dest2@test.ex: queued for routing
174 01:01:01 p1241  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
175 01:01:01 p1241  routing dest2@test.ex
176 01:01:01 p1241  --------> r1 router <--------
177 01:01:01 p1241  local_part=dest2 domain=test.ex
178 01:01:01 p1241  try option router_home_directory
179 01:01:01 p1241  try option set
180 01:01:01 p1241  calling r1 router
181 01:01:01 p1241  try option qualify_domain
182 01:01:01 p1241  rda_interpret (string): ':blackhole:'
183 01:01:01 p1241  expanded: ':blackhole:'
184 01:01:01 p1241  file is not a filter file
185 01:01:01 p1241  parse_forward_list: :blackhole:
186 01:01:01 p1241  extract item: :blackhole:
187 01:01:01 p1241  address :blackhole:d
188 01:01:01 p1241  LOG: MAIN
189 01:01:01 p1241    => :blackhole: <dest2@test.ex> R=r1
190 01:01:01 p1241  >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
191 01:01:01 p1241  After routing:
192 01:01:01 p1241    Local deliveries:
193 01:01:01 p1241    Remote deliveries:
194 01:01:01 p1241    Failed addresses:
195 01:01:01 p1241    Deferred addresses:
196 01:01:01 p1241  search_tidyup called
197 01:01:01 p1241  >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
198 01:01:01 p1241  changed uid/gid: post-delivery tidying
199 01:01:01 p1241    uid=EXIM_UID gid=EXIM_GID pid=p1241
200 01:01:01 p1241  set_process_info: pppp tidying up after delivering 10HmaY-000000005vi-0000
201 01:01:01 p1241  Processing retry items
202 01:01:01 p1241  Succeeded addresses:
203 01:01:01 p1241   dest2@test.ex: no retry items
204 01:01:01 p1241  Failed addresses:
205 01:01:01 p1241  Deferred addresses:
206 01:01:01 p1241  end of retry processing
207 01:01:01 p1241  DSN: processing router : r1
208 01:01:01 p1241  DSN: processing successful delivery address: dest2@test.ex
209 01:01:01 p1241  DSN: Sender_address: tester2@test.ex
210 01:01:01 p1241  DSN: orcpt: NULL  flags: 0x0
211 01:01:01 p1241  DSN: envid: NULL  ret: 0
212 01:01:01 p1241  DSN: Final recipient: dest2@test.ex
213 01:01:01 p1241  DSN: Remote SMTP server supports DSN: 0
214 01:01:01 p1241  DSN: not sending DSN success message
215 01:01:01 p1241  LOG: MAIN
216 01:01:01 p1241    Completed
217 01:01:01 p1241  end delivery of 10HmaY-000000005vi-0000
218 01:01:01 p1241  search_tidyup called
219 01:01:01 p1241  >>>>>>>>>>>>>>>> Exim pid=p1241 (qrun-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
220
221 ******** SERVER ********