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