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