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 SMTP>> 250 OK
  29 SMTP<< rcpt to:<warn_empty@test.ex>
  30 using ACL "warn_empty"
  31 processing "warn"
  32 warn: condition test succeeded in ACL "warn_empty"
  33 processing "accept"
  34 accept: condition test succeeded in ACL "warn_empty"
  35 end of ACL "warn_empty": ACCEPT
  36 SMTP>> 250 Accepted
  37 SMTP<< data
  38 SMTP>> 354 Enter message, ending with "." on a line by itself
  39 search_tidyup called
  40 host in ignore_fromline_hosts? no (option unset)
  41 >>Headers received:
  42
  43 search_tidyup called
  44 >>Headers after rewriting and local additions:
  45
  46 Data file written for message 10HmbF-0005vi-00
  47 >>Generated Received: header line
  48 P Received: from [V4NET.9.8.7]
  49         by myhost.test.ex with smtp (Exim x.yz)
  50         (envelope-from <x@y>)
  51         id 10HmbF-0005vi-00
  52         for warn_empty@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
  53 calling local_scan(); timeout=300
  54 local_scan() returned 0 NULL
  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 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 SMTP>> 250 OK
  93 SMTP<< rcpt to:<warn_log@test.ex>
  94 using ACL "warn_log"
  95 processing "warn"
  96 l_message: warn log message
  97 warn: condition test succeeded in ACL "warn_log"
  98 LOG: MAIN
  99   H=[V4NET.9.8.7] Warning: warn log message
 100 processing "accept"
 101 accept: condition test succeeded in ACL "warn_log"
 102 end of ACL "warn_log": ACCEPT
 103 SMTP>> 250 Accepted
 104 SMTP<< data
 105 SMTP>> 354 Enter message, ending with "." on a line by itself
 106 search_tidyup called
 107 host in ignore_fromline_hosts? no (option unset)
 108 >>Headers received:
 109
 110 search_tidyup called
 111 >>Headers after rewriting and local additions:
 112
 113 Data file written for message 10HmbG-0005vi-00
 114 >>Generated Received: header line
 115 P Received: from [V4NET.9.8.7]
 116         by myhost.test.ex with smtp (Exim x.yz)
 117         (envelope-from <x@y>)
 118         id 10HmbG-0005vi-00
 119         for warn_log@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 120 calling local_scan(); timeout=300
 121 local_scan() returned 0 NULL
 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 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 SMTP>> 250 OK
 160 SMTP<< rcpt to:<warn_user@test.ex>
 161 using ACL "warn_user"
 162 processing "warn"
 163   message: warn user message
 164 warn: condition test succeeded in ACL "warn_user"
 165 processing "accept"
 166 accept: condition test succeeded in ACL "warn_user"
 167 end of ACL "warn_user": ACCEPT
 168 SMTP>> 250 Accepted
 169 SMTP<< data
 170 SMTP>> 354 Enter message, ending with "." on a line by itself
 171 search_tidyup called
 172 host in ignore_fromline_hosts? no (option unset)
 173 >>Headers received:
 174
 175 search_tidyup called
 176 >>Headers after rewriting and local additions:
 177
 178 Data file written for message 10HmbH-0005vi-00
 179 >>Generated Received: header line
 180 P Received: from [V4NET.9.8.7]
 181         by myhost.test.ex with smtp (Exim x.yz)
 182         (envelope-from <x@y>)
 183         id 10HmbH-0005vi-00
 184         for warn_user@test.ex; Tue, 2 Mar 1999 09:44:33 +0000
 185 >>Headers added by MAIL or RCPT ACL:
 186   X-ACL-Warn: warn user message
 187 >>
 188 calling local_scan(); timeout=300
 189 local_scan() returned 0 NULL
 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 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"
 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"
 217 >>> accept: condition test succeeded in ACL "accept"
 218 >>> end of ACL "accept": ACCEPT
 219 >>> using ACL "drop"
 220 >>> processing "drop"
 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"
 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"
 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"
 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"
 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"
 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"
 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"
 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"
 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"
 351 >>> check acl = drop
 352 >>> using ACL "drop"
 353 >>> processing "drop"
 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"
 372 >>> check acl = drop
 373 >>> using ACL "drop"
 374 >>> processing "drop"
 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 ********