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