test/stderr/0402

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=p1234
   4 environment after trimming:
   5  PATH=<munged>
   6 adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys
   7 configuration file is TESTSUITE/test-config
   8 admin user
   9 changed uid/gid: privilege not needed
  10   uid=EXIM_UID gid=EXIM_GID pid=p1234
  11 seeking password data for user "CALLER": cache not available
  12 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  13 seeking password data for user "CALLER": using cached result
  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 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  18 sender address = CALLER@test.ex
  19 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
  20 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  21 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  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 qualify & rewrite recipients list
  33 rewrite rules on sender address
  34 qualify and rewrite headers
  35  rewrite_one_header: type=F:
  36    From: CALLER_NAME <CALLER@test.ex>
  37 search_tidyup called
  38 >>Headers after rewriting and local additions:
  39  I Message-Id: <E10HmaX-000000005vi-0000@mail.test.ex>
  40  F From: CALLER_NAME <CALLER@test.ex>
  41    Date: Tue, 2 Mar 1999 09:44:33 +0000
  42
  43 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
  44 Data file written for message 10HmaX-000000005vi-0000
  45  ╭considering: ${tod_full}
  46  ├──expanding: ${tod_full}
  47  ╰─────result: Tue, 2 Mar 1999 09:44:33 +0000
  48  ╭considering: Received: ${if def:sender_rcvhost {from $sender_rcvhost
  49         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
  50         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  51         }}(Exim $version_number)
  52         ${if def:sender_address {(envelope-from <$sender_address>)
  53         }}id $message_exim_id${if def:received_for {
  54         for $received_for}}
  55  ├───────text: Received:
  56  ├considering: ${if def:sender_rcvhost {from $sender_rcvhost
  57         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
  58         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  59         }}(Exim $version_number)
  60         ${if def:sender_address {(envelope-from <$sender_address>)
  61         }}id $message_exim_id${if def:received_for {
  62         for $received_for}}
  63  ├──condition: def:sender_rcvhost
  64  ├─────result: false
  65   ╭───scanning: from $sender_rcvhost
  66         }{${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_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  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   ├───────text: from
  73   ├───scanning: $sender_rcvhost
  74         }{${if def:sender_ident {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_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  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   ├──────value:
  81   ├───scanning:
  82         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
  83         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  84         }}(Exim $version_number)
  85         ${if def:sender_address {(envelope-from <$sender_address>)
  86         }}id $message_exim_id${if def:received_for {
  87         for $received_for}}
  88   ├───────text:
  89
  90   ├───scanning: }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
  91         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
  92         }}(Exim $version_number)
  93         ${if def:sender_address {(envelope-from <$sender_address>)
  94         }}id $message_exim_id${if def:received_for {
  95         for $received_for}}
  96   ├──expanding: from $sender_rcvhost
  97
  98   ├─────result: from
  99
 100   ╰───skipping: result is not used
 101   ╭considering: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 102         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 103         }}(Exim $version_number)
 104         ${if def:sender_address {(envelope-from <$sender_address>)
 105         }}id $message_exim_id${if def:received_for {
 106         for $received_for}}
 107   ├──condition: def:sender_ident
 108   ├─────result: true
 109    ╭considering: from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 110         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 111         }}(Exim $version_number)
 112         ${if def:sender_address {(envelope-from <$sender_address>)
 113         }}id $message_exim_id${if def:received_for {
 114         for $received_for}}
 115    ├───────text: from
 116    ├considering: ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 117         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 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    ╎╭considering: $sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 123    ╎  }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 124    ╎  }}(Exim $version_number)
 125    ╎  ${if def:sender_address {(envelope-from <$sender_address>)
 126    ╎  }}id $message_exim_id${if def:received_for {
 127    ╎  for $received_for}}
 128    ╎├──────value: CALLER
 129    ╎├considering: } }}${if def:sender_helo_name {(helo=$sender_helo_name)
 130    ╎  }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 131    ╎  }}(Exim $version_number)
 132    ╎  ${if def:sender_address {(envelope-from <$sender_address>)
 133    ╎  }}id $message_exim_id${if def:received_for {
 134    ╎  for $received_for}}
 135    ╎├──expanding: $sender_ident
 136    ╎╰─────result: CALLER
 137    ├─────op-res: CALLER
 138    ├considering:  }}${if def:sender_helo_name {(helo=$sender_helo_name)
 139         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 140         }}(Exim $version_number)
 141         ${if def:sender_address {(envelope-from <$sender_address>)
 142         }}id $message_exim_id${if def:received_for {
 143         for $received_for}}
 144    ├───────text:
 145    ├considering: }}${if def:sender_helo_name {(helo=$sender_helo_name)
 146         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 147         }}(Exim $version_number)
 148         ${if def:sender_address {(envelope-from <$sender_address>)
 149         }}id $message_exim_id${if def:received_for {
 150         for $received_for}}
 151    ├──expanding: from ${quote_local_part:$sender_ident}
 152    ╰─────result: from CALLER
 153   ├───item-res: from CALLER
 154   ├considering: ${if def:sender_helo_name {(helo=$sender_helo_name)
 155         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 156         }}(Exim $version_number)
 157         ${if def:sender_address {(envelope-from <$sender_address>)
 158         }}id $message_exim_id${if def:received_for {
 159         for $received_for}}
 160   ├──condition: def:sender_helo_name
 161   ├─────result: false
 162    ╭───scanning: (helo=$sender_helo_name)
 163         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 164         }}(Exim $version_number)
 165         ${if def:sender_address {(envelope-from <$sender_address>)
 166         }}id $message_exim_id${if def:received_for {
 167         for $received_for}}
 168    ├───────text: (helo=
 169    ├───scanning: $sender_helo_name)
 170         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 171         }}(Exim $version_number)
 172         ${if def:sender_address {(envelope-from <$sender_address>)
 173         }}id $message_exim_id${if def:received_for {
 174         for $received_for}}
 175    ├──────value:
 176    ├───scanning: )
 177         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 178         }}(Exim $version_number)
 179         ${if def:sender_address {(envelope-from <$sender_address>)
 180         }}id $message_exim_id${if def:received_for {
 181         for $received_for}}
 182    ├───────text: )
 183
 184    ├───scanning: }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 185         }}(Exim $version_number)
 186         ${if def:sender_address {(envelope-from <$sender_address>)
 187         }}id $message_exim_id${if def:received_for {
 188         for $received_for}}
 189    ├──expanding: (helo=$sender_helo_name)
 190
 191    ├─────result: (helo=)
 192
 193    ╰───skipping: result is not used
 194   ├───item-res:
 195   ├considering: }}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 196         }}(Exim $version_number)
 197         ${if def:sender_address {(envelope-from <$sender_address>)
 198         }}id $message_exim_id${if def:received_for {
 199         for $received_for}}
 200   ├──expanding: ${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 201         }}
 202   ╰─────result: from CALLER
 203  ├───item-res: from CALLER
 204  ├considering: by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 205         }}(Exim $version_number)
 206         ${if def:sender_address {(envelope-from <$sender_address>)
 207         }}id $message_exim_id${if def:received_for {
 208         for $received_for}}
 209  ├───────text: by
 210  ├considering: $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 211         }}(Exim $version_number)
 212         ${if def:sender_address {(envelope-from <$sender_address>)
 213         }}id $message_exim_id${if def:received_for {
 214         for $received_for}}
 215  ├──────value: mail.test.ex
 216  ├considering:  ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 217         }}(Exim $version_number)
 218         ${if def:sender_address {(envelope-from <$sender_address>)
 219         }}id $message_exim_id${if def:received_for {
 220         for $received_for}}
 221  ├───────text:
 222  ├considering: ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 223         }}(Exim $version_number)
 224         ${if def:sender_address {(envelope-from <$sender_address>)
 225         }}id $message_exim_id${if def:received_for {
 226         for $received_for}}
 227  ├──condition: def:received_protocol
 228  ├─────result: true
 229   ╭considering: with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 230         }}(Exim $version_number)
 231         ${if def:sender_address {(envelope-from <$sender_address>)
 232         }}id $message_exim_id${if def:received_for {
 233         for $received_for}}
 234   ├───────text: with
 235   ├considering: $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 236         }}(Exim $version_number)
 237         ${if def:sender_address {(envelope-from <$sender_address>)
 238         }}id $message_exim_id${if def:received_for {
 239         for $received_for}}
 240   ├──────value: local
 241   ├considering:  }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 242         }}(Exim $version_number)
 243         ${if def:sender_address {(envelope-from <$sender_address>)
 244         }}id $message_exim_id${if def:received_for {
 245         for $received_for}}
 246   ├───────text:
 247   ├considering: }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 248         }}(Exim $version_number)
 249         ${if def:sender_address {(envelope-from <$sender_address>)
 250         }}id $message_exim_id${if def:received_for {
 251         for $received_for}}
 252   ├──expanding: with $received_protocol
 253   ╰─────result: with local
 254  ├───item-res: with local
 255  ├considering: ${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 256         }}(Exim $version_number)
 257         ${if def:sender_address {(envelope-from <$sender_address>)
 258         }}id $message_exim_id${if def:received_for {
 259         for $received_for}}
 260         ${if def:sender_address {(envelope-from <$sender_address>)
 261         }}id $message_exim_id${if def:received_for {
 262         for $received_for}}
 263   ├──expanding:  ($tls_in_ver)
 264   ├─────result:  ()
 265   ╰───skipping: result is not used
 266  ├───item-res:
 267  ├considering: ${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 268         }}(Exim $version_number)
 269         ${if def:sender_address {(envelope-from <$sender_address>)
 270         }}id $message_exim_id${if def:received_for {
 271         for $received_for}}
 272  ├──condition: def:tls_in_cipher_std
 273  ├─────result: false
 274   ╭───scanning:  tls $tls_in_cipher_std
 275         }}(Exim $version_number)
 276         ${if def:sender_address {(envelope-from <$sender_address>)
 277         }}id $message_exim_id${if def:received_for {
 278         for $received_for}}
 279   ├───────text:  tls
 280   ├───scanning: $tls_in_cipher_std
 281         }}(Exim $version_number)
 282         ${if def:sender_address {(envelope-from <$sender_address>)
 283         }}id $message_exim_id${if def:received_for {
 284         for $received_for}}
 285   ├──────value:
 286   ├───scanning:
 287         }}(Exim $version_number)
 288         ${if def:sender_address {(envelope-from <$sender_address>)
 289         }}id $message_exim_id${if def:received_for {
 290         for $received_for}}
 291   ├───────text:
 292
 293   ├───scanning: }}(Exim $version_number)
 294         ${if def:sender_address {(envelope-from <$sender_address>)
 295         }}id $message_exim_id${if def:received_for {
 296         for $received_for}}
 297   ├──expanding:  tls $tls_in_cipher_std
 298
 299   ├─────result:  tls
 300
 301   ╰───skipping: result is not used
 302  ├───item-res:
 303  ├considering: (Exim $version_number)
 304         ${if def:sender_address {(envelope-from <$sender_address>)
 305         }}id $message_exim_id${if def:received_for {
 306         for $received_for}}
 307  ├───────text: (Exim
 308  ├considering: $version_number)
 309         ${if def:sender_address {(envelope-from <$sender_address>)
 310         }}id $message_exim_id${if def:received_for {
 311         for $received_for}}
 312  ├──────value: x.yz
 313  ├considering: )
 314         ${if def:sender_address {(envelope-from <$sender_address>)
 315         }}id $message_exim_id${if def:received_for {
 316         for $received_for}}
 317  ├───────text: )
 318
 319  ├considering: ${if def:sender_address {(envelope-from <$sender_address>)
 320         }}id $message_exim_id${if def:received_for {
 321         for $received_for}}
 322  ├──condition: def:sender_address
 323  ├─────result: true
 324   ╭considering: (envelope-from <$sender_address>)
 325         }}id $message_exim_id${if def:received_for {
 326         for $received_for}}
 327   ├───────text: (envelope-from <
 328   ├considering: $sender_address>)
 329         }}id $message_exim_id${if def:received_for {
 330         for $received_for}}
 331   ├──────value: CALLER@test.ex
 332   ├considering: >)
 333         }}id $message_exim_id${if def:received_for {
 334         for $received_for}}
 335   ├───────text: >)
 336
 337   ├considering: }}id $message_exim_id${if def:received_for {
 338         for $received_for}}
 339   ├──expanding: (envelope-from <$sender_address>)
 340
 341   ╰─────result: (envelope-from <CALLER@test.ex>)
 342
 343  ├───item-res: (envelope-from <CALLER@test.ex>)
 344
 345  ├considering: id $message_exim_id${if def:received_for {
 346         for $received_for}}
 347  ├───────text: id
 348  ├considering: $message_exim_id${if def:received_for {
 349         for $received_for}}
 350  ├──────value: 10HmaX-000000005vi-0000
 351  ├considering: ${if def:received_for {
 352         for $received_for}}
 353  ├──condition: def:received_for
 354  ├─────result: false
 355   ╭───scanning:
 356         for $received_for}}
 357   ├───────text:
 358         for
 359   ├───scanning: $received_for}}
 360   ├──────value:
 361   ├───scanning: }}
 362   ├──expanding:
 363         for $received_for
 364   ├─────result:
 365         for
 366   ╰───skipping: result is not used
 367  ├───item-res:
 368  ├──expanding: Received: ${if def:sender_rcvhost {from $sender_rcvhost
 369         }{${if def:sender_ident {from ${quote_local_part:$sender_ident} }}${if def:sender_helo_name {(helo=$sender_helo_name)
 370         }}}}by $primary_hostname ${if def:received_protocol {with $received_protocol }}${if def:tls_in_ver        { ($tls_in_ver)}}${if def:tls_in_cipher_std { tls $tls_in_cipher_std
 371         }}(Exim $version_number)
 372         ${if def:sender_address {(envelope-from <$sender_address>)
 373         }}id $message_exim_id${if def:received_for {
 374         for $received_for}}
 375  ╰─────result: Received: from CALLER by mail.test.ex with local (Exim x.yz)
 376         (envelope-from <CALLER@test.ex>)
 377         id 10HmaX-000000005vi-0000
 378 >>Generated Received: header line
 379 P Received: from CALLER by mail.test.ex with local (Exim x.yz)
 380         (envelope-from <CALLER@test.ex>)
 381         id 10HmaX-000000005vi-0000;
 382         Tue, 2 Mar 1999 09:44:33 +0000
 383  ╭considering: ${tod_full}
 384  ├──expanding: ${tod_full}
 385  ╰─────result: Tue, 2 Mar 1999 09:44:33 +0000
 386 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-000000005vi-0000
 387 DSN: **** SPOOL_OUT - address: <CALLER@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 388 DSN: **** SPOOL_OUT - address: <usery@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 389 DSN: **** SPOOL_OUT - address: <userz@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 390 DSN: **** SPOOL_OUT - address: <rd+CALLER@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 391 DSN: **** SPOOL_OUT - address: <rd+usery@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 392 Renaming spool header file: TESTSUITE/spool//input//10HmaX-000000005vi-0000-H
 393 Size of headers = sss
 394 LOG: MAIN
 395   <= CALLER@test.ex U=CALLER P=local S=sss
 396 created log directory TESTSUITE/spool/log
 397 search_tidyup called
 398 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715dfd -MCd local-accept-delivery -odi -Mc 10HmaX-000000005vi-0000
 399 Exim version x.yz ....
 400 changed uid/gid: forcing real = effective
 401   uid=uuuu gid=EXIM_GID pid=p1235
 402 environment after trimming:
 403  PATH=<munged>
 404 adding SSLKEYLOGFILE=TESTSUITE/spool/sslkeys
 405 configuration file is TESTSUITE/test-config
 406 trusted user
 407 admin user
 408 dropping to exim gid; retaining priv uid
 409 seeking password data for user "CALLER": cache not available
 410 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 411 seeking password data for user "CALLER": using cached result
 412 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 413 seeking password data for user "CALLER": using cached result
 414 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 415 set_process_info: pppp delivering specified messages
 416 set_process_info: pppp delivering 10HmaX-000000005vi-0000
 417 Trying spool file TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 418 reading spool file 10HmaX-000000005vi-0000-H
 419 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 420 sender_local=1 ident=CALLER
 421 Non-recipients:
 422  Empty Tree
 423 ---- End of tree ----
 424 recipients_count=5
 425 **** SPOOL_IN - No additional fields
 426 **** SPOOL_IN - No additional fields
 427 **** SPOOL_IN - No additional fields
 428 **** SPOOL_IN - No additional fields
 429 **** SPOOL_IN - No additional fields
 430 body_linecount=0 message_linecount=7
 431 DSN: set orcpt:   flags: 0x0
 432 DSN: set orcpt:   flags: 0x0
 433 DSN: set orcpt:   flags: 0x0
 434 DSN: set orcpt:   flags: 0x0
 435 DSN: set orcpt:   flags: 0x0
 436 Delivery address list:
 437   CALLER@test.ex
 438   usery@test.ex
 439   userz@test.ex
 440   rd+CALLER@test.ex
 441   rd+usery@test.ex
 442  locking TESTSUITE/spool/db/retry.lockfile
 443  locked  TESTSUITE/spool/db/retry.lockfile
 444  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 445  returned from EXIM_DBOPEN: (nil)
 446  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 447 no retry data available
 448 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 449 Considering: CALLER@test.ex
 450 unique = CALLER@test.ex
 451 no   domain  retry record
 452 no   address retry record
 453 CALLER@test.ex: queued for routing
 454 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 455 Considering: usery@test.ex
 456 unique = usery@test.ex
 457 no   domain  retry record
 458 no   address retry record
 459 usery@test.ex: queued for routing
 460 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 461 Considering: userz@test.ex
 462 unique = userz@test.ex
 463 no   domain  retry record
 464 no   address retry record
 465 userz@test.ex: queued for routing
 466 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 467 Considering: rd+CALLER@test.ex
 468 unique = rd+CALLER@test.ex
 469 no   domain  retry record
 470 no   address retry record
 471 rd+CALLER@test.ex: queued for routing
 472 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 473 Considering: rd+usery@test.ex
 474 unique = rd+usery@test.ex
 475 no   domain  retry record
 476 no   address retry record
 477 rd+usery@test.ex: queued for routing
 478 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 479 routing rd+usery@test.ex
 480 --------> r1 router <--------
 481 local_part=rd+usery domain=test.ex
 482 checking local_parts
 483 rd+usery in "CALLER"?
 484  list element: CALLER
 485 rd+usery in "CALLER"? no (end of list)
 486 r1 router skipped: local_parts mismatch
 487 --------> r2 router <--------
 488 local_part=rd+usery domain=test.ex
 489 checking local_parts
 490 rd+usery in "usery"?
 491  list element: usery
 492 rd+usery in "usery"? no (end of list)
 493 r2 router skipped: local_parts mismatch
 494 --------> r3 router <--------
 495 local_part=rd+usery domain=test.ex
 496 checking local_parts
 497 rd+usery in "userz"?
 498  list element: userz
 499 rd+usery in "userz"? no (end of list)
 500 r3 router skipped: local_parts mismatch
 501 --------> r4 router <--------
 502 local_part=rd+usery domain=test.ex
 503 stripped prefix rd+
 504 checking local_parts
 505 usery in "CALLER"?
 506  list element: CALLER
 507 usery in "CALLER"? no (end of list)
 508 r4 router skipped: local_parts mismatch
 509 --------> r5 router <--------
 510 local_part=rd+usery domain=test.ex
 511 stripped prefix rd+
 512 checking local_parts
 513 usery in "usery"?
 514  list element: usery
 515  usery in "usery"? yes (matched "usery")
 516  ╭considering: /non-exist/$domain
 517  ├───────text: /non-exist/
 518  ├considering: $domain
 519  ├──────value: test.ex
 520             ╰──(tainted)
 521  ├──expanding: /non-exist/$domain
 522  ╰─────result: /non-exist/test.ex
 523             ╰──(tainted)
 524 calling r5 router
 525 rda_interpret (string): 'TESTSUITE/test-mail/junk'
 526 expanded: 'TESTSUITE/test-mail/junk'
 527 file is not a filter file
 528 parse_forward_list: TESTSUITE/test-mail/junk
 529 extract item: TESTSUITE/test-mail/junk
 530 set transport ft1
 531 r5 router generated TESTSUITE/test-mail/junk
 532   pipe, file, or autoreply
 533   errors_to=NULL transport=ft1
 534   uid=unset gid=unset home=/non-exist/$local_part
 535 routed by r5 router
 536   envelope to: rd+usery@test.ex
 537   transport: <none>
 538 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 539 routing rd+CALLER@test.ex
 540 --------> r1 router <--------
 541 local_part=rd+CALLER domain=test.ex
 542 checking local_parts
 543 rd+CALLER in "CALLER"?
 544  list element: CALLER
 545 rd+CALLER in "CALLER"? no (end of list)
 546 r1 router skipped: local_parts mismatch
 547 --------> r2 router <--------
 548 local_part=rd+CALLER domain=test.ex
 549 checking local_parts
 550 rd+CALLER in "usery"?
 551  list element: usery
 552 rd+CALLER in "usery"? no (end of list)
 553 r2 router skipped: local_parts mismatch
 554 --------> r3 router <--------
 555 local_part=rd+CALLER domain=test.ex
 556 checking local_parts
 557 rd+CALLER in "userz"?
 558  list element: userz
 559 rd+CALLER in "userz"? no (end of list)
 560 r3 router skipped: local_parts mismatch
 561 --------> r4 router <--------
 562 local_part=rd+CALLER domain=test.ex
 563 stripped prefix rd+
 564 checking local_parts
 565 CALLER in "CALLER"?
 566  list element: CALLER
 567  CALLER in "CALLER"? yes (matched "CALLER")
 568  ╭considering: /non-exist/$local_part
 569  ├───────text: /non-exist/
 570  ├considering: $local_part
 571  ├──────value: CALLER
 572             ╰──(tainted)
 573  ├──expanding: /non-exist/$local_part
 574  ╰─────result: /non-exist/CALLER
 575             ╰──(tainted)
 576 calling r4 router
 577 rda_interpret (string): 'TESTSUITE/test-mail/junk'
 578 expanded: 'TESTSUITE/test-mail/junk'
 579 file is not a filter file
 580 parse_forward_list: TESTSUITE/test-mail/junk
 581 extract item: TESTSUITE/test-mail/junk
 582 set transport ft1
 583 r4 router generated TESTSUITE/test-mail/junk
 584   pipe, file, or autoreply
 585   errors_to=NULL transport=ft1
 586   uid=unset gid=unset home=/non-exist/CALLER
 587 routed by r4 router
 588   envelope to: rd+CALLER@test.ex
 589   transport: <none>
 590 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 591 routing userz@test.ex
 592 --------> r1 router <--------
 593 local_part=userz domain=test.ex
 594 checking local_parts
 595 userz in "CALLER"?
 596  list element: CALLER
 597 userz in "CALLER"? no (end of list)
 598 r1 router skipped: local_parts mismatch
 599 --------> r2 router <--------
 600 local_part=userz domain=test.ex
 601 checking local_parts
 602 userz in "usery"?
 603  list element: usery
 604 userz in "usery"? no (end of list)
 605 r2 router skipped: local_parts mismatch
 606 --------> r3 router <--------
 607 local_part=userz domain=test.ex
 608 checking local_parts
 609 userz in "userz"?
 610  list element: userz
 611  userz in "userz"? yes (matched "userz")
 612  ╭considering: /non-exist/$domain
 613  ├───────text: /non-exist/
 614  ├considering: $domain
 615  ├──────value: test.ex
 616             ╰──(tainted)
 617  ├──expanding: /non-exist/$domain
 618  ╰─────result: /non-exist/test.ex
 619             ╰──(tainted)
 620 calling r3 router
 621 r3 router called for userz@test.ex
 622   domain = test.ex
 623 set transport t2
 624 queued for t2 transport: local_part = userz
 625 domain = test.ex
 626   errors_to=NULL
 627   domain_data=NULL local_part_data=userz
 628 routed by r3 router
 629   envelope to: userz@test.ex
 630   transport: t2
 631 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 632 routing usery@test.ex
 633 --------> r1 router <--------
 634 local_part=usery domain=test.ex
 635 checking local_parts
 636 usery in "CALLER"?
 637  list element: CALLER
 638 usery in "CALLER"? no (end of list)
 639 r1 router skipped: local_parts mismatch
 640 --------> r2 router <--------
 641 local_part=usery domain=test.ex
 642 checking local_parts
 643 usery in "usery"?
 644  list element: usery
 645  usery in "usery"? yes (matched "usery")
 646  ╭considering: /non-exist/$domain
 647  ├───────text: /non-exist/
 648  ├considering: $domain
 649  ├──────value: test.ex
 650             ╰──(tainted)
 651  ├──expanding: /non-exist/$domain
 652  ╰─────result: /non-exist/test.ex
 653             ╰──(tainted)
 654 calling r2 router
 655 r2 router called for usery@test.ex
 656   domain = test.ex
 657 set transport t1
 658 queued for t1 transport: local_part = usery
 659 domain = test.ex
 660   errors_to=NULL
 661   domain_data=NULL local_part_data=usery
 662 routed by r2 router
 663   envelope to: usery@test.ex
 664   transport: t1
 665 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 666 routing CALLER@test.ex
 667 --------> r1 router <--------
 668 local_part=CALLER domain=test.ex
 669 checking local_parts
 670 CALLER in "CALLER"?
 671  list element: CALLER
 672  CALLER in "CALLER"? yes (matched "CALLER")
 673  ╭considering: /non-exist/$local_part
 674  ├───────text: /non-exist/
 675  ├considering: $local_part
 676  ├──────value: CALLER
 677             ╰──(tainted)
 678  ├──expanding: /non-exist/$local_part
 679  ╰─────result: /non-exist/CALLER
 680             ╰──(tainted)
 681 calling r1 router
 682 r1 router called for CALLER@test.ex
 683   domain = test.ex
 684 set transport t1
 685 queued for t1 transport: local_part = CALLER
 686 domain = test.ex
 687   errors_to=NULL
 688   domain_data=NULL local_part_data=CALLER
 689 routed by r1 router
 690   envelope to: CALLER@test.ex
 691   transport: t1
 692  locking TESTSUITE/spool/db/retry.lockfile
 693  locked  TESTSUITE/spool/db/retry.lockfile
 694  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 695  returned from EXIM_DBOPEN: (nil)
 696  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 697 no retry data available
 698 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 699 Considering: TESTSUITE/test-mail/junk
 700 unique = TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 701 queued for ft1 transport
 702 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 703 Considering: TESTSUITE/test-mail/junk
 704 unique = TESTSUITE/test-mail/junk:rd+usery@test.ex
 705 queued for ft1 transport
 706 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 707 After routing:
 708   Local deliveries:
 709     TESTSUITE/test-mail/junk
 710     TESTSUITE/test-mail/junk
 711     CALLER@test.ex
 712     usery@test.ex
 713     userz@test.ex
 714   Remote deliveries:
 715   Failed addresses:
 716   Deferred addresses:
 717 search_tidyup called
 718 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 719 --------> TESTSUITE/test-mail/junk <--------
 720  locking TESTSUITE/spool/db/retry.lockfile
 721  locked  TESTSUITE/spool/db/retry.lockfile
 722  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 723  returned from EXIM_DBOPEN: (nil)
 724  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 725 no retry data available
 726  ╭considering: /non-exist/$local_part
 727  ├───────text: /non-exist/
 728  ├considering: $local_part
 729  ├──────value: usery
 730             ╰──(tainted)
 731  ├──expanding: /non-exist/$local_part
 732  ╰─────result: /non-exist/usery
 733             ╰──(tainted)
 734 search_tidyup called
 735 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 736   uid=CALLER_UID gid=CALLER_GID pid=p1236
 737   home=/non-exist/usery current=/
 738 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to TESTSUITE/test-mail/junk using ft1
 739 appendfile transport entered
 740  ╭considering: $address_file
 741  ├──────value: TESTSUITE/test-mail/junk
 742  ├──expanding: $address_file
 743  ╰─────result: TESTSUITE/test-mail/junk
 744 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 745   file=TESTSUITE/test-mail/junk format=unix
 746   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 747   message_suffix=\n
 748   maildir_use_size_file=no
 749   locking by lockfile fcntl
 750 lock name: TESTSUITE/test-mail/junk.lock
 751 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 752 lock file created
 753 mailbox TESTSUITE/test-mail/junk is locked
 754 writing to file TESTSUITE/test-mail/junk
 755  ╭considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 756
 757  ├───────text: From
 758  ├considering: ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 759
 760  ├──condition: def:return_path
 761  ├─────result: true
 762   ╭considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 763
 764   ├──────value: CALLER@test.ex
 765              ╰──(tainted)
 766   ├considering: }{MAILER-DAEMON}} ${tod_bsdinbox}
 767
 768   ├──expanding: $return_path
 769   ╰─────result: CALLER@test.ex
 770              ╰──(tainted)
 771   ╭───scanning: MAILER-DAEMON}} ${tod_bsdinbox}
 772
 773   ├───────text: MAILER-DAEMON
 774   ├───scanning: }} ${tod_bsdinbox}
 775
 776   ├──expanding: MAILER-DAEMON
 777   ├─────result: MAILER-DAEMON
 778   ╰───skipping: result is not used
 779  ├───item-res: CALLER@test.ex
 780             ╰──(tainted)
 781  ├considering:  ${tod_bsdinbox}
 782
 783  ├───────text:
 784  ├considering: ${tod_bsdinbox}
 785
 786  ├considering:
 787
 788  ├───────text:
 789
 790  ├──expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 791
 792  ╰─────result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 793
 794             ╰──(tainted)
 795 writing data block fd=dddd size=sss timeout=0
 796 cannot use sendfile for body: spoolfile not wireformat
 797 writing data block fd=dddd size=sss timeout=0
 798 writing data block fd=dddd size=sss timeout=0
 799 appendfile yields 0 with errno=dd more_errno=dd
 800 search_tidyup called
 801 journalling TESTSUITE/test-mail/junk:rd+usery@test.ex
 802 ft1 transport returned OK for TESTSUITE/test-mail/junk
 803 post-process TESTSUITE/test-mail/junk (0)
 804 TESTSUITE/test-mail/junk delivered
 805 rd+usery@test.ex: children all complete
 806 LOG: MAIN
 807   => TESTSUITE/test-mail/junk <rd+usery@test.ex> R=r5 T=ft1
 808 --------> TESTSUITE/test-mail/junk <--------
 809  locking TESTSUITE/spool/db/retry.lockfile
 810  locked  TESTSUITE/spool/db/retry.lockfile
 811  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 812  returned from EXIM_DBOPEN: (nil)
 813  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 814 no retry data available
 815 search_tidyup called
 816 changed uid/gid: local delivery to TESTSUITE/test-mail/junk <TESTSUITE/test-mail/junk> transport=ft1
 817   uid=CALLER_UID gid=CALLER_GID pid=p1237
 818   home=/non-exist/CALLER current=/
 819 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to TESTSUITE/test-mail/junk using ft1
 820 appendfile transport entered
 821  ╭considering: $address_file
 822  ├──────value: TESTSUITE/test-mail/junk
 823  ├──expanding: $address_file
 824  ╰─────result: TESTSUITE/test-mail/junk
 825 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 826   file=TESTSUITE/test-mail/junk format=unix
 827   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 828   message_suffix=\n
 829   maildir_use_size_file=no
 830   locking by lockfile fcntl
 831 lock name: TESTSUITE/test-mail/junk.lock
 832 hitch name: TESTSUITE/test-mail/junk.lock.test.ex.dddddddd.pppppppp
 833 lock file created
 834 mailbox TESTSUITE/test-mail/junk is locked
 835 writing to file TESTSUITE/test-mail/junk
 836  ╭considering: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 837
 838  ├───────text: From
 839  ├considering: ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 840
 841  ├──condition: def:return_path
 842  ├─────result: true
 843   ╭considering: $return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 844
 845   ├──────value: CALLER@test.ex
 846              ╰──(tainted)
 847   ├considering: }{MAILER-DAEMON}} ${tod_bsdinbox}
 848
 849   ├──expanding: $return_path
 850   ╰─────result: CALLER@test.ex
 851              ╰──(tainted)
 852   ╭───scanning: MAILER-DAEMON}} ${tod_bsdinbox}
 853
 854   ├───────text: MAILER-DAEMON
 855   ├───scanning: }} ${tod_bsdinbox}
 856
 857   ├──expanding: MAILER-DAEMON
 858   ├─────result: MAILER-DAEMON
 859   ╰───skipping: result is not used
 860  ├───item-res: CALLER@test.ex
 861             ╰──(tainted)
 862  ├considering:  ${tod_bsdinbox}
 863
 864  ├───────text:
 865  ├considering: ${tod_bsdinbox}
 866
 867  ├considering:
 868
 869  ├───────text:
 870
 871  ├──expanding: From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}
 872
 873  ╰─────result: From CALLER@test.ex Tue Mar 02 09:44:33 1999
 874
 875             ╰──(tainted)
 876 writing data block fd=dddd size=sss timeout=0
 877 cannot use sendfile for body: spoolfile not wireformat
 878 writing data block fd=dddd size=sss timeout=0
 879 writing data block fd=dddd size=sss timeout=0
 880 appendfile yields 0 with errno=dd more_errno=dd
 881 search_tidyup called
 882 journalling TESTSUITE/test-mail/junk:rd+CALLER@test.ex
 883 ft1 transport returned OK for TESTSUITE/test-mail/junk
 884 post-process TESTSUITE/test-mail/junk (0)
 885 TESTSUITE/test-mail/junk delivered
 886 rd+CALLER@test.ex: children all complete
 887 LOG: MAIN
 888   => TESTSUITE/test-mail/junk <rd+CALLER@test.ex> R=r4 T=ft1
 889 --------> CALLER@test.ex <--------
 890  locking TESTSUITE/spool/db/retry.lockfile
 891  locked  TESTSUITE/spool/db/retry.lockfile
 892  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 893  returned from EXIM_DBOPEN: (nil)
 894  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 895 no retry data available
 896 search_tidyup called
 897 changed uid/gid: local delivery to CALLER <CALLER@test.ex> transport=t1
 898   uid=CALLER_UID gid=CALLER_GID pid=p1238
 899   home=/non-exist/CALLER current=/
 900 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to CALLER using t1
 901 appendfile transport entered
 902 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 903   file=/dev/null format=unix
 904   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 905   message_suffix=\n
 906   maildir_use_size_file=no
 907   locking by lockfile fcntl
 908 search_tidyup called
 909 journalling CALLER@test.ex
 910 t1 transport returned OK for CALLER@test.ex
 911 post-process CALLER@test.ex (0)
 912 CALLER@test.ex delivered
 913 LOG: MAIN
 914   => CALLER <CALLER@test.ex> R=r1 T=t1
 915 --------> usery@test.ex <--------
 916  locking TESTSUITE/spool/db/retry.lockfile
 917  locked  TESTSUITE/spool/db/retry.lockfile
 918  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 919  returned from EXIM_DBOPEN: (nil)
 920  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 921 no retry data available
 922  ╭considering: /non-exist/$local_part
 923  ├───────text: /non-exist/
 924  ├considering: $local_part
 925  ├──────value: usery
 926             ╰──(tainted)
 927  ├──expanding: /non-exist/$local_part
 928  ╰─────result: /non-exist/usery
 929             ╰──(tainted)
 930 search_tidyup called
 931 changed uid/gid: local delivery to usery <usery@test.ex> transport=t1
 932   uid=CALLER_UID gid=CALLER_GID pid=p1239
 933   home=/non-exist/usery current=/
 934 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to usery using t1
 935 appendfile transport entered
 936 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 937   file=/dev/null format=unix
 938   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 939   message_suffix=\n
 940   maildir_use_size_file=no
 941   locking by lockfile fcntl
 942 search_tidyup called
 943 journalling usery@test.ex
 944 t1 transport returned OK for usery@test.ex
 945 post-process usery@test.ex (0)
 946 usery@test.ex delivered
 947 LOG: MAIN
 948   => usery <usery@test.ex> R=r2 T=t1
 949 --------> userz@test.ex <--------
 950  locking TESTSUITE/spool/db/retry.lockfile
 951  locked  TESTSUITE/spool/db/retry.lockfile
 952  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 953  returned from EXIM_DBOPEN: (nil)
 954  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 955 no retry data available
 956  ╭considering: /$local_part
 957  ├───────text: /
 958  ├considering: $local_part
 959  ├──────value: userz
 960             ╰──(tainted)
 961  ├──expanding: /$local_part
 962  ╰─────result: /userz
 963             ╰──(tainted)
 964 search_tidyup called
 965 changed uid/gid: local delivery to userz <userz@test.ex> transport=t2
 966   uid=CALLER_UID gid=CALLER_GID pid=p1240
 967   home=/userz current=/
 968 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to userz using t2
 969 appendfile transport entered
 970 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 971   file=/dev/null format=unix
 972   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 973   message_suffix=\n
 974   maildir_use_size_file=no
 975   locking by lockfile fcntl
 976 search_tidyup called
 977 journalling userz@test.ex
 978 t2 transport returned OK for userz@test.ex
 979 post-process userz@test.ex (0)
 980 userz@test.ex delivered
 981 LOG: MAIN
 982   => userz <userz@test.ex> R=r3 T=t2
 983 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 984 changed uid/gid: post-delivery tidying
 985   uid=EXIM_UID gid=EXIM_GID pid=p1235
 986 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
 987 Processing retry items
 988 Succeeded addresses:
 989  userz@test.ex: no retry items
 990  usery@test.ex: no retry items
 991  CALLER@test.ex: no retry items
 992  TESTSUITE/test-mail/junk: no retry items
 993  rd+CALLER@test.ex: no retry items
 994  TESTSUITE/test-mail/junk: no retry items
 995  rd+usery@test.ex: no retry items
 996  rd+CALLER@test.ex: no retry items
 997  rd+usery@test.ex: no retry items
 998 Failed addresses:
 999 Deferred addresses:
