| 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 | dropping to exim gid; retaining priv uid |
| 7 | set_process_info: pppp delivering specified messages |
| 8 | set_process_info: pppp delivering 10HmaX-0005vi-00 |
| 9 | locking TESTSUITE/spool/db/retry.lockfile |
| 10 | locked TESTSUITE/spool/db/retry.lockfile |
| 11 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 12 | returned from EXIM_DBOPEN: (nil) |
| 13 | ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim |
| 14 | failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory |
| 15 | no retry data available |
| 16 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 17 | Considering: x@y |
| 18 | unique = x@y |
| 19 | no domain retry record |
| 20 | no address retry record |
| 21 | x@y: queued for routing |
| 22 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 23 | routing x@y |
| 24 | --------> r0 router <-------- |
| 25 | local_part=x domain=y |
| 26 | checking local_parts |
| 27 | x in "CALLER"? no (end of list) |
| 28 | r0 router skipped: local_parts mismatch |
| 29 | --------> r1 router <-------- |
| 30 | local_part=x domain=y |
| 31 | calling r1 router |
| 32 | r1 router called for x@y |
| 33 | domain = y |
| 34 | route_item = * "127.0.0.1 : V4NET.0.0.0" |
| 35 | y in "*"? yes (matched "*") |
| 36 | original list of hosts = '127.0.0.1 : V4NET.0.0.0' options = '' |
| 37 | expanded list of hosts = '127.0.0.1 : V4NET.0.0.0' options = '' |
| 38 | set transport smtp |
| 39 | finding IP address for 127.0.0.1 |
| 40 | calling host_find_byname |
| 41 | using host_fake_gethostbyname for 127.0.0.1 (IPv4) |
| 42 | local host found for non-MX address |
| 43 | fully qualified name = 127.0.0.1 |
| 44 | MUNGED: ::1 will be omitted in what follows |
| 45 | get[host|ipnode]byname[2] looked up these IP addresses: |
| 46 | name=127.0.0.1 address=127.0.0.1 |
| 47 | remote host address is the local host: y: configured to try delivery anyway |
| 48 | finding IP address for V4NET.0.0.0 |
| 49 | calling host_find_byname |
| 50 | using host_fake_gethostbyname for V4NET.0.0.0 (IPv4) |
| 51 | fully qualified name = V4NET.0.0.0 |
| 52 | MUNGED: ::1 will be omitted in what follows |
| 53 | get[host|ipnode]byname[2] looked up these IP addresses: |
| 54 | name=V4NET.0.0.0 address=V4NET.0.0.0 |
| 55 | queued for smtp transport: local_part = x |
| 56 | domain = y |
| 57 | errors_to=NULL |
| 58 | domain_data=NULL localpart_data=NULL |
| 59 | routed by r1 router |
| 60 | envelope to: x@y |
| 61 | transport: smtp |
| 62 | host 127.0.0.1 [127.0.0.1] |
| 63 | host V4NET.0.0.0 [V4NET.0.0.0] |
| 64 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 65 | After routing: |
| 66 | Local deliveries: |
| 67 | Remote deliveries: |
| 68 | x@y |
| 69 | Failed addresses: |
| 70 | Deferred addresses: |
| 71 | search_tidyup called |
| 72 | search_tidyup called |
| 73 | changed uid/gid: remote delivery to x@y with transport=smtp |
| 74 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 75 | set_process_info: pppp delivering 10HmaX-0005vi-00 using smtp |
| 76 | checking status of 127.0.0.1 |
| 77 | locking TESTSUITE/spool/db/retry.lockfile |
| 78 | locked TESTSUITE/spool/db/retry.lockfile |
| 79 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 80 | returned from EXIM_DBOPEN: (nil) |
| 81 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 82 | no retry data available |
| 83 | 127.0.0.1 in serialize_hosts? no (option unset) |
| 84 | set_process_info: pppp delivering 10HmaX-0005vi-00 to 127.0.0.1 [127.0.0.1]:PORT_S (x@y) |
| 85 | Connecting to 127.0.0.1 [127.0.0.1]:1224 ... connected |
| 86 | SMTP<< 220 Server ready |
| 87 | 127.0.0.1 in hosts_avoid_esmtp? no (option unset) |
| 88 | SMTP>> EHLO myhost.test.ex |
| 89 | cmd buf flush ddd bytes |
| 90 | SMTP<< 250 OK |
| 91 | 127.0.0.1 in hosts_require_auth? no (option unset) |
| 92 | SMTP>> MAIL FROM:<CALLER@myhost.test.ex> |
| 93 | cmd buf flush ddd bytes |
| 94 | SMTP<< 250 OK |
| 95 | SMTP>> RCPT TO:<x@y> |
| 96 | cmd buf flush ddd bytes |
| 97 | SMTP<< 451 Temporary error |
| 98 | LOG: MAIN |
| 99 | H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@y>: 451 Temporary error |
| 100 | added retry item for R:x@y: errno=-44 more_errno=dd,A flags=0 |
| 101 | SMTP>> QUIT |
| 102 | cmd buf flush ddd bytes |
| 103 | SMTP(close)>> |
| 104 | set_process_info: pppp delivering 10HmaX-0005vi-00: just tried 127.0.0.1 [127.0.0.1]:PORT_S for x@y: result OK |
| 105 | address match test: subject=*@127.0.0.1 pattern=* |
| 106 | 127.0.0.1 in "*"? yes (matched "*") |
| 107 | *@127.0.0.1 in "*"? yes (matched "*") |
| 108 | set_process_info: pppp delivering 10HmaX-0005vi-00: waiting for a remote delivery subprocess to finish |
| 109 | checking status of V4NET.0.0.0 |
| 110 | locking TESTSUITE/spool/db/retry.lockfile |
| 111 | locked TESTSUITE/spool/db/retry.lockfile |
| 112 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 113 | returned from EXIM_DBOPEN: (nil) |
| 114 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 115 | no retry data available |
| 116 | V4NET.0.0.0 in serialize_hosts? no (option unset) |
| 117 | set_process_info: pppp delivering 10HmaX-0005vi-00 to V4NET.0.0.0 [V4NET.0.0.0]:PORT_S (x@y) |
| 118 | Connecting to V4NET.0.0.0 [V4NET.0.0.0]:1224 ... failed: Network Error |
| 119 | LOG: MAIN |
| 120 | H=V4NET.0.0.0 [V4NET.0.0.0] Network Error |
| 121 | set_process_info: pppp delivering 10HmaX-0005vi-00: just tried V4NET.0.0.0 [V4NET.0.0.0]:PORT_S for x@y: result DEFER |
| 122 | added retry item for T:V4NET.0.0.0:V4NET.0.0.0:1224: errno=dd more_errno=dd,A flags=2 |
| 123 | set_process_info: pppp delivering 10HmaX-0005vi-00 (just run smtp for x@y in subprocess) |
| 124 | search_tidyup called |
| 125 | reading retry information for T:V4NET.0.0.0:V4NET.0.0.0:1224 from subprocess |
| 126 | added retry item |
| 127 | reading retry information for R:x@y from subprocess |
| 128 | added retry item |
| 129 | set_process_info: pppp delivering 10HmaX-0005vi-00 |
| 130 | LOG: MAIN |
| 131 | == x@y R=r1 T=smtp defer (dd): Network Error H=127.0.0.1 [127.0.0.1] |
| 132 | changed uid/gid: post-delivery tidying |
| 133 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 134 | set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 |
| 135 | Processing retry items |
| 136 | Succeeded addresses: |
| 137 | Failed addresses: |
| 138 | Deferred addresses: |
| 139 | x@y |
| 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_RDWR |
| 143 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 144 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR |
| 145 | address match test: subject=x@y pattern=* |
| 146 | y in "*"? yes (matched "*") |
| 147 | x@y in "*"? yes (matched "*") |
| 148 | retry for R:x@y = * 0 0 |
| 149 | dbfn_read: key=R:x@y |
| 150 | failing_interval=ttt message_age=ttt |
| 151 | Writing retry data for R:x@y |
| 152 | first failed=dddd last try=dddd next try=+1 expired=1 |
| 153 | errno=-44 more_errno=dd,A H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<x@y>: 451 Temporary error |
| 154 | dbfn_write: key=R:x@y |
| 155 | address match test: subject=*@V4NET.0.0.0 pattern=* |
| 156 | V4NET.0.0.0 in "*"? yes (matched "*") |
| 157 | *@V4NET.0.0.0 in "*"? yes (matched "*") |
| 158 | retry for T:V4NET.0.0.0:V4NET.0.0.0:1224 (y) = * 0 0 |
| 159 | dbfn_read: key=T:V4NET.0.0.0:V4NET.0.0.0:1224 |
| 160 | failing_interval=ttt message_age=ttt |
| 161 | on queue longer than maximum retry |
| 162 | Writing retry data for T:V4NET.0.0.0:V4NET.0.0.0:1224 |
| 163 | first failed=dddd last try=dddd next try=+0 expired=0 |
| 164 | errno=dd more_errno=dd,A Network Error |
| 165 | dbfn_write: key=T:V4NET.0.0.0:V4NET.0.0.0:1224 |
| 166 | timed out: all retries expired |
| 167 | LOG: MAIN |
| 168 | ** x@y: retry timeout exceeded |
| 169 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 170 | closed hints database and lockfile |
| 171 | end of retry processing |
| 172 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xd7715ced -odi -odi -t -oem -oi -f <> -E10HmaX-0005vi-00 |
| 173 | Exim version x.yz .... |
| 174 | changed uid/gid: forcing real = effective |
| 175 | uid=uuuu gid=EXIM_GID pid=pppp |
| 176 | configuration file is TESTSUITE/test-config |
| 177 | trusted user |
| 178 | admin user |
| 179 | changed uid/gid: privilege not needed |
| 180 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 181 | originator: uid=EXIM_UID gid=EXIM_GID login=EXIMUSER name= |
| 182 | sender address = |
| 183 | set_process_info: pppp accepting a local non-SMTP message from <> |
| 184 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
| 185 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
| 186 | Sender: |
| 187 | search_tidyup called |
| 188 | >>Headers received: |
| 189 | X-Failed-Recipients: x@y |
| 190 | Auto-Submitted: auto-replied |
| 191 | From: Mail Delivery System <Mailer-Daemon@myhost.test.ex> |
| 192 | To: CALLER@myhost.test.ex |
| 193 | Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM |
| 194 | MIME-Version: 1.0 |
| 195 | Subject: Mail delivery failed: returning message to sender |
| 196 | |
| 197 | rewrite_one_header: type=F: |
| 198 | From: Mail Delivery System <Mailer-Daemon@myhost.test.ex> |
| 199 | rewrite_one_header: type=T: |
| 200 | To: CALLER@myhost.test.ex |
| 201 | search_tidyup called |
| 202 | >>Headers after rewriting and local additions: |
| 203 | X-Failed-Recipients: x@y |
| 204 | Auto-Submitted: auto-replied |
| 205 | F From: Mail Delivery System <Mailer-Daemon@myhost.test.ex> |
| 206 | T To: CALLER@myhost.test.ex |
| 207 | Content-Type: multipart/report; report-type=delivery-status; boundary=NNNNNNNNNN-eximdsn-MMMMMMMMMM |
| 208 | MIME-Version: 1.0 |
| 209 | Subject: Mail delivery failed: returning message to sender |
| 210 | I Message-Id: <E10HmaY-0005vi-00@myhost.test.ex> |
| 211 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
| 212 | |
| 213 | Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D |
| 214 | Data file written for message 10HmaY-0005vi-00 |
| 215 | >>Generated Received: header line |
| 216 | P Received: from EXIMUSER by myhost.test.ex with local (Exim x.yz) |
| 217 | id 10HmaY-0005vi-00 |
| 218 | for CALLER@myhost.test.ex; Tue, 2 Mar 1999 09:44:33 +0000 |
| 219 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-0005vi-00 |
| 220 | Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H |
| 221 | Size of headers = sss |
| 222 | LOG: MAIN |
| 223 | <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss |
| 224 | search_tidyup called |
| 225 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xd7715ced -odi -Mc 10HmaY-0005vi-00 |
| 226 | Exim version x.yz .... |
| 227 | changed uid/gid: forcing real = effective |
| 228 | uid=uuuu gid=EXIM_GID pid=pppp |
| 229 | configuration file is TESTSUITE/test-config |
| 230 | trusted user |
| 231 | admin user |
| 232 | dropping to exim gid; retaining priv uid |
| 233 | set_process_info: pppp delivering specified messages |
| 234 | set_process_info: pppp delivering 10HmaY-0005vi-00 |
| 235 | locking TESTSUITE/spool/db/retry.lockfile |
| 236 | locked TESTSUITE/spool/db/retry.lockfile |
| 237 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 238 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 239 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY |
| 240 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 241 | Considering: CALLER@myhost.test.ex |
| 242 | unique = CALLER@myhost.test.ex |
| 243 | dbfn_read: key=R:myhost.test.ex |
| 244 | dbfn_read: key=R:CALLER@myhost.test.ex |
| 245 | dbfn_read: key=R:CALLER@myhost.test.ex:<> |
| 246 | no domain retry record |
| 247 | no address retry record |
| 248 | CALLER@myhost.test.ex: queued for routing |
| 249 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 250 | closed hints database and lockfile |
| 251 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 252 | routing CALLER@myhost.test.ex |
| 253 | --------> r0 router <-------- |
| 254 | local_part=CALLER domain=myhost.test.ex |
| 255 | checking local_parts |
| 256 | CALLER in "CALLER"? yes (matched "CALLER") |
| 257 | checking senders |
| 258 | address match test: subject= pattern= |
| 259 | in ":"? yes (matched "") |
| 260 | calling r0 router |
| 261 | rda_interpret (string): :blackhole: |
| 262 | expanded: :blackhole: |
| 263 | file is not a filter file |
| 264 | parse_forward_list: :blackhole: |
| 265 | extract item: :blackhole: |
| 266 | address :blackhole:d |
| 267 | LOG: MAIN |
| 268 | => :blackhole: <CALLER@myhost.test.ex> R=r0 |
| 269 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 270 | After routing: |
| 271 | Local deliveries: |
| 272 | Remote deliveries: |
| 273 | Failed addresses: |
| 274 | Deferred addresses: |
| 275 | search_tidyup called |
| 276 | changed uid/gid: post-delivery tidying |
| 277 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 278 | set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00 |
| 279 | Processing retry items |
| 280 | Succeeded addresses: |
| 281 | CALLER@myhost.test.ex: no retry items |
| 282 | Failed addresses: |
| 283 | Deferred addresses: |
| 284 | end of retry processing |
| 285 | LOG: MAIN |
| 286 | Completed |
| 287 | search_tidyup called |
| 288 | search_tidyup called |
| 289 | >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 290 | search_tidyup called |
| 291 | >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 292 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00 |
| 293 | Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H |
| 294 | Size of headers = sss |
| 295 | LOG: MAIN |
| 296 | Completed |
| 297 | search_tidyup called |
| 298 | search_tidyup called |
| 299 | >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>> |