test/stderr/0022

   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 changed uid/gid: privilege not needed
   7   uid=EXIM_UID gid=EXIM_GID pid=pppp
   8 seeking password data for user "CALLER": cache not available
   9 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  10 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  11 sender address = CALLER@test.ex
  12 sender_fullhost = [V4NET.9.8.7]
  13 sender_rcvhost = [V4NET.9.8.7]
  14 host in hosts_connection_nolog? no (end of list)
  15 LOG: smtp_connection MAIN
  16   SMTP connection from [V4NET.9.8.7]
  17 host in host_lookup? no (option unset)
  18 set_process_info: pppp handling incoming connection from [V4NET.9.8.7]
  19 host in host_reject_connection? no (option unset)
  20 host in sender_unqualified_hosts? no (option unset)
  21 host in recipient_unqualified_hosts? no (option unset)
  22 host in helo_verify_hosts? no (option unset)
  23 host in helo_try_verify_hosts? no (option unset)
  24 host in helo_accept_junk_hosts? no (option unset)
  25 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  26 smtp_setup_msg entered
  27 SMTP<< mail from:<x@y>
  28 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  29 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  30 SMTP>> 250 OK
  31 SMTP<< rcpt to:<warn_empty@test.ex>
  32 using ACL "warn_empty"
  33 processing "warn" (TESTSUITE/test-config 29)
  34 warn: condition test succeeded in ACL "warn_empty"
  35 processing "accept" (TESTSUITE/test-config 30)
  36 accept: condition test succeeded in ACL "warn_empty"
  37 end of ACL "warn_empty": ACCEPT
  38 SMTP>> 250 Accepted
  39 SMTP<< data
  40 SMTP>> 354 Enter message, ending with "." on a line by itself
  41 search_tidyup called
  42 >>Headers received:
  43
  44 search_tidyup called
  45 >>Headers after rewriting and local additions:
  46
  47 Data file name: TESTSUITE/spool//input//10HmbF-0005vi-00-D
  48 Data file written for message 10HmbF-0005vi-00
  49 >>Generated Received: header line
  50 P Received: from [V4NET.9.8.7]
  51         by myhost.test.ex with smtp (Exim x.yz)
  52         (envelope-from <x@y>)
  53         id 10HmbF-0005vi-00
  54         for warn_empty@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
  55 LOG: MAIN
  56   <= x@y H=[V4NET.9.8.7] P=smtp S=sss
  57 SMTP>> 250 OK id=10HmbF-0005vi-00
  58 smtp_setup_msg entered
  59 SMTP<< quit
  60 SMTP>> 221 myhost.test.ex closing connection
  61 LOG: smtp_connection MAIN
  62   SMTP connection from [V4NET.9.8.7] closed by QUIT
  63 search_tidyup called
  64 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
  65 Exim version x.yz ....
  66 changed uid/gid: forcing real = effective
  67   uid=uuuu gid=CALLER_GID pid=pppp
  68 configuration file is TESTSUITE/test-config
  69 admin user
  70 changed uid/gid: privilege not needed
  71   uid=EXIM_UID gid=EXIM_GID pid=pppp
  72 seeking password data for user "CALLER": cache not available
  73 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
  74 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
  75 sender address = CALLER@test.ex
  76 sender_fullhost = [V4NET.9.8.7]
  77 sender_rcvhost = [V4NET.9.8.7]
  78 host in hosts_connection_nolog? no (end of list)
  79 LOG: smtp_connection MAIN
  80   SMTP connection from [V4NET.9.8.7]
  81 host in host_lookup? no (option unset)
  82 set_process_info: pppp handling incoming connection from [V4NET.9.8.7]
  83 host in host_reject_connection? no (option unset)
  84 host in sender_unqualified_hosts? no (option unset)
  85 host in recipient_unqualified_hosts? no (option unset)
  86 host in helo_verify_hosts? no (option unset)
  87 host in helo_try_verify_hosts? no (option unset)
  88 host in helo_accept_junk_hosts? no (option unset)
  89 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
  90 smtp_setup_msg entered
  91 SMTP<< mail from:<x@y>
  92 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
  93 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
  94 SMTP>> 250 OK
  95 SMTP<< rcpt to:<warn_log@test.ex>
  96 using ACL "warn_log"
  97 processing "warn" (TESTSUITE/test-config 33)
  98 l_message: warn log message
  99 warn: condition test succeeded in ACL "warn_log"
 100 LOG: MAIN
 101   H=[V4NET.9.8.7] Warning: warn log message
 102 processing "accept" (TESTSUITE/test-config 34)
 103 accept: condition test succeeded in ACL "warn_log"
 104 end of ACL "warn_log": ACCEPT
 105 SMTP>> 250 Accepted
 106 SMTP<< data
 107 SMTP>> 354 Enter message, ending with "." on a line by itself
 108 search_tidyup called
 109 >>Headers received:
 110
 111 search_tidyup called
 112 >>Headers after rewriting and local additions:
 113
 114 Data file name: TESTSUITE/spool//input//10HmbG-0005vi-00-D
 115 Data file written for message 10HmbG-0005vi-00
 116 >>Generated Received: header line
 117 P Received: from [V4NET.9.8.7]
 118         by myhost.test.ex with smtp (Exim x.yz)
 119         (envelope-from <x@y>)
 120         id 10HmbG-0005vi-00
 121         for warn_log@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 122 LOG: MAIN
 123   <= x@y H=[V4NET.9.8.7] P=smtp S=sss
 124 SMTP>> 250 OK id=10HmbG-0005vi-00
 125 smtp_setup_msg entered
 126 SMTP<< quit
 127 SMTP>> 221 myhost.test.ex closing connection
 128 LOG: smtp_connection MAIN
 129   SMTP connection from [V4NET.9.8.7] closed by QUIT
 130 search_tidyup called
 131 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 132 Exim version x.yz ....
 133 changed uid/gid: forcing real = effective
 134   uid=uuuu gid=CALLER_GID pid=pppp
 135 configuration file is TESTSUITE/test-config
 136 admin user
 137 changed uid/gid: privilege not needed
 138   uid=EXIM_UID gid=EXIM_GID pid=pppp
 139 seeking password data for user "CALLER": cache not available
 140 getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID
 141 originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME
 142 sender address = CALLER@test.ex
 143 sender_fullhost = [V4NET.9.8.7]
 144 sender_rcvhost = [V4NET.9.8.7]
 145 host in hosts_connection_nolog? no (end of list)
 146 LOG: smtp_connection MAIN
 147   SMTP connection from [V4NET.9.8.7]
 148 host in host_lookup? no (option unset)
 149 set_process_info: pppp handling incoming connection from [V4NET.9.8.7]
 150 host in host_reject_connection? no (option unset)
 151 host in sender_unqualified_hosts? no (option unset)
 152 host in recipient_unqualified_hosts? no (option unset)
 153 host in helo_verify_hosts? no (option unset)
 154 host in helo_try_verify_hosts? no (option unset)
 155 host in helo_accept_junk_hosts? no (option unset)
 156 SMTP>> 220 myhost.test.ex ESMTP Exim x.yz Tue, 2 Mar 1999 09:44:33 +0000
 157 smtp_setup_msg entered
 158 SMTP<< mail from:<x@y>
 159 spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0
 160 log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100
 161 SMTP>> 250 OK
 162 SMTP<< rcpt to:<warn_user@test.ex>
 163 using ACL "warn_user"
 164 processing "warn" (TESTSUITE/test-config 37)
 165   message: warn user message
 166 warn: condition test succeeded in ACL "warn_user"
 167 processing "accept" (TESTSUITE/test-config 38)
 168 accept: condition test succeeded in ACL "warn_user"
 169 end of ACL "warn_user": ACCEPT
 170 SMTP>> 250 Accepted
 171 SMTP<< data
 172 SMTP>> 354 Enter message, ending with "." on a line by itself
 173 search_tidyup called
 174 >>Headers received:
 175
 176 search_tidyup called
 177 >>Headers after rewriting and local additions:
 178
 179 Data file name: TESTSUITE/spool//input//10HmbH-0005vi-00-D
 180 Data file written for message 10HmbH-0005vi-00
 181 >>Generated Received: header line
 182 P Received: from [V4NET.9.8.7]
 183         by myhost.test.ex with smtp (Exim x.yz)
 184         (envelope-from <x@y>)
 185         id 10HmbH-0005vi-00
 186         for warn_user@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 187 >>Headers added by MAIL or RCPT ACL:
 188   X-ACL-Warn: warn user message
 189 >>
 190 LOG: MAIN
 191   <= x@y H=[V4NET.9.8.7] P=smtp S=sss
 192 SMTP>> 250 OK id=10HmbH-0005vi-00
 193 smtp_setup_msg entered
 194 SMTP<< quit
 195 SMTP>> 221 myhost.test.ex closing connection
 196 LOG: smtp_connection MAIN
 197   SMTP connection from [V4NET.9.8.7] closed by QUIT
 198 search_tidyup called
 199 >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>>
 200 >>> host in hosts_connection_nolog? no (end of list)
 201 LOG: SMTP connection from [V4NET.9.8.7]
 202 >>> host in host_lookup? no (option unset)
 203 >>> host in host_reject_connection? no (option unset)
 204 >>> host in sender_unqualified_hosts? no (option unset)
 205 >>> host in recipient_unqualified_hosts? no (option unset)
 206 >>> host in helo_verify_hosts? no (option unset)
 207 >>> host in helo_try_verify_hosts? no (option unset)
 208 >>> host in helo_accept_junk_hosts? no (option unset)
 209 >>> using ACL "defer"
 210 >>> processing "defer" (TESTSUITE/test-config 51)
 211 >>>   message: forcibly deferred
 212 >>> defer: condition test succeeded in ACL "defer"
 213 >>> end of ACL "defer": DEFER
 214 LOG: H=[V4NET.9.8.7] F=<x@y> temporarily rejected RCPT <defer@y>: forcibly deferred
 215 >>> using ACL "accept"
 216 >>> processing "accept" (TESTSUITE/test-config 24)
 217 >>> accept: condition test succeeded in ACL "accept"
 218 >>> end of ACL "accept": ACCEPT
 219 >>> using ACL "drop"
 220 >>> processing "drop" (TESTSUITE/test-config 41)
 221 >>>   message: forcibly dropped
 222 >>> drop: condition test succeeded in ACL "drop"
 223 >>> end of ACL "drop": DROP
 224 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <drop@y>: forcibly dropped
 225 LOG: SMTP connection from [V4NET.9.8.7] closed by DROP in ACL
 226 >>> host in hosts_connection_nolog? no (end of list)
 227 LOG: SMTP connection from [V4NET.9.8.7]
 228 >>> host in host_lookup? no (option unset)
 229 >>> host in host_reject_connection? no (option unset)
 230 >>> host in sender_unqualified_hosts? no (option unset)
 231 >>> host in recipient_unqualified_hosts? no (option unset)
 232 >>> host in helo_verify_hosts? no (option unset)
 233 >>> host in helo_try_verify_hosts? no (option unset)
 234 >>> host in helo_accept_junk_hosts? no (option unset)
 235 >>> using ACL "defer_senders"
 236 >>> processing "defer" (TESTSUITE/test-config 54)
 237 >>> check senders = :
 238 >>>  in ":"? yes (matched "")
 239 >>> defer: condition test succeeded in ACL "defer_senders"
 240 >>> end of ACL "defer_senders": DEFER
 241 LOG: H=[V4NET.9.8.7] F=<> temporarily rejected RCPT <defer_senders@y>
 242 LOG: SMTP connection from [V4NET.9.8.7] closed by QUIT
 243 >>> host in hosts_connection_nolog? no (end of list)
 244 LOG: SMTP connection from [V4NET.9.8.7]
 245 >>> host in host_lookup? no (option unset)
 246 >>> host in host_reject_connection? no (option unset)
 247 >>> host in sender_unqualified_hosts? no (option unset)
 248 >>> host in recipient_unqualified_hosts? no (option unset)
 249 >>> host in helo_verify_hosts? no (option unset)
 250 >>> host in helo_try_verify_hosts? no (option unset)
 251 >>> host in helo_accept_junk_hosts? no (option unset)
 252 >>> using ACL "delay_accept"
 253 >>> processing "accept" (TESTSUITE/test-config 57)
 254 >>> check delay = 1s
 255 >>> delay modifier requests 1-second delay
 256 >>> delay skipped in -bh checking mode
 257 >>> accept: condition test succeeded in ACL "delay_accept"
 258 >>> end of ACL "delay_accept": ACCEPT
 259 >>> using ACL "delay_warn"
 260 >>> processing "warn" (TESTSUITE/test-config 60)
 261 >>> check delay = 1s
 262 >>> delay modifier requests 1-second delay
 263 >>> delay skipped in -bh checking mode
 264 >>> warn: condition test succeeded in ACL "delay_warn"
 265 >>> processing "accept" (TESTSUITE/test-config 61)
 266 >>> accept: condition test succeeded in ACL "delay_warn"
 267 >>> end of ACL "delay_warn": ACCEPT
 268 LOG: SMTP connection from [V4NET.9.8.7] closed by QUIT
 269 >>> host in hosts_connection_nolog? no (end of list)
 270 LOG: SMTP connection from [V4NET.9.8.7]
 271 >>> host in host_lookup? no (option unset)
 272 >>> host in host_reject_connection? no (option unset)
 273 >>> host in sender_unqualified_hosts? no (option unset)
 274 >>> host in recipient_unqualified_hosts? no (option unset)
 275 >>> host in helo_verify_hosts? no (option unset)
 276 >>> host in helo_try_verify_hosts? no (option unset)
 277 >>> host in helo_accept_junk_hosts? no (option unset)
 278 >>> using ACL "host_check"
 279 >>> processing "deny" (TESTSUITE/test-config 71)
 280 >>> check hosts = net-lsearch;TESTSUITE/aux-var/0022.hosts
 281 >>> host in "net-lsearch;TESTSUITE/aux-var/0022.hosts"? yes (matched "net-lsearch;TESTSUITE/aux-var/0022.hosts")
 282 >>>   message: host data >$host_data<
 283 >>> deny: condition test succeeded in ACL "host_check"
 284 >>> end of ACL "host_check": DENY
 285 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <host_check@y>: host data >A host-specific message<
 286 >>> using ACL "host_check"
 287 >>> processing "deny" (TESTSUITE/test-config 71)
 288 >>> check hosts = net-lsearch;TESTSUITE/aux-var/0022.hosts
 289 >>> host in "net-lsearch;TESTSUITE/aux-var/0022.hosts"? yes (matched "net-lsearch;TESTSUITE/aux-var/0022.hosts")
 290 >>>   message: host data >$host_data<
 291 >>> deny: condition test succeeded in ACL "host_check"
 292 >>> end of ACL "host_check": DENY
 293 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <host_check@y>: host data >A host-specific message<
 294 >>> using ACL "host_check2"
 295 >>> processing "deny" (TESTSUITE/test-config 75)
 296 >>>   message: host data >$host_data<
 297 >>> check hosts = +some_hosts
 298 >>> host in "net-lsearch;TESTSUITE/aux-var/0022.hosts"? yes (matched "net-lsearch;TESTSUITE/aux-var/0022.hosts")
 299 >>> host in "+some_hosts"? yes (matched "+some_hosts")
 300 >>> deny: condition test succeeded in ACL "host_check2"
 301 >>> end of ACL "host_check2": DENY
 302 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <host_check2@y>: host data >A host-specific message<
 303 >>> using ACL "host_check2"
 304 >>> processing "deny" (TESTSUITE/test-config 75)
 305 >>>   message: host data >$host_data<
 306 >>> check hosts = +some_hosts
 307 >>> host in "+some_hosts"? yes (matched "+some_hosts" - cached)
 308 >>> deny: condition test succeeded in ACL "host_check2"
 309 >>> end of ACL "host_check2": DENY
 310 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <host_check2@y>: host data >A host-specific message<
 311 LOG: SMTP connection from [V4NET.9.8.7] closed by QUIT
 312 LOG: smtp_connection MAIN
 313   SMTP connection from CALLER
 314 LOG: MAIN
 315   Connections=0
 316 LOG: MAIN
 317   <= CALLER@test.ex U=CALLER P=local-smtp S=sss
 318 LOG: MAIN
 319   frozen by ACL
 320 LOG: MAIN
 321   <= CALLER@test.ex U=CALLER P=local-smtp S=sss
 322 delivering 10HmaY-0005vi-00
 323 LOG: MAIN
 324   *> accept <accept@y> R=accept T=appendfile
 325 LOG: MAIN
 326   Completed
 327 LOG: MAIN
 328   <= CALLER@test.ex U=CALLER P=local-smtp S=sss
 329 LOG: delay_delivery MAIN
 330   no immediate delivery: queued by ACL
 331 LOG: MAIN
 332   <= CALLER@test.ex U=CALLER P=local-smtp S=sss
 333 delivering 10HmbA-0005vi-00
 334 LOG: MAIN
 335   *> accept <accept@y> R=accept T=appendfile
 336 LOG: MAIN
 337   Completed
 338 LOG: smtp_connection MAIN
 339   SMTP connection from CALLER closed by QUIT
 340 >>> host in hosts_connection_nolog? no (end of list)
 341 LOG: SMTP connection from [V4NET.9.8.7]
 342 >>> host in host_lookup? no (option unset)
 343 >>> host in host_reject_connection? no (option unset)
 344 >>> host in sender_unqualified_hosts? no (option unset)
 345 >>> host in recipient_unqualified_hosts? no (option unset)
 346 >>> host in helo_verify_hosts? no (option unset)
 347 >>> host in helo_try_verify_hosts? no (option unset)
 348 >>> host in helo_accept_junk_hosts? no (option unset)
 349 >>> using ACL "nested_drop"
 350 >>> processing "accept" (TESTSUITE/test-config 44)
 351 >>> check acl = drop
 352 >>>  using ACL "drop"
 353 >>>  processing "drop" (TESTSUITE/test-config 41)
 354 >>>    message: forcibly dropped
 355 >>>  drop: condition test succeeded in ACL "drop"
 356 >>>  end of ACL "drop": DROP
 357 >>> accept: condition test yielded "drop" in ACL "nested_drop"
 358 >>> accept: endpass encountered - denying access
 359 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <nested_drop@y>: forcibly dropped
 360 LOG: SMTP connection from [V4NET.9.8.7] closed by DROP in ACL
 361 >>> host in hosts_connection_nolog? no (end of list)
 362 LOG: SMTP connection from [V4NET.9.8.7]
 363 >>> host in host_lookup? no (option unset)
 364 >>> host in host_reject_connection? no (option unset)
 365 >>> host in sender_unqualified_hosts? no (option unset)
 366 >>> host in recipient_unqualified_hosts? no (option unset)
 367 >>> host in helo_verify_hosts? no (option unset)
 368 >>> host in helo_try_verify_hosts? no (option unset)
 369 >>> host in helo_accept_junk_hosts? no (option unset)
 370 >>> using ACL "nested_drop_require"
 371 >>> processing "require" (TESTSUITE/test-config 48)
 372 >>> check acl = drop
 373 >>>  using ACL "drop"
 374 >>>  processing "drop" (TESTSUITE/test-config 41)
 375 >>>    message: forcibly dropped
 376 >>>  drop: condition test succeeded in ACL "drop"
 377 >>>  end of ACL "drop": DROP
 378 >>> require: condition test yielded "drop" in ACL "nested_drop_require"
 379 >>> end of ACL "nested_drop_require": not OK
 380 LOG: H=[V4NET.9.8.7] F=<x@y> rejected RCPT <nested_drop_require@y>: forcibly dropped
 381 LOG: SMTP connection from [V4NET.9.8.7] closed by DROP in ACL
 382
 383 ******** SERVER ********