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