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;
 137         Tue, 2 Mar 1999 09:44:33 +0000
 138 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
 139 DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
 140 Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H
 141 Size of headers = sss
 142 LOG: MAIN
 143   <= CALLER@test.ex U=CALLER P=local S=sss
 144 created log directory TESTSUITE/spool/log
 145 search_tidyup called
 146 exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00
 147 Exim version x.yz ....
 148 changed uid/gid: forcing real = effective
 149   uid=uuuu gid=EXIM_GID pid=pppp
 150 configuration file is TESTSUITE/test-config
 151 trusted user
 152 admin user
 153 dropping to exim gid; retaining priv uid
 154 seeking password data for user "CALLER": cache not available
 155 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 156 set_process_info: pppp delivering specified messages
 157 set_process_info: pppp delivering 10HmaX-0005vi-00
 158 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 159 reading spool file 10HmaX-0005vi-00-H
 160 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 161 sender_local=1 ident=CALLER
 162 Non-recipients:
 163  Empty Tree
 164 ---- End of tree ----
 165 recipients_count=1
 166 **** SPOOL_IN - No additional fields
 167 body_linecount=0 message_linecount=8
 168 DSN: set orcpt:   flags: 0x0
 169 Delivery address list:
 170   userx@test.ex
 171  locking TESTSUITE/spool/db/retry.lockfile
 172  locked  TESTSUITE/spool/db/retry.lockfile
 173  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 174  returned from EXIM_DBOPEN: (nil)
 175  ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 176  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 177 no retry data available
 178 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 179 Considering: userx@test.ex
 180 test.ex in "! *.ex"? no (matched "! *.ex")
 181 test.ex in "test.ex"? yes (matched "test.ex")
 182 test.ex in percent_hack_domains? yes (matched "+not_queue_domains")
 183 cached no match for +hold_domains
 184 test.ex in hold_domains? no (end of list)
 185 unique = userx@test.ex
 186 no   domain  retry record
 187 no   address retry record
 188 userx@test.ex: queued for routing
 189 cached yes match for +not_queue_domains
 190 test.ex in queue_domains? no (matched "!+not_queue_domains" - cached)
 191 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 192 routing userx@test.ex
 193 --------> r00 router <--------
 194 local_part=userx domain=test.ex
 195 checking domains
 196 test.ex in "userx"? no (end of list)
 197 test.ex in "+nocache"? no (end of list)
 198 r00 router skipped: domains mismatch
 199 --------> r01 router <--------
 200 local_part=userx domain=test.ex
 201 checking domains
 202 test.ex in "userx"? no (end of list)
 203 test.ex in "+nocache"? no (end of list)
 204 r01 router skipped: domains mismatch
 205 --------> r02 router <--------
 206 local_part=userx domain=test.ex
 207 checking domains
 208 test.ex in "userx"? no (end of list)
 209 test.ex in "+nocache"? no (end of list)
 210 test.ex in "+nocache2"? no (end of list)
 211 r02 router skipped: domains mismatch
 212 --------> r03 router <--------
 213 local_part=userx domain=test.ex
 214 checking domains
 215 test.ex in "userx"? no (end of list)
 216 test.ex in "+nocache"? no (end of list)
 217 test.ex in "+nocache2"? no (end of list)
 218 r03 router skipped: domains mismatch
 219 --------> r04 router <--------
 220 local_part=userx domain=test.ex
 221 checking domains
 222 test.ex in "userx"? no (end of list)
 223 test.ex in "+forcecache"? no (end of list)
 224 r04 router skipped: domains mismatch
 225 --------> r05 router <--------
 226 local_part=userx domain=test.ex
 227 checking domains
 228 cached no match for +forcecache
 229 cached lookup data = NULL
 230 test.ex in "+forcecache"? no (end of list)
 231 r05 router skipped: domains mismatch
 232 --------> r1 router <--------
 233 local_part=userx domain=test.ex
 234 checking domains
 235 test.ex in "never.ex"? no (end of list)
 236 test.ex in "never1.ex"? no (end of list)
 237 test.ex in "test.ex"? yes (matched "test.ex")
 238 data from lookup saved for cache for +local_domains: key 'test.ex' value 'test.ex'
 239 test.ex in "+never_domains : +n1_domains : ! +local_domains"? no (matched "! +local_domains")
 240 r1 router skipped: domains mismatch
 241 --------> r2 router <--------
 242 local_part=userx domain=test.ex
 243 checking domains
 244 cached no match for +never_domains
 245 cached lookup data = NULL
 246 cached no match for +n1_domains
 247 cached lookup data = NULL
 248 test.ex in "<; never2.ex ; +n1_domains"? no (end of list)
 249 cached yes match for +local_domains
 250 cached lookup data = test.ex
 251 test.ex in "+never_domains : +n2_domains : !+local_domains"? no (matched "!+local_domains" - cached)
 252 r2 router skipped: domains mismatch
 253 --------> r3 router <--------
 254 local_part=userx domain=test.ex
 255 checking domains
 256 cached yes match for +local_domains
 257 cached lookup data = test.ex
 258 test.ex in "+local_domains"? yes (matched "+local_domains" - cached)
 259 checking local_parts
 260 userx in "userx"? yes (matched "userx")
 261 calling r3 router
 262 r3 router called for userx@test.ex
 263   domain = test.ex
 264 set transport t1
 265 queued for t1 transport: local_part = userx
 266 domain = test.ex
 267   errors_to=NULL
 268   domain_data=test.ex local_part_data=userx
 269 routed by r3 router
 270   envelope to: userx@test.ex
 271   transport: t1
 272 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 273 After routing:
 274   Local deliveries:
 275     userx@test.ex
 276   Remote deliveries:
 277   Failed addresses:
 278   Deferred addresses:
 279 search_tidyup called
 280 >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>>
 281 --------> userx@test.ex <--------
 282  locking TESTSUITE/spool/db/retry.lockfile
 283  locked  TESTSUITE/spool/db/retry.lockfile
 284  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 285  returned from EXIM_DBOPEN: (nil)
 286  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 287 no retry data available
 288 search_tidyup called
 289 changed uid/gid: local delivery to userx <userx@test.ex> transport=t1
 290   uid=CALLER_UID gid=CALLER_GID pid=pppp
 291   home=NULL current=/
 292 set_process_info: pppp delivering 10HmaX-0005vi-00 to userx using t1
 293 appendfile transport entered
 294 appendfile: mode=600 notify_comsat=0 quota=0 warning=0
 295   file=/dev/null format=unix
 296   message_prefix=From ${if def:return_path{$return_path}{MAILER-DAEMON}} ${tod_bsdinbox}\n
 297   message_suffix=\n
 298   maildir_use_size_file=no
 299   locking by lockfile fcntl
 300 search_tidyup called
 301 journalling userx@test.ex
 302 t1 transport returned OK for userx@test.ex
 303 post-process userx@test.ex (0)
 304 userx@test.ex delivered
 305 LOG: MAIN
 306   => userx <userx@test.ex> R=r3 T=t1
 307 >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>>
 308 changed uid/gid: post-delivery tidying
 309   uid=EXIM_UID gid=EXIM_GID pid=pppp
 310 set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00
 311 Processing retry items
 312 Succeeded addresses:
 313  userx@test.ex: no retry items
 314 Failed addresses:
 315 Deferred addresses:
 316 end of retry processing
 317 DSN: processing router : r3
 318 DSN: processing successful delivery address: userx@test.ex
 319 DSN: Sender_address: CALLER@test.ex
 320 DSN: orcpt: NULL  flags: 0x0
 321 DSN: envid: NULL  ret: 0
 322 DSN: Final recipient: userx@test.ex
 323 DSN: Remote SMTP server supports DSN: 0
 324 DSN: not sending DSN success message
 325 LOG: MAIN
 326   Completed
 327 end delivery of 10HmaX-0005vi-00
 328 search_tidyup called
 329 search_tidyup called
 330 >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 331 search_tidyup called
 332 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 333 Exim version x.yz ....
 334 changed uid/gid: forcing real = effective
 335   uid=uuuu gid=CALLER_GID pid=pppp
 336 configuration file is TESTSUITE/test-config
 337 admin user
 338 changed uid/gid: privilege not needed
 339   uid=EXIM_UID gid=EXIM_GID pid=pppp
 340 seeking password data for user "CALLER": cache not available
 341 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 342 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 343 sender address = CALLER@test.ex
 344 sender_fullhost = [127.0.0.1]
 345 sender_rcvhost = [127.0.0.1]
 346 host in hosts_connection_nolog? no (option unset)
 347 LOG: smtp_connection MAIN
 348   SMTP connection from [127.0.0.1]
 349 host in host_lookup? no (option unset)
 350 set_process_info: pppp handling incoming connection from [127.0.0.1]
 351 host in host_reject_connection? no (option unset)
 352 host in sender_unqualified_hosts? no (option unset)
 353 host in recipient_unqualified_hosts? no (option unset)
 354 host in helo_verify_hosts? no (option unset)
 355 host in helo_try_verify_hosts? no (option unset)
 356 host in helo_accept_junk_hosts? no (option unset)
 357 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 358 smtp_setup_msg entered
 359 SMTP<< HELO test
 360 test in helo_lookup_domains? no (end of list)
 361 sender_fullhost = (test) [127.0.0.1]
 362 sender_rcvhost = [127.0.0.1] (helo=test)
 363 set_process_info: pppp handling incoming connection from (test) [127.0.0.1]
 364 SMTP>> 250 myhost.test.ex Hello test [127.0.0.1]
 365 SMTP<< MAIL FROM:<test@test.ex>
 366 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 367 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 368 SMTP>> 250 OK
 369 SMTP<< RCPT TO:<error@test.ex>
 370 test.ex in "! *.ex"? no (matched "! *.ex")
 371 test.ex in "test.ex"? yes (matched "test.ex")
 372 test.ex in percent_hack_domains? yes (matched "+not_queue_domains")
 373 processing "accept" (TESTSUITE/test-config 102)
 374 check verify = recipient
 375 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 376 Verifying error@test.ex
 377 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 378 Considering error@test.ex
 379 cached no match for +hold_domains
 380 cached yes match for +not_queue_domains
 381 test.ex in percent_hack_domains? yes (matched "+not_queue_domains" - cached)
 382 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 383 routing error@test.ex
 384 --------> r0f router <--------
 385 local_part=error domain=test.ex
 386 checking domains
 387 LOG: MAIN PANIC
 388   unknown named domain list "+no_such_list"
 389 domains check lookup or other defer
 390 ----------- end verify ------------
 391 accept: condition test deferred in inline ACL
 392 SMTP>> 451 Temporary local problem - please try later
 393 LOG: MAIN REJECT
 394   H=(test) [127.0.0.1] F=<test@test.ex> temporarily rejected RCPT <error@test.ex>: domains check lookup or other defer
 395 SMTP<< QUIT
 396 SMTP>> 221 myhost.test.ex closing connection
 397 LOG: smtp_connection MAIN
 398   SMTP connection from (test) [127.0.0.1] closed by QUIT
 399 search_tidyup called
 400 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>