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