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 writing data block fd=dddd size=sss timeout=0
 491 writing data block fd=dddd size=sss timeout=0
 492 appendfile yields 0 with errno=dd more_errno=dd
 493 search_tidyup called
 494 journalling TESTSUITE/test-mail/junk:rd+usery@test.ex
 495 ft1 transport returned OK for TESTSUITE/test-mail/junk
 496 post-process TESTSUITE/test-mail/junk (0)
 497 TESTSUITE/test-mail/junk delivered
 498 rd+usery@test.ex: children all complete
 499 LOG: MAIN
 500   => TESTSUITE/test-mail/junk <rd+usery@test.ex> R=r5 T=ft1
 501 --------> TESTSUITE/test-mail/junk <--------
 502 locking TESTSUITE/spool/db/retry.lockfile
 503 locked  TESTSUITE/spool/db/retry.lockfile
 504 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 505 returned from EXIM_DBOPEN
 506 no retry data available
 507 search_tidyup called
 508 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 509   uid=CALLER_UID gid=CALLER_GID pid=pppp
 510   home=/non-exist/CALLER current=/
 511 set_process_info: pppp delivering 10HmaX-0005vi-00 to TESTSUITE/test-mail/junk using ft1
 512 appendfile transport entered
 513  ┌considering: $address_file
 514  ├──expanding: $address_file
 515  └─────result: TESTSUITE/test-mail/junk
 516 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 517   file=TESTSUITE/test-mail/junk format=unix
 518   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 519   message_suffix=\n
 520   maildir_use_size_file=no
 521   locking by lockfile fcntl
 522 lock name: TESTSUITE/test-mail/junk.lock
 523 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 524 lock file created
 525 mailbox TESTSUITE/test-mail/junk is locked
 526 writing to file TESTSUITE/test-mail/junk
 527  ┌considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 528
 529  ├──condition: def:return_path
 530  ├─────result: true
 531   ┌considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 532
 533   ├──expanding: $return_path
 534   └─────result: CALLER@test.ex
 535   ┌───scanning: MAILER-DAEMON}} ${tod_bsdinbox}
 536
 537   ├──expanding: MAILER-DAEMON
 538   ├─────result: MAILER-DAEMON
 539   └───skipping: result is not used
 540  ├──expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 541
 542  └─────result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 543
 544 writing data block fd=dddd size=sss timeout=0
 545 writing data block fd=dddd size=sss timeout=0
 546 writing data block fd=dddd size=sss timeout=0
 547 appendfile yields 0 with errno=dd more_errno=dd
 548 search_tidyup called
 549 journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 550 ft1 transport returned OK for TESTSUITE/test-mail/junk
 551 post-process TESTSUITE/test-mail/junk (0)
 552 TESTSUITE/test-mail/junk delivered
 553 rd+CALLER@test.ex: children all complete
 554 LOG: MAIN
 555   => TESTSUITE/test-mail/junk <rd+CALLER@test.ex> R=r4 T=ft1
 556 --------> CALLER@test.ex <--------
 557 locking TESTSUITE/spool/db/retry.lockfile
 558 locked  TESTSUITE/spool/db/retry.lockfile
 559 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 560 returned from EXIM_DBOPEN
 561 no retry data available
 562 search_tidyup called
 563 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
 564   uid=CALLER_UID gid=CALLER_GID pid=pppp
 565   home=/non-exist/CALLER current=/
 566 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
 567 appendfile transport entered
 568 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 569   file=/dev/null format=unix
 570   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 571   message_suffix=\n
 572   maildir_use_size_file=no
 573   locking by lockfile fcntl
 574 search_tidyup called
 575 journalling CALLER@test.ex
 576 t1 transport returned OK for CALLER@test.ex
 577 post-process CALLER@test.ex (0)
 578 CALLER@test.ex delivered
 579 LOG: MAIN
 580   => CALLER <CALLER@test.ex> R=r1 T=t1
 581 --------> usery@test.ex <--------
 582 locking TESTSUITE/spool/db/retry.lockfile
 583 locked  TESTSUITE/spool/db/retry.lockfile
 584 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 585 returned from EXIM_DBOPEN
 586 no retry data available
 587  ┌considering: /non-exist/$local_part
 588  ├──expanding: /non-exist/$local_part
 589  └─────result: /non-exist/usery
 590 search_tidyup called
 591 changed uid/gid: local delivery to usery <usery@test.ex> transport=t1
 592   uid=CALLER_UID gid=CALLER_GID pid=pppp
 593   home=/non-exist/usery current=/
 594 set_process_info: pppp delivering 10HmaX-0005vi-00 to usery using t1
 595 appendfile transport entered
 596 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 597   file=/dev/null format=unix
 598   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 599   message_suffix=\n
 600   maildir_use_size_file=no
 601   locking by lockfile fcntl
 602 search_tidyup called
 603 journalling usery@test.ex
 604 t1 transport returned OK for usery@test.ex
 605 post-process usery@test.ex (0)
 606 usery@test.ex delivered
 607 LOG: MAIN
 608   => usery <usery@test.ex> R=r2 T=t1
 609 --------> userz@test.ex <--------
 610 locking TESTSUITE/spool/db/retry.lockfile
 611 locked  TESTSUITE/spool/db/retry.lockfile
 612 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 613 returned from EXIM_DBOPEN
 614 no retry data available
 615  ┌considering: /$local_part
 616  ├──expanding: /$local_part
 617  └─────result: /userz
 618 search_tidyup called
 619 changed uid/gid: local delivery to userz <userz@test.ex> transport=t2
 620   uid=CALLER_UID gid=CALLER_GID pid=pppp
 621   home=/userz current=/
 622 set_process_info: pppp delivering 10HmaX-0005vi-00 to userz using t2
 623 appendfile transport entered
 624 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 625   file=/dev/null format=unix
 626   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 627   message_suffix=\n
 628   maildir_use_size_file=no
 629   locking by lockfile fcntl
 630 search_tidyup called
 631 journalling userz@test.ex
 632 t2 transport returned OK for userz@test.ex
 633 post-process userz@test.ex (0)
 634 userz@test.ex delivered
 635 LOG: MAIN
 636   => userz <userz@test.ex> R=r3 T=t2
 637 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 638 changed uid/gid: post-delivery tidying
 639   uid=EXIM_UID gid=EXIM_GID pid=pppp
 640 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 641 Processing retry items
 642 Succeeded addresses:
 643  userz@test.ex: no retry items
 644  usery@test.ex: no retry items
 645  CALLER@test.ex: no retry items
 646  TESTSUITE/test-mail/junk: no retry items
 647  rd+CALLER@test.ex: no retry items
 648  TESTSUITE/test-mail/junk: no retry items
 649  rd+usery@test.ex: no retry items
 650  rd+CALLER@test.ex: no retry items
 651  rd+usery@test.ex: no retry items
 652 Failed addresses:
 653 Deferred addresses:
 654 end of retry processing
 655 DSN: processing router : r3
 656 DSN: processing successful delivery address: userz@test.ex
 657 DSN: Sender_address: CALLER@test.ex
 658 DSN: orcpt: NULL  flags: 0
 659 DSN: envid: NULL  ret: 0
 660 DSN: Final recipient: userz@test.ex
 661 DSN: Remote SMTP server supports DSN: 0
 662 DSN: not sending DSN success message
 663 DSN: processing router : r2
 664 DSN: processing successful delivery address: usery@test.ex
 665 DSN: Sender_address: CALLER@test.ex
 666 DSN: orcpt: NULL  flags: 0
 667 DSN: envid: NULL  ret: 0
 668 DSN: Final recipient: usery@test.ex
 669 DSN: Remote SMTP server supports DSN: 0
 670 DSN: not sending DSN success message
 671 DSN: processing router : r1
 672 DSN: processing successful delivery address: CALLER@test.ex
 673 DSN: Sender_address: CALLER@test.ex
 674 DSN: orcpt: NULL  flags: 0
 675 DSN: envid: NULL  ret: 0
 676 DSN: Final recipient: CALLER@test.ex
 677 DSN: Remote SMTP server supports DSN: 0
 678 DSN: not sending DSN success message
 679 DSN: processing router : r4
 680 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 681 DSN: Sender_address: CALLER@test.ex
 682 DSN: orcpt: NULL  flags: 0
 683 DSN: envid: NULL  ret: 0
 684 DSN: Final recipient: TESTSUITE/test-mail/junk
 685 DSN: Remote SMTP server supports DSN: 0
 686 DSN: not sending DSN success message
 687 DSN: processing router : r5
 688 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
 689 DSN: Sender_address: CALLER@test.ex
 690 DSN: orcpt: NULL  flags: 0
 691 DSN: envid: NULL  ret: 0
 692 DSN: Final recipient: TESTSUITE/test-mail/junk
 693 DSN: Remote SMTP server supports DSN: 0
 694 DSN: not sending DSN success message
 695 DSN: processing router : r4
 696 DSN: processing successful delivery address: rd+CALLER@test.ex
 697 DSN: Sender_address: CALLER@test.ex
 698 DSN: orcpt: NULL  flags: 0
 699 DSN: envid: NULL  ret: 0
 700 DSN: Final recipient: rd+CALLER@test.ex
 701 DSN: Remote SMTP server supports DSN: 0
 702 DSN: not sending DSN success message
 703 DSN: processing router : r5
 704 DSN: processing successful delivery address: rd+usery@test.ex
 705 DSN: Sender_address: CALLER@test.ex
 706 DSN: orcpt: NULL  flags: 0
 707 DSN: envid: NULL  ret: 0
 708 DSN: Final recipient: rd+usery@test.ex
 709 DSN: Remote SMTP server supports DSN: 0
 710 DSN: not sending DSN success message
 711 LOG: MAIN
 712   Completed
 713 end delivery of 10HmaX-0005vi-00
 714 search_tidyup called
 715 search_tidyup called
 716 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 717 search_tidyup called
 718 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>