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