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