| 1 | Exim version x.yz .... |
| 2 | configuration file is TESTSUITE/test-config |
| 3 | admin user |
| 4 | LOG: MAIN |
| 5 | <= CALLER@myhost.test.ex U=CALLER P=local S=sss |
| 6 | created log directory TESTSUITE/spool/log |
| 7 | Exim version x.yz .... |
| 8 | configuration file is TESTSUITE/test-config |
| 9 | trusted user |
| 10 | admin user |
| 11 | locking TESTSUITE/spool/db/retry.lockfile |
| 12 | no retry data available |
| 13 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 14 | Considering: a1@myhost.test.ex |
| 15 | unique = a1@myhost.test.ex |
| 16 | a1@myhost.test.ex: queued for routing |
| 17 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 18 | Considering: b1@myhost.test.ex |
| 19 | unique = b1@myhost.test.ex |
| 20 | b1@myhost.test.ex: queued for routing |
| 21 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 22 | Considering: c1@myhost.test.ex |
| 23 | unique = c1@myhost.test.ex |
| 24 | c1@myhost.test.ex: queued for routing |
| 25 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 26 | Considering: d1@myhost.test.ex |
| 27 | unique = d1@myhost.test.ex |
| 28 | d1@myhost.test.ex: queued for routing |
| 29 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 30 | Considering: d2@myhost.test.ex |
| 31 | unique = d2@myhost.test.ex |
| 32 | d2@myhost.test.ex: queued for routing |
| 33 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 34 | Considering: d3@myhost.test.ex |
| 35 | unique = d3@myhost.test.ex |
| 36 | d3@myhost.test.ex: queued for routing |
| 37 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 38 | routing d3@myhost.test.ex |
| 39 | --------> u1 router <-------- |
| 40 | local_part=d3 domain=myhost.test.ex |
| 41 | checking local_parts |
| 42 | u1 router skipped: local_parts mismatch |
| 43 | --------> ut2 router <-------- |
| 44 | local_part=d3 domain=myhost.test.ex |
| 45 | checking local_parts |
| 46 | ut2 router skipped: local_parts mismatch |
| 47 | --------> ut3 router <-------- |
| 48 | local_part=d3 domain=myhost.test.ex |
| 49 | checking local_parts |
| 50 | ut3 router skipped: local_parts mismatch |
| 51 | --------> ut4 router <-------- |
| 52 | local_part=d3 domain=myhost.test.ex |
| 53 | checking local_parts |
| 54 | calling ut4 router |
| 55 | ut4 router called for d3@myhost.test.ex |
| 56 | domain = myhost.test.ex |
| 57 | set transport ut4 |
| 58 | queued for ut4 transport: local_part = d3 |
| 59 | domain = myhost.test.ex |
| 60 | errors_to=NULL |
| 61 | domain_data=NULL localpart_data=NULL |
| 62 | routed by ut4 router (unseen) |
| 63 | envelope to: d3@myhost.test.ex |
| 64 | transport: ut4 |
| 65 | "unseen" set: replicated d3@myhost.test.ex |
| 66 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 67 | routing d2@myhost.test.ex |
| 68 | --------> u1 router <-------- |
| 69 | local_part=d2 domain=myhost.test.ex |
| 70 | checking local_parts |
| 71 | u1 router skipped: local_parts mismatch |
| 72 | --------> ut2 router <-------- |
| 73 | local_part=d2 domain=myhost.test.ex |
| 74 | checking local_parts |
| 75 | ut2 router skipped: local_parts mismatch |
| 76 | --------> ut3 router <-------- |
| 77 | local_part=d2 domain=myhost.test.ex |
| 78 | checking local_parts |
| 79 | ut3 router skipped: local_parts mismatch |
| 80 | --------> ut4 router <-------- |
| 81 | local_part=d2 domain=myhost.test.ex |
| 82 | checking local_parts |
| 83 | calling ut4 router |
| 84 | ut4 router called for d2@myhost.test.ex |
| 85 | domain = myhost.test.ex |
| 86 | queued for ut4 transport: local_part = d2 |
| 87 | domain = myhost.test.ex |
| 88 | errors_to=NULL |
| 89 | domain_data=NULL localpart_data=NULL |
| 90 | routed by ut4 router (unseen) |
| 91 | envelope to: d2@myhost.test.ex |
| 92 | transport: ut4 |
| 93 | "unseen" set: replicated d2@myhost.test.ex |
| 94 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 95 | routing d1@myhost.test.ex |
| 96 | --------> u1 router <-------- |
| 97 | local_part=d1 domain=myhost.test.ex |
| 98 | checking local_parts |
| 99 | u1 router skipped: local_parts mismatch |
| 100 | --------> ut2 router <-------- |
| 101 | local_part=d1 domain=myhost.test.ex |
| 102 | checking local_parts |
| 103 | ut2 router skipped: local_parts mismatch |
| 104 | --------> ut3 router <-------- |
| 105 | local_part=d1 domain=myhost.test.ex |
| 106 | checking local_parts |
| 107 | ut3 router skipped: local_parts mismatch |
| 108 | --------> ut4 router <-------- |
| 109 | local_part=d1 domain=myhost.test.ex |
| 110 | checking local_parts |
| 111 | calling ut4 router |
| 112 | ut4 router called for d1@myhost.test.ex |
| 113 | domain = myhost.test.ex |
| 114 | queued for ut4 transport: local_part = d1 |
| 115 | domain = myhost.test.ex |
| 116 | errors_to=NULL |
| 117 | domain_data=NULL localpart_data=NULL |
| 118 | routed by ut4 router (unseen) |
| 119 | envelope to: d1@myhost.test.ex |
| 120 | transport: ut4 |
| 121 | "unseen" set: replicated d1@myhost.test.ex |
| 122 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 123 | routing c1@myhost.test.ex |
| 124 | --------> u1 router <-------- |
| 125 | local_part=c1 domain=myhost.test.ex |
| 126 | checking local_parts |
| 127 | u1 router skipped: local_parts mismatch |
| 128 | --------> ut2 router <-------- |
| 129 | local_part=c1 domain=myhost.test.ex |
| 130 | checking local_parts |
| 131 | ut2 router skipped: local_parts mismatch |
| 132 | --------> ut3 router <-------- |
| 133 | local_part=c1 domain=myhost.test.ex |
| 134 | checking local_parts |
| 135 | calling ut3 router |
| 136 | ut3 router called for c1@myhost.test.ex |
| 137 | domain = myhost.test.ex |
| 138 | set transport ut3 |
| 139 | queued for ut3 transport: local_part = c1 |
| 140 | domain = myhost.test.ex |
| 141 | errors_to=NULL |
| 142 | domain_data=NULL localpart_data=NULL |
| 143 | routed by ut3 router (unseen) |
| 144 | envelope to: c1@myhost.test.ex |
| 145 | transport: ut3 |
| 146 | "unseen" set: replicated c1@myhost.test.ex |
| 147 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 148 | routing b1@myhost.test.ex |
| 149 | --------> u1 router <-------- |
| 150 | local_part=b1 domain=myhost.test.ex |
| 151 | checking local_parts |
| 152 | u1 router skipped: local_parts mismatch |
| 153 | --------> ut2 router <-------- |
| 154 | local_part=b1 domain=myhost.test.ex |
| 155 | checking local_parts |
| 156 | calling ut2 router |
| 157 | ut2 router called for b1@myhost.test.ex |
| 158 | domain = myhost.test.ex |
| 159 | set transport ut2 |
| 160 | queued for ut2 transport: local_part = b1 |
| 161 | domain = myhost.test.ex |
| 162 | errors_to=NULL |
| 163 | domain_data=NULL localpart_data=NULL |
| 164 | routed by ut2 router (unseen) |
| 165 | envelope to: b1@myhost.test.ex |
| 166 | transport: ut2 |
| 167 | "unseen" set: replicated b1@myhost.test.ex |
| 168 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 169 | routing a1@myhost.test.ex |
| 170 | --------> u1 router <-------- |
| 171 | local_part=a1 domain=myhost.test.ex |
| 172 | checking local_parts |
| 173 | calling u1 router |
| 174 | u1 router called for a1@myhost.test.ex |
| 175 | domain = myhost.test.ex |
| 176 | set transport ut1 |
| 177 | queued for ut1 transport: local_part = a1 |
| 178 | domain = myhost.test.ex |
| 179 | errors_to=NULL |
| 180 | domain_data=NULL localpart_data=NULL |
| 181 | routed by u1 router (unseen) |
| 182 | envelope to: a1@myhost.test.ex |
| 183 | transport: ut1 |
| 184 | "unseen" set: replicated a1@myhost.test.ex |
| 185 | locking TESTSUITE/spool/db/retry.lockfile |
| 186 | no retry data available |
| 187 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 188 | Considering: a1@myhost.test.ex |
| 189 | unique = \0\a1@myhost.test.ex |
| 190 | a1@myhost.test.ex: queued for routing |
| 191 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 192 | Considering: b1@myhost.test.ex |
| 193 | unique = \0\b1@myhost.test.ex |
| 194 | b1@myhost.test.ex: queued for routing |
| 195 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 196 | Considering: c1@myhost.test.ex |
| 197 | unique = \0\c1@myhost.test.ex |
| 198 | c1@myhost.test.ex: queued for routing |
| 199 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 200 | Considering: d1@myhost.test.ex |
| 201 | unique = \0\d1@myhost.test.ex |
| 202 | d1@myhost.test.ex: queued for routing |
| 203 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 204 | Considering: d2@myhost.test.ex |
| 205 | unique = \0\d2@myhost.test.ex |
| 206 | d2@myhost.test.ex: queued for routing |
| 207 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 208 | Considering: d3@myhost.test.ex |
| 209 | unique = \0\d3@myhost.test.ex |
| 210 | d3@myhost.test.ex: queued for routing |
| 211 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 212 | routing d3@myhost.test.ex |
| 213 | --------> real router <-------- |
| 214 | local_part=d3 domain=myhost.test.ex |
| 215 | calling real router |
| 216 | real router called for d3@myhost.test.ex |
| 217 | domain = myhost.test.ex |
| 218 | set transport real |
| 219 | queued for real transport: local_part = d3 |
| 220 | domain = myhost.test.ex |
| 221 | errors_to=NULL |
| 222 | domain_data=NULL localpart_data=NULL |
| 223 | routed by real router |
| 224 | envelope to: d3@myhost.test.ex |
| 225 | transport: real |
| 226 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 227 | routing d2@myhost.test.ex |
| 228 | --------> real router <-------- |
| 229 | local_part=d2 domain=myhost.test.ex |
| 230 | calling real router |
| 231 | real router called for d2@myhost.test.ex |
| 232 | domain = myhost.test.ex |
| 233 | queued for real transport: local_part = d2 |
| 234 | domain = myhost.test.ex |
| 235 | errors_to=NULL |
| 236 | domain_data=NULL localpart_data=NULL |
| 237 | routed by real router |
| 238 | envelope to: d2@myhost.test.ex |
| 239 | transport: real |
| 240 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 241 | routing d1@myhost.test.ex |
| 242 | --------> real router <-------- |
| 243 | local_part=d1 domain=myhost.test.ex |
| 244 | calling real router |
| 245 | real router called for d1@myhost.test.ex |
| 246 | domain = myhost.test.ex |
| 247 | queued for real transport: local_part = d1 |
| 248 | domain = myhost.test.ex |
| 249 | errors_to=NULL |
| 250 | domain_data=NULL localpart_data=NULL |
| 251 | routed by real router |
| 252 | envelope to: d1@myhost.test.ex |
| 253 | transport: real |
| 254 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 255 | routing c1@myhost.test.ex |
| 256 | --------> ut4 router <-------- |
| 257 | local_part=c1 domain=myhost.test.ex |
| 258 | checking local_parts |
| 259 | ut4 router skipped: local_parts mismatch |
| 260 | --------> real router <-------- |
| 261 | local_part=c1 domain=myhost.test.ex |
| 262 | calling real router |
| 263 | real router called for c1@myhost.test.ex |
| 264 | domain = myhost.test.ex |
| 265 | queued for real transport: local_part = c1 |
| 266 | domain = myhost.test.ex |
| 267 | errors_to=NULL |
| 268 | domain_data=NULL localpart_data=NULL |
| 269 | routed by real router |
| 270 | envelope to: c1@myhost.test.ex |
| 271 | transport: real |
| 272 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 273 | routing b1@myhost.test.ex |
| 274 | --------> ut3 router <-------- |
| 275 | local_part=b1 domain=myhost.test.ex |
| 276 | checking local_parts |
| 277 | ut3 router skipped: local_parts mismatch |
| 278 | --------> ut4 router <-------- |
| 279 | local_part=b1 domain=myhost.test.ex |
| 280 | checking local_parts |
| 281 | ut4 router skipped: local_parts mismatch |
| 282 | --------> real router <-------- |
| 283 | local_part=b1 domain=myhost.test.ex |
| 284 | calling real router |
| 285 | real router called for b1@myhost.test.ex |
| 286 | domain = myhost.test.ex |
| 287 | queued for real transport: local_part = b1 |
| 288 | domain = myhost.test.ex |
| 289 | errors_to=NULL |
| 290 | domain_data=NULL localpart_data=NULL |
| 291 | routed by real router |
| 292 | envelope to: b1@myhost.test.ex |
| 293 | transport: real |
| 294 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 295 | routing a1@myhost.test.ex |
| 296 | --------> ut2 router <-------- |
| 297 | local_part=a1 domain=myhost.test.ex |
| 298 | checking local_parts |
| 299 | ut2 router skipped: local_parts mismatch |
| 300 | --------> ut3 router <-------- |
| 301 | local_part=a1 domain=myhost.test.ex |
| 302 | checking local_parts |
| 303 | ut3 router skipped: local_parts mismatch |
| 304 | --------> ut4 router <-------- |
| 305 | local_part=a1 domain=myhost.test.ex |
| 306 | checking local_parts |
| 307 | ut4 router skipped: local_parts mismatch |
| 308 | --------> real router <-------- |
| 309 | local_part=a1 domain=myhost.test.ex |
| 310 | calling real router |
| 311 | real router called for a1@myhost.test.ex |
| 312 | domain = myhost.test.ex |
| 313 | queued for real transport: local_part = a1 |
| 314 | domain = myhost.test.ex |
| 315 | errors_to=NULL |
| 316 | domain_data=NULL localpart_data=NULL |
| 317 | routed by real router |
| 318 | envelope to: a1@myhost.test.ex |
| 319 | transport: real |
| 320 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 321 | After routing: |
| 322 | Local deliveries: |
| 323 | a1@myhost.test.ex |
| 324 | b1@myhost.test.ex |
| 325 | c1@myhost.test.ex |
| 326 | d1@myhost.test.ex |
| 327 | d2@myhost.test.ex |
| 328 | d3@myhost.test.ex |
| 329 | a1@myhost.test.ex |
| 330 | b1@myhost.test.ex |
| 331 | c1@myhost.test.ex |
| 332 | Remote deliveries: |
| 333 | d1@myhost.test.ex |
| 334 | d2@myhost.test.ex |
| 335 | d3@myhost.test.ex |
| 336 | Failed addresses: |
| 337 | Deferred addresses: |
| 338 | locking TESTSUITE/spool/db/retry.lockfile |
| 339 | LOG: MAIN |
| 340 | => a1 <a1@myhost.test.ex> R=real T=real |
| 341 | locking TESTSUITE/spool/db/retry.lockfile |
| 342 | LOG: MAIN |
| 343 | => b1 <b1@myhost.test.ex> R=real T=real |
| 344 | locking TESTSUITE/spool/db/retry.lockfile |
| 345 | LOG: MAIN |
| 346 | => c1 <c1@myhost.test.ex> R=real T=real |
| 347 | locking TESTSUITE/spool/db/retry.lockfile |
| 348 | LOG: MAIN |
| 349 | => d1 <d1@myhost.test.ex> R=real T=real |
| 350 | locking TESTSUITE/spool/db/retry.lockfile |
| 351 | LOG: MAIN |
| 352 | => d2 <d2@myhost.test.ex> R=real T=real |
| 353 | locking TESTSUITE/spool/db/retry.lockfile |
| 354 | LOG: MAIN |
| 355 | => d3 <d3@myhost.test.ex> R=real T=real |
| 356 | locking TESTSUITE/spool/db/retry.lockfile |
| 357 | LOG: MAIN |
| 358 | => a1 <a1@myhost.test.ex> R=u1 T=ut1 |
| 359 | locking TESTSUITE/spool/db/retry.lockfile |
| 360 | transport error EPIPE ignored |
| 361 | LOG: MAIN |
| 362 | ** b1@myhost.test.ex R=ut2 T=ut2: Child process of ut2 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file |
| 363 | locking TESTSUITE/spool/db/retry.lockfile |
| 364 | transport error EPIPE ignored |
| 365 | LOG: MAIN |
| 366 | == c1@myhost.test.ex R=ut3 T=ut3 defer (0): Child process of ut3 transport returned 127 (could mean unable to exec or command does not exist) from command: /non/existent/file |
| 367 | locking TESTSUITE/spool/db/retry.lockfile |
| 368 | locking TESTSUITE/spool/db/wait-ut4.lockfile |
| 369 | LOG: MAIN |
| 370 | => d1@myhost.test.ex R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1] C="250 OK" |
| 371 | locking TESTSUITE/spool/db/retry.lockfile |
| 372 | LOG: MAIN |
| 373 | == d2@myhost.test.ex R=ut4 T=ut4 defer (-44) H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d2@myhost.test.ex>: 450 soft error |
| 374 | locking TESTSUITE/spool/db/retry.lockfile |
| 375 | locking TESTSUITE/spool/db/wait-ut4.lockfile |
| 376 | LOG: MAIN |
| 377 | ** d3@myhost.test.ex R=ut4 T=ut4 H=127.0.0.1 [127.0.0.1]: SMTP error from remote mail server after RCPT TO:<d3@myhost.test.ex>: 550 hard error |
| 378 | locking TESTSUITE/spool/db/retry.lockfile |
| 379 | Exim version x.yz .... |
| 380 | configuration file is TESTSUITE/test-config |
| 381 | trusted user |
| 382 | admin user |
| 383 | LOG: MAIN |
| 384 | <= <> R=10HmaX-0005vi-00 U=EXIMUSER P=local S=sss |
| 385 | Exim version x.yz .... |
| 386 | configuration file is TESTSUITE/test-config |
| 387 | trusted user |
| 388 | admin user |
| 389 | locking TESTSUITE/spool/db/retry.lockfile |
| 390 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 391 | Considering: CALLER@myhost.test.ex |
| 392 | unique = CALLER@myhost.test.ex |
| 393 | CALLER@myhost.test.ex: queued for routing |
| 394 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 395 | routing CALLER@myhost.test.ex |
| 396 | --------> u1 router <-------- |
| 397 | local_part=CALLER domain=myhost.test.ex |
| 398 | checking local_parts |
| 399 | u1 router skipped: local_parts mismatch |
| 400 | --------> ut2 router <-------- |
| 401 | local_part=CALLER domain=myhost.test.ex |
| 402 | checking local_parts |
| 403 | ut2 router skipped: local_parts mismatch |
| 404 | --------> ut3 router <-------- |
| 405 | local_part=CALLER domain=myhost.test.ex |
| 406 | checking local_parts |
| 407 | ut3 router skipped: local_parts mismatch |
| 408 | --------> ut4 router <-------- |
| 409 | local_part=CALLER domain=myhost.test.ex |
| 410 | checking local_parts |
| 411 | ut4 router skipped: local_parts mismatch |
| 412 | --------> real router <-------- |
| 413 | local_part=CALLER domain=myhost.test.ex |
| 414 | calling real router |
| 415 | real router called for CALLER@myhost.test.ex |
| 416 | domain = myhost.test.ex |
| 417 | set transport real |
| 418 | queued for real transport: local_part = CALLER |
| 419 | domain = myhost.test.ex |
| 420 | errors_to=NULL |
| 421 | domain_data=NULL localpart_data=NULL |
| 422 | routed by real router |
| 423 | envelope to: CALLER@myhost.test.ex |
| 424 | transport: real |
| 425 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 426 | After routing: |
| 427 | Local deliveries: |
| 428 | CALLER@myhost.test.ex |
| 429 | Remote deliveries: |
| 430 | Failed addresses: |
| 431 | Deferred addresses: |
| 432 | locking TESTSUITE/spool/db/retry.lockfile |
| 433 | LOG: MAIN |
| 434 | => CALLER <CALLER@myhost.test.ex> R=real T=real |
| 435 | LOG: MAIN |
| 436 | Completed |
| 437 | >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>> |
| 438 | >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>> |
| 439 | >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>> |
| 440 | >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>> |