test/stderr/0374

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