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 data from lookup saved for cache for +local_localparts: key 'CALLER' value 'CALLER'
  25 CALLER in "+never_localparts : +n1_localparts : ! +local_localparts"? no (matched "! +local_localparts")
  26 r1 router skipped: local_parts mismatch
  27 --------> r2 router <--------
  28 local_part=CALLER domain=test.ex
  29 checking local_parts
  30 cached no match for +never_localparts
  31 cached lookup data = NULL
  32 cached no match for +n1_localparts
  33 cached lookup data = NULL
  34 CALLER in "<; never2 ; +n1_localparts"? no (end of list)
  35 cached yes match for +local_localparts
  36 cached lookup data = CALLER
  37 CALLER in "+never_localparts : +n2_localparts : !+local_localparts"? no (matched "!+local_localparts" - cached)
  38 r2 router skipped: local_parts mismatch
  39 --------> r3 router <--------
  40 local_part=CALLER domain=test.ex
  41 checking local_parts
  42 cached yes match for +local_localparts
  43 cached lookup data = CALLER
  44 CALLER in "+local_localparts"? yes (matched "+local_localparts" - cached)
  45 checking for local user
  46 seeking password data for user "CALLER": using cached result
  47 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  48 calling r3 router
  49 r3 router called for CALLER@test.ex
  50   domain = test.ex
  51 set transport t1
  52 queued for t1 transport: local_part = CALLER
  53 domain = test.ex
  54   errors_to=NULL
  55   domain_data=NULL local_part_data=CALLER
  56 routed by r3 router
  57   envelope to: CALLER@test.ex
  58   transport: t1
  59 search_tidyup called
  60 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
  61 Exim version x.yz ....
  62 changed uid/gid: forcing real = effective
  63   uid=uuuu gid=CALLER_GID pid=pppp
  64 configuration file is TESTSUITE/test-config
  65 admin user
  66 changed uid/gid: privilege not needed
  67   uid=EXIM_UID gid=EXIM_GID pid=pppp
  68 seeking password data for user "CALLER": cache not available
  69 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  70 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  71 sender address = CALLER@test.ex
  72 set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex>
  73 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  74 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  75 Sender: CALLER@test.ex
  76 Recipients:
  77   CALLER@test.ex
  78 search_tidyup called
  79 >>Headers received:
  80
  81 rewrite_one_header: type=F:
  82   From: CALLER_NAME <CALLER@test.ex>
  83 search_tidyup called
  84 >>Headers after rewriting and local additions:
  85 I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex>
  86 F From: CALLER_NAME <CALLER@test.ex>
  87   Date: Tue, 2 Mar 1999 09:44:33 +0000
  88
  89 Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D
  90 Data file written for message 10HmaX-0005vi-00
  91 >>Generated Received: header line
  92 P Received: from CALLER by myhost.test.ex with local (Exim x.yz)
  93         (envelope-from <CALLER@test.ex>)
  94         id 10HmaX-0005vi-00
  95         for CALLER@test.ex;
  96         Tue, 2 Mar 1999 09:44:33 +0000
  97 Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00
  98 DSN: **** SPOOL_OUT - address: <CALLER@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0
  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=0xf7715cfd -MCd local-accept-delivery -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 dropping to exim gid; retaining priv uid
 113 seeking password data for user "CALLER": cache not available
 114 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 115 set_process_info: pppp delivering specified messages
 116 set_process_info: pppp delivering 10HmaX-0005vi-00
 117 Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D
 118 reading spool file 10HmaX-0005vi-00-H
 119 user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex
 120 sender_local=1 ident=CALLER
 121 Non-recipients:
 122  Empty Tree
 123 ---- End of tree ----
 124 recipients_count=1
 125 **** SPOOL_IN - No additional fields
 126 body_linecount=0 message_linecount=8
 127 DSN: set orcpt:   flags: 0x0
 128 Delivery address list:
 129   CALLER@test.ex
 130  locking TESTSUITE/spool/db/retry.lockfile
 131  locked  TESTSUITE/spool/db/retry.lockfile
 132  EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY
 133  returned from EXIM_DBOPEN: (nil)
 134  ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim
 135  failed to open DB file TESTSUITE/spool/db/retry: No such file or directory
 136 no retry data available
 137 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 138 Considering: CALLER@test.ex
 139 unique = CALLER@test.ex
 140 no   domain  retry record
 141 no   address retry record
 142 CALLER@test.ex: queued for routing
 143 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 144 routing CALLER@test.ex
 145 --------> r1 router <--------
 146 local_part=CALLER domain=test.ex
 147 checking local_parts
 148 CALLER in "never"? no (end of list)
 149 CALLER in "never1"? no (end of list)
 150 CALLER in "CALLER"? yes (matched "CALLER")
 151 data from lookup saved for cache for +local_localparts: key 'CALLER' value '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 = CALLER
 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 = CALLER
 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 local_part_data=CALLER
 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: 0x0
 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 (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>>
 245 search_tidyup called
 246 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) 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 dropping to exim gid; retaining priv uid
 253 seeking password data for user "CALLER": cache not available
 254 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 255 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 256 sender address = CALLER@test.ex
 257 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
 258 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 259 Testing unknown@test.ex
 260 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 261 Considering unknown@test.ex
 262 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
 263 routing unknown@test.ex
 264 --------> r1 router <--------
 265 local_part=unknown domain=test.ex
 266 checking local_parts
 267 unknown in "never"? no (end of list)
 268 unknown in "never1"? no (end of list)
 269 unknown in "CALLER"? no (end of list)
 270 unknown in "+never_localparts : +n1_localparts : ! +local_localparts"? yes (end of list)
 271 calling r1 router
 272 r1 router called for unknown@test.ex
 273   domain = test.ex
 274 route_item = never
 275 test.ex in "never"? no (end of list)
 276 r1 router declined for unknown@test.ex
 277 --------> r2 router <--------
 278 local_part=unknown domain=test.ex
 279 checking local_parts
 280 cached no match for +never_localparts
 281 cached lookup data = NULL
 282 cached no match for +n1_localparts
 283 cached lookup data = NULL
 284 unknown in "<; never2 ; +n1_localparts"? no (end of list)
 285 cached no match for +local_localparts
 286 cached lookup data = NULL
 287 unknown in "+never_localparts : +n2_localparts : !+local_localparts"? yes (end of list)
 288 calling r2 router
 289 r2 router called for unknown@test.ex
 290   domain = test.ex
 291 test.ex in "*"? yes (matched "*")
 292 DNS lookup of test.ex (MX) using fakens
 293 DNS lookup of test.ex (MX) gave NO_DATA
 294 returning DNS_NODATA
 295 faking res_search(MX) response length as 65535
 296  writing neg-cache entry for test.ex-MX-xxxx, ttl 3000
 297 test.ex (MX resp) DNSSEC
 298 DNS lookup of test.ex (A) using fakens
 299 DNS lookup of test.ex (A) gave NO_DATA
 300 returning DNS_NODATA
 301 faking res_search(A) response length as 65535
 302  writing neg-cache entry for test.ex-A-xxxx, ttl 3000
 303 r2 router declined for unknown@test.ex
 304 --------> r3 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 "+local_localparts"? no (end of list)
 310 r3 router skipped: local_parts mismatch
 311 --------> r4 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 unknown in "unexpanded"? no (end of list)
 318 unknown in "+local_localparts : +expanded : +unexpanded"? no (end of list)
 319 r4 router skipped: local_parts mismatch
 320 --------> r5 router <--------
 321 local_part=unknown domain=test.ex
 322 checking local_parts
 323 cached no match for +local_localparts
 324 cached lookup data = NULL
 325 unknown in "test.ex"? no (end of list)
 326 cached no match for +unexpanded
 327 cached lookup data = NULL
 328 unknown in "+local_localparts : +expanded : +unexpanded"? no (end of list)
 329 r5 router skipped: local_parts mismatch
 330 no more routers
 331 search_tidyup called
 332 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=2 >>>>>>>>>>>>>>>>