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 78 of TESTSUITE/test-config:
 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 78 of TESTSUITE/test-config:
 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 78 of TESTSUITE/test-config:
 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 78 of TESTSUITE/test-config:
 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 LOG: MAIN PANIC
 297   tainted search query is not properly quoted (ACL warn, TESTSUITE/test-config 27): select name from them where id = 'c'
 298  search_type NN (pgsql) quoting -1 (none)
 299  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 300  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 301  PGSQL: no data found
 302  replacing old cache entry
 303  lookup failed
 304 check set acl_m0 = FAIL: ${lookup pgsql,cache=no_rd        {select name from them where id = '$local_part'}}
 305                  = FAIL:
 306 warn: condition test succeeded in ACL "check_recipient"
 307 processing "warn" (TESTSUITE/test-config 32)
 308  search_open: pgsql "NULL"
 309    cached open
 310  search_find: file="NULL"
 311    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 312  LRU list:
 313  internal_search_find: file="NULL"
 314    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N/test/CALLER/"
 315  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 316                               (tainted, quoted:pgsql)
 317  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 318  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 319  PGSQL: no data found
 320  replacing old cache entry
 321  lookup failed
 322 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N/test/CALLER/      {select name from them where id = '${quote_pgsql:$local_part}'}}
 323                  = ok:
 324  search_open: pgsql "NULL"
 325    cached open
 326  search_find: file="NULL"
 327    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N"
 328  LRU list:
 329  internal_search_find: file="NULL"
 330    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N"
 331  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 332                               (tainted, quoted:pgsql)
 333  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N'
 334  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 335  PGSQL: no data found
 336  replacing old cache entry
 337  lookup failed
 338 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N    {select name from them where id = '${quote_pgsql:$local_part}'}}
 339                  = ok:
 340  search_open: pgsql "NULL"
 341    cached open
 342  search_find: file="NULL"
 343    key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 344  LRU list:
 345  internal_search_find: file="NULL"
 346    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts=NULL
 347  database lookup required for servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'
 348                               (tainted, quoted:pgsql)
 349  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts 'NULL'
 350 LOG: MAIN
 351   Exim configuration error in line 78 of TESTSUITE/test-config:
 352   WARNING: obsolete syntax used for lookup
 353  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 354 warn: condition test deferred in ACL "check_recipient"
 355 LOG: MAIN
 356   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 357 processing "warn" (TESTSUITE/test-config 41)
 358 check set acl_m0 = ok:   hostlist
 359 check hosts = net-pgsql;select * from them where id='${quote_pgsql:$local_part}'
 360 host in "net-pgsql;select * from them where id='c'"?
 361  list element: net-pgsql;select░*░from░them░where░id='c'
 362  search_open: pgsql "NULL"
 363    cached open
 364  search_find: file="NULL"
 365    key="select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 366  LRU list:
 367  internal_search_find: file="NULL"
 368    type=pgsql key="select * from them where id='c'" opts=NULL
 369  database lookup required for select * from them where id='c'
 370                               (tainted, quoted:pgsql)
 371  PostgreSQL query: "select * from them where id='c'" opts 'NULL'
 372  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 373  PGSQL: no data found
 374  creating new cache entry
 375  lookup failed
 376 host in "net-pgsql;select * from them where id='c'"? no (end of list)
 377 warn: condition test failed in ACL "check_recipient"
 378 processing "warn" (TESTSUITE/test-config 44)
 379 check set acl_m0 = FAIL: hostlist
 380 check hosts = <& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 381 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 382  list element: net-pgsql;servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 383  search_open: pgsql "NULL"
 384    cached open
 385  search_find: file="NULL"
 386    key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 387  LRU list:
 388  internal_search_find: file="NULL"
 389    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts=NULL
 390  database lookup required for servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'
 391                               (tainted, quoted:pgsql)
 392  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts 'NULL'
 393 LOG: MAIN
 394   Exim configuration error in line 78 of TESTSUITE/test-config:
 395   WARNING: obsolete syntax used for lookup
 396  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 397 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'
 398 warn: condition test deferred in ACL "check_recipient"
 399 LOG: MAIN
 400   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 401 processing "warn" (TESTSUITE/test-config 49)
 402 check set acl_m0 = FAIL: hostlist
 403 check hosts = <& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 404 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 405  list element: net-pgsql,servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 406  search_open: pgsql "NULL"
 407    cached open
 408  search_find: file="NULL"
 409    key=" select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 410  LRU list:
 411  internal_search_find: file="NULL"
 412    type=pgsql key=" select * from them where id='c'" opts="servers=localhost::PORT_N/test/CALLER/"
 413  database lookup required for  select * from them where id='c'
 414                               (tainted, quoted:pgsql)
 415  PostgreSQL query: " select * from them where id='c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 416  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 417 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'
 418 warn: condition test deferred in ACL "check_recipient"
 419 LOG: MAIN
 420   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 421 processing "accept" (TESTSUITE/test-config 52)
 422 check domains = +local_domains
 423 d in "+local_domains"?
 424  list element: +local_domains
 425   start sublist local_domains
 426    d in "@"?
 427    ╎list element: @
 428    d in "@"? no (end of list)
 429   end sublist local_domains
 430 d in "+local_domains"? no (end of list)
 431 accept: condition test failed in ACL "check_recipient"
 432 processing "accept" (TESTSUITE/test-config 53)
 433 check hosts = +relay_hosts
 434 host in "+relay_hosts"?
 435  list element: +relay_hosts
 436   start sublist relay_hosts
 437   host in "net-pgsql;select * from them where id='10.0.0.0'"?
 438    ╎list element: net-pgsql;select░*░from░them░where░id='10.0.0.0'
 439    ╎search_open: pgsql "NULL"
 440    ╎  cached open
 441    ╎search_find: file="NULL"
 442    ╎  key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
 443    ╎LRU list:
 444    ╎internal_search_find: file="NULL"
 445    ╎  type=pgsql key="select * from them where id='10.0.0.0'" opts=NULL
 446    ╎database lookup required for select * from them where id='10.0.0.0'
 447    ╎PostgreSQL query: "select * from them where id='10.0.0.0'" opts 'NULL'
 448    ╎PGSQL using cached connection for localhost:PORT_N/test/CALLER
 449    ╎PGSQL: no data found
 450    ╎creating new cache entry
 451    ╎lookup failed
 452   host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 453   end sublist relay_hosts
 454 host in "+relay_hosts"? no (end of list)
 455 accept: condition test failed in ACL "check_recipient"
 456 processing "deny" (TESTSUITE/test-config 54)
 457   message: relay not permitted
 458 deny: condition test succeeded in ACL "check_recipient"
 459 end of ACL "check_recipient": DENY
 460 SMTP>> 550 relay not permitted
 461 LOG: MAIN REJECT
 462   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 463 SMTP<< rcpt to:<c@d>
 464 using ACL "check_recipient"
 465 processing "warn" (TESTSUITE/test-config 27)
 466  search_open: pgsql "NULL"
 467    cached open
 468  search_find: file="NULL"
 469    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 470  LRU list:
 471  internal_search_find: file="NULL"
 472    type=pgsql key="select name from them where id = 'c'" opts=NULL
 473  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 474                               (tainted, quoted:pgsql)
 475  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 476  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 477  PGSQL: no data found
 478  replacing old cache entry
 479  lookup failed
 480 check set acl_m0 = ok:   ${lookup pgsql                    {select name from them where id = '${quote_pgsql:$local_part}'}}
 481                  = ok:
 482  search_open: pgsql "NULL"
 483    cached open
 484  search_find: file="NULL"
 485    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="cache=no_rd"
 486  LRU list:
 487  internal_search_find: file="NULL"
 488    type=pgsql key="select name from them where id = 'c'" opts=NULL
 489  cached data found but no_rd option set;  database lookup required for select name from them where id = 'c'
 490                               (tainted)
 491 LOG: MAIN PANIC
 492   tainted search query is not properly quoted (ACL warn, TESTSUITE/test-config 27): select name from them where id = 'c'
 493  search_type NN (pgsql) quoting -1 (none)
 494  PostgreSQL query: "select name from them where id = 'c'" opts 'NULL'
 495  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 496  PGSQL: no data found
 497  replacing old cache entry
 498  lookup failed
 499 check set acl_m0 = FAIL: ${lookup pgsql,cache=no_rd        {select name from them where id = '$local_part'}}
 500                  = FAIL:
 501 warn: condition test succeeded in ACL "check_recipient"
 502 processing "warn" (TESTSUITE/test-config 32)
 503  search_open: pgsql "NULL"
 504    cached open
 505  search_find: file="NULL"
 506    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 507  LRU list:
 508  internal_search_find: file="NULL"
 509    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N/test/CALLER/"
 510  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 511                               (tainted, quoted:pgsql)
 512  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 513  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 514  PGSQL: no data found
 515  replacing old cache entry
 516  lookup failed
 517 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N/test/CALLER/      {select name from them where id = '${quote_pgsql:$local_part}'}}
 518                  = ok:
 519  search_open: pgsql "NULL"
 520    cached open
 521  search_find: file="NULL"
 522    key="select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N"
 523  LRU list:
 524  internal_search_find: file="NULL"
 525    type=pgsql key="select name from them where id = 'c'" opts="servers=localhost::PORT_N"
 526  cached data found but wrong opts;  database lookup required for select name from them where id = 'c'
 527                               (tainted, quoted:pgsql)
 528  PostgreSQL query: "select name from them where id = 'c'" opts 'servers=localhost::PORT_N'
 529  PGSQL using cached connection for localhost:PORT_N/test/CALLER
 530  PGSQL: no data found
 531  replacing old cache entry
 532  lookup failed
 533 check set acl_m0 = ok:   ${lookup pgsql,servers=localhost::PORT_N    {select name from them where id = '${quote_pgsql:$local_part}'}}
 534                  = ok:
 535  search_open: pgsql "NULL"
 536    cached open
 537  search_find: file="NULL"
 538    key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" partial=-1 affix=NULL starflags=0 opts=NULL
 539  LRU list:
 540  internal_search_find: file="NULL"
 541    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts=NULL
 542  database lookup required for servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'
 543                               (tainted, quoted:pgsql)
 544  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select name from them where id = 'c'" opts 'NULL'
 545 LOG: MAIN
 546   Exim configuration error in line 78 of TESTSUITE/test-config:
 547   WARNING: obsolete syntax used for lookup
 548  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 549 warn: condition test deferred in ACL "check_recipient"
 550 LOG: MAIN
 551   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 552 processing "warn" (TESTSUITE/test-config 41)
 553 check set acl_m0 = ok:   hostlist
 554 check hosts = net-pgsql;select * from them where id='${quote_pgsql:$local_part}'
 555 host in "net-pgsql;select * from them where id='c'"?
 556  list element: net-pgsql;select░*░from░them░where░id='c'
 557  search_open: pgsql "NULL"
 558    cached open
 559  search_find: file="NULL"
 560    key="select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 561  LRU list:
 562  internal_search_find: file="NULL"
 563    type=pgsql key="select * from them where id='c'" opts=NULL
 564  cached data used for lookup of select * from them where id='c'
 565  lookup failed
 566 host in "net-pgsql;select * from them where id='c'"? no (end of list)
 567 warn: condition test failed in ACL "check_recipient"
 568 processing "warn" (TESTSUITE/test-config 44)
 569 check set acl_m0 = FAIL: hostlist
 570 check hosts = <& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 571 host in "<& net-pgsql;servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 572  list element: net-pgsql;servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 573  search_open: pgsql "NULL"
 574    cached open
 575  search_find: file="NULL"
 576    key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts=NULL
 577  LRU list:
 578  internal_search_find: file="NULL"
 579    type=pgsql key="servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts=NULL
 580  database lookup required for servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'
 581                               (tainted, quoted:pgsql)
 582  PostgreSQL query: "servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'" opts 'NULL'
 583 LOG: MAIN
 584   Exim configuration error in line 78 of TESTSUITE/test-config:
 585   WARNING: obsolete syntax used for lookup
 586  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 587 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'
 588 warn: condition test deferred in ACL "check_recipient"
 589 LOG: MAIN
 590   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 591 processing "warn" (TESTSUITE/test-config 49)
 592 check set acl_m0 = FAIL: hostlist
 593 check hosts = <& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='${quote_pgsql:$local_part}'
 594 host in "<& net-pgsql,servers=localhost::PORT_N/test/CALLER/; select * from them where id='c'"?
 595  list element: net-pgsql,servers=localhost::PORT_N/test/CALLER/;░select░*░from░them░where░id='c'
 596  search_open: pgsql "NULL"
 597    cached open
 598  search_find: file="NULL"
 599    key=" select * from them where id='c'" partial=-1 affix=NULL starflags=0 opts="servers=localhost::PORT_N/test/CALLER/"
 600  LRU list:
 601  internal_search_find: file="NULL"
 602    type=pgsql key=" select * from them where id='c'" opts="servers=localhost::PORT_N/test/CALLER/"
 603  database lookup required for  select * from them where id='c'
 604                               (tainted, quoted:pgsql)
 605  PostgreSQL query: " select * from them where id='c'" opts 'servers=localhost::PORT_N/test/CALLER/'
 606  lookup deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 607 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'
 608 warn: condition test deferred in ACL "check_recipient"
 609 LOG: MAIN
 610   H=(test) [10.0.0.0] Warning: ACL "warn" statement skipped: condition test deferred: PostgreSQL server "localhost:PORT_N/test" is tainted
 611 processing "accept" (TESTSUITE/test-config 52)
 612 check domains = +local_domains
 613 d in "+local_domains"?
 614  list element: +local_domains
 615   start sublist local_domains
 616    d in "@"?
 617    ╎list element: @
 618    d in "@"? no (end of list)
 619   end sublist local_domains
 620 d in "+local_domains"? no (end of list)
 621 accept: condition test failed in ACL "check_recipient"
 622 processing "accept" (TESTSUITE/test-config 53)
 623 check hosts = +relay_hosts
 624 host in "+relay_hosts"?
 625  list element: +relay_hosts
 626   start sublist relay_hosts
 627   host in "net-pgsql;select * from them where id='10.0.0.0'"?
 628    ╎list element: net-pgsql;select░*░from░them░where░id='10.0.0.0'
 629    ╎search_open: pgsql "NULL"
 630    ╎  cached open
 631    ╎search_find: file="NULL"
 632    ╎  key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0 opts=NULL
 633    ╎LRU list:
 634    ╎internal_search_find: file="NULL"
 635    ╎  type=pgsql key="select * from them where id='10.0.0.0'" opts=NULL
 636    ╎cached data used for lookup of select * from them where id='10.0.0.0'
 637    ╎lookup failed
 638   host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 639   end sublist relay_hosts
 640 host in "+relay_hosts"? no (end of list)
 641 accept: condition test failed in ACL "check_recipient"
 642 processing "deny" (TESTSUITE/test-config 54)
 643   message: relay not permitted
 644 deny: condition test succeeded in ACL "check_recipient"
 645 end of ACL "check_recipient": DENY
 646 SMTP>> 550 relay not permitted
 647 LOG: MAIN REJECT
 648   H=(test) [10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 649 SMTP<< quit
 650 SMTP>> 221 myhost.test.ex closing connection
 651 LOG: smtp_connection MAIN
 652   SMTP connection from (test) [10.0.0.0] D=qqs closed by QUIT
 653 search_tidyup called
 654 close PGSQL connection: localhost:PORT_N/test/CALLER
 655 >>>>>>>>>>>>>>>> Exim pid=p1236 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 656 Exim version x.yz ....
 657 Hints DB:
 658 changed uid/gid: forcing real = effective
 659   uid=uuuu gid=CALLER_GID pid=p1237
 660 configuration file is TESTSUITE/test-config
 661 admin user
 662 changed uid/gid: privilege not needed
 663   uid=EXIM_UID gid=EXIM_GID pid=p1237
 664 seeking password data for user "CALLER": cache not available
 665 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 666 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 667 sender address = CALLER@myhost.test.ex
 668 set_process_info: pppp accepting a local non-SMTP message from <CALLER@myhost.test.ex>
 669 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 670 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 671 Sender: CALLER@myhost.test.ex
 672 Recipients:
 673   CALLER
 674 search_tidyup called
 675 >>Headers received:
 676
 677 qualify & rewrite recipients list
 678 rewrite rules on sender address
 679 qualify and rewrite headers
 680  rewrite_one_header: type=F:
 681    From: CALLER_NAME <CALLER@myhost.test.ex>
 682 search_tidyup called
 683 >>Headers after rewriting and local additions:
 684  I Message-Id: <E10HmaX-000000005vi-0000@myhost.test.ex>
 685  F From: CALLER_NAME <CALLER@myhost.test.ex>
 686    Date: Tue, 2 Mar 1999 09:44:33 +0000
 687
 688 Data file name: TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 689 Data file written for message 10HmaX-000000005vi-0000
 690 >>Generated Received: header line
 691 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
 692         (envelope-from <CALLER@myhost.test.ex>)
 693         id 10HmaX-000000005vi-0000
 694         for CALLER@myhost.test.ex;
 695         Tue, 2 Mar 1999 09:44:33 +0000
 696 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-000000005vi-0000
 697 DSN: **** SPOOL_OUT - address: <CALLER@myhost.test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 698 Renaming spool header file: TESTSUITE/spool//input//10HmaX-000000005vi-0000-H
 699 Size of headers = sss
 700 LOG: MAIN
 701   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
 702 created log directory TESTSUITE/spool/log
 703 search_tidyup called
 704 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-000000005vi-0000
 705 Exim version x.yz ....
 706 Hints DB:
 707 changed uid/gid: forcing real = effective
 708   uid=uuuu gid=EXIM_GID pid=p1238
 709 configuration file is TESTSUITE/test-config
 710 trusted user
 711 admin user
 712 dropping to exim gid; retaining priv uid
 713 seeking password data for user "CALLER": cache not available
 714 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 715 set_process_info: pppp delivering specified messages
 716 set_process_info: pppp delivering 10HmaX-000000005vi-0000
 717 Trying spool file TESTSUITE/spool//input//10HmaX-000000005vi-0000-D
 718 reading spool file 10HmaX-000000005vi-0000-H
 719 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
 720 sender_local=1 ident=CALLER
 721 Non-recipients:
 722  Empty Tree
 723 ---- End of tree ----
 724 recipients_count=1
 725 **** SPOOL_IN - No additional fields
 726 body_linecount=1 message_linecount=8
 727 DSN: set orcpt:   flags: 0x0
 728 Delivery address list:
 729   CALLER@myhost.test.ex
 730  locking TESTSUITE/spool/db/retry.lockfile
 731  locked  TESTSUITE/spool/db/retry.lockfile
 732  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 733  returned from EXIM_DBOPEN: (nil)
 734  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 735 no retry data available
 736 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 737 Considering: CALLER@myhost.test.ex
 738 unique = CALLER@myhost.test.ex
 739 no   domain  retry record
 740 no   address retry record
 741 CALLER@myhost.test.ex: queued for routing
 742 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 743 routing CALLER@myhost.test.ex
 744 --------> r1 router <--------
 745 local_part=CALLER domain=myhost.test.ex
 746 processing address_data
 747  search_open: pgsql "NULL"
 748  search_find: file="NULL"
 749    key="select name from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
 750  LRU list:
 751  internal_search_find: file="NULL"
 752    type=pgsql key="select name from them where id='ph10'" opts=NULL
 753  database lookup required for select name from them where id='ph10'
 754  PostgreSQL query: "select name from them where id='ph10'" opts 'NULL'
 755  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
 756  creating new cache entry
 757  lookup yielded: Philip░Hazel
 758 calling r1 router
 759 r1 router called for CALLER@myhost.test.ex
 760   domain = myhost.test.ex
 761 set transport t1
 762 queued for t1 transport: local_part = CALLER
 763 domain = myhost.test.ex
 764   errors_to=NULL
 765   domain_data=NULL local_part_data=NULL
 766 routed by r1 router
 767   envelope to: CALLER@myhost.test.ex
 768   transport: t1
 769 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 770 After routing:
 771   Local deliveries:
 772     CALLER@myhost.test.ex
 773   Remote deliveries:
 774   Failed addresses:
 775   Deferred addresses:
 776 search_tidyup called
 777 close PGSQL connection: localhost:PORT_N/test/CALLER
 778 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 779 --------> CALLER@myhost.test.ex <--------
 780  locking TESTSUITE/spool/db/retry.lockfile
 781  locked  TESTSUITE/spool/db/retry.lockfile
 782  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 783  returned from EXIM_DBOPEN: (nil)
 784  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 785 no retry data available
 786 search_tidyup called
 787 changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t1
 788   uid=CALLER_UID gid=CALLER_GID pid=p1239
 789   home=NULL current=/
 790 set_process_info: pppp delivering 10HmaX-000000005vi-0000 to CALLER using t1
 791 appendfile transport entered
 792  search_open: pgsql "NULL"
 793  search_find: file="NULL"
 794    key="select id from them where id='ph10'" partial=-1 affix=NULL starflags=0 opts=NULL
 795  LRU list:
 796  internal_search_find: file="NULL"
 797    type=pgsql key="select id from them where id='ph10'" opts=NULL
 798  database lookup required for select id from them where id='ph10'
 799  PostgreSQL query: "select id from them where id='ph10'" opts 'NULL'
 800  PGSQL new connection: host=localhost port=PORT_N database=test user=CALLER
 801  creating new cache entry
 802  lookup yielded: ph10
 803 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 804   file=TESTSUITE/test-mail/ph10 format=unix
 805   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 806   message_suffix=\n
 807   maildir_use_size_file=no
 808   locking by lockfile fcntl
 809 lock name: TESTSUITE/test-mail/ph10.lock
 810 hitch name: TESTSUITE/test-mail/ph10.lock.test.ex.dddddddd.pppppppp
 811 lock file created
 812 mailbox TESTSUITE/test-mail/ph10 is locked
 813 writing to file TESTSUITE/test-mail/ph10
 814 writing data block fd=dddd size=sss timeout=0
 815 cannot use sendfile for body: spoolfile not wireformat
 816 writing data block fd=dddd size=sss timeout=0
 817 writing data block fd=dddd size=sss timeout=0
 818 appendfile yields 0 with errno=dd more_errno=dd
 819 search_tidyup called
 820 close PGSQL connection: localhost:PORT_N/test/CALLER
 821 journalling CALLER@myhost.test.ex
 822 t1 transport returned OK for CALLER@myhost.test.ex
 823 post-process CALLER@myhost.test.ex (0)
 824 CALLER@myhost.test.ex delivered
 825 LOG: MAIN
 826   => CALLER <CALLER@myhost.test.ex> R=r1 T=t1
 827 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 828 changed uid/gid: post-delivery tidying
 829   uid=EXIM_UID gid=EXIM_GID pid=p1238
 830 set_process_info: pppp tidying up after delivering 10HmaX-000000005vi-0000
 831 Processing retry items
 832 Succeeded addresses:
 833  CALLER@myhost.test.ex: no retry items
 834 Failed addresses:
 835 Deferred addresses:
 836 end of retry processing
 837 DSN: processing router : r1
 838 DSN: processing successful delivery address: CALLER@myhost.test.ex
 839 DSN: Sender_address: CALLER@myhost.test.ex
 840 DSN: orcpt: NULL  flags: 0x0
 841 DSN: envid: NULL  ret: 0
 842 DSN: Final recipient: CALLER@myhost.test.ex
 843 DSN: Remote SMTP server supports DSN: 0
 844 DSN: not sending DSN success message
 845 LOG: MAIN
 846   Completed
 847 end delivery of 10HmaX-000000005vi-0000
 848 search_tidyup called
 849 search_tidyup called
 850 >>>>>>>>>>>>>>>> Exim pid=p1238 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 851 search_tidyup called
 852 >>>>>>>>>>>>>>>> Exim pid=p1237 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 853 Exim version x.yz ....
 854 Hints DB:
 855 configuration file is TESTSUITE/test-config
 856 admin user
 857 dropping to exim gid; retaining priv uid
 858  search_open: pgsql "NULL"
 859  search_find: file="NULL"
 860    key="select name from them where id='ph10';" partial=-1 affix=NULL starflags=0 opts=NULL
 861  LRU list:
 862  internal_search_find: file="NULL"
 863    type=pgsql key="select name from them where id='ph10';" opts=NULL
 864  database lookup required for select name from them where id='ph10';
 865  PostgreSQL query: "select name from them where id='ph10';" opts 'NULL'
 866  PGSQL new connection: socket=TESTSUITE/pgsql/.s.PGSQL.1223 database=test user=CALLER
 867  creating new cache entry
 868  lookup yielded: Philip░Hazel
 869 search_tidyup called
 870 close PGSQL connection: (TESTSUITE/pgsql/.s.PGSQL.1223)/test/CALLER
 871 >>>>>>>>>>>>>>>> Exim pid=p1240 (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 872
 873 ******** SERVER ********
 874 2017-07-30 18:51:05.712 [pppp] LOG:  redirecting log output to logging collector process
 875 2017-07-30 18:51:05.712 [pppp] HINT:  Future log output will appear in directory "log".