test/stderr/2201

   1 Exim version x.yz ....
   2 changed uid/gid: forcing real = effective
   3   uid=uuuu gid=CALLER_GID pid=pppp
   4 seeking password data for user "CALLER": cache not available
   5 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
   6 configuration file is TESTSUITE/test-config
   7 trusted user
   8 admin user
   9 dropping to exim gid; retaining priv uid
  10 seeking password data for user "CALLER": using cached result
  11 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  12 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  13 sender address = CALLER@myhost.test.ex
  14 Address testing: uid=uuuu gid=EXIM_GID euid=uuuu egid=EXIM_GID
  15 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  16 Testing test.ex@test.ex
  17 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  18 Considering test.ex@test.ex
  19 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  20 routing test.ex@test.ex
  21 --------> r0 router <--------
  22 local_part=test.ex domain=test.ex
  23 checking senders
  24 address match test: subject=CALLER@myhost.test.ex pattern=a@shorthost.test.ex
  25 CALLER@myhost.test.ex in "a@shorthost.test.ex"? no (end of list)
  26 r0 router skipped: senders mismatch
  27 --------> r1 router <--------
  28 local_part=test.ex domain=test.ex
  29 checking domains
  30 search_open: dnsdb "NULL"
  31 search_find: file="NULL"
  32   key="test.ex" partial=-1 affix=NULL starflags=0
  33 LRU list:
  34 internal_search_find: file="NULL"
  35   type=dnsdb key="test.ex"
  36 database lookup required for test.ex
  37 dnsdb key: test.ex
  38 DNS lookup of test.ex (TXT) using fakens
  39 fresh-exec forking for child-open
  40 postfork: child-open
  41 fresh-exec forked for child-open: npppp
  42 DNS lookup of test.ex (TXT) succeeded
  43 lookup yielded: A TXT record for test.ex.
  44 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
  45 checking local_parts
  46 search_open: dnsdb "NULL"
  47   cached open
  48 search_find: file="NULL"
  49   key="test.ex" partial=-1 affix=NULL starflags=0
  50 LRU list:
  51 internal_search_find: file="NULL"
  52   type=dnsdb key="test.ex"
  53 cached data used for lookup of test.ex
  54 lookup yielded: A TXT record for test.ex.
  55 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
  56 calling r1 router
  57 r1 router called for test.ex@test.ex
  58   domain = test.ex
  59 set transport local_delivery
  60 queued for local_delivery transport: local_part = test.ex
  61 domain = test.ex
  62   errors_to=NULL
  63   domain_data=A TXT record for test.ex. localpart_data=A TXT record for test.ex.
  64 routed by r1 router
  65   envelope to: test.ex@test.ex
  66   transport: local_delivery
  67 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  68 Testing unknown@test.ex
  69 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  70 Considering unknown@test.ex
  71 >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
  72 routing unknown@test.ex
  73 --------> r0 router <--------
  74 local_part=unknown domain=test.ex
  75 checking senders
  76 address match test: subject=CALLER@myhost.test.ex pattern=a@shorthost.test.ex
  77 CALLER@myhost.test.ex in "a@shorthost.test.ex"? no (end of list)
  78 r0 router skipped: senders mismatch
  79 --------> r1 router <--------
  80 local_part=unknown domain=test.ex
  81 checking domains
  82 search_open: dnsdb "NULL"
  83   cached open
  84 search_find: file="NULL"
  85   key="test.ex" partial=-1 affix=NULL starflags=0
  86 LRU list:
  87 internal_search_find: file="NULL"
  88   type=dnsdb key="test.ex"
  89 cached data used for lookup of test.ex
  90 lookup yielded: A TXT record for test.ex.
  91 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
  92 checking local_parts
  93 search_open: dnsdb "NULL"
  94   cached open
  95 search_find: file="NULL"
  96   key="unknown" partial=-1 affix=NULL starflags=0
  97 LRU list:
  98 internal_search_find: file="NULL"
  99   type=dnsdb key="unknown"
 100 database lookup required for unknown
 101 dnsdb key: unknown
 102 DNS lookup of unknown (TXT) using fakens
 103 fresh-exec forking for child-open
 104 postfork: child-open
 105 fresh-exec forked for child-open: npppp
 106 DNS lookup of unknown (TXT) gave HOST_NOT_FOUND
 107 returning DNS_NOMATCH
 108 faking res_search(TXT) response length as 65535
 109  writing neg-cache entry for unknown-TXT-xxxx, ttl 3000
 110 lookup failed
 111 unknown in "dnsdb;unknown"? no (end of list)
 112 r1 router skipped: local_parts mismatch
 113 --------> r2 router <--------
 114 local_part=unknown domain=test.ex
 115 checking domains
 116 search_open: dnsdb "NULL"
 117   cached open
 118 search_find: file="NULL"
 119   key="test.ex" partial=-1 affix=NULL starflags=0
 120 LRU list:
 121 internal_search_find: file="NULL"
 122   type=dnsdb key="test.ex"
 123 cached data used for lookup of test.ex
 124 lookup yielded: A TXT record for test.ex.
 125 test.ex in "dnsdb;test.ex"? yes (matched "dnsdb;test.ex")
 126 checking senders
 127 address match test: subject=CALLER@myhost.test.ex pattern=dnsdb;A=myhost.test.ex
 128 search_open: dnsdb "NULL"
 129   cached open
 130 search_find: file="NULL"
 131   key="A=myhost.test.ex" partial=-1 affix=NULL starflags=0
 132 LRU list:
 133 internal_search_find: file="NULL"
 134   type=dnsdb key="A=myhost.test.ex"
 135 database lookup required for A=myhost.test.ex
 136 dnsdb key: myhost.test.ex
 137 DNS lookup of myhost.test.ex (A) using fakens
 138 fresh-exec forking for child-open
 139 postfork: child-open
 140 fresh-exec forked for child-open: npppp
 141 DNS lookup of myhost.test.ex (A) succeeded
 142 lookup yielded: V4NET.10.10.10
 143 CALLER@myhost.test.ex in "dnsdb;A=myhost.test.ex"? yes (matched "dnsdb;A=myhost.test.ex")
 144 calling r2 router
 145 r2 router called for unknown@test.ex
 146   domain = test.ex
 147 set transport local_delivery
 148 queued for local_delivery transport: local_part = unknown
 149 domain = test.ex
 150   errors_to=NULL
 151   domain_data=A TXT record for test.ex. localpart_data=NULL
 152 routed by r2 router
 153   envelope to: unknown@test.ex
 154   transport: local_delivery
 155 search_tidyup called
 156 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
 157 Exim version x.yz ....
 158 configuration file is TESTSUITE/test-config
 159 trusted user
 160 admin user
 161 search_tidyup called
 162 search_tidyup called
 163 search_open: dnsdb "NULL"
 164 search_find: file="NULL"
 165   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
 166 LRU list:
 167 internal_search_find: file="NULL"
 168   type=dnsdb key="a=shorthost.test.ex"
 169 database lookup required for a=shorthost.test.ex
 170 dnsdb key: shorthost.test.ex
 171 fresh-exec forking for child-open
 172 postfork: child-open
 173 fresh-exec forked for child-open: npppp
 174 lookup yielded: 127.0.0.1
 175 search_open: dnsdb "NULL"
 176   cached open
 177 search_find: file="NULL"
 178   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
 179 LRU list:
 180 internal_search_find: file="NULL"
 181   type=dnsdb key="a=shorthost.test.ex"
 182 cached data used for lookup of a=shorthost.test.ex
 183 lookup yielded: 127.0.0.1
 184 search_open: dnsdb "NULL"
 185   cached open
 186 search_find: file="NULL"
 187   key="a=shorthost.test.ex" partial=-1 affix=NULL starflags=0
 188 LRU list:
 189 internal_search_find: file="NULL"
 190   type=dnsdb key="a=shorthost.test.ex"
 191 cached data found but past valid time; database lookup required for a=shorthost.test.ex
 192 dnsdb key: shorthost.test.ex
 193 fresh-exec forking for child-open
 194 postfork: child-open
 195 fresh-exec forked for child-open: npppp
 196 lookup yielded: 127.0.0.1
 197 LOG: MAIN
 198   <= a@shorthost.test.ex U=CALLER P=local S=sss
 199 created log directory TESTSUITE/spool/log
 200 search_tidyup called
 201 >>>>>>>>>>>>>>>> Exim pid=pppp (main) terminating with rc=0 >>>>>>>>>>>>>>>>
 202
 203 ******** SERVER ********
 204 Exim version x.yz ....
 205 configuration file is TESTSUITE/test-config
 206 trusted user
 207 admin user
 208 dropping to exim gid; retaining priv uid
 209 ppppp daemon_smtp_port overridden by -oX:
 210 ppppp   <: 1225
 211 ppppp creating notifier socket
 212 ppppp  TESTSUITE/spool/exim_daemon_notify
 213 ppppp listening on all interfaces (IPv4) port 1225
 214 ppppp pid written to TESTSUITE/spool/exim-daemon.pid
 215 ppppp LOG: MAIN
 216 ppppp   exim x.yz daemon started: pid=pppp, no queue runs, listening for SMTP on port 1225
 217 ppppp daemon running with uid=EXIM_UID gid=EXIM_GID euid=EXIM_UID egid=EXIM_GID
 218 ppppp Listening...
 219 ppppp Connection request from 127.0.0.1 port sssss
 220 ppppp fresh-exec forking for daemon accept
 221 ppppp postfork: daemon accept
 222 ppppp Process ppppp is handling incoming connection from [127.0.0.1]
 223 ppppp Process ppppp is ready for new message
 224 ppppp daemon accept forking for child-open
 225 ppppp postfork: child-open
 226 ppppp fresh-exec forked for daemon accept: npppp
 227 ppppp 1 SMTP accept process running
 228 ppppp Listening...
 229 ppppp daemon accept forked for child-open: npppp
 230 ppppp daemon accept forking for child-open
 231 ppppp postfork: child-open
 232 ppppp daemon accept forked for child-open: npppp
 233 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
 234 ppppp new DNS lookup for 14.12.11.V4NET.rbl.test.ex
 235 ppppp daemon accept forking for child-open
 236 ppppp postfork: child-open
 237 ppppp daemon accept forked for child-open: npppp
 238 ppppp dnslists: wrote cache entry, ttl=2
 239 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
 240 ppppp daemon accept forking for child-open
 241 ppppp postfork: child-open
 242 ppppp daemon accept forked for child-open: npppp
 243 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
 244 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
 245 ppppp dnslists: using result of previous lookup
 246 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
 247 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
 248 ppppp dnslists check: rbl.test.ex/V4NET.11.12.14
 249 ppppp cached data found but past valid time; new DNS lookup for 14.12.11.V4NET.rbl.test.ex
 250 ppppp daemon accept forking for child-open
 251 ppppp postfork: child-open
 252 ppppp daemon accept forked for child-open: npppp
 253 ppppp dnslists: wrote cache entry, ttl=2
 254 ppppp DNS lookup for 14.12.11.V4NET.rbl.test.ex succeeded (yielding 127.0.0.2)
 255 ppppp daemon accept forking for child-open
 256 ppppp postfork: child-open
 257 ppppp daemon accept forked for child-open: npppp
 258 ppppp => that means V4NET.11.12.14 is listed at rbl.test.ex
 259 ppppp LOG: MAIN
 260 ppppp   <= a@shorthost.test.ex H=localhost (myhost.test.ex) [127.0.0.1] P=esmtp S=sss id=E10HmaX-0005vi-00@myhost.test.ex
 261 ppppp Process ppppp is ready for new message
 262 ppppp LOG: smtp_connection MAIN
 263 ppppp   SMTP connection from localhost (myhost.test.ex) [127.0.0.1] closed by QUIT
 264 ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (conn-setup) terminating with rc=0 >>>>>>>>>>>>>>>>
 265 ppppp child ppppp ended: status=0x0
 266 ppppp   normal exit, 0
 267 ppppp 0 SMTP accept processes now running
 268 ppppp Listening...
 269 ppppp fresh-exec forking for daemon del pidfile
 270 ppppp postfork: daemon del pidfile
 271 ppppp fresh-exec forked for daemon del pidfile: npppp
 272 ppppp >>>>>>>>>>>>>>>> Exim pid=pppp (daemon) terminating with rc=0 >>>>>>>>>>>>>>>>