test/stderr/0402

   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 changed uid/gid: privilege not needed
   7   uid=EXIM_UID gid=EXIM_GID pid=pppp
   8 DSN: r1 propagating DSN
   9 DSN: r2 propagating DSN
  10 DSN: r3 propagating DSN
  11 DSN: r4 propagating DSN
  12 DSN: r5 propagating DSN
  13 seeking password data for user "CALLER": cache not available
  14 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  15 seeking password data for user "CALLER": using cached result
  16 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  17 seeking password data for user "CALLER": using cached result
  18 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  19 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  20 sender address = CALLER@test.ex
  21 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
  22 Sender: CALLER@test.ex
  23 Recipients:
  24   CALLER@test.ex
  25   usery@test.ex
  26   userz
  27   rd+CALLER
  28   rd+usery
  29 search_tidyup called
  30 >>Headers received:
  31
  32 rewrite_one_header: type=F:
  33   From: CALLER_NAME <CALLER@test.ex>
  34 search_tidyup called
  35 >>Headers after rewriting and local additions:
  36 I Message-Id: <E10HmaX-0005vi-00@mail.test.ex>
  37 F From: CALLER_NAME <CALLER@test.ex>
  38   Date: Tue, 2 Mar 1999 09:44:33 +0000
  39
  40 Data file written for message 10HmaX-0005vi-00
  41 expanding: ${tod_full}
  42    result: Tue, 2 Mar 1999 09:44:33 +0000
  43 condition: def:sender_rcvhost
  44    result: false
  45 expanding: from $sender_rcvhost
  46
  47    result: from
  48
  49 skipping: result is not used
  50 condition: def:sender_ident
  51    result: true
  52 expanding: $sender_ident
  53    result: CALLER
  54 expanding: from ${quote_local_part:$sender_ident}
  55    result: from CALLER
  56 condition: def:sender_helo_name
  57    result: false
  58 expanding: (helo=$sender_helo_name)
  59
  60    result: (helo=)
  61
  62 skipping: result is not used
  63 expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
  64         }}
  65    result: from CALLER
  66 condition: def:received_protocol
  67    result: true
  68 expanding: with $received_protocol
  69    result: with local
  70 condition: def:sender_address
  71    result: true
  72 expanding: (envelope-from <$sender_address>)
  73
  74    result: (envelope-from <CALLER@test.ex>)
  75
  76 condition: def:received_for
  77    result: false
  78 expanding:
  79         for $received_for
  80    result:
  81         for
  82 skipping: result is not used
  83 >>Generated Received: header line
  84 P Received: from CALLER by mail.test.ex with local (Exim x.yz)
  85         (envelope-from <CALLER@test.ex>)
  86         id 10HmaX-0005vi-00; Tue, 2 Mar 1999 09:44:33 +0000
  87 calling local_scan(); timeout=300
  88 local_scan() returned 0 NULL
  89 expanding: ${tod_full}
  90    result: Tue, 2 Mar 1999 09:44:33 +0000
  91 Writing spool header file
  92 DSN: Write SPOOL :-dsn_envid NULL
  93 DSN: Write SPOOL :-dsn_ret 0
  94 DSN: Flags :0
  95 DSN: **** SPOOL_OUT - address: |CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
  96 DSN: Flags :0
  97 DSN: **** SPOOL_OUT - address: |usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
  98 DSN: Flags :0
  99 DSN: **** SPOOL_OUT - address: |userz@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
 100 DSN: Flags :0
 101 DSN: **** SPOOL_OUT - address: |rd+CALLER@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
 102 DSN: Flags :0
 103 DSN: **** SPOOL_OUT - address: |rd+usery@test.ex| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
 104 Size of headers = sss
 105 LOG: MAIN
 106   <= CALLER@test.ex U=CALLER P=local S=sss
 107 created log directory TESTSUITE/spool/log
 108 search_tidyup called
 109 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95dfd -odi -Mc 10HmaX-0005vi-00
 110 Exim version x.yz ....
 111 changed uid/gid: forcing real = effective
 112   uid=uuuu gid=EXIM_GID pid=pppp
 113 configuration file is TESTSUITE/test-config
 114 trusted user
 115 admin user
 116 DSN: r1 propagating DSN
 117 DSN: r2 propagating DSN
 118 DSN: r3 propagating DSN
 119 DSN: r4 propagating DSN
 120 DSN: r5 propagating DSN
 121 seeking password data for user "CALLER": cache not available
 122 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 123 seeking password data for user "CALLER": using cached result
 124 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 125 seeking password data for user "CALLER": using cached result
 126 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 127 set_process_info: pppp delivering specified messages
 128 set_process_info: pppp delivering 10HmaX-0005vi-00
 129 reading spool file 10HmaX-0005vi-00-H
 130 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 131 sender_local=1 ident=CALLER
 132 Non-recipients:
 133 Empty Tree
 134 ---- End of tree ----
 135 recipients_count=5
 136 **** SPOOL_IN - No additional fields
 137 **** SPOOL_IN - No additional fields
 138 **** SPOOL_IN - No additional fields
 139 **** SPOOL_IN - No additional fields
 140 **** SPOOL_IN - No additional fields
 141 body_linecount=0 message_linecount=6
 142 DSN: set orcpt: NULL  flags: 0
 143 DSN: set orcpt: NULL  flags: 0
 144 DSN: set orcpt: NULL  flags: 0
 145 DSN: set orcpt: NULL  flags: 0
 146 DSN: set orcpt: NULL  flags: 0
 147 Delivery address list:
 148   CALLER@test.ex
 149   usery@test.ex
 150   userz@test.ex
 151   rd+CALLER@test.ex
 152   rd+usery@test.ex
 153 locking TESTSUITE/spool/db/retry.lockfile
 154 locked TESTSUITE/spool/db/retry.lockfile
 155 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 156 returned from EXIM_DBOPEN
 157 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 158 no retry data available
 159 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 160 Considering: CALLER@test.ex
 161 unique = CALLER@test.ex
 162 no domain retry record
 163 no address retry record
 164 CALLER@test.ex: queued for routing
 165 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 166 Considering: usery@test.ex
 167 unique = usery@test.ex
 168 no domain retry record
 169 no address retry record
 170 usery@test.ex: queued for routing
 171 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 172 Considering: userz@test.ex
 173 unique = userz@test.ex
 174 no domain retry record
 175 no address retry record
 176 userz@test.ex: queued for routing
 177 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 178 Considering: rd+CALLER@test.ex
 179 unique = rd+CALLER@test.ex
 180 no domain retry record
 181 no address retry record
 182 rd+CALLER@test.ex: queued for routing
 183 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 184 Considering: rd+usery@test.ex
 185 unique = rd+usery@test.ex
 186 no domain retry record
 187 no address retry record
 188 rd+usery@test.ex: queued for routing
 189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 190 routing rd+usery@test.ex
 191 --------> r1 router <--------
 192 local_part=rd+usery domain=test.ex
 193 checking local_parts
 194 rd+usery in "CALLER"? no (end of list)
 195 r1 router skipped: local_parts mismatch
 196 --------> r2 router <--------
 197 local_part=rd+usery domain=test.ex
 198 checking local_parts
 199 rd+usery in "usery"? no (end of list)
 200 r2 router skipped: local_parts mismatch
 201 --------> r3 router <--------
 202 local_part=rd+usery domain=test.ex
 203 checking local_parts
 204 rd+usery in "userz"? no (end of list)
 205 r3 router skipped: local_parts mismatch
 206 --------> r4 router <--------
 207 local_part=rd+usery domain=test.ex
 208 stripped prefix rd+
 209 checking local_parts
 210 usery in "CALLER"? no (end of list)
 211 r4 router skipped: local_parts mismatch
 212 --------> r5 router <--------
 213 local_part=rd+usery domain=test.ex
 214 stripped prefix rd+
 215 checking local_parts
 216 usery in "usery"? yes (matched "usery")
 217 expanding: /non-exist/$domain
 218    result: /non-exist/test.ex
 219 calling r5 router
 220 rda_interpret (string): TESTSUITE/test-mail/junk
 221 expanded: TESTSUITE/test-mail/junk
 222 file is not a filter file
 223 parse_forward_list: TESTSUITE/test-mail/junk
 224 extract item: TESTSUITE/test-mail/junk
 225 set transport ft1
 226 r5 router generated TESTSUITE/test-mail/junk
 227   pipe, file, or autoreply
 228   errors_to=NULL transport=ft1
 229   uid=unset gid=unset home=/non-exist/$local_part
 230 routed by r5 router
 231   envelope to: rd+usery@test.ex
 232   transport: <none>
 233 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 234 routing rd+CALLER@test.ex
 235 --------> r1 router <--------
 236 local_part=rd+CALLER domain=test.ex
 237 checking local_parts
 238 rd+CALLER in "CALLER"? no (end of list)
 239 r1 router skipped: local_parts mismatch
 240 --------> r2 router <--------
 241 local_part=rd+CALLER domain=test.ex
 242 checking local_parts
 243 rd+CALLER in "usery"? no (end of list)
 244 r2 router skipped: local_parts mismatch
 245 --------> r3 router <--------
 246 local_part=rd+CALLER domain=test.ex
 247 checking local_parts
 248 rd+CALLER in "userz"? no (end of list)
 249 r3 router skipped: local_parts mismatch
 250 --------> r4 router <--------
 251 local_part=rd+CALLER domain=test.ex
 252 stripped prefix rd+
 253 checking local_parts
 254 CALLER in "CALLER"? yes (matched "CALLER")
 255 expanding: /non-exist/$local_part
 256    result: /non-exist/CALLER
 257 calling r4 router
 258 rda_interpret (string): TESTSUITE/test-mail/junk
 259 expanded: TESTSUITE/test-mail/junk
 260 file is not a filter file
 261 parse_forward_list: TESTSUITE/test-mail/junk
 262 extract item: TESTSUITE/test-mail/junk
 263 set transport ft1
 264 r4 router generated TESTSUITE/test-mail/junk
 265   pipe, file, or autoreply
 266   errors_to=NULL transport=ft1
 267   uid=unset gid=unset home=/non-exist/CALLER
 268 routed by r4 router
 269   envelope to: rd+CALLER@test.ex
 270   transport: <none>
 271 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 272 routing userz@test.ex
 273 --------> r1 router <--------
 274 local_part=userz domain=test.ex
 275 checking local_parts
 276 userz in "CALLER"? no (end of list)
 277 r1 router skipped: local_parts mismatch
 278 --------> r2 router <--------
 279 local_part=userz domain=test.ex
 280 checking local_parts
 281 userz in "usery"? no (end of list)
 282 r2 router skipped: local_parts mismatch
 283 --------> r3 router <--------
 284 local_part=userz domain=test.ex
 285 checking local_parts
 286 userz in "userz"? yes (matched "userz")
 287 expanding: /non-exist/$domain
 288    result: /non-exist/test.ex
 289 calling r3 router
 290 r3 router called for userz@test.ex
 291   domain = test.ex
 292 set transport t2
 293 queued for t2 transport: local_part = userz
 294 domain = test.ex
 295   errors_to=NULL
 296   domain_data=NULL localpart_data=NULL
 297 routed by r3 router
 298   envelope to: userz@test.ex
 299   transport: t2
 300 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 301 routing usery@test.ex
 302 --------> r1 router <--------
 303 local_part=usery domain=test.ex
 304 checking local_parts
 305 usery in "CALLER"? no (end of list)
 306 r1 router skipped: local_parts mismatch
 307 --------> r2 router <--------
 308 local_part=usery domain=test.ex
 309 checking local_parts
 310 usery in "usery"? yes (matched "usery")
 311 expanding: /non-exist/$domain
 312    result: /non-exist/test.ex
 313 calling r2 router
 314 r2 router called for usery@test.ex
 315   domain = test.ex
 316 set transport t1
 317 queued for t1 transport: local_part = usery
 318 domain = test.ex
 319   errors_to=NULL
 320   domain_data=NULL localpart_data=NULL
 321 routed by r2 router
 322   envelope to: usery@test.ex
 323   transport: t1
 324 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 325 routing CALLER@test.ex
 326 --------> r1 router <--------
 327 local_part=CALLER domain=test.ex
 328 checking local_parts
 329 CALLER in "CALLER"? yes (matched "CALLER")
 330 expanding: /non-exist/$local_part
 331    result: /non-exist/CALLER
 332 calling r1 router
 333 r1 router called for CALLER@test.ex
 334   domain = test.ex
 335 set transport t1
 336 queued for t1 transport: local_part = CALLER
 337 domain = test.ex
 338   errors_to=NULL
 339   domain_data=NULL localpart_data=NULL
 340 routed by r1 router
 341   envelope to: CALLER@test.ex
 342   transport: t1
 343 locking TESTSUITE/spool/db/retry.lockfile
 344 locked TESTSUITE/spool/db/retry.lockfile
 345 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 346 returned from EXIM_DBOPEN
 347 no retry data available
 348 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 349 Considering: TESTSUITE/test-mail/junk
 350 unique = TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 351 queued for ft1 transport
 352 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 353 Considering: TESTSUITE/test-mail/junk
 354 unique = TESTSUITE/test-mail/junk:rd+usery@test.ex
 355 queued for ft1 transport
 356 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 357 After routing:
 358   Local deliveries:
 359     TESTSUITE/test-mail/junk
 360     TESTSUITE/test-mail/junk
 361     CALLER@test.ex
 362     usery@test.ex
 363     userz@test.ex
 364   Remote deliveries:
 365   Failed addresses:
 366   Deferred addresses:
 367 search_tidyup called
 368 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 369 --------> TESTSUITE/test-mail/junk <--------
 370 locking TESTSUITE/spool/db/retry.lockfile
 371 locked TESTSUITE/spool/db/retry.lockfile
 372 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 373 returned from EXIM_DBOPEN
 374 no retry data available
 375 expanding: /non-exist/$local_part
 376    result: /non-exist/usery
 377 search_tidyup called
 378 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 379   uid=CALLER_UID gid=CALLER_GID pid=pppp
 380   home=/non-exist/usery current=/
 381 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
 382 appendfile transport entered
 383 expanding: $address_file
 384    result: TESTSUITE/test-mail/junk
 385 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 386   file=TESTSUITE/test-mail/junk format=unix
 387   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 388   message_suffix=\n
 389   maildir_use_size_file=no
 390   locking by lockfile fcntl
 391 lock name: TESTSUITE/test-mail/junk.lock
 392 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 393 lock file created
 394 mailbox TESTSUITE/test-mail/junk is locked
 395 writing to file TESTSUITE/test-mail/junk
 396 condition: def:return_path
 397    result: true
 398 expanding: $return_path
 399    result: CALLER@test.ex
 400 expanding: MAILER-DAEMON
 401    result: MAILER-DAEMON
 402 skipping: result is not used
 403 expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 404
 405    result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 406
 407 writing data block fd=dddd size=sss timeout=0
 408 writing data block fd=dddd size=sss timeout=0
 409 writing data block fd=dddd size=sss timeout=0
 410 appendfile yields 0 with errno=dd more_errno=dd
 411 search_tidyup called
 412 journalling TESTSUITE/test-mail/junk:rd+usery@test.ex
 413 ft1 transport returned OK for TESTSUITE/test-mail/junk
 414 post-process TESTSUITE/test-mail/junk (0)
 415 TESTSUITE/test-mail/junk delivered
 416 rd+usery@test.ex: children all complete
 417 LOG: MAIN
 418   => TESTSUITE/test-mail/junk <rd+usery@test.ex> R=r5 T=ft1
 419 --------> TESTSUITE/test-mail/junk <--------
 420 locking TESTSUITE/spool/db/retry.lockfile
 421 locked TESTSUITE/spool/db/retry.lockfile
 422 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 423 returned from EXIM_DBOPEN
 424 no retry data available
 425 search_tidyup called
 426 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 427   uid=CALLER_UID gid=CALLER_GID pid=pppp
 428   home=/non-exist/CALLER current=/
 429 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
 430 appendfile transport entered
 431 expanding: $address_file
 432    result: TESTSUITE/test-mail/junk
 433 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 434   file=TESTSUITE/test-mail/junk format=unix
 435   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 436   message_suffix=\n
 437   maildir_use_size_file=no
 438   locking by lockfile fcntl
 439 lock name: TESTSUITE/test-mail/junk.lock
 440 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 441 lock file created
 442 mailbox TESTSUITE/test-mail/junk is locked
 443 writing to file TESTSUITE/test-mail/junk
 444 condition: def:return_path
 445    result: true
 446 expanding: $return_path
 447    result: CALLER@test.ex
 448 expanding: MAILER-DAEMON
 449    result: MAILER-DAEMON
 450 skipping: result is not used
 451 expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 452
 453    result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 454
 455 writing data block fd=dddd size=sss timeout=0
 456 writing data block fd=dddd size=sss timeout=0
 457 writing data block fd=dddd size=sss timeout=0
 458 appendfile yields 0 with errno=dd more_errno=dd
 459 search_tidyup called
 460 journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 461 ft1 transport returned OK for TESTSUITE/test-mail/junk
 462 post-process TESTSUITE/test-mail/junk (0)
 463 TESTSUITE/test-mail/junk delivered
 464 rd+CALLER@test.ex: children all complete
 465 LOG: MAIN
 466   => TESTSUITE/test-mail/junk <rd+CALLER@test.ex> R=r4 T=ft1
 467 --------> CALLER@test.ex <--------
 468 locking TESTSUITE/spool/db/retry.lockfile
 469 locked TESTSUITE/spool/db/retry.lockfile
 470 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 471 returned from EXIM_DBOPEN
 472 no retry data available
 473 search_tidyup called
 474 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
 475   uid=CALLER_UID gid=CALLER_GID pid=pppp
 476   home=/non-exist/CALLER current=/
 477 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
 478 appendfile transport entered
 479 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 480   file=/dev/null format=unix
 481   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 482   message_suffix=\n
 483   maildir_use_size_file=no
 484   locking by lockfile fcntl
 485 search_tidyup called
 486 journalling CALLER@test.ex
 487 t1 transport returned OK for CALLER@test.ex
 488 post-process CALLER@test.ex (0)
 489 CALLER@test.ex delivered
 490 LOG: MAIN
 491   => CALLER <CALLER@test.ex> R=r1 T=t1
 492 --------> usery@test.ex <--------
 493 locking TESTSUITE/spool/db/retry.lockfile
 494 locked TESTSUITE/spool/db/retry.lockfile
 495 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 496 returned from EXIM_DBOPEN
 497 no retry data available
 498 expanding: /non-exist/$local_part
 499    result: /non-exist/usery
 500 search_tidyup called
 501 changed uid/gid: local delivery to usery <usery@test.ex> transport=t1
 502   uid=CALLER_UID gid=CALLER_GID pid=pppp
 503   home=/non-exist/usery current=/
 504 set_process_info: pppp delivering 10HmaX-0005vi-00 to usery using t1
 505 appendfile transport entered
 506 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 507   file=/dev/null format=unix
 508   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 509   message_suffix=\n
 510   maildir_use_size_file=no
 511   locking by lockfile fcntl
 512 search_tidyup called
 513 journalling usery@test.ex
 514 t1 transport returned OK for usery@test.ex
 515 post-process usery@test.ex (0)
 516 usery@test.ex delivered
 517 LOG: MAIN
 518   => usery <usery@test.ex> R=r2 T=t1
 519 --------> userz@test.ex <--------
 520 locking TESTSUITE/spool/db/retry.lockfile
 521 locked TESTSUITE/spool/db/retry.lockfile
 522 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 523 returned from EXIM_DBOPEN
 524 no retry data available
 525 expanding: /$local_part
 526    result: /userz
 527 search_tidyup called
 528 changed uid/gid: local delivery to userz <userz@test.ex> transport=t2
 529   uid=CALLER_UID gid=CALLER_GID pid=pppp
 530   home=/userz current=/
 531 set_process_info: pppp delivering 10HmaX-0005vi-00 to userz using t2
 532 appendfile transport entered
 533 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 534   file=/dev/null format=unix
 535   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 536   message_suffix=\n
 537   maildir_use_size_file=no
 538   locking by lockfile fcntl
 539 search_tidyup called
 540 journalling userz@test.ex
 541 t2 transport returned OK for userz@test.ex
 542 post-process userz@test.ex (0)
 543 userz@test.ex delivered
 544 LOG: MAIN
 545   => userz <userz@test.ex> R=r3 T=t2
 546 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 547 changed uid/gid: post-delivery tidying
 548   uid=EXIM_UID gid=EXIM_GID pid=pppp
 549 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 550 Processing retry items
 551 Succeeded addresses:
 552 userz@test.ex: no retry items
 553 usery@test.ex: no retry items
 554 CALLER@test.ex: no retry items
 555 TESTSUITE/test-mail/junk: no retry items
 556 rd+CALLER@test.ex: no retry items
 557 TESTSUITE/test-mail/junk: no retry items
 558 rd+usery@test.ex: no retry items
 559 rd+CALLER@test.ex: no retry items
 560 rd+usery@test.ex: no retry items
 561 Failed addresses:
 562 Deferred addresses:
 563 end of retry processing
 564 DSN: processing router : r3
 565 DSN: processing successful delivery address: userz@test.ex
 566 DSN: Sender_address: CALLER@test.ex
 567 DSN: orcpt: NULL  flags: 0
 568 DSN: envid: NULL  ret: 0
 569 DSN: Final recipient: userz@test.ex
 570 DSN: Remote SMTP server supports DSN: 0
 571 DSN: *** NOT SENDING DSN SUCCESS Message ***
 572 DSN: processing router : r2
 573 DSN: processing successful delivery address: usery@test.ex
 574 DSN: Sender_address: CALLER@test.ex
 575 DSN: orcpt: NULL  flags: 0
 576 DSN: envid: NULL  ret: 0
 577 DSN: Final recipient: usery@test.ex
 578 DSN: Remote SMTP server supports DSN: 0
 579 DSN: *** NOT SENDING DSN SUCCESS Message ***
 580 DSN: processing router : r1
 581 DSN: processing successful delivery address: CALLER@test.ex
 582 DSN: Sender_address: CALLER@test.ex
 583 DSN: orcpt: NULL  flags: 0
 584 DSN: envid: NULL  ret: 0
 585 DSN: Final recipient: CALLER@test.ex
 586 DSN: Remote SMTP server supports DSN: 0
 587 DSN: *** NOT SENDING DSN SUCCESS Message ***
 588 DSN: processing router : r4
 589 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 590 DSN: Sender_address: CALLER@test.ex
 591 DSN: orcpt: NULL  flags: 0
 592 DSN: envid: NULL  ret: 0
 593 DSN: Final recipient: TESTSUITE/test-mail/junk
 594 DSN: Remote SMTP server supports DSN: 0
 595 DSN: *** NOT SENDING DSN SUCCESS Message ***
 596 DSN: processing router : r5
 597 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 598 DSN: Sender_address: CALLER@test.ex
 599 DSN: orcpt: NULL  flags: 0
 600 DSN: envid: NULL  ret: 0
 601 DSN: Final recipient: TESTSUITE/test-mail/junk
 602 DSN: Remote SMTP server supports DSN: 0
 603 DSN: *** NOT SENDING DSN SUCCESS Message ***
 604 DSN: processing router : r4
 605 DSN: processing successful delivery address: rd+CALLER@test.ex
 606 DSN: Sender_address: CALLER@test.ex
 607 DSN: orcpt: NULL  flags: 0
 608 DSN: envid: NULL  ret: 0
 609 DSN: Final recipient: rd+CALLER@test.ex
 610 DSN: Remote SMTP server supports DSN: 0
 611 DSN: *** NOT SENDING DSN SUCCESS Message ***
 612 DSN: processing router : r5
 613 DSN: processing successful delivery address: rd+usery@test.ex
 614 DSN: Sender_address: CALLER@test.ex
 615 DSN: orcpt: NULL  flags: 0
 616 DSN: envid: NULL  ret: 0
 617 DSN: Final recipient: rd+usery@test.ex
 618 DSN: Remote SMTP server supports DSN: 0
 619 DSN: *** NOT SENDING DSN SUCCESS Message ***
 620 LOG: MAIN
 621   Completed
 622 end delivery of 10HmaX-0005vi-00
 623 search_tidyup called
 624 search_tidyup called
 625 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 626 search_tidyup called
 627 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>