test/stderr/0278

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