1000 end of retry processing
1001 DSN: processing router : r3
1002 DSN: processing successful delivery address: userz@test.ex
1003 DSN: Sender_address: CALLER@test.ex
1004 DSN: orcpt: NULL  flags: 0x0
1005 DSN: envid: NULL  ret: 0
1006 DSN: Final recipient: userz@test.ex
1007 DSN: Remote SMTP server supports DSN: 0
1008 DSN: not sending DSN success message
1009 DSN: processing router : r2
1010 DSN: processing successful delivery address: usery@test.ex
1011 DSN: Sender_address: CALLER@test.ex
1012 DSN: orcpt: NULL  flags: 0x0
1013 DSN: envid: NULL  ret: 0
1014 DSN: Final recipient: usery@test.ex
1015 DSN: Remote SMTP server supports DSN: 0
1016 DSN: not sending DSN success message
1017 DSN: processing router : r1
1018 DSN: processing successful delivery address: CALLER@test.ex
1019 DSN: Sender_address: CALLER@test.ex
1020 DSN: orcpt: NULL  flags: 0x0
1021 DSN: envid: NULL  ret: 0
1022 DSN: Final recipient: CALLER@test.ex
1023 DSN: Remote SMTP server supports DSN: 0
1024 DSN: not sending DSN success message
1025 DSN: processing router : r4
1026 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
1027 DSN: Sender_address: CALLER@test.ex
1028 DSN: orcpt: NULL  flags: 0x0
1029 DSN: envid: NULL  ret: 0
1030 DSN: Final recipient: TESTSUITE/test-mail/junk
1031 DSN: Remote SMTP server supports DSN: 0
1032 DSN: not sending DSN success message
1033 DSN: processing router : r5
1034 DSN: processing successful delivery address: TESTSUITE/test-mail/junk
1035 DSN: Sender_address: CALLER@test.ex
1036 DSN: orcpt: NULL  flags: 0x0
1037 DSN: envid: NULL  ret: 0
1038 DSN: Final recipient: TESTSUITE/test-mail/junk
1039 DSN: Remote SMTP server supports DSN: 0
1040 DSN: not sending DSN success message
1041 DSN: processing router : r4
1042 DSN: processing successful delivery address: rd+CALLER@test.ex
1043 DSN: Sender_address: CALLER@test.ex
1044 DSN: orcpt: NULL  flags: 0x0
1045 DSN: envid: NULL  ret: 0
1046 DSN: Final recipient: rd+CALLER@test.ex
1047 DSN: Remote SMTP server supports DSN: 0
1048 DSN: not sending DSN success message
1049 DSN: processing router : r5
1050 DSN: processing successful delivery address: rd+usery@test.ex
1051 DSN: Sender_address: CALLER@test.ex
1052 DSN: orcpt: NULL  flags: 0x0
1053 DSN: envid: NULL  ret: 0
1054 DSN: Final recipient: rd+usery@test.ex
1055 DSN: Remote SMTP server supports DSN: 0
1056 DSN: not sending DSN success message
1057 LOG: MAIN
1058   Completed
1059 end delivery of 10HmaX-000000005vi-0000
1060 search_tidyup called
1061 search_tidyup called
1062 >>>>>>>>>>>>>>>> Exim pid=p1235 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
1063 search_tidyup called
1064 >>>>>>>>>>>>>>>> Exim pid=p1234 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>