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 (fresh-exec) 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 26)
 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 27)
 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 28)
 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 26)
 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 27)
 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 28)
 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 (fresh-exec) 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 26)
 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 27)
 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 26)
 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 27)
 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 (fresh-exec) 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 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00
 335 Exim version x.yz ....
 336 changed uid/gid: forcing real = effective
 337   uid=uuuu gid=EXIM_GID pid=pppp
 338 configuration file is TESTSUITE/test-config
 339 trusted user
 340 admin user
 341 dropping to exim gid; retaining priv uid
 342 seeking password data for user "CALLER": cache not available
 343 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 344 set_process_info: pppp delivering specified messages
 345 set_process_info: pppp delivering 10HmaX-0005vi-00
 346 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 347 reading spool file 10HmaX-0005vi-00-H
 348 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
 349 sender_local=1 ident=CALLER
 350 Non-recipients:
 351 Empty Tree
 352 ---- End of tree ----
 353 recipients_count=1
 354 **** SPOOL_IN - No additional fields
 355 body_linecount=1 message_linecount=7
 356 DSN: set orcpt:   flags: 0x0
 357 Delivery address list:
 358   userx@myhost.test.ex
 359  locking TESTSUITE/spool/db/retry.lockfile
 360  locked  TESTSUITE/spool/db/retry.lockfile
 361  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 362  returned from EXIM_DBOPEN: (nil)
 363  ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 364  failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory
 365 no retry data available
 366 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 367 Considering: userx@myhost.test.ex
 368 unique = userx@myhost.test.ex
 369 no   domain  retry record
 370 no   address retry record
 371 userx@myhost.test.ex: queued for routing
 372 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 373 routing userx@myhost.test.ex
 374 --------> r1 router <--------
 375 local_part=userx domain=myhost.test.ex
 376 processing address_data
 377  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
 378  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 379    key="select name from them where id='userx'" partial=-1 affix=NULL starflags=0
 380  LRU list:
 381  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 382    type=sqlite key="select name from them where id='userx'"
 383  file lookup required for select name from them where id='userx'
 384    in TESTSUITE/aux-fixed/sqlitedb
 385  lookup yielded: Ayen Other
 386 calling r1 router
 387 r1 router called for userx@myhost.test.ex
 388   domain = myhost.test.ex
 389 set transport t1
 390 queued for t1 transport: local_part = userx
 391 domain = myhost.test.ex
 392   errors_to=NULL
 393   domain_data=NULL localpart_data=NULL
 394 routed by r1 router
 395   envelope to: userx@myhost.test.ex
 396   transport: t1
 397 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 398 After routing:
 399   Local deliveries:
 400     userx@myhost.test.ex
 401   Remote deliveries:
 402   Failed addresses:
 403   Deferred addresses:
 404 search_tidyup called
 405 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 406 --------> userx@myhost.test.ex <--------
 407  locking TESTSUITE/spool/db/retry.lockfile
 408  locked  TESTSUITE/spool/db/retry.lockfile
 409  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 410  returned from EXIM_DBOPEN: (nil)
 411  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 412 no retry data available
 413 search_tidyup called
 414 changed uid/gid: local delivery to userx <userx@myhost.test.ex> transport=t1
 415   uid=CALLER_UID gid=CALLER_GID pid=pppp
 416   home=NULL current=/
 417 set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1
 418 appendfile transport entered
 419  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
 420  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 421    key="select id from them where id='userx'" partial=-1 affix=NULL starflags=0
 422  LRU list:
 423  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 424    type=sqlite key="select id from them where id='userx'"
 425  file lookup required for select id from them where id='userx'
 426    in TESTSUITE/aux-fixed/sqlitedb
 427  lookup yielded: userx
 428 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 429   file=TESTSUITE/test-mail/userx format=unix
 430   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 431   message_suffix=\n
 432   maildir_use_size_file=no
 433   locking by lockfile fcntl
 434 lock name: TESTSUITE/test-mail/userx.lock
 435 hitch name: TESTSUITE/test-mail/userx.lock.test.ex.dddddddd.pppppppp
 436 lock file created
 437 mailbox TESTSUITE/test-mail/userx is locked
 438 writing to file TESTSUITE/test-mail/userx
 439 writing data block fd=dddd size=sss timeout=0
 440 cannot use sendfile for body: spoolfile not wireformat
 441 writing data block fd=dddd size=sss timeout=0
 442 writing data block fd=dddd size=sss timeout=0
 443 appendfile yields 0 with errno=dd more_errno=dd
 444 search_tidyup called
 445 journalling userx@myhost.test.ex
 446 t1 transport returned OK for userx@myhost.test.ex
 447 post-process userx@myhost.test.ex (0)
 448 userx@myhost.test.ex delivered
 449 LOG: MAIN
 450   => userx <userx@myhost.test.ex> R=r1 T=t1
 451 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 452 changed uid/gid: post-delivery tidying
 453   uid=EXIM_UID gid=EXIM_GID pid=pppp
 454 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 455 Processing retry items
 456 Succeeded addresses:
 457  userx@myhost.test.ex: no retry items
 458 Failed addresses:
 459 Deferred addresses:
 460 end of retry processing
 461 DSN: processing router : r1
 462 DSN: processing successful delivery address: userx@myhost.test.ex
 463 DSN: Sender_address: CALLER@myhost.test.ex
 464 DSN: orcpt: NULL  flags: 0x0
 465 DSN: envid: NULL  ret: 0
 466 DSN: Final recipient: userx@myhost.test.ex
 467 DSN: Remote SMTP server supports DSN: 0
 468 DSN: not sending DSN success message
 469 LOG: MAIN
 470   Completed
 471 end delivery of 10HmaX-0005vi-00
 472 search_tidyup called
 473 search_tidyup called
 474 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 475 search_tidyup called
 476 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 477 Exim version x.yz ....
 478 configuration file is TESTSUITE/test-config
 479 admin user
 480 dropping to exim gid; retaining priv uid
 481  search_open: sqlite "TESTSUITE/aux-fixed/sqlitedb"
 482  search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 483    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0
 484  LRU list:
 485  internal_search_find: file="TESTSUITE/aux-fixed/sqlitedb"
 486    type=sqlite key="select name from them where id='userx';"
 487  file lookup required for select name from them where id='userx';
 488    in TESTSUITE/aux-fixed/sqlitedb
 489  lookup yielded: Ayen Other
 490 search_tidyup called
 491 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 492 Exim version x.yz ....
 493 configuration file is TESTSUITE/test-config
 494 admin user
 495 dropping to exim gid; retaining priv uid
 496  search_open: sqlite "NULL"
 497  search_find: file="NULL"
 498    key="select name from them where id='userx';" partial=-1 affix=NULL starflags=0
 499  LRU list:
 500  internal_search_find: file="NULL"
 501    type=sqlite key="select name from them where id='userx';"
 502  database lookup required for select name from them where id='userx';
 503  lookup yielded: Ayen Other
 504 search_tidyup called
 505 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>