<html>
<head>
<meta content="text/html; charset=ISO-8859-15"
http-equiv="Content-Type">
</head>
<body bgcolor="#FFFFFF" text="#000000">
<div class="moz-cite-prefix">Am 12-09-20 17:47, schrieb Michal
Trojnara:<br>
</div>
<blockquote cite="mid:2d838b28c93fd0c7ca6c7034731da543@mirt.net"
type="cite">Kai M. Becker wrote:
<br>
<blockquote type="cite">although several postings state that this
issue has been fixed, I'm still
<br>
getting this error message:
<br>
��� Error detected on SSL (read) file descriptor: Broken pipe
(32)
<br>
</blockquote>
<br>
A longer sample of your logs (with "debug = 7") would be useful
here.
<br>
</blockquote>
<br>
<pre wrap="">Sorry, I didn't want to spam the list with my first posting :)
----- Config -----
client = no
setuid = root
setgid = root
pid = /var/run/stunnel.pid
debug = 7
output = /var/log/stunnel.log
socket = l:TCP_NODELAY=1
socket = r:TCP_NODELAY=1
cert = /etc/stunnel/stunnel.pem
[evs]
accept = 8080
connect = 8001
delay = yes
TIMEOUTclose = 1
TIMEOUTconnect = 1
TIMEOUTbusy = 30
TIMEOUTidle = 30
----- End config -----
Log, containing both issues, broken pipe and lazy accept (below).
Hope this contains some useful information for you.
----- Log -----
2012.09.20 20:25:45 LOG7[1376:3074193088]: Private key loaded
2012.09.20 20:25:45 LOG7[1376:3074193088]: Could not load DH parameters from /etc/stunnel/stunnel.pem
2012.09.20 20:25:45 LOG7[1376:3074193088]: Using hardcoded DH parameters
2012.09.20 20:25:45 LOG7[1376:3074193088]: DH initialized with 2048-bit key
2012.09.20 20:25:45 LOG7[1376:3074193088]: ECDH initialized with curve prime256v1
2012.09.20 20:25:45 LOG7[1376:3074193088]: SSL options set: 0x00000004
2012.09.20 20:25:45 LOG5[1376:3074193088]: Configuration successful
2012.09.20 20:25:45 LOG7[1376:3074193088]: Service [evs] (FD=8) bound to 0.0.0.0:8080
2012.09.20 20:25:45 LOG7[1407:3074193088]: Created pid file /var/run/stunnel.pid
normal operation:
2012.09.20 20:28:03 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49596
2012.09.20 20:28:03 LOG7[1407:3074190192]: Service [evs] started
2012.09.20 20:28:03 LOG5[1407:3074190192]: Service [evs] accepted connection from 192.168.0.101:49596
2012.09.20 20:28:03 LOG6[1407:3074190192]: SSL accepted: new session negotiated
2012.09.20 20:28:03 LOG6[1407:3074190192]: Negotiated TLSv1/SSLv3 ciphersuite: ECDHE-RSA-AES256-SHA (256-bit encryption)
2012.09.20 20:28:03 LOG6[1407:3074190192]: Compression: null, expansion: null
2012.09.20 20:28:03 LOG6[1407:3074190192]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:03 LOG7[1407:3074190192]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:03 LOG5[1407:3074190192]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:03 LOG5[1407:3074190192]: Service [evs] connected remote server from 127.0.0.1:50117
2012.09.20 20:28:03 LOG7[1407:3074190192]: Remote socket (FD=10) initialized
2012.09.20 20:28:04 LOG7[1407:3074190192]: Socket closed on read
2012.09.20 20:28:04 LOG7[1407:3074190192]: Sending close_notify alert
2012.09.20 20:28:04 LOG6[1407:3074190192]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:28:04 LOG7[1407:3074190192]: SSL closed on SSL_read
2012.09.20 20:28:04 LOG7[1407:3074190192]: Sent socket write shutdown
2012.09.20 20:28:04 LOG5[1407:3074190192]: Connection closed: 12880 byte(s) sent to SSL, 323 byte(s) sent to socket
2012.09.20 20:28:04 LOG7[1407:3074190192]: Remote socket (FD=10) closed
2012.09.20 20:28:04 LOG7[1407:3074190192]: Local socket (FD=3) closed
2012.09.20 20:28:04 LOG7[1407:3074190192]: Service [evs] finished (0 left)
"broken pipe" occurs:
2012.09.20 20:28:04 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49597
2012.09.20 20:28:04 LOG7[1407:3074190192]: Service [evs] started
2012.09.20 20:28:04 LOG5[1407:3074190192]: Service [evs] accepted connection from 192.168.0.101:49597
2012.09.20 20:28:04 LOG7[1407:3074193088]: Service [evs] accepted (FD=10) from 192.168.0.101:49598
2012.09.20 20:28:04 LOG6[1407:3074190192]: SSL accepted: previous session reused
2012.09.20 20:28:04 LOG6[1407:3074190192]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:04 LOG7[1407:3074190192]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:04 LOG5[1407:3074190192]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:04 LOG5[1407:3074190192]: Service [evs] connected remote server from 127.0.0.1:50118
2012.09.20 20:28:04 LOG7[1407:3074190192]: Remote socket (FD=11) initialized
2012.09.20 20:28:04 LOG7[1407:3074100080]: Service [evs] started
2012.09.20 20:28:04 LOG5[1407:3074100080]: Service [evs] accepted connection from 192.168.0.101:49598
2012.09.20 20:28:04 LOG7[1407:3074190192]: Socket closed on read
2012.09.20 20:28:04 LOG7[1407:3074190192]: Sending close_notify alert
2012.09.20 20:28:04 LOG5[1407:3074190192]: Error detected on socket (read) file descriptor: Broken pipe (32)
2012.09.20 20:28:04 LOG5[1407:3074190192]: Connection reset: 0 byte(s) sent to SSL, 304 byte(s) sent to socket
2012.09.20 20:28:04 LOG7[1407:3074190192]: Remote socket (FD=11) closed
2012.09.20 20:28:04 LOG7[1407:3074190192]: Local socket (FD=3) closed
2012.09.20 20:28:04 LOG7[1407:3074190192]: Service [evs] finished (1 left)
2012.09.20 20:28:04 LOG6[1407:3074100080]: SSL accepted: previous session reused
2012.09.20 20:28:04 LOG6[1407:3074100080]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:04 LOG7[1407:3074100080]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:04 LOG5[1407:3074100080]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:04 LOG5[1407:3074100080]: Service [evs] connected remote server from 127.0.0.1:50119
2012.09.20 20:28:04 LOG7[1407:3074100080]: Remote socket (FD=3) initialized
2012.09.20 20:28:04 LOG7[1407:3074100080]: Socket closed on read
2012.09.20 20:28:04 LOG7[1407:3074100080]: Sending close_notify alert
2012.09.20 20:28:04 LOG6[1407:3074100080]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:28:04 LOG5[1407:3074100080]: Error detected on SSL (read) file descriptor: Broken pipe (32)
2012.09.20 20:28:04 LOG5[1407:3074100080]: Connection reset: 9763 byte(s) sent to SSL, 334 byte(s) sent to socket
2012.09.20 20:28:04 LOG7[1407:3074100080]: Remote socket (FD=3) closed
2012.09.20 20:28:04 LOG7[1407:3074100080]: Local socket (FD=10) closed
2012.09.20 20:28:04 LOG7[1407:3074100080]: Service [evs] finished (0 left)
but not always:
2012.09.20 20:28:06 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49599
2012.09.20 20:28:06 LOG7[1407:3074100080]: Service [evs] started
2012.09.20 20:28:06 LOG5[1407:3074100080]: Service [evs] accepted connection from 192.168.0.101:49599
2012.09.20 20:28:06 LOG6[1407:3074100080]: SSL accepted: previous session reused
2012.09.20 20:28:06 LOG6[1407:3074100080]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:06 LOG7[1407:3074100080]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:06 LOG5[1407:3074100080]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:06 LOG5[1407:3074100080]: Service [evs] connected remote server from 127.0.0.1:50120
2012.09.20 20:28:06 LOG7[1407:3074100080]: Remote socket (FD=10) initialized
2012.09.20 20:28:06 LOG7[1407:3074193088]: Service [evs] accepted (FD=11) from 192.168.0.101:49600
2012.09.20 20:28:06 LOG7[1407:3074190192]: Service [evs] started
2012.09.20 20:28:06 LOG5[1407:3074190192]: Service [evs] accepted connection from 192.168.0.101:49600
2012.09.20 20:28:06 LOG6[1407:3074190192]: SSL accepted: previous session reused
2012.09.20 20:28:06 LOG6[1407:3074190192]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:06 LOG7[1407:3074190192]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:06 LOG5[1407:3074190192]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:06 LOG5[1407:3074190192]: Service [evs] connected remote server from 127.0.0.1:50121
2012.09.20 20:28:06 LOG7[1407:3074190192]: Remote socket (FD=12) initialized
2012.09.20 20:28:06 LOG7[1407:3074100080]: Socket closed on read
2012.09.20 20:28:06 LOG7[1407:3074100080]: Sending close_notify alert
2012.09.20 20:28:06 LOG6[1407:3074100080]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:28:06 LOG7[1407:3074100080]: SSL closed on SSL_read
2012.09.20 20:28:06 LOG7[1407:3074100080]: Sent socket write shutdown
2012.09.20 20:28:06 LOG5[1407:3074100080]: Connection closed: 926 byte(s) sent to SSL, 446 byte(s) sent to socket
2012.09.20 20:28:06 LOG7[1407:3074100080]: Remote socket (FD=10) closed
2012.09.20 20:28:06 LOG7[1407:3074100080]: Local socket (FD=3) closed
2012.09.20 20:28:06 LOG7[1407:3074100080]: Service [evs] finished (1 left)
2012.09.20 20:28:07 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49601
2012.09.20 20:28:07 LOG7[1407:3074193088]: Service [evs] accepted (FD=10) from 192.168.0.101:49602
2012.09.20 20:28:07 LOG7[1407:3074030448]: Service [evs] started
2012.09.20 20:28:07 LOG5[1407:3074030448]: Service [evs] accepted connection from 192.168.0.101:49602
2012.09.20 20:28:07 LOG7[1407:3074100080]: Service [evs] started
2012.09.20 20:28:07 LOG5[1407:3074100080]: Service [evs] accepted connection from 192.168.0.101:49601
2012.09.20 20:28:07 LOG7[1407:3074193088]: Service [evs] accepted (FD=13) from 192.168.0.101:49603
2012.09.20 20:28:07 LOG6[1407:3074100080]: SSL accepted: previous session reused
2012.09.20 20:28:07 LOG6[1407:3074100080]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:07 LOG7[1407:3074100080]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:07 LOG5[1407:3074100080]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:07 LOG5[1407:3074100080]: Service [evs] connected remote server from 127.0.0.1:50122
2012.09.20 20:28:07 LOG7[1407:3074100080]: Remote socket (FD=14) initialized
2012.09.20 20:28:07 LOG7[1407:3073919856]: Service [evs] started
2012.09.20 20:28:07 LOG5[1407:3073919856]: Service [evs] accepted connection from 192.168.0.101:49603
2012.09.20 20:28:07 LOG6[1407:3074030448]: SSL accepted: previous session reused
2012.09.20 20:28:07 LOG6[1407:3074030448]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:07 LOG7[1407:3074030448]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:07 LOG5[1407:3074030448]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:07 LOG5[1407:3074030448]: Service [evs] connected remote server from 127.0.0.1:50123
2012.09.20 20:28:07 LOG7[1407:3074030448]: Remote socket (FD=15) initialized
2012.09.20 20:28:07 LOG6[1407:3073919856]: SSL accepted: previous session reused
2012.09.20 20:28:07 LOG6[1407:3073919856]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:07 LOG7[1407:3073919856]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:07 LOG5[1407:3073919856]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:07 LOG5[1407:3073919856]: Service [evs] connected remote server from 127.0.0.1:50124
2012.09.20 20:28:07 LOG7[1407:3073919856]: Remote socket (FD=16) initialized
2012.09.20 20:28:07 LOG7[1407:3074190192]: Socket closed on read
2012.09.20 20:28:07 LOG7[1407:3074190192]: Sending close_notify alert
2012.09.20 20:28:07 LOG6[1407:3074190192]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:28:07 LOG7[1407:3074190192]: SSL closed on SSL_read
2012.09.20 20:28:07 LOG7[1407:3074190192]: Sent socket write shutdown
2012.09.20 20:28:07 LOG5[1407:3074190192]: Connection closed: 9717 byte(s) sent to SSL, 380 byte(s) sent to socket
2012.09.20 20:28:07 LOG7[1407:3074190192]: Remote socket (FD=12) closed
2012.09.20 20:28:07 LOG7[1407:3074190192]: Local socket (FD=11) closed
2012.09.20 20:28:07 LOG7[1407:3074190192]: Service [evs] finished (3 left)
2012.09.20 20:28:07 LOG7[1407:3074193088]: Service [evs] accepted (FD=11) from 192.168.0.101:49604
2012.09.20 20:28:07 LOG7[1407:3074190192]: Service [evs] started
2012.09.20 20:28:07 LOG5[1407:3074190192]: Service [evs] accepted connection from 192.168.0.101:49604
2012.09.20 20:28:07 LOG6[1407:3074190192]: SSL accepted: previous session reused
2012.09.20 20:28:07 LOG6[1407:3074190192]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:28:07 LOG7[1407:3074190192]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:28:07 LOG5[1407:3074190192]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:28:07 LOG5[1407:3074190192]: Service [evs] connected remote server from 127.0.0.1:50125
2012.09.20 20:28:07 LOG7[1407:3074190192]: Remote socket (FD=12) initialized
2012.09.20 20:28:07 LOG7[1407:3074100080]: Socket closed on read
2012.09.20 20:28:07 LOG7[1407:3074100080]: Sending close_notify alert
2012.09.20 20:28:07 LOG6[1407:3074100080]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:28:07 LOG7[1407:3074100080]: SSL closed on SSL_read
2012.09.20 20:28:07 LOG7[1407:3074100080]: Sent socket write shutdown
2012.09.20 20:28:07 LOG5[1407:3074100080]: Connection closed: 10497 byte(s) sent to SSL, 383 byte(s) sent to socket
2012.09.20 20:28:07 LOG7[1407:3074100080]: Remote socket (FD=14) closed
2012.09.20 20:28:07 LOG7[1407:3074100080]: Local socket (FD=3) closed
2012.09.20 20:28:07 LOG7[1407:3074100080]: Service [evs] finished (3 left)
refreshing the same page every second
2012.09.20 20:29:09 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:09 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:09 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:09 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:09 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:09 LOG5[1407:3073780592]: Connection closed: 36704 byte(s) sent to SSL, 740 byte(s) sent to socket
2012.09.20 20:29:09 LOG7[1407:3073780592]: Remote socket (FD=12) closed
2012.09.20 20:29:09 LOG7[1407:3073780592]: Local socket (FD=11) closed
2012.09.20 20:29:09 LOG7[1407:3073780592]: Service [evs] finished (0 left)
2012.09.20 20:29:10 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49643
2012.09.20 20:29:10 LOG7[1407:3073780592]: Service [evs] started
2012.09.20 20:29:10 LOG5[1407:3073780592]: Service [evs] accepted connection from 192.168.0.101:49643
2012.09.20 20:29:10 LOG6[1407:3073780592]: SSL accepted: previous session reused
2012.09.20 20:29:10 LOG6[1407:3073780592]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:10 LOG7[1407:3073780592]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:10 LOG5[1407:3073780592]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:10 LOG5[1407:3073780592]: Service [evs] connected remote server from 127.0.0.1:50164
2012.09.20 20:29:10 LOG7[1407:3073780592]: Remote socket (FD=10) initialized
2012.09.20 20:29:10 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:10 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:10 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:10 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:10 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:10 LOG5[1407:3073780592]: Connection closed: 39878 byte(s) sent to SSL, 1167 byte(s) sent to socket
2012.09.20 20:29:10 LOG7[1407:3073780592]: Remote socket (FD=10) closed
2012.09.20 20:29:10 LOG7[1407:3073780592]: Local socket (FD=3) closed
2012.09.20 20:29:10 LOG7[1407:3073780592]: Service [evs] finished (0 left)
2012.09.20 20:29:11 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49644
2012.09.20 20:29:11 LOG7[1407:3073780592]: Service [evs] started
2012.09.20 20:29:11 LOG5[1407:3073780592]: Service [evs] accepted connection from 192.168.0.101:49644
2012.09.20 20:29:11 LOG6[1407:3073780592]: SSL accepted: previous session reused
2012.09.20 20:29:11 LOG6[1407:3073780592]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:11 LOG7[1407:3073780592]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:11 LOG5[1407:3073780592]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:11 LOG5[1407:3073780592]: Service [evs] connected remote server from 127.0.0.1:50165
2012.09.20 20:29:11 LOG7[1407:3073780592]: Remote socket (FD=10) initialized
2012.09.20 20:29:11 LOG7[1407:3074193088]: Service [evs] accepted (FD=11) from 192.168.0.101:49645
2012.09.20 20:29:11 LOG7[1407:3073919856]: Service [evs] started
2012.09.20 20:29:11 LOG5[1407:3073919856]: Service [evs] accepted connection from 192.168.0.101:49645
2012.09.20 20:29:11 LOG6[1407:3073919856]: SSL accepted: previous session reused
2012.09.20 20:29:11 LOG6[1407:3073919856]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:11 LOG7[1407:3073919856]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:11 LOG5[1407:3073919856]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:11 LOG5[1407:3073919856]: Service [evs] connected remote server from 127.0.0.1:50166
2012.09.20 20:29:11 LOG7[1407:3073919856]: Remote socket (FD=12) initialized
2012.09.20 20:29:11 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:11 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:11 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:11 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:11 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:11 LOG5[1407:3073780592]: Connection closed: 32852 byte(s) sent to SSL, 1320 byte(s) sent to socket
2012.09.20 20:29:11 LOG7[1407:3073780592]: Remote socket (FD=10) closed
2012.09.20 20:29:11 LOG7[1407:3073780592]: Local socket (FD=3) closed
2012.09.20 20:29:11 LOG7[1407:3073780592]: Service [evs] finished (1 left)
2012.09.20 20:29:12 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49646
2012.09.20 20:29:12 LOG7[1407:3073780592]: Service [evs] started
2012.09.20 20:29:12 LOG5[1407:3073780592]: Service [evs] accepted connection from 192.168.0.101:49646
2012.09.20 20:29:12 LOG7[1407:3073919856]: Socket closed on read
2012.09.20 20:29:12 LOG7[1407:3073919856]: Sending close_notify alert
2012.09.20 20:29:12 LOG6[1407:3073919856]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:12 LOG6[1407:3073780592]: SSL accepted: previous session reused
2012.09.20 20:29:12 LOG6[1407:3073780592]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:12 LOG7[1407:3073780592]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:12 LOG5[1407:3073780592]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:12 LOG5[1407:3073780592]: Service [evs] connected remote server from 127.0.0.1:50167
2012.09.20 20:29:12 LOG7[1407:3073780592]: Remote socket (FD=10) initialized
2012.09.20 20:29:12 LOG7[1407:3073919856]: SSL closed on SSL_read
2012.09.20 20:29:12 LOG7[1407:3073919856]: Sent socket write shutdown
2012.09.20 20:29:12 LOG5[1407:3073919856]: Connection closed: 40856 byte(s) sent to SSL, 933 byte(s) sent to socket
2012.09.20 20:29:12 LOG7[1407:3073919856]: Remote socket (FD=12) closed
2012.09.20 20:29:12 LOG7[1407:3073919856]: Local socket (FD=11) closed
2012.09.20 20:29:12 LOG7[1407:3073919856]: Service [evs] finished (1 left)
2012.09.20 20:29:12 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:12 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:12 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:12 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:12 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:12 LOG5[1407:3073780592]: Connection closed: 10274 byte(s) sent to SSL, 330 byte(s) sent to socket
2012.09.20 20:29:12 LOG7[1407:3073780592]: Remote socket (FD=10) closed
2012.09.20 20:29:12 LOG7[1407:3073780592]: Local socket (FD=3) closed
2012.09.20 20:29:12 LOG7[1407:3073780592]: Service [evs] finished (0 left)
2012.09.20 20:29:13 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49647
2012.09.20 20:29:13 LOG7[1407:3073780592]: Service [evs] started
2012.09.20 20:29:13 LOG5[1407:3073780592]: Service [evs] accepted connection from 192.168.0.101:49647
2012.09.20 20:29:13 LOG6[1407:3073780592]: SSL accepted: previous session reused
2012.09.20 20:29:13 LOG6[1407:3073780592]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:13 LOG7[1407:3073780592]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:13 LOG5[1407:3073780592]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:13 LOG5[1407:3073780592]: Service [evs] connected remote server from 127.0.0.1:50168
2012.09.20 20:29:13 LOG7[1407:3073780592]: Remote socket (FD=10) initialized
2012.09.20 20:29:13 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:13 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:13 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:13 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:13 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:13 LOG5[1407:3073780592]: Connection closed: 37490 byte(s) sent to SSL, 1399 byte(s) sent to socket
2012.09.20 20:29:13 LOG7[1407:3073780592]: Remote socket (FD=10) closed
2012.09.20 20:29:13 LOG7[1407:3073780592]: Local socket (FD=3) closed
2012.09.20 20:29:13 LOG7[1407:3073780592]: Service [evs] finished (0 left)
2012.09.20 20:29:15 LOG7[1407:3074193088]: Service [evs] accepted (FD=3) from 192.168.0.101:49648
2012.09.20 20:29:15 LOG7[1407:3073780592]: Service [evs] started
2012.09.20 20:29:15 LOG5[1407:3073780592]: Service [evs] accepted connection from 192.168.0.101:49648
2012.09.20 20:29:15 LOG7[1407:3074193088]: Service [evs] accepted (FD=10) from 192.168.0.101:49649
2012.09.20 20:29:15 LOG7[1407:3073919856]: Service [evs] started
2012.09.20 20:29:15 LOG5[1407:3073919856]: Service [evs] accepted connection from 192.168.0.101:49649
2012.09.20 20:29:15 LOG6[1407:3073780592]: SSL accepted: previous session reused
2012.09.20 20:29:15 LOG6[1407:3073780592]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:15 LOG7[1407:3073780592]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:15 LOG5[1407:3073780592]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:15 LOG5[1407:3073780592]: Service [evs] connected remote server from 127.0.0.1:50169
2012.09.20 20:29:15 LOG7[1407:3073780592]: Remote socket (FD=11) initialized
2012.09.20 20:29:15 LOG6[1407:3073919856]: SSL accepted: previous session reused
2012.09.20 20:29:15 LOG6[1407:3073919856]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:15 LOG7[1407:3073919856]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:15 LOG5[1407:3073919856]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:15 LOG5[1407:3073919856]: Service [evs] connected remote server from 127.0.0.1:50170
2012.09.20 20:29:15 LOG7[1407:3073919856]: Remote socket (FD=12) initialized
all responses within 1 second ==> okay
...until here:
2012.09.20 20:29:16 LOG7[1407:3073919856]: Socket closed on read
2012.09.20 20:29:16 LOG7[1407:3073919856]: Sending close_notify alert
2012.09.20 20:29:16 LOG6[1407:3073919856]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:16 LOG7[1407:3073919856]: SSL closed on SSL_read
2012.09.20 20:29:16 LOG7[1407:3073919856]: Sent socket write shutdown
2012.09.20 20:29:16 LOG5[1407:3073919856]: Connection closed: 40856 byte(s) sent to SSL, 908 byte(s) sent to socket
2012.09.20 20:29:16 LOG7[1407:3073919856]: Remote socket (FD=12) closed
2012.09.20 20:29:16 LOG7[1407:3073919856]: Local socket (FD=10) closed
2012.09.20 20:29:16 LOG7[1407:3073919856]: Service [evs] finished (1 left)
^-- clicked immediately, i.e. 20:29:16
v-- accept 10s later, I assume because of "1 left"
2012.09.20 20:29:27 LOG7[1407:3074193088]: Service [evs] accepted (FD=10) from 192.168.0.101:49650
2012.09.20 20:29:27 LOG7[1407:3073919856]: Service [evs] started
2012.09.20 20:29:27 LOG5[1407:3073919856]: Service [evs] accepted connection from 192.168.0.101:49650
2012.09.20 20:29:27 LOG6[1407:3073919856]: SSL accepted: previous session reused
2012.09.20 20:29:27 LOG6[1407:3073919856]: connect_blocking: connecting 127.0.0.1:8001
2012.09.20 20:29:27 LOG7[1407:3073919856]: connect_blocking: s_poll_wait 127.0.0.1:8001: waiting 1 seconds
2012.09.20 20:29:27 LOG5[1407:3073919856]: connect_blocking: connected 127.0.0.1:8001
2012.09.20 20:29:27 LOG5[1407:3073919856]: Service [evs] connected remote server from 127.0.0.1:50171
2012.09.20 20:29:27 LOG7[1407:3073919856]: Remote socket (FD=12) initialized
2012.09.20 20:29:27 LOG7[1407:3073780592]: Socket closed on read
2012.09.20 20:29:27 LOG7[1407:3073780592]: Sending close_notify alert
2012.09.20 20:29:27 LOG6[1407:3073780592]: SSL_shutdown successfully sent close_notify alert
2012.09.20 20:29:27 LOG7[1407:3073780592]: SSL closed on SSL_read
2012.09.20 20:29:27 LOG7[1407:3073780592]: Sent socket write shutdown
2012.09.20 20:29:27 LOG5[1407:3073780592]: Connection closed: 32852 byte(s) sent to SSL, 1401 byte(s) sent to socket
2012.09.20 20:29:27 LOG7[1407:3073780592]: Remote socket (FD=11) closed
2012.09.20 20:29:27 LOG7[1407:3073780592]: Local socket (FD=3) closed
2012.09.20 20:29:27 LOG7[1407:3073780592]: Service [evs] finished (1 left)
----- End Log -----
</pre>
<pre class="moz-signature" cols="76">--
== Kai M. Becker == <a class="moz-txt-link-abbreviated" href="mailto:kmb@kai-m-becker.de">kmb@kai-m-becker.de</a> == Bremen, Germany ==
"Any technology distinguishable from magic is insufficiently advanced"
</pre>
</body>
</html>