Bug Report:
description:
stunnel just terminated after exactly two incoming SSL connections. No
error is logged, no core dump.
affected versions: (plain ./configure)
stunnel-4.04: works fine
stunnel-4.05: crashes
stunnel-4.08: crashes
stunnel-4.10: crashes
uname -a:
FreeBSD db.kanti-zug.ch 5.4-RELEASE-p1 FreeBSD 5.4-RELEASE-p1 #0: Thu May
26 15:36:18 CEST 2005 root@db.kanti-zug.ch:/usr/src/sys/i386/compile/db
i386
log:
2005.05.26 16:28:43 LOG5[20644:1]: stunnel 4.10 on i386-unknown-freebsd5.4
UCONTEXT+POLL+IPv4+LIBWRAP with OpenSSL 0.9.7e 25 Oct 2004
2005.05.26 16:28:43 LOG7[20644:1]: RAND_status claims sufficient entropy
for the PRNG
2005.05.26 16:28:43 LOG6[20644:1]: PRNG seeded successfully
2005.05.26 16:28:43 LOG7[20644:1]: Certificate: /db/server.crt
2005.05.26 16:28:43 LOG7[20644:1]: Key file: /db/server.key
2005.05.26 16:28:43 LOG6[20644:1]: file ulimit = 11095 (can be changed with
'ulimit -n')
2005.05.26 16:28:43 LOG6[20644:1]: poll() used - no FD_SETSIZE limit for
file descriptors
2005.05.26 16:28:43 LOG5[20644:1]: 5417 clients allowed
2005.05.26 16:28:43 LOG7[20644:1]: FD 4 in non-blocking mode
2005.05.26 16:28:43 LOG7[20644:1]: FD 5 in non-blocking mode
2005.05.26 16:28:43 LOG7[20644:1]: FD 6 in non-blocking mode
2005.05.26 16:28:43 LOG7[20644:1]: SO_REUSEADDR option set on accept socket
2005.05.26 16:28:43 LOG7[20644:1]: postgres bound to 85.158.25.7:5430
2005.05.26 16:28:43 LOG7[20644:1]: No pid file being created
2005.05.26 16:28:43 LOG7[20644:0]: Waiting -1 second(s) for 2 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:1]: postgres accepted FD=7 from
212.203.73.19:55038
2005.05.26 16:28:46 LOG7[20644:1]: Creating a new context
2005.05.26 16:28:46 LOG7[20644:1]: Context 2 created
2005.05.26 16:28:46 LOG7[20644:2]: postgres started
2005.05.26 16:28:46 LOG7[20644:2]: FD 7 in non-blocking mode
2005.05.26 16:28:46 LOG5[20644:2]: postgres connected from
212.203.73.19:55038
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): before/accept
initialization
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 read client
hello A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 write server
hello A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 write
certificate A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 write
certificate request A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 flush data
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 300 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:2]: SSL alert (read): warning: no certificate
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 read client
key exchange A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 read finished A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 write change
cipher spec A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 write finished
A
2005.05.26 16:28:46 LOG7[20644:2]: SSL state (accept): SSLv3 flush data
2005.05.26 16:28:46 LOG7[20644:2]: 1 items in the session cache
2005.05.26 16:28:46 LOG7[20644:2]: 0 client connects (SSL_connect())
2005.05.26 16:28:46 LOG7[20644:2]: 0 client connects that finished
2005.05.26 16:28:46 LOG7[20644:2]: 0 client renegotiatations requested
2005.05.26 16:28:46 LOG7[20644:2]: 1 server connects (SSL_accept())
2005.05.26 16:28:46 LOG7[20644:2]: 1 server connects that finished
2005.05.26 16:28:46 LOG7[20644:2]: 0 server renegotiatiations requested
2005.05.26 16:28:46 LOG7[20644:2]: 0 session cache hits
2005.05.26 16:28:46 LOG7[20644:2]: 1 session cache misses
2005.05.26 16:28:46 LOG7[20644:2]: 0 session cache timeouts
2005.05.26 16:28:46 LOG6[20644:2]: SSL accepted: new session negotiated
2005.05.26 16:28:46 LOG6[20644:2]: Negotiated ciphers: AES256-SHA
SSLv3 Kx=RSA Au=RSA Enc=AES(256) Mac=SHA1
2005.05.26 16:28:46 LOG7[20644:2]: FD 8 in non-blocking mode
2005.05.26 16:28:46 LOG7[20644:2]: postgres connecting 127.0.0.1:5432
2005.05.26 16:28:46 LOG7[20644:2]: connect_wait: waiting 10 seconds
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 10 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:2]: connect_wait: connected
2005.05.26 16:28:46 LOG7[20644:2]: Remote FD=8 initialized
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=8, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->()
2005.05.26 16:28:46 LOG7[20644:2]: Socket closed on read
2005.05.26 16:28:46 LOG7[20644:2]: SSL write shutdown
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 60 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:46 LOG7[20644:2]: SSL alert (write): warning: close notify
2005.05.26 16:28:46 LOG7[20644:2]: SSL_shutdown retrying
2005.05.26 16:28:46 LOG7[20644:2]: SSL doesn't need to read or write
2005.05.26 16:28:46 LOG7[20644:0]: Waiting 60 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:46 LOG7[20644:0]: CONTEXT 2, FD=7, (IN)->(IN)
2005.05.26 16:28:46 LOG7[20644:2]: SSL alert (read): warning: close notify
2005.05.26 16:28:46 LOG7[20644:2]: SSL closed on SSL_read
2005.05.26 16:28:46 LOG7[20644:2]: Socket write shutdown
2005.05.26 16:28:46 LOG5[20644:2]: Connection closed: 550 bytes sent to
SSL, 446 bytes sent to socket
2005.05.26 16:28:46 LOG7[20644:2]: postgres finished (0 left)
2005.05.26 16:28:46 LOG7[20644:2]: Context 2 closed
2005.05.26 16:28:46 LOG7[20644:0]: Waiting -1 second(s) for 2 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:1]: postgres accepted FD=7 from
212.203.73.19:55040
2005.05.26 16:28:48 LOG7[20644:1]: Creating a new context
2005.05.26 16:28:48 LOG7[20644:1]: Context 3 created
2005.05.26 16:28:48 LOG7[20644:3]: postgres started
2005.05.26 16:28:48 LOG7[20644:3]: FD 7 in non-blocking mode
2005.05.26 16:28:48 LOG5[20644:3]: postgres connected from
212.203.73.19:55040
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): before/accept
initialization
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 read client
hello A
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 write server
hello A
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 write change
cipher spec A
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 write finished
A
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 flush data
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 300 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:3]: SSL state (accept): SSLv3 read finished A
2005.05.26 16:28:48 LOG7[20644:3]: 1 items in the session cache
2005.05.26 16:28:48 LOG7[20644:3]: 0 client connects (SSL_connect())
2005.05.26 16:28:48 LOG7[20644:3]: 0 client connects that finished
2005.05.26 16:28:48 LOG7[20644:3]: 0 client renegotiatations requested
2005.05.26 16:28:48 LOG7[20644:3]: 2 server connects (SSL_accept())
2005.05.26 16:28:48 LOG7[20644:3]: 2 server connects that finished
2005.05.26 16:28:48 LOG7[20644:3]: 0 server renegotiatiations requested
2005.05.26 16:28:48 LOG7[20644:3]: 1 session cache hits
2005.05.26 16:28:48 LOG7[20644:3]: 1 session cache misses
2005.05.26 16:28:48 LOG7[20644:3]: 0 session cache timeouts
2005.05.26 16:28:48 LOG6[20644:3]: SSL accepted: previous session reused
2005.05.26 16:28:48 LOG7[20644:3]: FD 8 in non-blocking mode
2005.05.26 16:28:48 LOG7[20644:3]: postgres connecting 127.0.0.1:5432
2005.05.26 16:28:48 LOG7[20644:3]: connect_wait: waiting 10 seconds
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 10 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:3]: connect_wait: connected
2005.05.26 16:28:48 LOG7[20644:3]: Remote FD=8 initialized
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 43200 second(s) for 4 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=8, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->()
2005.05.26 16:28:48 LOG7[20644:3]: Socket closed on read
2005.05.26 16:28:48 LOG7[20644:3]: SSL write shutdown
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 60 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (INOUT)->(OUT)
2005.05.26 16:28:48 LOG7[20644:3]: SSL alert (write): warning: close notify
2005.05.26 16:28:48 LOG7[20644:3]: SSL_shutdown retrying
2005.05.26 16:28:48 LOG7[20644:3]: SSL doesn't need to read or write
2005.05.26 16:28:48 LOG7[20644:0]: Waiting 60 second(s) for 3 file
descriptor(s)
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=4, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 1, FD=6, (IN)->()
2005.05.26 16:28:48 LOG7[20644:0]: CONTEXT 3, FD=7, (IN)->(IN)
2005.05.26 16:28:48 LOG7[20644:3]: SSL alert (read): warning: close notify
2005.05.26 16:28:48 LOG7[20644:3]: SSL closed on SSL_read
2005.05.26 16:28:48 LOG7[20644:3]: Socket write shutdown
2005.05.26 16:28:48 LOG5[20644:3]: Connection closed: 550 bytes sent to
SSL, 446 bytes sent to socket
2005.05.26 16:28:48 LOG7[20644:3]: postgres finished (0 left)