test/stderr/9200

   1 Exim version x.yz ....
   2 configuration file is TESTSUITE/test-config
   3 admin user
   4 search_open: pgsql "NULL"
   5 search_find: file="NULL"
   6   key="select name from them where id='CALLER';" partial=-1 affix=NULL starflags=0
   7 LRU list:
   8 internal_search_find: file="NULL"
   9   type=pgsql key="select name from them where id='CALLER';"
  10 database lookup required for select name from them where id='CALLER';
  11 PGSQL query: select name from them where id='CALLER';
  12 PGSQL new connection: host=localhost port= database=test user=CALLER
  13 lookup yielded: Philip Hazel
  14 search_open: pgsql "NULL"
  15   cached open
  16 search_find: file="NULL"
  17   key="select name from them where id='CALLER';" partial=-1 affix=NULL starflags=0
  18 LRU list:
  19 internal_search_find: file="NULL"
  20   type=pgsql key="select name from them where id='CALLER';"
  21 cached data used for lookup of select name from them where id='CALLER';
  22 lookup yielded: Philip Hazel
  23 search_open: pgsql "NULL"
  24   cached open
  25 search_find: file="NULL"
  26   key="select name from them where id='xxxx';" partial=-1 affix=NULL starflags=0
  27 LRU list:
  28 internal_search_find: file="NULL"
  29   type=pgsql key="select name from them where id='xxxx';"
  30 database lookup required for select name from them where id='xxxx';
  31 PGSQL query: select name from them where id='xxxx';
  32 PGSQL using cached connection for localhost/test/CALLER
  33 PGSQL: no data found
  34 lookup failed
  35 search_open: pgsql "NULL"
  36   cached open
  37 search_find: file="NULL"
  38   key="select name from them where id='nothing';" partial=-1 affix=NULL starflags=0
  39 LRU list:
  40 internal_search_find: file="NULL"
  41   type=pgsql key="select name from them where id='nothing';"
  42 database lookup required for select name from them where id='nothing';
  43 PGSQL query: select name from them where id='nothing';
  44 PGSQL using cached connection for localhost/test/CALLER
  45 lookup yielded:
  46 search_open: pgsql "NULL"
  47   cached open
  48 search_find: file="NULL"
  49   key="select id,name from them where id='nothing';" partial=-1 affix=NULL starflags=0
  50 LRU list:
  51 internal_search_find: file="NULL"
  52   type=pgsql key="select id,name from them where id='nothing';"
  53 database lookup required for select id,name from them where id='nothing';
  54 PGSQL query: select id,name from them where id='nothing';
  55 PGSQL using cached connection for localhost/test/CALLER
  56 lookup yielded: id=nothing name=""
  57 search_open: pgsql "NULL"
  58   cached open
  59 search_find: file="NULL"
  60   key="delete from them where id='nonexist';" partial=-1 affix=NULL starflags=0
  61 LRU list:
  62 internal_search_find: file="NULL"
  63   type=pgsql key="delete from them where id='nonexist';"
  64 database lookup required for delete from them where id='nonexist';
  65 PGSQL query: delete from them where id='nonexist';
  66 PGSQL using cached connection for localhost/test/CALLER
  67 PGSQL: command does not return any data but was successful. Rows affected: 0
  68 lookup forced cache cleanup
  69 lookup yielded: 0
  70 search_open: pgsql "NULL"
  71   cached open
  72 search_find: file="NULL"
  73   key="select * from them where id='quote2';" partial=-1 affix=NULL starflags=0
  74 LRU list:
  75 internal_search_find: file="NULL"
  76   type=pgsql key="select * from them where id='quote2';"
  77 database lookup required for select * from them where id='quote2';
  78 PGSQL query: select * from them where id='quote2';
  79 PGSQL using cached connection for localhost/test/CALLER
  80 lookup yielded: name="\"stquot" id=quote2
  81 search_open: pgsql "NULL"
  82   cached open
  83 search_find: file="NULL"
  84   key="select * from them where id='newline';" partial=-1 affix=NULL starflags=0
  85 LRU list:
  86 internal_search_find: file="NULL"
  87   type=pgsql key="select * from them where id='newline';"
  88 database lookup required for select * from them where id='newline';
  89 PGSQL query: select * from them where id='newline';
  90 PGSQL using cached connection for localhost/test/CALLER
  91 lookup yielded: name="before
  92 after" id=newline
  93 search_open: pgsql "NULL"
  94   cached open
  95 search_find: file="NULL"
  96   key="select * from them where id='tab';" partial=-1 affix=NULL starflags=0
  97 LRU list:
  98 internal_search_find: file="NULL"
  99   type=pgsql key="select * from them where id='tab';"
 100 database lookup required for select * from them where id='tab';
 101 PGSQL query: select * from them where id='tab';
 102 PGSQL using cached connection for localhost/test/CALLER
 103 lookup yielded: name="x x" id=tab
 104 search_open: pgsql "NULL"
 105   cached open
 106 search_find: file="NULL"
 107   key="select * from them where name='''stquot';" partial=-1 affix=NULL starflags=0
 108 LRU list:
 109 internal_search_find: file="NULL"
 110   type=pgsql key="select * from them where name='''stquot';"
 111 database lookup required for select * from them where name='''stquot';
 112 PGSQL query: select * from them where name='''stquot';
 113 PGSQL using cached connection for localhost/test/CALLER
 114 lookup yielded: name='stquot id=quote1
 115 search_tidyup called
 116 close PGSQL connection: localhost/test/CALLER
 117 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 118 Exim version x.yz ....
 119 changed uid/gid: forcing real = effective
 120   uid=uuuu gid=CALLER_GID pid=pppp
 121 configuration file is TESTSUITE/test-config
 122 admin user
 123 changed uid/gid: privilege not needed
 124   uid=EXIM_UID gid=EXIM_GID pid=pppp
 125 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 126 sender address = CALLER@myhost.test.ex
 127 sender_fullhost = [10.0.0.0]
 128 sender_rcvhost = [10.0.0.0]
 129 host in hosts_connection_nolog? no (option unset)
 130 LOG: smtp_connection MAIN
 131   SMTP connection from [10.0.0.0]
 132 host in host_lookup? no (option unset)
 133 set_process_info: pppp handling incoming connection from [10.0.0.0]
 134 host in host_reject_connection? no (option unset)
 135 host in sender_unqualified_hosts? no (option unset)
 136 host in recipient_unqualified_hosts? no (option unset)
 137 host in helo_verify_hosts? no (option unset)
 138 host in helo_try_verify_hosts? no (option unset)
 139 host in helo_accept_junk_hosts? no (option unset)
 140 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 141 smtp_setup_msg entered
 142 SMTP<< mail from:<a@b>
 143 SMTP>> 250 OK
 144 SMTP<< rcpt to:<c@d>
 145 using ACL "check_recipient"
 146 processing "accept"
 147 check domains = +local_domains
 148 d in "@"? no (end of list)
 149 d in "+local_domains"? no (end of list)
 150 accept: condition test failed
 151 processing "accept"
 152 check hosts = +relay_hosts
 153 search_open: pgsql "NULL"
 154 search_find: file="NULL"
 155   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0
 156 LRU list:
 157 internal_search_find: file="NULL"
 158   type=pgsql key="select * from them where id='10.0.0.0'"
 159 database lookup required for select * from them where id='10.0.0.0'
 160 PGSQL query: select * from them where id='10.0.0.0'
 161 PGSQL new connection: host=localhost port= database=test user=CALLER
 162 PGSQL: no data found
 163 lookup failed
 164 host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 165 host in "+relay_hosts"? no (end of list)
 166 accept: condition test failed
 167 processing "deny"
 168 deny: condition test succeeded
 169 SMTP>> 550 relay not permitted
 170 LOG: MAIN REJECT
 171   H=[10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 172 SMTP<< rcpt to:<c@d>
 173 using ACL "check_recipient"
 174 processing "accept"
 175 check domains = +local_domains
 176 d in "@"? no (end of list)
 177 d in "+local_domains"? no (end of list)
 178 accept: condition test failed
 179 processing "accept"
 180 check hosts = +relay_hosts
 181 search_open: pgsql "NULL"
 182   cached open
 183 search_find: file="NULL"
 184   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0
 185 LRU list:
 186 internal_search_find: file="NULL"
 187   type=pgsql key="select * from them where id='10.0.0.0'"
 188 cached data used for lookup of select * from them where id='10.0.0.0'
 189 lookup failed
 190 host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 191 host in "+relay_hosts"? no (end of list)
 192 accept: condition test failed
 193 processing "deny"
 194 deny: condition test succeeded
 195 SMTP>> 550 relay not permitted
 196 LOG: MAIN REJECT
 197   H=[10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 198 SMTP<< quit
 199 SMTP>> 221 myhost.test.ex closing connection
 200 LOG: smtp_connection MAIN
 201   SMTP connection from [10.0.0.0] closed by QUIT
 202 search_tidyup called
 203 close PGSQL connection: localhost/test/CALLER
 204 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 205 Exim version x.yz ....
 206 changed uid/gid: forcing real = effective
 207   uid=uuuu gid=CALLER_GID pid=pppp
 208 configuration file is TESTSUITE/test-config
 209 admin user
 210 changed uid/gid: privilege not needed
 211   uid=EXIM_UID gid=EXIM_GID pid=pppp
 212 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 213 sender address = CALLER@myhost.test.ex
 214 set_process_info: pppp accepting a local non-SMTP message from <CALLER@myhost.test.ex>
 215 Sender: CALLER@myhost.test.ex
 216 Recipients:
 217   CALLER
 218 search_tidyup called
 219 >>Headers received:
 220
 221 rewrite_one_header: type=F:
 222   From: CALLER_NAME <CALLER@myhost.test.ex>
 223 search_tidyup called
 224 >>Headers after rewriting and local additions:
 225 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
 226 F From: CALLER_NAME <CALLER@myhost.test.ex>
 227   Date: Tue, 2 Mar 1999 09:44:33 +0000
 228
 229 Data file written for message 10HmaX-0005vi-00
 230 >>Generated Received: header line
 231 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
 232         (envelope-from <CALLER@myhost.test.ex>)
 233         id 10HmaX-0005vi-00
 234         for CALLER@myhost.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 235 calling local_scan(); timeout=300
 236 local_scan() returned 0 NULL
 237 Writing spool header file
 238 Size of headers = sss
 239 LOG: MAIN
 240   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
 241 created log directory TESTSUITE/spool/log
 242 search_tidyup called
 243 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
 244 Exim version x.yz ....
 245 changed uid/gid: forcing real = effective
 246   uid=uuuu gid=EXIM_GID pid=pppp
 247 configuration file is TESTSUITE/test-config
 248 trusted user
 249 admin user
 250 skipping ACL configuration - not needed
 251 set_process_info: pppp delivering specified messages
 252 set_process_info: pppp delivering 10HmaX-0005vi-00
 253 reading spool file 10HmaX-0005vi-00-H
 254 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
 255 sender_local=1 ident=CALLER
 256 Non-recipients:
 257 Empty Tree
 258 ---- End of tree ----
 259 recipients_count=1
 260 body_linecount=1 message_linecount=7
 261 Delivery address list:
 262   CALLER@myhost.test.ex
 263 locking TESTSUITE/spool/db/retry.lockfile
 264 locked TESTSUITE/spool/db/retry.lockfile
 265 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 266 returned from EXIM_DBOPEN
 267 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 268 no retry data available
 269 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 270 Considering: CALLER@myhost.test.ex
 271 unique = CALLER@myhost.test.ex
 272 no domain retry record
 273 no address retry record
 274 CALLER@myhost.test.ex: queued for routing
 275 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 276 routing CALLER@myhost.test.ex
 277 --------> r1 router <--------
 278 local_part=CALLER domain=myhost.test.ex
 279 processing address_data
 280 search_open: pgsql "NULL"
 281 search_find: file="NULL"
 282   key="select name from them where id='CALLER'" partial=-1 affix=NULL starflags=0
 283 LRU list:
 284 internal_search_find: file="NULL"
 285   type=pgsql key="select name from them where id='CALLER'"
 286 database lookup required for select name from them where id='CALLER'
 287 PGSQL query: select name from them where id='CALLER'
 288 PGSQL new connection: host=localhost port= database=test user=CALLER
 289 lookup yielded: Philip Hazel
 290 calling r1 router
 291 r1 router called for CALLER@myhost.test.ex
 292   domain = myhost.test.ex
 293 set transport t1
 294 queued for t1 transport: local_part = CALLER
 295 domain = myhost.test.ex
 296   errors_to=NULL
 297   domain_data=NULL localpart_data=NULL
 298 routed by r1 router
 299   envelope to: CALLER@myhost.test.ex
 300   transport: t1
 301 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 302 After routing:
 303   Local deliveries:
 304     CALLER@myhost.test.ex
 305   Remote deliveries:
 306   Failed addresses:
 307   Deferred addresses:
 308 search_tidyup called
 309 close PGSQL connection: localhost/test/CALLER
 310 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 311 --------> CALLER@myhost.test.ex <--------
 312 locking TESTSUITE/spool/db/retry.lockfile
 313 locked TESTSUITE/spool/db/retry.lockfile
 314 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 315 returned from EXIM_DBOPEN
 316 no retry data available
 317 search_tidyup called
 318 changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t1
 319   uid=CALLER_UID gid=CALLER_GID pid=pppp
 320   home=NULL current=/
 321 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
 322 appendfile transport entered
 323 search_open: pgsql "NULL"
 324 search_find: file="NULL"
 325   key="select id from them where id='CALLER'" partial=-1 affix=NULL starflags=0
 326 LRU list:
 327 internal_search_find: file="NULL"
 328   type=pgsql key="select id from them where id='CALLER'"
 329 database lookup required for select id from them where id='CALLER'
 330 PGSQL query: select id from them where id='CALLER'
 331 PGSQL new connection: host=localhost port= database=test user=CALLER
 332 lookup yielded: CALLER
 333 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 334   file=TESTSUITE/test-mail/CALLER format=unix
 335   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 336   message_suffix=\n
 337   maildir_use_size_file=no
 338   locking by lockfile fcntl
 339 lock name: TESTSUITE/test-mail/CALLER.lock
 340 hitch name: TESTSUITE/test-mail/CALLER.lock.test.ex.dddddddd.pppppppp
 341 lock file created
 342 mailbox TESTSUITE/test-mail/CALLER is locked
 343 writing to file TESTSUITE/test-mail/CALLER
 344 writing data block fd=8 size=sss timeout=0
 345 writing data block fd=8 size=sss timeout=0
 346 writing data block fd=8 size=sss timeout=0
 347 appendfile yields 0 with errno=dd more_errno=dd
 348 search_tidyup called
 349 close PGSQL connection: localhost/test/CALLER
 350 journalling CALLER@myhost.test.ex
 351 t1 transport returned OK for CALLER@myhost.test.ex
 352 post-process CALLER@myhost.test.ex (0)
 353 CALLER@myhost.test.ex delivered
 354 LOG: MAIN
 355   => CALLER <CALLER@myhost.test.ex> R=r1 T=t1
 356 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 357 changed uid/gid: post-delivery tidying
 358   uid=EXIM_UID gid=EXIM_GID pid=pppp
 359 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 360 Processing retry items
 361 Succeeded addresses:
 362 CALLER@myhost.test.ex: no retry items
 363 Failed addresses:
 364 Deferred addresses:
 365 end of retry processing
 366 LOG: MAIN
 367   Completed
 368 end delivery of 10HmaX-0005vi-00
 369 search_tidyup called
 370 search_tidyup called
 371 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 372 search_tidyup called
 373 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 374 Exim version x.yz ....
 375 configuration file is TESTSUITE/test-config
 376 admin user
 377 search_open: pgsql "NULL"
 378 search_find: file="NULL"
 379   key="select name from them where id='CALLER';" partial=-1 affix=NULL starflags=0
 380 LRU list:
 381 internal_search_find: file="NULL"
 382   type=pgsql key="select name from them where id='CALLER';"
 383 database lookup required for select name from them where id='CALLER';
 384 PGSQL query: select name from them where id='CALLER';
 385 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=test user=CALLER
 386 lookup yielded: Philip Hazel
 387 search_tidyup called
 388 close PGSQL connection: (/tmp/.s.PGSQL.5432)/test/CALLER
 389 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>