test/stderr/0374

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