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 release cutthrough conn: msg passed for delivery
 178 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95dfd -odi -Mc 10HmaX-0005vi-00
 179 Exim version x.yz ....
 180 changed uid/gid: forcing real = effective
 181   uid=uuuu gid=EXIM_GID pid=pppp
 182 configuration file is TESTSUITE/test-config
 183 trusted user
 184 admin user
 185 DSN: r1 propagating DSN
 186 DSN: r2 propagating DSN
 187 DSN: r3 propagating DSN
 188 DSN: r4 propagating DSN
 189 DSN: r5 propagating DSN
 190 seeking password data for user "CALLER": cache not available
 191 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 192 seeking password data for user "CALLER": using cached result
 193 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 194 seeking password data for user "CALLER": using cached result
 195 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 196 set_process_info: pppp delivering specified messages
 197 set_process_info: pppp delivering 10HmaX-0005vi-00
 198 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 199 reading spool file 10HmaX-0005vi-00-H
 200 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 201 sender_local=1 ident=CALLER
 202 Non-recipients:
 203 Empty Tree
 204 ---- End of tree ----
 205 recipients_count=5
 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 **** SPOOL_IN - No additional fields
 211 body_linecount=0 message_linecount=6
 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 DSN: set orcpt: NULL  flags: 0
 217 Delivery address list:
 218   CALLER@test.ex
 219   usery@test.ex
 220   userz@test.ex
 221   rd+CALLER@test.ex
 222   rd+usery@test.ex
 223 locking TESTSUITE/spool/db/retry.lockfile
 224 locked  TESTSUITE/spool/db/retry.lockfile
 225 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 226 returned from EXIM_DBOPEN
 227 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 228 no retry data available
 229 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 230 Considering: CALLER@test.ex
 231 unique = CALLER@test.ex
 232 no domain retry record
 233 no address retry record
 234 CALLER@test.ex: queued for routing
 235 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 236 Considering: usery@test.ex
 237 unique = usery@test.ex
 238 no domain retry record
 239 no address retry record
 240 usery@test.ex: queued for routing
 241 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 242 Considering: userz@test.ex
 243 unique = userz@test.ex
 244 no domain retry record
 245 no address retry record
 246 userz@test.ex: queued for routing
 247 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 248 Considering: rd+CALLER@test.ex
 249 unique = rd+CALLER@test.ex
 250 no domain retry record
 251 no address retry record
 252 rd+CALLER@test.ex: queued for routing
 253 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 254 Considering: rd+usery@test.ex
 255 unique = rd+usery@test.ex
 256 no domain retry record
 257 no address retry record
 258 rd+usery@test.ex: queued for routing
 259 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 260 routing rd+usery@test.ex
 261 --------> r1 router <--------
 262 local_part=rd+usery domain=test.ex
 263 checking local_parts
 264 rd+usery in "CALLER"? no (end of list)
 265 r1 router skipped: local_parts mismatch
 266 --------> r2 router <--------
 267 local_part=rd+usery domain=test.ex
 268 checking local_parts
 269 rd+usery in "usery"? no (end of list)
 270 r2 router skipped: local_parts mismatch
 271 --------> r3 router <--------
 272 local_part=rd+usery domain=test.ex
 273 checking local_parts
 274 rd+usery in "userz"? no (end of list)
 275 r3 router skipped: local_parts mismatch
 276 --------> r4 router <--------
 277 local_part=rd+usery domain=test.ex
 278 stripped prefix rd+
 279 checking local_parts
 280 usery in "CALLER"? no (end of list)
 281 r4 router skipped: local_parts mismatch
 282 --------> r5 router <--------
 283 local_part=rd+usery domain=test.ex
 284 stripped prefix rd+
 285 checking local_parts
 286 usery in "usery"? yes (matched "usery")
 287  ┌considering: /non-exist/$domain
 288  ├──expanding: /non-exist/$domain
 289  └─────result: /non-exist/test.ex
 290 calling r5 router
 291 rda_interpret (string): TESTSUITE/test-mail/junk
 292 expanded: TESTSUITE/test-mail/junk
 293 file is not a filter file
 294 parse_forward_list: TESTSUITE/test-mail/junk
 295 extract item: TESTSUITE/test-mail/junk
 296 set transport ft1
 297 r5 router generated TESTSUITE/test-mail/junk
 298   pipe, file, or autoreply
 299   errors_to=NULL transport=ft1
 300   uid=unset gid=unset home=/non-exist/$local_part
 301 routed by r5 router
 302   envelope to: rd+usery@test.ex
 303   transport: <none>
 304 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 305 routing rd+CALLER@test.ex
 306 --------> r1 router <--------
 307 local_part=rd+CALLER domain=test.ex
 308 checking local_parts
 309 rd+CALLER in "CALLER"? no (end of list)
 310 r1 router skipped: local_parts mismatch
 311 --------> r2 router <--------
 312 local_part=rd+CALLER domain=test.ex
 313 checking local_parts
 314 rd+CALLER in "usery"? no (end of list)
 315 r2 router skipped: local_parts mismatch
 316 --------> r3 router <--------
 317 local_part=rd+CALLER domain=test.ex
 318 checking local_parts
 319 rd+CALLER in "userz"? no (end of list)
 320 r3 router skipped: local_parts mismatch
 321 --------> r4 router <--------
 322 local_part=rd+CALLER domain=test.ex
 323 stripped prefix rd+
 324 checking local_parts
 325 CALLER in "CALLER"? yes (matched "CALLER")
 326  ┌considering: /non-exist/$local_part
 327  ├──expanding: /non-exist/$local_part
 328  └─────result: /non-exist/CALLER
 329 calling r4 router
 330 rda_interpret (string): TESTSUITE/test-mail/junk
 331 expanded: TESTSUITE/test-mail/junk
 332 file is not a filter file
 333 parse_forward_list: TESTSUITE/test-mail/junk
 334 extract item: TESTSUITE/test-mail/junk
 335 set transport ft1
 336 r4 router generated TESTSUITE/test-mail/junk
 337   pipe, file, or autoreply
 338   errors_to=NULL transport=ft1
 339   uid=unset gid=unset home=/non-exist/CALLER
 340 routed by r4 router
 341   envelope to: rd+CALLER@test.ex
 342   transport: <none>
 343 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 344 routing userz@test.ex
 345 --------> r1 router <--------
 346 local_part=userz domain=test.ex
 347 checking local_parts
 348 userz in "CALLER"? no (end of list)
 349 r1 router skipped: local_parts mismatch
 350 --------> r2 router <--------
 351 local_part=userz domain=test.ex
 352 checking local_parts
 353 userz in "usery"? no (end of list)
 354 r2 router skipped: local_parts mismatch
 355 --------> r3 router <--------
 356 local_part=userz domain=test.ex
 357 checking local_parts
 358 userz in "userz"? yes (matched "userz")
 359  ┌considering: /non-exist/$domain
 360  ├──expanding: /non-exist/$domain
 361  └─────result: /non-exist/test.ex
 362 calling r3 router
 363 r3 router called for userz@test.ex
 364   domain = test.ex
 365 set transport t2
 366 queued for t2 transport: local_part = userz
 367 domain = test.ex
 368   errors_to=NULL
 369   domain_data=NULL localpart_data=NULL
 370 routed by r3 router
 371   envelope to: userz@test.ex
 372   transport: t2
 373 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 374 routing usery@test.ex
 375 --------> r1 router <--------
 376 local_part=usery domain=test.ex
 377 checking local_parts
 378 usery in "CALLER"? no (end of list)
 379 r1 router skipped: local_parts mismatch
 380 --------> r2 router <--------
 381 local_part=usery domain=test.ex
 382 checking local_parts
 383 usery in "usery"? yes (matched "usery")
 384  ┌considering: /non-exist/$domain
 385  ├──expanding: /non-exist/$domain
 386  └─────result: /non-exist/test.ex
 387 calling r2 router
 388 r2 router called for usery@test.ex
 389   domain = test.ex
 390 set transport t1
 391 queued for t1 transport: local_part = usery
 392 domain = test.ex
 393   errors_to=NULL
 394   domain_data=NULL localpart_data=NULL
 395 routed by r2 router
 396   envelope to: usery@test.ex
 397   transport: t1
 398 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 399 routing CALLER@test.ex
 400 --------> r1 router <--------
 401 local_part=CALLER domain=test.ex
 402 checking local_parts
 403 CALLER in "CALLER"? yes (matched "CALLER")
 404  ┌considering: /non-exist/$local_part
 405  ├──expanding: /non-exist/$local_part
 406  └─────result: /non-exist/CALLER
 407 calling r1 router
 408 r1 router called for CALLER@test.ex
 409   domain = test.ex
 410 set transport t1
 411 queued for t1 transport: local_part = CALLER
 412 domain = test.ex
 413   errors_to=NULL
 414   domain_data=NULL localpart_data=NULL
 415 routed by r1 router
 416   envelope to: CALLER@test.ex
 417   transport: t1
 418 locking TESTSUITE/spool/db/retry.lockfile
 419 locked  TESTSUITE/spool/db/retry.lockfile
 420 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 421 returned from EXIM_DBOPEN
 422 no retry data available
 423 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 424 Considering: TESTSUITE/test-mail/junk
 425 unique = TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 426 queued for ft1 transport
 427 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 428 Considering: TESTSUITE/test-mail/junk
 429 unique = TESTSUITE/test-mail/junk:rd+usery@test.ex
 430 queued for ft1 transport
 431 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 432 After routing:
 433   Local deliveries:
 434     TESTSUITE/test-mail/junk
 435     TESTSUITE/test-mail/junk
 436     CALLER@test.ex
 437     usery@test.ex
 438     userz@test.ex
 439   Remote deliveries:
 440   Failed addresses:
 441   Deferred addresses:
 442 search_tidyup called
 443 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 444 --------> TESTSUITE/test-mail/junk <--------
 445 locking TESTSUITE/spool/db/retry.lockfile
 446 locked  TESTSUITE/spool/db/retry.lockfile
 447 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 448 returned from EXIM_DBOPEN
 449 no retry data available
 450  ┌considering: /non-exist/$local_part
 451  ├──expanding: /non-exist/$local_part
 452  └─────result: /non-exist/usery
 453 search_tidyup called
 454 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 455   uid=CALLER_UID gid=CALLER_GID pid=pppp
 456   home=/non-exist/usery current=/
 457 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
 458 appendfile transport entered
 459  ┌considering: $address_file
 460  ├──expanding: $address_file
 461  └─────result: TESTSUITE/test-mail/junk
 462 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 463   file=TESTSUITE/test-mail/junk format=unix
 464   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 465   message_suffix=\n
 466   maildir_use_size_file=no
 467   locking by lockfile fcntl
 468 lock name: TESTSUITE/test-mail/junk.lock
 469 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 470 lock file created
 471 mailbox TESTSUITE/test-mail/junk is locked
 472 writing to file TESTSUITE/test-mail/junk
 473  ┌considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 474
 475  ├──condition: def:return_path
 476  ├─────result: true
 477   ┌considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 478
 479   ├──expanding: $return_path
 480   └─────result: CALLER@test.ex
 481   ┌───scanning: MAILER-DAEMON}} ${tod_bsdinbox}
 482
 483   ├──expanding: MAILER-DAEMON
 484   ├─────result: MAILER-DAEMON
 485   └───skipping: result is not used
 486  ├──expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 487
 488  └─────result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 489
 490 writing data block fd=dddd size=sss timeout=0
 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 writing data block fd=dddd size=sss timeout=0
 547 writing data block fd=dddd size=sss timeout=0
 548 appendfile yields 0 with errno=dd more_errno=dd
 549 search_tidyup called
 550 journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 551 ft1 transport returned OK for TESTSUITE/test-mail/junk
 552 post-process TESTSUITE/test-mail/junk (0)
 553 TESTSUITE/test-mail/junk delivered
 554 rd+CALLER@test.ex: children all complete
 555 LOG: MAIN
 556   => TESTSUITE/test-mail/junk <rd+CALLER@test.ex> R=r4 T=ft1
 557 --------> CALLER@test.ex <--------
 558 locking TESTSUITE/spool/db/retry.lockfile
 559 locked  TESTSUITE/spool/db/retry.lockfile
 560 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 561 returned from EXIM_DBOPEN
 562 no retry data available
 563 search_tidyup called
 564 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
 565   uid=CALLER_UID gid=CALLER_GID pid=pppp
 566   home=/non-exist/CALLER current=/
 567 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
 568 appendfile transport entered
 569 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 570   file=/dev/null format=unix
 571   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 572   message_suffix=\n
 573   maildir_use_size_file=no
 574   locking by lockfile fcntl
 575 search_tidyup called
 576 journalling CALLER@test.ex
 577 t1 transport returned OK for CALLER@test.ex
 578 post-process CALLER@test.ex (0)
 579 CALLER@test.ex delivered
 580 LOG: MAIN
 581   => CALLER <CALLER@test.ex> R=r1 T=t1
 582 --------> usery@test.ex <--------
 583 locking TESTSUITE/spool/db/retry.lockfile
 584 locked  TESTSUITE/spool/db/retry.lockfile
 585 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 586 returned from EXIM_DBOPEN
 587 no retry data available
 588  ┌considering: /non-exist/$local_part
 589  ├──expanding: /non-exist/$local_part
 590  └─────result: /non-exist/usery
 591 search_tidyup called
 592 changed uid/gid: local delivery to usery <usery@test.ex> transport=t1
 593   uid=CALLER_UID gid=CALLER_GID pid=pppp
 594   home=/non-exist/usery current=/
 595 set_process_info: pppp delivering 10HmaX-0005vi-00 to usery using t1
 596 appendfile transport entered
 597 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 598   file=/dev/null format=unix
 599   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 600   message_suffix=\n
 601   maildir_use_size_file=no
 602   locking by lockfile fcntl
 603 search_tidyup called
 604 journalling usery@test.ex
 605 t1 transport returned OK for usery@test.ex
 606 post-process usery@test.ex (0)
 607 usery@test.ex delivered
 608 LOG: MAIN
 609   => usery <usery@test.ex> R=r2 T=t1
 610 --------> userz@test.ex <--------
 611 locking TESTSUITE/spool/db/retry.lockfile
 612 locked  TESTSUITE/spool/db/retry.lockfile
 613 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 614 returned from EXIM_DBOPEN
 615 no retry data available
 616  ┌considering: /$local_part
 617  ├──expanding: /$local_part
 618  └─────result: /userz
 619 search_tidyup called
 620 changed uid/gid: local delivery to userz <userz@test.ex> transport=t2
 621   uid=CALLER_UID gid=CALLER_GID pid=pppp
 622   home=/userz current=/
 623 set_process_info: pppp delivering 10HmaX-0005vi-00 to userz using t2
 624 appendfile transport entered
 625 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 626   file=/dev/null format=unix
 627   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 628   message_suffix=\n
 629   maildir_use_size_file=no
 630   locking by lockfile fcntl
 631 search_tidyup called
 632 journalling userz@test.ex
 633 t2 transport returned OK for userz@test.ex
 634 post-process userz@test.ex (0)
 635 userz@test.ex delivered
 636 LOG: MAIN
 637   => userz <userz@test.ex> R=r3 T=t2
 638 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 639 changed uid/gid: post-delivery tidying
 640   uid=EXIM_UID gid=EXIM_GID pid=pppp
 641 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 642 Processing retry items
 643 Succeeded addresses:
 644  userz@test.ex: no retry items
 645  usery@test.ex: no retry items
 646  CALLER@test.ex: no retry items
 647  TESTSUITE/test-mail/junk: no retry items
 648  rd+CALLER@test.ex: no retry items
 649  TESTSUITE/test-mail/junk: no retry items
 650  rd+usery@test.ex: no retry items
 651  rd+CALLER@test.ex: no retry items
 652  rd+usery@test.ex: no retry items
 653 Failed addresses:
 654 Deferred addresses:
 655 end of retry processing
 656 DSN: processing router : r3
 657 DSN: processing successful delivery address: userz@test.ex
 658 DSN: Sender_address: CALLER@test.ex
 659 DSN: orcpt: NULL  flags: 0
 660 DSN: envid: NULL  ret: 0
 661 DSN: Final recipient: userz@test.ex
 662 DSN: Remote SMTP server supports DSN: 0
 663 DSN: not sending DSN success message
 664 DSN: processing router : r2
 665 DSN: processing successful delivery address: usery@test.ex
 666 DSN: Sender_address: CALLER@test.ex
 667 DSN: orcpt: NULL  flags: 0
 668 DSN: envid: NULL  ret: 0
 669 DSN: Final recipient: usery@test.ex
 670 DSN: Remote SMTP server supports DSN: 0
 671 DSN: not sending DSN success message
 672 DSN: processing router : r1
 673 DSN: processing successful delivery address: CALLER@test.ex
 674 DSN: Sender_address: CALLER@test.ex
 675 DSN: orcpt: NULL  flags: 0
 676 DSN: envid: NULL  ret: 0
 677 DSN: Final recipient: CALLER@test.ex
 678 DSN: Remote SMTP server supports DSN: 0
 679 DSN: not sending DSN success message
 680 DSN: processing router : r4
 681 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 682 DSN: Sender_address: CALLER@test.ex
 683 DSN: orcpt: NULL  flags: 0
 684 DSN: envid: NULL  ret: 0
 685 DSN: Final recipient: TESTSUITE/test-mail/junk
 686 DSN: Remote SMTP server supports DSN: 0
 687 DSN: not sending DSN success message
 688 DSN: processing router : r5
 689 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 690 DSN: Sender_address: CALLER@test.ex
 691 DSN: orcpt: NULL  flags: 0
 692 DSN: envid: NULL  ret: 0
 693 DSN: Final recipient: TESTSUITE/test-mail/junk
 694 DSN: Remote SMTP server supports DSN: 0
 695 DSN: not sending DSN success message
 696 DSN: processing router : r4
 697 DSN: processing successful delivery address: rd+CALLER@test.ex
 698 DSN: Sender_address: CALLER@test.ex
 699 DSN: orcpt: NULL  flags: 0
 700 DSN: envid: NULL  ret: 0
 701 DSN: Final recipient: rd+CALLER@test.ex
 702 DSN: Remote SMTP server supports DSN: 0
 703 DSN: not sending DSN success message
 704 DSN: processing router : r5
 705 DSN: processing successful delivery address: rd+usery@test.ex
 706 DSN: Sender_address: CALLER@test.ex
 707 DSN: orcpt: NULL  flags: 0
 708 DSN: envid: NULL  ret: 0
 709 DSN: Final recipient: rd+usery@test.ex
 710 DSN: Remote SMTP server supports DSN: 0
 711 DSN: not sending DSN success message
 712 LOG: MAIN
 713   Completed
 714 end delivery of 10HmaX-0005vi-00
 715 search_tidyup called
 716 search_tidyup called
 717 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 718 search_tidyup called
 719 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>