test/stderr/2600

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