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