test/stderr/2620

   1
   2 WARNING: enabling "trust" authentication for local connections
   3 initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.
   4 Exim version x.yz ....
   5 Hints DB:
   6 configuration file is TESTSUITE/test-config
   7 admin user
   8 dropping to exim gid; retaining priv uid
   9  search_open: pgsql "NULL"
  10  search_find: file="NULL"
  11    key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
  12  LRU list:
  13  internal_search_find: file="NULL"
  14    type=pgsql key="select name from them where id='ph10';" opts=NULL
  15  database lookup required for select name from them where id='ph10';
  16  PostgreSQL query: "select name from them where id='ph10';" opts 'NULL'
  17  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
  18  creating new cache entry
  19  lookup yielded: Philip░Hazel
  20  search_open: pgsql "NULL"
  21    cached open
  22  search_find: file="NULL"
  23    key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
  24  LRU list:
  25  internal_search_find: file="NULL"
  26    type=pgsql key="select name from them where id='ph10';" opts=NULL
  27  cached data used for lookup of select name from them where id='ph10';
  28  lookup yielded: Philip░Hazel
  29  search_open: pgsql "NULL"
  30    cached open
  31  search_find: file="NULL"
  32    key="select name from them where id='xxxx';" partial=-1 affix=NULL starflags=0 opts=NULL
  33  LRU list:
  34  internal_search_find: file="NULL"
  35    type=pgsql key="select name from them where id='xxxx';" opts=NULL
  36  database lookup required for select name from them where id='xxxx';
  37  PostgreSQL query: "select name from them where id='xxxx';" opts 'NULL'
  38  PGSQL using cached connection for localhost:PORT_N/test/CALLER
  39  PGSQL: no data found
  40  creating new cache entry
  41  lookup failed
  42  search_open: pgsql "NULL"
  43    cached open
  44  search_find: file="NULL"
  45    key="select name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts=NULL
  46  LRU list:
  47  internal_search_find: file="NULL"
  48    type=pgsql key="select name from them where id='nothing';" opts=NULL
  49  database lookup required for select name from them where id='nothing';
  50  PostgreSQL query: "select name from them where id='nothing';" opts 'NULL'
  51  PGSQL using cached connection for localhost:PORT_N/test/CALLER
  52  creating new cache entry
  53  lookup yielded:
  54  search_open: pgsql "NULL"
  55    cached open
  56  search_find: file="NULL"
  57    key="select id,name from them where id='nothing';" partial=-1 affix=NULL starflags=0 opts=NULL
  58  LRU list:
  59  internal_search_find: file="NULL"
  60    type=pgsql key="select id,name from them where id='nothing';" opts=NULL
  61  database lookup required for select id,name from them where id='nothing';
  62  PostgreSQL query: "select id,name from them where id='nothing';" opts 'NULL'
  63  PGSQL using cached connection for localhost:PORT_N/test/CALLER
  64  creating new cache entry
  65  lookup yielded: id=nothing░name=""░
  66  search_open: pgsql "NULL"
  67    cached open
  68  search_find: file="NULL"
  69    key="delete from them where id='nonexist';" partial=-1 affix=NULL starflags=0 opts=NULL
  70  LRU list:
  71  internal_search_find: file="NULL"
  72    type=pgsql key="delete from them where id='nonexist';" opts=NULL
  73  database lookup required for delete from them where id='nonexist';
  74  PostgreSQL query: "delete from them where id='nonexist';" opts 'NULL'
  75  PGSQL using cached connection for localhost:PORT_N/test/CALLER
  76  PGSQL: command does not return any data but was successful. Rows affected: 0
  77  lookup forced cache cleanup
  78  lookup yielded: 0
  79  search_open: pgsql "NULL"
  80    cached open
  81  search_find: file="NULL"
  82    key="select * from them where id='quote2';" partial=-1 affix=NULL starflags=0 opts=NULL
  83  LRU list:
  84  internal_search_find: file="NULL"
  85    type=pgsql key="select * from them where id='quote2';" opts=NULL
  86  database lookup required for select * from them where id='quote2';
  87  PostgreSQL query: "select * from them where id='quote2';" opts 'NULL'
  88  PGSQL using cached connection for localhost:PORT_N/test/CALLER
  89  creating new cache entry
  90  lookup yielded: name="\"stquot"░id=quote2░
  91  search_open: pgsql "NULL"
  92    cached open
  93  search_find: file="NULL"
  94    key="select * from them where id='newline';" partial=-1 affix=NULL starflags=0 opts=NULL
  95  LRU list:
  96  internal_search_find: file="NULL"
  97    type=pgsql key="select * from them where id='newline';" opts=NULL
  98  database lookup required for select * from them where id='newline';
  99  PostgreSQL query: "select * from them where id='newline';" opts 'NULL'
 100  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 101  creating new cache entry
 102  lookup yielded: name="before␍↩
 103  after"░id=newline░
 104  search_open: pgsql "NULL"
 105    cached open
 106  search_find: file="NULL"
 107    key="select * from them where id='tab';" partial=-1 affix=NULL starflags=0 opts=NULL
 108  LRU list:
 109  internal_search_find: file="NULL"
 110    type=pgsql key="select * from them where id='tab';" opts=NULL
 111  database lookup required for select * from them where id='tab';
 112  PostgreSQL query: "select * from them where id='tab';" opts 'NULL'
 113  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 114  creating new cache entry
 115  lookup yielded: name="x␉x"░id=tab░
 116  search_open: pgsql "NULL"
 117    cached open
 118  search_find: file="NULL"
 119    key="select * from them where name='''stquot';" partial=-1 affix=NULL starflags=0 opts=NULL
 120  LRU list:
 121  internal_search_find: file="NULL"
 122    type=pgsql key="select * from them where name='''stquot';" opts=NULL
 123  database lookup required for select * from them where name='''stquot';
 124  PostgreSQL query: "select * from them where name='''stquot';" opts 'NULL'
 125  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 126  creating new cache entry
 127  lookup yielded: name='stquot░id=quote1░
 128  search_open: pgsql "NULL"
 129    cached open
 130  search_find: file="NULL"
 131    key="servers=x:localhost; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 132  LRU list:
 133  internal_search_find: file="NULL"
 134    type=pgsql key="servers=x:localhost; select name from them where id='ph10';" opts=NULL
 135  database lookup required for servers=x:localhost; select name from them where id='ph10';
 136  PostgreSQL query: "servers=x:localhost; select name from them where id='ph10';" opts 'NULL'
 137 LOG: MAIN
 138   Exim configuration error in line 11 of -be stdin:
 139   WARNING: obsolete syntax used for lookup
 140  lookup deferred: PostgreSQL server "x" not found in pgsql_servers
 141  search_open: pgsql "NULL"
 142    cached open
 143  search_find: file="NULL"
 144    key="servers=localhost::PORT_N:x; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 145  LRU list:
 146  internal_search_find: file="NULL"
 147    type=pgsql key="servers=localhost::PORT_N:x; select name from them where id='ph10';" opts=NULL
 148  database lookup required for servers=localhost::PORT_N:x; select name from them where id='ph10';
 149  PostgreSQL query: "servers=localhost::PORT_N:x; select name from them where id='ph10';" opts 'NULL'
 150 LOG: MAIN
 151   Exim configuration error in line 12 of -be stdin:
 152   WARNING: obsolete syntax used for lookup
 153  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 154  creating new cache entry
 155  lookup yielded: Philip░Hazel
 156  search_open: pgsql "NULL"
 157    cached open
 158  search_find: file="NULL"
 159    key="servers=localhost::PORT_N/test/CALLER/:x; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 160  LRU list:
 161  internal_search_find: file="NULL"
 162    type=pgsql key="servers=localhost::PORT_N/test/CALLER/:x; select name from them where id='ph10';" opts=NULL
 163  database lookup required for servers=localhost::PORT_N/test/CALLER/:x; select name from them where id='ph10';
 164  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/:x; select name from them where id='ph10';" opts 'NULL'
 165 LOG: MAIN
 166   Exim configuration error in line 13 of -be stdin:
 167   WARNING: obsolete syntax used for lookup
 168  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 169  creating new cache entry
 170  lookup yielded: Philip░Hazel
 171  search_open: pgsql "NULL"
 172    cached open
 173  search_find: file="NULL"
 174    key="servers=(TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER/:x; select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 175  LRU list:
 176  internal_search_find: file="NULL"
 177    type=pgsql key="servers=(TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER/:x; select name from them where id='ph10';" opts=NULL
 178  database lookup required for servers=(TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER/:x; select name from them where id='ph10';
 179  PostgreSQL query: "servers=(TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER/:x; select name from them where id='ph10';" opts 'NULL'
 180 LOG: MAIN
 181   Exim configuration error in line 14 of -be stdin:
 182   WARNING: obsolete syntax used for lookup
 183  PGSQL new connection: socket=TESTSUITE/pgsql/.s.PGSQL.1223 database=test user=CALLER
 184  creating new cache entry
 185  lookup yielded: Philip░Hazel
 186  search_open: pgsql "NULL"
 187    cached open
 188  search_find: file="NULL"
 189    key="SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" partial=-1 affix=NULL starflags=0 opts=NULL
 190  LRU list:
 191  internal_search_find: file="NULL"
 192    type=pgsql key="SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" opts=NULL
 193  database lookup required for SELECT name FROM them WHERE id IN ('ph10', 'aaaa');
 194  PostgreSQL query: "SELECT name FROM them WHERE id IN ('ph10', 'aaaa');" opts 'NULL'
 195  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 196  creating new cache entry
 197  lookup yielded: Philip░Hazel↩
 198  Aristotle
 199  search_open: pgsql "NULL"
 200    cached open
 201  search_find: file="NULL"
 202    key="SELECT *    FROM them WHERE id IN ('ph10', 'aaaa');" partial=-1 affix=NULL starflags=0 opts=NULL
 203  LRU list:
 204  internal_search_find: file="NULL"
 205    type=pgsql key="SELECT *    FROM them WHERE id IN ('ph10', 'aaaa');" opts=NULL
 206  database lookup required for SELECT *    FROM them WHERE id IN ('ph10', 'aaaa');
 207  PostgreSQL query: "SELECT *    FROM them WHERE id IN ('ph10', 'aaaa');" opts 'NULL'
 208  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 209  creating new cache entry
 210  lookup yielded: name="Philip░Hazel"░id=ph10░↩
 211  name=Aristotle░id=aaaa░
 212  search_open: pgsql "NULL"
 213    cached open
 214  search_find: file="NULL"
 215    key="delete from them where id='aaaa'" partial=-1 affix=NULL starflags=0 opts=NULL
 216  LRU list:
 217  internal_search_find: file="NULL"
 218    type=pgsql key="delete from them where id='aaaa'" opts=NULL
 219  database lookup required for delete from them where id='aaaa'
 220  PostgreSQL query: "delete from them where id='aaaa'" opts 'NULL'
 221  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 222  PGSQL: command does not return any data but was successful. Rows affected: 1
 223  lookup forced cache cleanup
 224  lookup yielded: 1
 225 search_tidyup called
 226 close PGSQL connection: (TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER
 227 close PGSQL connection: localhost:PORT_N/test/CALLER
 228 >>>>>>>>>>>>>>>> Exim pid=p1235 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 229 Exim version x.yz ....
 230 Hints DB:
 231 changed uid/gid: forcing real = effective
 232   uid=uuuu gid=CALLER_GID pid=p1236
 233 configuration file is TESTSUITE/test-config
 234 admin user
 235 changed uid/gid: privilege not needed
 236   uid=EXIM_UID gid=EXIM_GID pid=p1236
 237 seeking password data for user "CALLER": cache not available
 238 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 239 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 240 sender address = CALLER@myhost.test.ex
 241 sender_fullhost = [10.0.0.0]
 242 sender_rcvhost = [10.0.0.0]
 243 host in hosts_connection_nolog? no (option unset)
 244 LOG: smtp_connection MAIN
 245   SMTP connection from [10.0.0.0]
 246 host in host_lookup? no (option unset)
 247 set_process_info: pppp handling incoming connection from [10.0.0.0]
 248 host in host_reject_connection? no (option unset)
 249 host in sender_unqualified_hosts? no (option unset)
 250 host in recipient_unqualified_hosts? no (option unset)
 251 host in helo_verify_hosts? no (option unset)
 252 host in helo_try_verify_hosts? no (option unset)
 253 host in helo_accept_junk_hosts? no (option unset)
 254 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 255 smtp_setup_msg entered
 256 SMTP<< helo test
 257 test in helo_lookup_domains?
 258  list element: @
 259  list element: @[]
 260 test in helo_lookup_domains? no (end of list)
 261 sender_fullhost = (test) [10.0.0.0]
 262 sender_rcvhost = [10.0.0.0] (helo=test)
 263 set_process_info: pppp handling incoming connection from (test) [10.0.0.0]
 264 SMTP>> 250 myhost.test.ex Hello test [10.0.0.0]
 265 SMTP<< mail from:<a@b>
 266 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 267 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 268 SMTP>> 250 OK
 269 SMTP<< rcpt to:<c@d>
 270 using ACL "check_recipient"
 271 processing "warn" (TESTSUITE/test-config 27)
 272  search_open: pgsql "NULL"
 273  search_find: file="NULL"
 274    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 275  LRU list:
 276  internal_search_find: file="NULL"
 277    type=pgsql key="select name from them where id = 'c'" opts=NULL
 278  database lookup required for select name from them where id = 'c'
 279                               (tainted, quoted:pgsql)
 280  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 281  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
 282  PGSQL: no data found
 283  creating new cache entry
 284  lookup failed
 285 check set acl_m0 = ok:   ${lookup pgsql                    {select name from them where id = '${quote_pgsql:$local_part}'}}
 286                  = ok:
 287  search_open: pgsql "NULL"
 288    cached open
 289  search_find: file="NULL"
 290    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="cache=no_rd"
 291  LRU list:
 292  internal_search_find: file="NULL"
 293    type=pgsql key="select name from them where id = 'c'" opts=NULL
 294  cached data found but no_rd option set;  database lookup required for select name from them where id = 'c'
 295                               (tainted)
 296 No quoter name for addr
 297 LOG: MAIN PANIC
 298   tainted search query is not properly quoted (ACL warn, TESTSUITE/test-config 27): select name from them where id = 'c'
 299  required_quoter_id (pgsql) quoting -1 (NULL)
 300  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 301  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 302  PGSQL: no data found
 303  replacing old cache entry
 304  lookup failed
 305 check set acl_m0 = FAIL: ${lookup pgsql,cache=no_rd        {select name from them where id = '$local_part'}}
 306                  = FAIL:
 307 warn: condition test succeeded in ACL "check_recipient"
 308 processing "warn" (TESTSUITE/test-config 32)
 309  search_open: pgsql "NULL"
 310    cached open
 311  search_find: file="NULL"
 312    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 313  LRU list:
 314  internal_search_find: file="NULL"
 315    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N/test/CALLER/"
 316  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 317                               (tainted, quoted:pgsql)
 318  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 319  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 320  PGSQL: no data found
 321  replacing old cache entry
 322  lookup failed
 323 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N/test/CALLER/      {select name from them where id = '${quote_pgsql:$local_part}'}}
 324                  = ok:
 325  search_open: pgsql "NULL"
 326    cached open
 327  search_find: file="NULL"
 328    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N"
 329  LRU list:
 330  internal_search_find: file="NULL"
 331    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N"
 332  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 333                               (tainted, quoted:pgsql)
 334  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N'
 335  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 336  PGSQL: no data found
 337  replacing old cache entry
 338  lookup failed
 339 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N    {select name from them where id = '${quote_pgsql:$local_part}'}}
 340                  = ok:
 341  search_open: pgsql "NULL"
 342    cached open
 343  search_find: file="NULL"
 344    key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 345  LRU list:
 346  internal_search_find: file="NULL"
 347    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts=NULL
 348  database lookup required for servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'
 349                               (tainted, quoted:pgsql)
 350  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts 'NULL'
 351 LOG: MAIN
 352   Exim configuration error in ACL verb at line 32 of TESTSUITE/test-config:
 353   WARNING: obsolete syntax used for lookup
 354  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 355 warn: condition test deferred in ACL "check_recipient"
 356 LOG: MAIN
 357   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 358 processing "warn" (TESTSUITE/test-config 41)
 359 check set acl_m0 = ok:   hostlist
 360 check hosts = net-pgsql;select * from them where id='${quote_pgsql:$local_part}'
 361 host in "net-pgsql;select * from them where id='c'"?
 362  list element: net-pgsql;select░*░from░them░where░id='c'
 363  search_open: pgsql "NULL"
 364    cached open
 365  search_find: file="NULL"
 366    key="select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 367  LRU list:
 368  internal_search_find: file="NULL"
 369    type=pgsql key="select * from them where id='c'" opts=NULL
 370  database lookup required for select * from them where id='c'
 371                               (tainted, quoted:pgsql)
 372  PostgreSQL query: "select * from them where id='c'" opts 'NULL'
 373  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 374  PGSQL: no data found
 375  creating new cache entry
 376  lookup failed
 377 host in "net-pgsql;select * from them where id='c'"? no (end of list)
 378 warn: condition test failed in ACL "check_recipient"
 379 processing "warn" (TESTSUITE/test-config 44)
 380 check set acl_m0 = FAIL: hostlist
 381 check hosts = <& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 382 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 383  list element: net-pgsql;servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 384  search_open: pgsql "NULL"
 385    cached open
 386  search_find: file="NULL"
 387    key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 388  LRU list:
 389  internal_search_find: file="NULL"
 390    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts=NULL
 391  database lookup required for servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'
 392                               (tainted, quoted:pgsql)
 393  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts 'NULL'
 394 LOG: MAIN
 395   Exim configuration error in ACL verb at line 44 of TESTSUITE/test-config:
 396   WARNING: obsolete syntax used for lookup
 397  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 398 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"? list match deferred for net-pgsql;servers=localhost::1223/test/CALLER/; select * from them where id='c'
 399 warn: condition test deferred in ACL "check_recipient"
 400 LOG: MAIN
 401   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 402 processing "warn" (TESTSUITE/test-config 49)
 403 check set acl_m0 = FAIL: hostlist
 404 check hosts = <& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 405 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 406  list element: net-pgsql,servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 407  search_open: pgsql "NULL"
 408    cached open
 409  search_find: file="NULL"
 410    key=" select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 411  LRU list:
 412  internal_search_find: file="NULL"
 413    type=pgsql key=" select * from them where id='c'" opts="servers=localhost::PORT_N/test/CALLER/"
 414  database lookup required for  select * from them where id='c'
 415                               (tainted, quoted:pgsql)
 416  PostgreSQL query: " select * from them where id='c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 417  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 418 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"? list match deferred for net-pgsql,servers=localhost::1223/test/CALLER/; select * from them where id='c'
 419 warn: condition test deferred in ACL "check_recipient"
 420 LOG: MAIN
 421   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 422 processing "accept" (TESTSUITE/test-config 52)
 423 check domains = +local_domains
 424 d in "+local_domains"?
 425  list element: +local_domains
 426   start sublist local_domains
 427    d in "@"?
 428    ╎list element: @
 429    d in "@"? no (end of list)
 430   end sublist local_domains
 431 d in "+local_domains"? no (end of list)
 432 accept: condition test failed in ACL "check_recipient"
 433 processing "accept" (TESTSUITE/test-config 53)
 434 check hosts = +relay_hosts
 435 host in "+relay_hosts"?
 436  list element: +relay_hosts
 437   start sublist relay_hosts
 438   host in "net-pgsql;select * from them where id='10.0.0.0'"?
 439    ╎list element: net-pgsql;select░*░from░them░where░id='10.0.0.0'
 440    ╎search_open: pgsql "NULL"
 441    ╎  cached open
 442    ╎search_find: file="NULL"
 443    ╎  key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
 444    ╎LRU list:
 445    ╎internal_search_find: file="NULL"
 446    ╎  type=pgsql key="select * from them where id='10.0.0.0'" opts=NULL
 447    ╎database lookup required for select * from them where id='10.0.0.0'
 448    ╎PostgreSQL query: "select * from them where id='10.0.0.0'" opts 'NULL'
 449    ╎PGSQL using cached connection for localhost:PORT_N/test/CALLER
 450    ╎PGSQL: no data found
 451    ╎creating new cache entry
 452    ╎lookup failed
 453   host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 454   end sublist relay_hosts
 455 host in "+relay_hosts"? no (end of list)
 456 accept: condition test failed in ACL "check_recipient"
 457 processing "deny" (TESTSUITE/test-config 54)
 458   message: relay not permitted
 459 deny: condition test succeeded in ACL "check_recipient"
 460 end of ACL "check_recipient": DENY
 461 SMTP>> 550 relay not permitted
 462 LOG: MAIN REJECT
 463   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 464 SMTP<< rcpt to:<c@d>
 465 using ACL "check_recipient"
 466 processing "warn" (TESTSUITE/test-config 27)
 467  search_open: pgsql "NULL"
 468    cached open
 469  search_find: file="NULL"
 470    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 471  LRU list:
 472  internal_search_find: file="NULL"
 473    type=pgsql key="select name from them where id = 'c'" opts=NULL
 474  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 475                               (tainted, quoted:pgsql)
 476  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 477  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 478  PGSQL: no data found
 479  replacing old cache entry
 480  lookup failed
 481 check set acl_m0 = ok:   ${lookup pgsql                    {select name from them where id = '${quote_pgsql:$local_part}'}}
 482                  = ok:
 483  search_open: pgsql "NULL"
 484    cached open
 485  search_find: file="NULL"
 486    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="cache=no_rd"
 487  LRU list:
 488  internal_search_find: file="NULL"
 489    type=pgsql key="select name from them where id = 'c'" opts=NULL
 490  cached data found but no_rd option set;  database lookup required for select name from them where id = 'c'
 491                               (tainted)
 492 No quoter name for addr
 493 LOG: MAIN PANIC
 494   tainted search query is not properly quoted (ACL warn, TESTSUITE/test-config 27): select name from them where id = 'c'
 495  required_quoter_id (pgsql) quoting -1 (NULL)
 496  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 497  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 498  PGSQL: no data found
 499  replacing old cache entry
 500  lookup failed
 501 check set acl_m0 = FAIL: ${lookup pgsql,cache=no_rd        {select name from them where id = '$local_part'}}
 502                  = FAIL:
 503 warn: condition test succeeded in ACL "check_recipient"
 504 processing "warn" (TESTSUITE/test-config 32)
 505  search_open: pgsql "NULL"
 506    cached open
 507  search_find: file="NULL"
 508    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 509  LRU list:
 510  internal_search_find: file="NULL"
 511    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N/test/CALLER/"
 512  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 513                               (tainted, quoted:pgsql)
 514  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 515  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 516  PGSQL: no data found
 517  replacing old cache entry
 518  lookup failed
 519 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N/test/CALLER/      {select name from them where id = '${quote_pgsql:$local_part}'}}
 520                  = ok:
 521  search_open: pgsql "NULL"
 522    cached open
 523  search_find: file="NULL"
 524    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N"
 525  LRU list:
 526  internal_search_find: file="NULL"
 527    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N"
 528  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 529                               (tainted, quoted:pgsql)
 530  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N'
 531  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 532  PGSQL: no data found
 533  replacing old cache entry
 534  lookup failed
 535 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N    {select name from them where id = '${quote_pgsql:$local_part}'}}
 536                  = ok:
 537  search_open: pgsql "NULL"
 538    cached open
 539  search_find: file="NULL"
 540    key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 541  LRU list:
 542  internal_search_find: file="NULL"
 543    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts=NULL
 544  database lookup required for servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'
 545                               (tainted, quoted:pgsql)
 546  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts 'NULL'
 547 LOG: MAIN
 548   Exim configuration error in ACL verb at line 32 of TESTSUITE/test-config:
 549   WARNING: obsolete syntax used for lookup
 550  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 551 warn: condition test deferred in ACL "check_recipient"
 552 LOG: MAIN
 553   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 554 processing "warn" (TESTSUITE/test-config 41)
 555 check set acl_m0 = ok:   hostlist
 556 check hosts = net-pgsql;select * from them where id='${quote_pgsql:$local_part}'
 557 host in "net-pgsql;select * from them where id='c'"?
 558  list element: net-pgsql;select░*░from░them░where░id='c'
 559  search_open: pgsql "NULL"
 560    cached open
 561  search_find: file="NULL"
 562    key="select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 563  LRU list:
 564  internal_search_find: file="NULL"
 565    type=pgsql key="select * from them where id='c'" opts=NULL
 566  cached data used for lookup of select * from them where id='c'
 567  lookup failed
 568 host in "net-pgsql;select * from them where id='c'"? no (end of list)
 569 warn: condition test failed in ACL "check_recipient"
 570 processing "warn" (TESTSUITE/test-config 44)
 571 check set acl_m0 = FAIL: hostlist
 572 check hosts = <& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 573 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 574  list element: net-pgsql;servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 575  search_open: pgsql "NULL"
 576    cached open
 577  search_find: file="NULL"
 578    key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 579  LRU list:
 580  internal_search_find: file="NULL"
 581    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts=NULL
 582  database lookup required for servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'
 583                               (tainted, quoted:pgsql)
 584  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts 'NULL'
 585 LOG: MAIN
 586   Exim configuration error in ACL verb at line 44 of TESTSUITE/test-config:
 587   WARNING: obsolete syntax used for lookup
 588  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 589 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"? list match deferred for net-pgsql;servers=localhost::1223/test/CALLER/; select * from them where id='c'
 590 warn: condition test deferred in ACL "check_recipient"
 591 LOG: MAIN
 592   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 593 processing "warn" (TESTSUITE/test-config 49)
 594 check set acl_m0 = FAIL: hostlist
 595 check hosts = <& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 596 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 597  list element: net-pgsql,servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 598  search_open: pgsql "NULL"
 599    cached open
 600  search_find: file="NULL"
 601    key=" select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 602  LRU list:
 603  internal_search_find: file="NULL"
 604    type=pgsql key=" select * from them where id='c'" opts="servers=localhost::PORT_N/test/CALLER/"
 605  database lookup required for  select * from them where id='c'
 606                               (tainted, quoted:pgsql)
 607  PostgreSQL query: " select * from them where id='c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 608  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 609 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"? list match deferred for net-pgsql,servers=localhost::1223/test/CALLER/; select * from them where id='c'
 610 warn: condition test deferred in ACL "check_recipient"
 611 LOG: MAIN
 612   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 613 processing "accept" (TESTSUITE/test-config 52)
 614 check domains = +local_domains
 615 d in "+local_domains"?
 616  list element: +local_domains
 617   start sublist local_domains
 618    d in "@"?
 619    ╎list element: @
 620    d in "@"? no (end of list)
 621   end sublist local_domains
 622 d in "+local_domains"? no (end of list)
 623 accept: condition test failed in ACL "check_recipient"
 624 processing "accept" (TESTSUITE/test-config 53)
 625 check hosts = +relay_hosts
 626 host in "+relay_hosts"?
 627  list element: +relay_hosts
 628   start sublist relay_hosts
 629   host in "net-pgsql;select * from them where id='10.0.0.0'"?
 630    ╎list element: net-pgsql;select░*░from░them░where░id='10.0.0.0'
 631    ╎search_open: pgsql "NULL"
 632    ╎  cached open
 633    ╎search_find: file="NULL"
 634    ╎  key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
 635    ╎LRU list:
 636    ╎internal_search_find: file="NULL"
 637    ╎  type=pgsql key="select * from them where id='10.0.0.0'" opts=NULL
 638    ╎cached data used for lookup of select * from them where id='10.0.0.0'
 639    ╎lookup failed
 640   host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 641   end sublist relay_hosts
 642 host in "+relay_hosts"? no (end of list)
 643 accept: condition test failed in ACL "check_recipient"
 644 processing "deny" (TESTSUITE/test-config 54)
 645   message: relay not permitted
 646 deny: condition test succeeded in ACL "check_recipient"
 647 end of ACL "check_recipient": DENY
 648 SMTP>> 550 relay not permitted
 649 LOG: MAIN REJECT
 650   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 651 SMTP<< quit
 652 SMTP>> 221 myhost.test.ex closing connection
 653 LOG: smtp_connection MAIN
 654   SMTP connection from (test) [10.0.0.0] D=qqs closed by QUIT
 655 search_tidyup called
 656 close PGSQL connection: localhost:PORT_N/test/CALLER
 657 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 658 Exim version x.yz ....
 659 Hints DB:
 660 changed uid/gid: forcing real = effective
 661   uid=uuuu gid=CALLER_GID pid=p1237
 662 configuration file is TESTSUITE/test-config
 663 admin user
 664 changed uid/gid: privilege not needed
 665   uid=EXIM_UID gid=EXIM_GID pid=p1237
 666 seeking password data for user "CALLER": cache not available
 667 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 668 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 669 sender address = CALLER@myhost.test.ex
 670 set_process_info: pppp accepting a local non-SMTP message from <CALLER@myhost.test.ex>
 671 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 672 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 673 Sender: CALLER@myhost.test.ex
 674 Recipients:
 675   CALLER
 676 search_tidyup called
 677 >>Headers received:
 678
 679 qualify & rewrite recipients list
 680 rewrite rules on sender address
 681 qualify and rewrite headers
 682  rewrite_one_header: type=F:
 683    From: CALLER_NAME <CALLER@myhost.test.ex>
 684 search_tidyup called
 685 >>Headers after rewriting and local additions:
 686  I Message-Id: <E10HmaX-000000005vi-0000@myhost.test.ex>
 687  F From: CALLER_NAME <CALLER@myhost.test.ex>
 688    Date: Tue, 2 Mar 1999 09:44:33 +0000
 689
 690 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 691 Data file written for message 10HmaX-000000005vi-0000
 692 >>Generated Received: header line
 693 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
 694         (envelope-from <CALLER@myhost.test.ex>)
 695         id 10HmaX-000000005vi-0000
 696         for CALLER@myhost.test.ex;
 697         Tue, 2 Mar 1999 09:44:33 +0000
 698 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-000000005vi-0000
 699 DSN: **** SPOOL_OUT - address: <CALLER@myhost.test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 700 Renaming spool header file: TESTSUITE/spool//input//10HmaX-000000005vi-0000-H
 701 Size of headers = sss
 702 LOG: MAIN
 703   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
 704 created log directory TESTSUITE/spool/log
 705 search_tidyup called
 706 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-000000005vi-0000
 707 Exim version x.yz ....
 708 Hints DB:
 709 changed uid/gid: forcing real = effective
 710   uid=uuuu gid=EXIM_GID pid=p1238
 711 configuration file is TESTSUITE/test-config
 712 trusted user
 713 admin user
 714 dropping to exim gid; retaining priv uid
 715 seeking password data for user "CALLER": cache not available
 716 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 717 set_process_info: pppp delivering specified messages
 718 set_process_info: pppp delivering 10HmaX-000000005vi-0000
 719 Trying spool file TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 720 reading spool file 10HmaX-000000005vi-0000-H
 721 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
 722 sender_local=1 ident=CALLER
 723 Non-recipients:
 724  Empty Tree
 725 ---- End of tree ----
 726 recipients_count=1
 727 **** SPOOL_IN - No additional fields
 728 body_linecount=1 message_linecount=8
 729 DSN: set orcpt:   flags: 0x0
 730 Delivery address list:
 731   CALLER@myhost.test.ex
 732 no retry data available
 733 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 734 Considering: CALLER@myhost.test.ex
 735 unique = CALLER@myhost.test.ex
 736 checking router retry status
 737  no   domain  retry record
 738  no   address retry record
 739 CALLER@myhost.test.ex: queued for routing
 740 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 741 routing CALLER@myhost.test.ex
 742 --------> r1 router <--------
 743 local_part=CALLER domain=myhost.test.ex
 744 processing address_data
 745  search_open: pgsql "NULL"
 746  search_find: file="NULL"
 747    key="select name from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
 748  LRU list:
 749  internal_search_find: file="NULL"
 750    type=pgsql key="select name from them where id='ph10'" opts=NULL
 751  database lookup required for select name from them where id='ph10'
 752  PostgreSQL query: "select name from them where id='ph10'" opts 'NULL'
 753  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
 754  creating new cache entry
 755  lookup yielded: Philip░Hazel
 756 calling r1 router
 757 r1 router called for CALLER@myhost.test.ex
 758   domain = myhost.test.ex
 759 set transport t1
 760 queued for t1 transport: local_part = CALLER
 761 domain = myhost.test.ex
 762   errors_to=NULL
 763   domain_data=NULL local_part_data=NULL
 764 routed by r1 router
 765   envelope to: CALLER@myhost.test.ex
 766   transport: t1
 767 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 768 After routing:
 769   Local deliveries:
 770     CALLER@myhost.test.ex
 771   Remote deliveries:
 772   Failed addresses:
 773   Deferred addresses:
 774 search_tidyup called
 775 close PGSQL connection: localhost:PORT_N/test/CALLER
 776 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 777 --------> CALLER@myhost.test.ex <--------
 778 no retry data available
 779 search_tidyup called
 780 changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t1
 781   uid=CALLER_UID gid=CALLER_GID pid=p1239
 782   home=NULL current=/
 783 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to CALLER using t1
 784 appendfile transport entered
 785  search_open: pgsql "NULL"
 786  search_find: file="NULL"
 787    key="select id from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
 788  LRU list:
 789  internal_search_find: file="NULL"
 790    type=pgsql key="select id from them where id='ph10'" opts=NULL
 791  database lookup required for select id from them where id='ph10'
 792  PostgreSQL query: "select id from them where id='ph10'" opts 'NULL'
 793  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
 794  creating new cache entry
 795  lookup yielded: ph10
 796 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 797   file=TESTSUITE/test-mail/ph10 format=unix
 798   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 799   message_suffix=\n
 800   maildir_use_size_file=no
 801   locking by lockfile fcntl
 802 lock name: TESTSUITE/test-mail/ph10.lock
 803 hitch name: TESTSUITE/test-mail/ph10.lock.test.ex.dddddddd.pppppppp
 804 lock file created
 805 mailbox TESTSUITE/test-mail/ph10 is locked
 806 writing to file TESTSUITE/test-mail/ph10
 807 writing data block fd=dddd size=sss timeout=0
 808 cannot use sendfile for body: spoolfile not wireformat
 809 writing data block fd=dddd size=sss timeout=0
 810 writing data block fd=dddd size=sss timeout=0
 811 appendfile yields 0 with errno=dd more_errno=dd
 812 search_tidyup called
 813 close PGSQL connection: localhost:PORT_N/test/CALLER
 814 >>>>>>>>>>>>>>>> Exim pid=p1239 (delivery-local) terminating with rc=0 >>>>>>>>>>>>>>>>
 815 journalling CALLER@myhost.test.ex
 816 t1 transport returned OK for CALLER@myhost.test.ex
 817 post-process CALLER@myhost.test.ex (0)
 818 CALLER@myhost.test.ex delivered
 819 LOG: MAIN
 820   => CALLER <CALLER@myhost.test.ex> R=r1 T=t1
 821 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 822 changed uid/gid: post-delivery tidying
 823   uid=EXIM_UID gid=EXIM_GID pid=p1238
 824 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
 825 Processing retry items
 826  Succeeded addresses:
 827   CALLER@myhost.test.ex: no retry items
 828  Failed addresses:
 829  Deferred addresses:
 830 end of retry processing
 831 DSN: processing router : r1
 832 DSN: processing successful delivery address: CALLER@myhost.test.ex
 833 DSN: Sender_address: CALLER@myhost.test.ex
 834 DSN: orcpt: NULL  flags: 0x0
 835 DSN: envid: NULL  ret: 0
 836 DSN: Final recipient: CALLER@myhost.test.ex
 837 DSN: Remote SMTP server supports DSN: 0
 838 DSN: not sending DSN success message
 839 LOG: MAIN
 840   Completed
 841 end delivery of 10HmaX-000000005vi-0000
 842 search_tidyup called
 843 search_tidyup called
 844 >>>>>>>>>>>>>>>> Exim pid=p1238 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 845 search_tidyup called
 846 >>>>>>>>>>>>>>>> Exim pid=p1237 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 847 Exim version x.yz ....
 848 Hints DB:
 849 configuration file is TESTSUITE/test-config
 850 admin user
 851 dropping to exim gid; retaining priv uid
 852  search_open: pgsql "NULL"
 853  search_find: file="NULL"
 854    key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 855  LRU list:
 856  internal_search_find: file="NULL"
 857    type=pgsql key="select name from them where id='ph10';" opts=NULL
 858  database lookup required for select name from them where id='ph10';
 859  PostgreSQL query: "select name from them where id='ph10';" opts 'NULL'
 860  PGSQL new connection: socket=TESTSUITE/pgsql/.s.PGSQL.1223 database=test user=CALLER
 861  creating new cache entry
 862  lookup yielded: Philip░Hazel
 863 search_tidyup called
 864 close PGSQL connection: (TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER
 865 >>>>>>>>>>>>>>>> Exim pid=p1240 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 866
 867 ******** SERVER ********
 868 2017-07-30 18:51:05.712 [pppp] LOG:  redirecting log output to logging collector process
 869 2017-07-30 18:51:05.712 [pppp] HINT:  Future log output will appear in directory "log".