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 seeking password data for user "CALLER": cache not available
 126 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 127 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 128 sender address = CALLER@myhost.test.ex
 129 sender_fullhost = [10.0.0.0]
 130 sender_rcvhost = [10.0.0.0]
 131 host in hosts_connection_nolog? no (option unset)
 132 LOG: smtp_connection MAIN
 133   SMTP connection from [10.0.0.0]
 134 host in host_lookup? no (option unset)
 135 set_process_info: pppp handling incoming connection from [10.0.0.0]
 136 host in host_reject_connection? no (option unset)
 137 host in sender_unqualified_hosts? no (option unset)
 138 host in recipient_unqualified_hosts? no (option unset)
 139 host in helo_verify_hosts? no (option unset)
 140 host in helo_try_verify_hosts? no (option unset)
 141 host in helo_accept_junk_hosts? no (option unset)
 142 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 143 smtp_setup_msg entered
 144 SMTP<< mail from:<a@b>
 145 SMTP>> 250 OK
 146 SMTP<< rcpt to:<c@d>
 147 using ACL "check_recipient"
 148 processing "accept"
 149 check domains = +local_domains
 150 d in "@"? no (end of list)
 151 d in "+local_domains"? no (end of list)
 152 accept: condition test failed
 153 processing "accept"
 154 check hosts = +relay_hosts
 155 search_open: pgsql "NULL"
 156 search_find: file="NULL"
 157   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0
 158 LRU list:
 159 internal_search_find: file="NULL"
 160   type=pgsql key="select * from them where id='10.0.0.0'"
 161 database lookup required for select * from them where id='10.0.0.0'
 162 PGSQL query: select * from them where id='10.0.0.0'
 163 PGSQL new connection: host=localhost port= database=test user=CALLER
 164 PGSQL: no data found
 165 lookup failed
 166 host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 167 host in "+relay_hosts"? no (end of list)
 168 accept: condition test failed
 169 processing "deny"
 170 deny: condition test succeeded
 171 SMTP>> 550 relay not permitted
 172 LOG: MAIN REJECT
 173   H=[10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 174 SMTP<< rcpt to:<c@d>
 175 using ACL "check_recipient"
 176 processing "accept"
 177 check domains = +local_domains
 178 d in "@"? no (end of list)
 179 d in "+local_domains"? no (end of list)
 180 accept: condition test failed
 181 processing "accept"
 182 check hosts = +relay_hosts
 183 search_open: pgsql "NULL"
 184   cached open
 185 search_find: file="NULL"
 186   key="select * from them where id='10.0.0.0'" partial=-1 affix=NULL starflags=0
 187 LRU list:
 188 internal_search_find: file="NULL"
 189   type=pgsql key="select * from them where id='10.0.0.0'"
 190 cached data used for lookup of select * from them where id='10.0.0.0'
 191 lookup failed
 192 host in "net-pgsql;select * from them where id='10.0.0.0'"? no (end of list)
 193 host in "+relay_hosts"? no (end of list)
 194 accept: condition test failed
 195 processing "deny"
 196 deny: condition test succeeded
 197 SMTP>> 550 relay not permitted
 198 LOG: MAIN REJECT
 199   H=[10.0.0.0] F=<a@b> rejected RCPT <c@d>: relay not permitted
 200 SMTP<< quit
 201 SMTP>> 221 myhost.test.ex closing connection
 202 LOG: smtp_connection MAIN
 203   SMTP connection from [10.0.0.0] closed by QUIT
 204 search_tidyup called
 205 close PGSQL connection: localhost/test/CALLER
 206 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 207 Exim version x.yz ....
 208 changed uid/gid: forcing real = effective
 209   uid=uuuu gid=CALLER_GID pid=pppp
 210 configuration file is TESTSUITE/test-config
 211 admin user
 212 changed uid/gid: privilege not needed
 213   uid=EXIM_UID gid=EXIM_GID pid=pppp
 214 seeking password data for user "CALLER": cache not available
 215 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 216 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 217 sender address = CALLER@myhost.test.ex
 218 set_process_info: pppp accepting a local non-SMTP message from <CALLER@myhost.test.ex>
 219 Sender: CALLER@myhost.test.ex
 220 Recipients:
 221   CALLER
 222 search_tidyup called
 223 >>Headers received:
 224
 225 rewrite_one_header: type=F:
 226   From: CALLER_NAME <CALLER@myhost.test.ex>
 227 search_tidyup called
 228 >>Headers after rewriting and local additions:
 229 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
 230 F From: CALLER_NAME <CALLER@myhost.test.ex>
 231   Date: Tue, 2 Mar 1999 09:44:33 +0000
 232
 233 Data file written for message 10HmaX-0005vi-00
 234 >>Generated Received: header line
 235 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
 236         (envelope-from <CALLER@myhost.test.ex>)
 237         id 10HmaX-0005vi-00
 238         for CALLER@myhost.test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 239 calling local_scan(); timeout=300
 240 local_scan() returned 0 NULL
 241 Writing spool header file
 242 Size of headers = sss
 243 LOG: MAIN
 244   <= CALLER@myhost.test.ex U=CALLER P=local S=sss
 245 created log directory TESTSUITE/spool/log
 246 search_tidyup called
 247 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xfbb95cfd -odi -Mc 10HmaX-0005vi-00
 248 Exim version x.yz ....
 249 changed uid/gid: forcing real = effective
 250   uid=uuuu gid=EXIM_GID pid=pppp
 251 configuration file is TESTSUITE/test-config
 252 trusted user
 253 admin user
 254 skipping ACL configuration - not needed
 255 seeking password data for user "CALLER": cache not available
 256 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 257 set_process_info: pppp delivering specified messages
 258 set_process_info: pppp delivering 10HmaX-0005vi-00
 259 reading spool file 10HmaX-0005vi-00-H
 260 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@myhost.test.ex
 261 sender_local=1 ident=CALLER
 262 Non-recipients:
 263 Empty Tree
 264 ---- End of tree ----
 265 recipients_count=1
 266 body_linecount=1 message_linecount=7
 267 Delivery address list:
 268   CALLER@myhost.test.ex
 269 locking TESTSUITE/spool/db/retry.lockfile
 270 locked TESTSUITE/spool/db/retry.lockfile
 271 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 272 returned from EXIM_DBOPEN
 273 ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 274 no retry data available
 275 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 276 Considering: CALLER@myhost.test.ex
 277 unique = CALLER@myhost.test.ex
 278 no domain retry record
 279 no address retry record
 280 CALLER@myhost.test.ex: queued for routing
 281 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 282 routing CALLER@myhost.test.ex
 283 --------> r1 router <--------
 284 local_part=CALLER domain=myhost.test.ex
 285 processing address_data
 286 search_open: pgsql "NULL"
 287 search_find: file="NULL"
 288   key="select name from them where id='CALLER'" partial=-1 affix=NULL starflags=0
 289 LRU list:
 290 internal_search_find: file="NULL"
 291   type=pgsql key="select name from them where id='CALLER'"
 292 database lookup required for select name from them where id='CALLER'
 293 PGSQL query: select name from them where id='CALLER'
 294 PGSQL new connection: host=localhost port= database=test user=CALLER
 295 lookup yielded: Philip Hazel
 296 calling r1 router
 297 r1 router called for CALLER@myhost.test.ex
 298   domain = myhost.test.ex
 299 set transport t1
 300 queued for t1 transport: local_part = CALLER
 301 domain = myhost.test.ex
 302   errors_to=NULL
 303   domain_data=NULL localpart_data=NULL
 304 routed by r1 router
 305   envelope to: CALLER@myhost.test.ex
 306   transport: t1
 307 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 308 After routing:
 309   Local deliveries:
 310     CALLER@myhost.test.ex
 311   Remote deliveries:
 312   Failed addresses:
 313   Deferred addresses:
 314 search_tidyup called
 315 close PGSQL connection: localhost/test/CALLER
 316 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 317 --------> CALLER@myhost.test.ex <--------
 318 locking TESTSUITE/spool/db/retry.lockfile
 319 locked TESTSUITE/spool/db/retry.lockfile
 320 EXIM_DBOPEN(TESTSUITE/spool/db/retry)
 321 returned from EXIM_DBOPEN
 322 no retry data available
 323 search_tidyup called
 324 changed uid/gid: local delivery to CALLER <CALLER@myhost.test.ex> transport=t1
 325   uid=CALLER_UID gid=CALLER_GID pid=pppp
 326   home=NULL current=/
 327 set_process_info: pppp delivering 10HmaX-0005vi-00 to CALLER using t1
 328 appendfile transport entered
 329 search_open: pgsql "NULL"
 330 search_find: file="NULL"
 331   key="select id from them where id='CALLER'" partial=-1 affix=NULL starflags=0
 332 LRU list:
 333 internal_search_find: file="NULL"
 334   type=pgsql key="select id from them where id='CALLER'"
 335 database lookup required for select id from them where id='CALLER'
 336 PGSQL query: select id from them where id='CALLER'
 337 PGSQL new connection: host=localhost port= database=test user=CALLER
 338 lookup yielded: CALLER
 339 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 340   file=TESTSUITE/test-mail/CALLER format=unix
 341   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 342   message_suffix=\n
 343   maildir_use_size_file=no
 344   locking by lockfile fcntl
 345 lock name: TESTSUITE/test-mail/CALLER.lock
 346 hitch name: TESTSUITE/test-mail/CALLER.lock.test.ex.dddddddd.pppppppp
 347 lock file created
 348 mailbox TESTSUITE/test-mail/CALLER is locked
 349 writing to file TESTSUITE/test-mail/CALLER
 350 writing data block fd=dddd size=sss timeout=0
 351 writing data block fd=dddd size=sss timeout=0
 352 writing data block fd=dddd size=sss timeout=0
 353 appendfile yields 0 with errno=dd more_errno=dd
 354 search_tidyup called
 355 close PGSQL connection: localhost/test/CALLER
 356 journalling CALLER@myhost.test.ex
 357 t1 transport returned OK for CALLER@myhost.test.ex
 358 post-process CALLER@myhost.test.ex (0)
 359 CALLER@myhost.test.ex delivered
 360 LOG: MAIN
 361   => CALLER <CALLER@myhost.test.ex> R=r1 T=t1
 362 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 363 changed uid/gid: post-delivery tidying
 364   uid=EXIM_UID gid=EXIM_GID pid=pppp
 365 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 366 Processing retry items
 367 Succeeded addresses:
 368 CALLER@myhost.test.ex: no retry items
 369 Failed addresses:
 370 Deferred addresses:
 371 end of retry processing
 372 LOG: MAIN
 373   Completed
 374 end delivery of 10HmaX-0005vi-00
 375 search_tidyup called
 376 search_tidyup called
 377 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 378 search_tidyup called
 379 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>
 380 Exim version x.yz ....
 381 configuration file is TESTSUITE/test-config
 382 admin user
 383 search_open: pgsql "NULL"
 384 search_find: file="NULL"
 385   key="select name from them where id='CALLER';" partial=-1 affix=NULL starflags=0
 386 LRU list:
 387 internal_search_find: file="NULL"
 388   type=pgsql key="select name from them where id='CALLER';"
 389 database lookup required for select name from them where id='CALLER';
 390 PGSQL query: select name from them where id='CALLER';
 391 PGSQL new connection: socket=/tmp/.s.PGSQL.5432 database=test user=CALLER
 392 lookup yielded: Philip Hazel
 393 search_tidyup called
 394 close PGSQL connection: (/tmp/.s.PGSQL.5432)/test/CALLER
 395 >>>>>>>>>>>>>>>> Exim pid=pppp terminating with rc=0 >>>>>>>>>>>>>>>>