test/stderr/0386

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=pppp
   4 seeking password data for user "CALLER": cache not available
   5 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
   6 configuration file is TESTSUITE/test-config
   7 trusted user
   8 admin user
   9 changed uid/gid: privilege not needed
  10   uid=EXIM_UID gid=EXIM_GID pid=pppp
  11 DSN: r1 propagating DSN
  12 seeking password data for user "CALLER": using cached result
  13 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  14 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  15 sender address = CALLER@test.ex
  16 sender_fullhost = [V4NET.9.8.7]
  17 sender_rcvhost = [V4NET.9.8.7]
  18 host in hosts_connection_nolog? no (option unset)
  19 LOG: smtp_connection MAIN
  20   SMTP connection from [V4NET.9.8.7]
  21 host in host_lookup? no (option unset)
  22 set_process_info: pppp handling incoming connection from [V4NET.9.8.7]
  23 host in host_reject_connection? no (option unset)
  24 host in sender_unqualified_hosts? no (option unset)
  25 host in recipient_unqualified_hosts? no (option unset)
  26 host in helo_verify_hosts? no (option unset)
  27 host in helo_try_verify_hosts? no (option unset)
  28 host in helo_accept_junk_hosts? no (option unset)
  29 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  30 smtp_setup_msg entered
  31 SMTP<< mail from:<x@y>
  32 SMTP>> 250 OK
  33 SMTP<< rcpt to:<1@b>
  34 read ACL from file TESTSUITE/aux-fixed/0386.acl1
  35 processing "accept"
  36 check hosts = :
  37 host in ":"? no (end of list)
  38 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
  39 processing "deny"
  40 check local_parts = ^.*[@%!/|]
  41 1 in "^.*[@%!/|]"? no (end of list)
  42 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
  43 processing "require"
  44 l_message: Invalid sender
  45   message: Couldn't verify the sender
  46 check verify = sender/defer_ok
  47 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  48 Verifying x@y
  49 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  50 Considering x@y
  51 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  52 routing x@y
  53 --------> r1 router <--------
  54 local_part=x domain=y
  55 calling r1 router
  56 r1 router called for x@y
  57   domain = y
  58 set transport t1
  59 queued for t1 transport: local_part = x
  60 domain = y
  61   errors_to=NULL
  62   domain_data=NULL localpart_data=NULL
  63 routed by r1 router
  64   envelope to: x@y
  65   transport: t1
  66 ----------- end verify ------------
  67 sender x@y verified ok
  68 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
  69 processing "deny"
  70   message: No such user here
  71 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
  72 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
  73 SMTP>> 550 No such user here
  74 LOG: MAIN REJECT
  75   H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
  76 SMTP<< rset
  77 SMTP>> 250 Reset OK
  78 SMTP<< mail from:<x@y>
  79 SMTP>> 250 OK
  80 SMTP<< rcpt to:<1@b>
  81 using ACL "TESTSUITE/aux-fixed/0386.acl1"
  82 processing "accept"
  83 check hosts = :
  84 host in ":"? no (end of list)
  85 accept: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
  86 processing "deny"
  87 check local_parts = ^.*[@%!/|]
  88 1 in "^.*[@%!/|]"? no (end of list)
  89 deny: condition test failed in ACL "TESTSUITE/aux-fixed/0386.acl1"
  90 processing "require"
  91 l_message: Invalid sender
  92   message: Couldn't verify the sender
  93 check verify = sender/defer_ok
  94 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  95 Verifying x@y
  96 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  97 Considering x@y
  98 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  99 routing x@y
 100 --------> r1 router <--------
 101 local_part=x domain=y
 102 calling r1 router
 103 r1 router called for x@y
 104   domain = y
 105 queued for t1 transport: local_part = x
 106 domain = y
 107   errors_to=NULL
 108   domain_data=NULL localpart_data=NULL
 109 routed by r1 router
 110   envelope to: x@y
 111   transport: t1
 112 ----------- end verify ------------
 113 sender x@y verified ok
 114 require: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
 115 processing "deny"
 116   message: No such user here
 117 deny: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl1"
 118 end of ACL "TESTSUITE/aux-fixed/0386.acl1": DENY
 119 SMTP>> 550 No such user here
 120 LOG: MAIN REJECT
 121   H=[V4NET.9.8.7] F=<x@y> rejected RCPT <1@b>: No such user here
 122 SMTP<< quit
 123 SMTP>> 221 myhost.test.ex closing connection
 124 LOG: smtp_connection MAIN
 125   SMTP connection from [V4NET.9.8.7] closed by QUIT
 126 search_tidyup called
 127 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 128 Exim version x.yz ....
 129 changed uid/gid: forcing real = effective
 130   uid=uuuu gid=CALLER_GID pid=pppp
 131 seeking password data for user "CALLER": cache not available
 132 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 133 configuration file is TESTSUITE/test-config
 134 trusted user
 135 admin user
 136 changed uid/gid: privilege not needed
 137   uid=EXIM_UID gid=EXIM_GID pid=pppp
 138 DSN: r1 propagating DSN
 139 seeking password data for user "CALLER": using cached result
 140 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 141 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 142 sender address = NULL
 143 sender_fullhost = [V4NET.11.12.13]
 144 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
 145 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] via -oMa
 146 set_process_info: pppp accepting a local SMTP message from <CALLER>
 147 host in hosts_connection_nolog? no (option unset)
 148 LOG: smtp_connection MAIN
 149   SMTP connection from CALLER
 150 host in host_lookup? no (option unset)
 151 set_process_info: pppp handling incoming connection from [V4NET.11.12.13] U=CALLER
 152 host in host_reject_connection? no (option unset)
 153 host in sender_unqualified_hosts? no (option unset)
 154 host in recipient_unqualified_hosts? no (option unset)
 155 host in helo_verify_hosts? no (option unset)
 156 host in helo_try_verify_hosts? no (option unset)
 157 host in helo_accept_junk_hosts? no (option unset)
 158 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 159 smtp_setup_msg entered
 160 SMTP<< mail from:<x@y>
 161 SMTP>> 250 OK
 162 SMTP<< rcpt to:<2@b>
 163 read ACL from file TESTSUITE/aux-fixed/0386.acl2
 164 processing "warn"
 165   message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
 166 l_message: found in $dnslist_domain: $dnslist_text
 167 check dnslists = rbl.test.ex
 168 DNS list check: rbl.test.ex
 169 new DNS lookup for 13.12.11.V4NET.rbl.test.ex
 170 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) using fakens
 171 DNS lookup of 13.12.11.V4NET.rbl.test.ex (A) succeeded
 172 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
 173 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) using fakens
 174 DNS lookup of 13.12.11.V4NET.rbl.test.ex (TXT) succeeded
 175 => that means V4NET.11.12.13 is listed at rbl.test.ex
 176 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
 177 LOG: MAIN
 178   H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
 179 created log directory TESTSUITE/spool/log
 180 processing "accept"
 181 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
 182 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
 183 SMTP>> 250 Accepted
 184 DSN: orcpt: NULL  flags: 0
 185 SMTP<< data
 186 SMTP>> 354 Enter message, ending with "." on a line by itself
 187 search_tidyup called
 188 host in ignore_fromline_hosts? no (option unset)
 189 >>Headers received:
 190
 191 search_tidyup called
 192 >>Headers after rewriting and local additions:
 193
 194 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
 195 Data file written for message 10HmaX-0005vi-00
 196 >>Generated Received: header line
 197 P Received: from [V4NET.11.12.13] (ident=CALLER)
 198         by myhost.test.ex with smtp (Exim x.yz)
 199         (envelope-from <x@y>)
 200         id 10HmaX-0005vi-00
 201         for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
 202 >>Headers added by MAIL or RCPT ACL:
 203   X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
 204   X-Warning: This is a test blacklisting message
 205 >>
 206 calling local_scan(); timeout=300
 207 local_scan() returned 0 NULL
 208 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
 209 DSN: Write SPOOL :-dsn_envid NULL
 210 DSN: Write SPOOL :-dsn_ret 0
 211 DSN: Flags :0
 212 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
 213 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
 214 Size of headers = sss
 215 LOG: MAIN
 216   <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
 217 SMTP>> 250 OK id=10HmaX-0005vi-00
 218 search_tidyup called
 219 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
 220 Exim version x.yz ....
 221 changed uid/gid: forcing real = effective
 222   uid=uuuu gid=EXIM_GID pid=pppp
 223 seeking password data for user "CALLER": cache not available
 224 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 225 configuration file is TESTSUITE/test-config
 226 trusted user
 227 admin user
 228 DSN: r1 propagating DSN
 229 seeking password data for user "CALLER": using cached result
 230 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 231 set_process_info: pppp delivering specified messages
 232 set_process_info: pppp delivering 10HmaX-0005vi-00
 233 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 234 reading spool file 10HmaX-0005vi-00-H
 235 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
 236 sender_fullhost = [V4NET.11.12.13]
 237 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
 238 sender_local=0 ident=CALLER
 239 Non-recipients:
 240 Empty Tree
 241 ---- End of tree ----
 242 recipients_count=1
 243 **** SPOOL_IN - No additional fields
 244 body_linecount=1 message_linecount=7
 245 DSN: set orcpt: NULL  flags: 0
 246 Delivery address list:
 247   2@b
 248 locking TESTSUITE/spool/db/retry.lockfile
 249 locked  TESTSUITE/spool/db/retry.lockfile
 250 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 251 returned from EXIM_DBOPEN
 252 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 253 no retry data available
 254 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 255 Considering: 2@b
 256 unique = 2@b
 257 no domain retry record
 258 no address retry record
 259 2@b: queued for routing
 260 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 261 routing 2@b
 262 --------> r1 router <--------
 263 local_part=2 domain=b
 264 calling r1 router
 265 r1 router called for 2@b
 266   domain = b
 267 set transport t1
 268 queued for t1 transport: local_part = 2
 269 domain = b
 270   errors_to=NULL
 271   domain_data=NULL localpart_data=NULL
 272 routed by r1 router
 273   envelope to: 2@b
 274   transport: t1
 275 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 276 After routing:
 277   Local deliveries:
 278     2@b
 279   Remote deliveries:
 280   Failed addresses:
 281   Deferred addresses:
 282 search_tidyup called
 283 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 284 --------> 2@b <--------
 285 locking TESTSUITE/spool/db/retry.lockfile
 286 locked  TESTSUITE/spool/db/retry.lockfile
 287 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 288 returned from EXIM_DBOPEN
 289 no retry data available
 290 search_tidyup called
 291 changed uid/gid: local delivery to 2 <2@b> transport=t1
 292   uid=CALLER_UID gid=CALLER_GID pid=pppp
 293   home=NULL current=/
 294 set_process_info: pppp delivering 10HmaX-0005vi-00 to 2 using t1
 295 appendfile transport entered
 296 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 297   file=TESTSUITE/test-mail/2 format=unix
 298   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 299   message_suffix=\n
 300   maildir_use_size_file=no
 301   locking by lockfile fcntl
 302 lock name: TESTSUITE/test-mail/2.lock
 303 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
 304 lock file created
 305 mailbox TESTSUITE/test-mail/2 is locked
 306 writing to file TESTSUITE/test-mail/2
 307 writing data block fd=dddd size=sss timeout=0
 308 writing data block fd=dddd size=sss timeout=0
 309 writing data block fd=dddd size=sss timeout=0
 310 appendfile yields 0 with errno=dd more_errno=dd
 311 search_tidyup called
 312 journalling 2@b
 313 t1 transport returned OK for 2@b
 314 post-process 2@b (0)
 315 2@b delivered
 316 LOG: MAIN
 317   => 2 <2@b> R=r1 T=t1
 318 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 319 changed uid/gid: post-delivery tidying
 320   uid=EXIM_UID gid=EXIM_GID pid=pppp
 321 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 322 Processing retry items
 323 Succeeded addresses:
 324  2@b: no retry items
 325 Failed addresses:
 326 Deferred addresses:
 327 end of retry processing
 328 DSN: processing router : r1
 329 DSN: processing successful delivery address: 2@b
 330 DSN: Sender_address: x@y
 331 DSN: orcpt: NULL  flags: 0
 332 DSN: envid: NULL  ret: 0
 333 DSN: Final recipient: 2@b
 334 DSN: Remote SMTP server supports DSN: 0
 335 DSN: not sending DSN success message
 336 LOG: MAIN
 337   Completed
 338 end delivery of 10HmaX-0005vi-00
 339 search_tidyup called
 340 search_tidyup called
 341 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 342 smtp_setup_msg entered
 343 SMTP<< rset
 344 SMTP>> 250 Reset OK
 345 SMTP<< mail from:<x@y>
 346 SMTP>> 250 OK
 347 SMTP<< rcpt to:<2@b>
 348 using ACL "TESTSUITE/aux-fixed/0386.acl2"
 349 processing "warn"
 350   message: X-Warning: $sender_host_address is listed at $dnslist_domain\nX-Warning: $dnslist_text
 351 l_message: found in $dnslist_domain: $dnslist_text
 352 check dnslists = rbl.test.ex
 353 DNS list check: rbl.test.ex
 354 using result of previous DNS lookup
 355 DNS lookup for 13.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
 356 => that means V4NET.11.12.13 is listed at rbl.test.ex
 357 warn: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
 358 LOG: MAIN
 359   H=[V4NET.11.12.13] U=CALLER Warning: found in rbl.test.ex: This is a test blacklisting message
 360 processing "accept"
 361 accept: condition test succeeded in ACL "TESTSUITE/aux-fixed/0386.acl2"
 362 end of ACL "TESTSUITE/aux-fixed/0386.acl2": ACCEPT
 363 SMTP>> 250 Accepted
 364 DSN: orcpt: NULL  flags: 0
 365 SMTP<< data
 366 SMTP>> 354 Enter message, ending with "." on a line by itself
 367 search_tidyup called
 368 host in ignore_fromline_hosts? no (option unset)
 369 >>Headers received:
 370
 371 search_tidyup called
 372 >>Headers after rewriting and local additions:
 373
 374 Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D
 375 Data file written for message 10HmaY-0005vi-00
 376 >>Generated Received: header line
 377 P Received: from [V4NET.11.12.13] (ident=CALLER)
 378         by myhost.test.ex with smtp (Exim x.yz)
 379         (envelope-from <x@y>)
 380         id 10HmaY-0005vi-00
 381         for 2@b; Tue, 2 Mar 1999 09:44:33 +0000
 382 >>Headers added by MAIL or RCPT ACL:
 383   X-Warning: V4NET.11.12.13 is listed at rbl.test.ex
 384   X-Warning: This is a test blacklisting message
 385 >>
 386 calling local_scan(); timeout=300
 387 local_scan() returned 0 NULL
 388 Writing spool header file: TESTSUITE/spool//input//hdr.pppp
 389 DSN: Write SPOOL :-dsn_envid NULL
 390 DSN: Write SPOOL :-dsn_ret 0
 391 DSN: Flags :0
 392 DSN: **** SPOOL_OUT - address: |2@b| errorsto: |NULL| orcpt: |NULL| dsn_flags: 0
 393 Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H
 394 Size of headers = sss
 395 LOG: MAIN
 396   <= x@y H=[V4NET.11.12.13] U=CALLER P=smtp S=sss
 397 SMTP>> 250 OK id=10HmaY-0005vi-00
 398 search_tidyup called
 399 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaY-0005vi-00
 400 Exim version x.yz ....
 401 changed uid/gid: forcing real = effective
 402   uid=uuuu gid=EXIM_GID pid=pppp
 403 seeking password data for user "CALLER": cache not available
 404 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 405 configuration file is TESTSUITE/test-config
 406 trusted user
 407 admin user
 408 DSN: r1 propagating DSN
 409 seeking password data for user "CALLER": using cached result
 410 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 411 set_process_info: pppp delivering specified messages
 412 set_process_info: pppp delivering 10HmaY-0005vi-00
 413 Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D
 414 reading spool file 10HmaY-0005vi-00-H
 415 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=x@y
 416 sender_fullhost = [V4NET.11.12.13]
 417 sender_rcvhost = [V4NET.11.12.13] (ident=CALLER)
 418 sender_local=0 ident=CALLER
 419 Non-recipients:
 420 Empty Tree
 421 ---- End of tree ----
 422 recipients_count=1
 423 **** SPOOL_IN - No additional fields
 424 body_linecount=1 message_linecount=7
 425 DSN: set orcpt: NULL  flags: 0
 426 Delivery address list:
 427   2@b
 428 locking TESTSUITE/spool/db/retry.lockfile
 429 locked  TESTSUITE/spool/db/retry.lockfile
 430 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 431 returned from EXIM_DBOPEN
 432 no retry data available
 433 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 434 Considering: 2@b
 435 unique = 2@b
 436 no domain retry record
 437 no address retry record
 438 2@b: queued for routing
 439 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 440 routing 2@b
 441 --------> r1 router <--------
 442 local_part=2 domain=b
 443 calling r1 router
 444 r1 router called for 2@b
 445   domain = b
 446 set transport t1
 447 queued for t1 transport: local_part = 2
 448 domain = b
 449   errors_to=NULL
 450   domain_data=NULL localpart_data=NULL
 451 routed by r1 router
 452   envelope to: 2@b
 453   transport: t1
 454 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 455 After routing:
 456   Local deliveries:
 457     2@b
 458   Remote deliveries:
 459   Failed addresses:
 460   Deferred addresses:
 461 search_tidyup called
 462 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 463 --------> 2@b <--------
 464 locking TESTSUITE/spool/db/retry.lockfile
 465 locked  TESTSUITE/spool/db/retry.lockfile
 466 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 467 returned from EXIM_DBOPEN
 468 no retry data available
 469 search_tidyup called
 470 changed uid/gid: local delivery to 2 <2@b> transport=t1
 471   uid=CALLER_UID gid=CALLER_GID pid=pppp
 472   home=NULL current=/
 473 set_process_info: pppp delivering 10HmaY-0005vi-00 to 2 using t1
 474 appendfile transport entered
 475 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 476   file=TESTSUITE/test-mail/2 format=unix
 477   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 478   message_suffix=\n
 479   maildir_use_size_file=no
 480   locking by lockfile fcntl
 481 lock name: TESTSUITE/test-mail/2.lock
 482 hitch name: TESTSUITE/test-mail/2.lock.test.ex.dddddddd.pppppppp
 483 lock file created
 484 mailbox TESTSUITE/test-mail/2 is locked
 485 writing to file TESTSUITE/test-mail/2
 486 writing data block fd=dddd size=sss timeout=0
 487 writing data block fd=dddd size=sss timeout=0
 488 writing data block fd=dddd size=sss timeout=0
 489 appendfile yields 0 with errno=dd more_errno=dd
 490 search_tidyup called
 491 journalling 2@b
 492 t1 transport returned OK for 2@b
 493 post-process 2@b (0)
 494 2@b delivered
 495 LOG: MAIN
 496   => 2 <2@b> R=r1 T=t1
 497 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 498 changed uid/gid: post-delivery tidying
 499   uid=EXIM_UID gid=EXIM_GID pid=pppp
 500 set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00
 501 Processing retry items
 502 Succeeded addresses:
 503  2@b: no retry items
 504 Failed addresses:
 505 Deferred addresses:
 506 end of retry processing
 507 DSN: processing router : r1
 508 DSN: processing successful delivery address: 2@b
 509 DSN: Sender_address: x@y
 510 DSN: orcpt: NULL  flags: 0
 511 DSN: envid: NULL  ret: 0
 512 DSN: Final recipient: 2@b
 513 DSN: Remote SMTP server supports DSN: 0
 514 DSN: not sending DSN success message
 515 LOG: MAIN
 516   Completed
 517 end delivery of 10HmaY-0005vi-00
 518 search_tidyup called
 519 search_tidyup called
 520 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 521 smtp_setup_msg entered
 522 SMTP<< quit
 523 SMTP>> 221 myhost.test.ex closing connection
 524 LOG: smtp_connection MAIN
 525   SMTP connection from CALLER closed by QUIT
 526 search_tidyup called
 527 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>