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