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