test/stderr/0275

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=pppp
   4 configuration file is TESTSUITE/test-config
   5 admin user
   6 dropping to exim gid; retaining priv uid
   7 seeking password data for user "CALLER": cache not available
   8 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
   9 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  10 sender address = CALLER@test.ex
  11 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
  12 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  13 Testing userx@test.ex
  14 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  15 Considering userx@test.ex
  16 test.ex in "! *.ex"? no (matched "! *.ex")
  17 test.ex in "test.ex"? yes (matched "test.ex")
  18 test.ex in percent_hack_domains? yes (matched "+not_queue_domains")
  19 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  20 routing userx@test.ex
  21 --------> r00 router <--------
  22 local_part=userx domain=test.ex
  23 checking domains
  24 test.ex in "userx"? no (end of list)
  25 test.ex in "+nocache"? no (end of list)
  26 r00 router skipped: domains mismatch
  27 --------> r01 router <--------
  28 local_part=userx domain=test.ex
  29 checking domains
  30 test.ex in "userx"? no (end of list)
  31 test.ex in "+nocache"? no (end of list)
  32 r01 router skipped: domains mismatch
  33 --------> r02 router <--------
  34 local_part=userx domain=test.ex
  35 checking domains
  36 test.ex in "userx"? no (end of list)
  37 test.ex in "+nocache"? no (end of list)
  38 test.ex in "+nocache2"? no (end of list)
  39 r02 router skipped: domains mismatch
  40 --------> r03 router <--------
  41 local_part=userx domain=test.ex
  42 checking domains
  43 test.ex in "userx"? no (end of list)
  44 test.ex in "+nocache"? no (end of list)
  45 test.ex in "+nocache2"? no (end of list)
  46 r03 router skipped: domains mismatch
  47 --------> r04 router <--------
  48 local_part=userx domain=test.ex
  49 checking domains
  50 test.ex in "userx"? no (end of list)
  51 test.ex in "+forcecache"? no (end of list)
  52 r04 router skipped: domains mismatch
  53 --------> r05 router <--------
  54 local_part=userx domain=test.ex
  55 checking domains
  56 cached no match for +forcecache
  57 cached lookup data = NULL
  58 test.ex in "+forcecache"? no (end of list)
  59 r05 router skipped: domains mismatch
  60 --------> r1 router <--------
  61 local_part=userx domain=test.ex
  62 checking domains
  63 test.ex in "never.ex"? no (end of list)
  64 test.ex in "never1.ex"? no (end of list)
  65 test.ex in "test.ex"? yes (matched "test.ex")
  66 data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex'
  67 test.ex in "+never_domains : +n1_domains : ! +local_domains"? no (matched "! +local_domains")
  68 r1 router skipped: domains mismatch
  69 --------> r2 router <--------
  70 local_part=userx domain=test.ex
  71 checking domains
  72 cached no match for +never_domains
  73 cached lookup data = NULL
  74 cached no match for +n1_domains
  75 cached lookup data = NULL
  76 test.ex in "<; never2.ex ; +n1_domains"? no (end of list)
  77 cached yes match for +local_domains
  78 cached lookup data = test.ex
  79 test.ex in "+never_domains : +n2_domains : !+local_domains"? no (matched "!+local_domains" - cached)
  80 r2 router skipped: domains mismatch
  81 --------> r3 router <--------
  82 local_part=userx domain=test.ex
  83 checking domains
  84 cached yes match for +local_domains
  85 cached lookup data = test.ex
  86 test.ex in "+local_domains"? yes (matched "+local_domains" - cached)
  87 checking local_parts
  88 userx in "userx"? yes (matched "userx")
  89 calling r3 router
  90 r3 router called for userx@test.ex
  91   domain = test.ex
  92 set transport t1
  93 queued for t1 transport: local_part = userx
  94 domain = test.ex
  95   errors_to=NULL
  96   domain_data=test.ex local_part_data=userx
  97 routed by r3 router
  98   envelope to: userx@test.ex
  99   transport: t1
 100 search_tidyup called
 101 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 102 Exim version x.yz ....
 103 changed uid/gid: forcing real = effective
 104   uid=uuuu gid=CALLER_GID pid=pppp
 105 configuration file is TESTSUITE/test-config
 106 admin user
 107 changed uid/gid: privilege not needed
 108   uid=EXIM_UID gid=EXIM_GID pid=pppp
 109 seeking password data for user "CALLER": cache not available
 110 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 111 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 112 sender address = CALLER@test.ex
 113 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
 114 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 115 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 116 Sender: CALLER@test.ex
 117 Recipients:
 118   userx@test.ex
 119 search_tidyup called
 120 >>Headers received:
 121
 122 rewrite_one_header: type=F:
 123   From: CALLER_NAME <CALLER@test.ex>
 124 search_tidyup called
 125 >>Headers after rewriting and local additions:
 126 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
 127 F From: CALLER_NAME <CALLER@test.ex>
 128   Date: Tue, 2 Mar 1999 09:44:33 +0000
 129
 130 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
 131 Data file written for message 10HmaX-0005vi-00
 132 >>Generated Received: header line
 133 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
 134         (envelope-from <CALLER@test.ex>)
 135         id 10HmaX-0005vi-00
 136         for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 137 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
 138 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 139 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
 140 Size of headers = sss
 141 LOG: MAIN
 142   <= CALLER@test.ex U=CALLER P=local S=sss
 143 created log directory TESTSUITE/spool/log
 144 search_tidyup called
 145 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00
 146 Exim version x.yz ....
 147 changed uid/gid: forcing real = effective
 148   uid=uuuu gid=EXIM_GID pid=pppp
 149 configuration file is TESTSUITE/test-config
 150 trusted user
 151 admin user
 152 dropping to exim gid; retaining priv uid
 153 seeking password data for user "CALLER": cache not available
 154 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 155 set_process_info: pppp delivering specified messages
 156 set_process_info: pppp delivering 10HmaX-0005vi-00
 157 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 158 reading spool file 10HmaX-0005vi-00-H
 159 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 160 sender_local=1 ident=CALLER
 161 Non-recipients:
 162 Empty Tree
 163 ---- End of tree ----
 164 recipients_count=1
 165 **** SPOOL_IN - No additional fields
 166 body_linecount=0 message_linecount=7
 167 DSN: set orcpt:   flags: 0x0
 168 Delivery address list:
 169   userx@test.ex
 170  locking TESTSUITE/spool/db/retry.lockfile
 171  locked  TESTSUITE/spool/db/retry.lockfile
 172  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 173  returned from EXIM_DBOPEN: (nil)
 174  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 175 no retry data available
 176 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 177 Considering: userx@test.ex
 178 test.ex in "! *.ex"? no (matched "! *.ex")
 179 test.ex in "test.ex"? yes (matched "test.ex")
 180 test.ex in percent_hack_domains? yes (matched "+not_queue_domains")
 181 cached no match for +hold_domains
 182 test.ex in hold_domains? no (end of list)
 183 unique = userx@test.ex
 184 no   domain  retry record
 185 no   address retry record
 186 userx@test.ex: queued for routing
 187 cached yes match for +not_queue_domains
 188 test.ex in queue_domains? no (matched "!+not_queue_domains" - cached)
 189 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 190 routing userx@test.ex
 191 --------> r00 router <--------
 192 local_part=userx domain=test.ex
 193 checking domains
 194 test.ex in "userx"? no (end of list)
 195 test.ex in "+nocache"? no (end of list)
 196 r00 router skipped: domains mismatch
 197 --------> r01 router <--------
 198 local_part=userx domain=test.ex
 199 checking domains
 200 test.ex in "userx"? no (end of list)
 201 test.ex in "+nocache"? no (end of list)
 202 r01 router skipped: domains mismatch
 203 --------> r02 router <--------
 204 local_part=userx domain=test.ex
 205 checking domains
 206 test.ex in "userx"? no (end of list)
 207 test.ex in "+nocache"? no (end of list)
 208 test.ex in "+nocache2"? no (end of list)
 209 r02 router skipped: domains mismatch
 210 --------> r03 router <--------
 211 local_part=userx domain=test.ex
 212 checking domains
 213 test.ex in "userx"? no (end of list)
 214 test.ex in "+nocache"? no (end of list)
 215 test.ex in "+nocache2"? no (end of list)
 216 r03 router skipped: domains mismatch
 217 --------> r04 router <--------
 218 local_part=userx domain=test.ex
 219 checking domains
 220 test.ex in "userx"? no (end of list)
 221 test.ex in "+forcecache"? no (end of list)
 222 r04 router skipped: domains mismatch
 223 --------> r05 router <--------
 224 local_part=userx domain=test.ex
 225 checking domains
 226 cached no match for +forcecache
 227 cached lookup data = NULL
 228 test.ex in "+forcecache"? no (end of list)
 229 r05 router skipped: domains mismatch
 230 --------> r1 router <--------
 231 local_part=userx domain=test.ex
 232 checking domains
 233 test.ex in "never.ex"? no (end of list)
 234 test.ex in "never1.ex"? no (end of list)
 235 test.ex in "test.ex"? yes (matched "test.ex")
 236 data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex'
 237 test.ex in "+never_domains : +n1_domains : ! +local_domains"? no (matched "! +local_domains")
 238 r1 router skipped: domains mismatch
 239 --------> r2 router <--------
 240 local_part=userx domain=test.ex
 241 checking domains
 242 cached no match for +never_domains
 243 cached lookup data = NULL
 244 cached no match for +n1_domains
 245 cached lookup data = NULL
 246 test.ex in "<; never2.ex ; +n1_domains"? no (end of list)
 247 cached yes match for +local_domains
 248 cached lookup data = test.ex
 249 test.ex in "+never_domains : +n2_domains : !+local_domains"? no (matched "!+local_domains" - cached)
 250 r2 router skipped: domains mismatch
 251 --------> r3 router <--------
 252 local_part=userx domain=test.ex
 253 checking domains
 254 cached yes match for +local_domains
 255 cached lookup data = test.ex
 256 test.ex in "+local_domains"? yes (matched "+local_domains" - cached)
 257 checking local_parts
 258 userx in "userx"? yes (matched "userx")
 259 calling r3 router
 260 r3 router called for userx@test.ex
 261   domain = test.ex
 262 set transport t1
 263 queued for t1 transport: local_part = userx
 264 domain = test.ex
 265   errors_to=NULL
 266   domain_data=test.ex local_part_data=userx
 267 routed by r3 router
 268   envelope to: userx@test.ex
 269   transport: t1
 270 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 271 After routing:
 272   Local deliveries:
 273     userx@test.ex
 274   Remote deliveries:
 275   Failed addresses:
 276   Deferred addresses:
 277 search_tidyup called
 278 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 279 --------> userx@test.ex <--------
 280  locking TESTSUITE/spool/db/retry.lockfile
 281  locked  TESTSUITE/spool/db/retry.lockfile
 282  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 283  returned from EXIM_DBOPEN: (nil)
 284  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 285 no retry data available
 286 search_tidyup called
 287 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
 288   uid=CALLER_UID gid=CALLER_GID pid=pppp
 289   home=NULL current=/
 290 set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1
 291 appendfile transport entered
 292 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 293   file=/dev/null format=unix
 294   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 295   message_suffix=\n
 296   maildir_use_size_file=no
 297   locking by lockfile fcntl
 298 search_tidyup called
 299 journalling userx@test.ex
 300 t1 transport returned OK for userx@test.ex
 301 post-process userx@test.ex (0)
 302 userx@test.ex delivered
 303 LOG: MAIN
 304   => userx <userx@test.ex> R=r3 T=t1
 305 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 306 changed uid/gid: post-delivery tidying
 307   uid=EXIM_UID gid=EXIM_GID pid=pppp
 308 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 309 Processing retry items
 310 Succeeded addresses:
 311  userx@test.ex: no retry items
 312 Failed addresses:
 313 Deferred addresses:
 314 end of retry processing
 315 DSN: processing router : r3
 316 DSN: processing successful delivery address: userx@test.ex
 317 DSN: Sender_address: CALLER@test.ex
 318 DSN: orcpt: NULL  flags: 0x0
 319 DSN: envid: NULL  ret: 0
 320 DSN: Final recipient: userx@test.ex
 321 DSN: Remote SMTP server supports DSN: 0
 322 DSN: not sending DSN success message
 323 LOG: MAIN
 324   Completed
 325 end delivery of 10HmaX-0005vi-00
 326 search_tidyup called
 327 search_tidyup called
 328 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 329 search_tidyup called
 330 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 331 Exim version x.yz ....
 332 changed uid/gid: forcing real = effective
 333   uid=uuuu gid=CALLER_GID pid=pppp
 334 configuration file is TESTSUITE/test-config
 335 admin user
 336 changed uid/gid: privilege not needed
 337   uid=EXIM_UID gid=EXIM_GID pid=pppp
 338 seeking password data for user "CALLER": cache not available
 339 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 340 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 341 sender address = CALLER@test.ex
 342 sender_fullhost = [127.0.0.1]
 343 sender_rcvhost = [127.0.0.1]
 344 host in hosts_connection_nolog? no (option unset)
 345 LOG: smtp_connection MAIN
 346   SMTP connection from [127.0.0.1]
 347 host in host_lookup? no (option unset)
 348 set_process_info: pppp handling incoming connection from [127.0.0.1]
 349 host in host_reject_connection? no (option unset)
 350 host in sender_unqualified_hosts? no (option unset)
 351 host in recipient_unqualified_hosts? no (option unset)
 352 host in helo_verify_hosts? no (option unset)
 353 host in helo_try_verify_hosts? no (option unset)
 354 host in helo_accept_junk_hosts? no (option unset)
 355 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 356 smtp_setup_msg entered
 357 SMTP<< HELO test
 358 test in helo_lookup_domains? no (end of list)
 359 sender_fullhost = (test) [127.0.0.1]
 360 sender_rcvhost = [127.0.0.1] (helo=test)
 361 set_process_info: pppp handling incoming connection from (test) [127.0.0.1]
 362 SMTP>> 250 myhost.test.ex Hello test [127.0.0.1]
 363 SMTP<< MAIL FROM:<test@test.ex>
 364 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 365 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 366 SMTP>> 250 OK
 367 SMTP<< RCPT TO:<error@test.ex>
 368 test.ex in "! *.ex"? no (matched "! *.ex")
 369 test.ex in "test.ex"? yes (matched "test.ex")
 370 test.ex in percent_hack_domains? yes (matched "+not_queue_domains")
 371 processing "accept" (TESTSUITE/test-config 102)
 372 check verify = recipient
 373 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 374 Verifying error@test.ex
 375 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 376 Considering error@test.ex
 377 cached no match for +hold_domains
 378 cached yes match for +not_queue_domains
 379 test.ex in percent_hack_domains? yes (matched "+not_queue_domains" - cached)
 380 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 381 routing error@test.ex
 382 --------> r0f router <--------
 383 local_part=error domain=test.ex
 384 checking domains
 385 LOG: MAIN PANIC
 386   unknown named domain list "+no_such_list"
 387 domains check lookup or other defer
 388 ----------- end verify ------------
 389 accept: condition test deferred in inline ACL
 390 SMTP>> 451 Temporary local problem - please try later
 391 LOG: MAIN REJECT
 392   H=(test) [127.0.0.1] F=<test@test.ex> temporarily rejected RCPT <error@test.ex>: domains check lookup or other defer
 393 SMTP<< QUIT
 394 SMTP>> 221 myhost.test.ex closing connection
 395 LOG: smtp_connection MAIN
 396   SMTP connection from (test) [127.0.0.1] closed by QUIT
 397 search_tidyup called
 398 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>