test/stderr/0402

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