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