# failure-transfer_loop_not_transferring_only.txt [dustin@lilthing stunnel_test (master)]$ ./test_truncated_response.pl q 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Clients allowed=500 2013.02.04 16:49:25 LOG5[10172:140602188109568]: stunnel 4.54 on x86_64-unknown-linux-gnu platform 2013.02.04 16:49:25 LOG5[10172:140602188109568]: Compiled/running with OpenSSL 1.0.1c 10 May 2012 2013.02.04 16:49:25 LOG5[10172:140602188109568]: Threading:PTHREAD SSL:+ENGINE+OCSP Auth:none Sockets:POLL+IPv6 2013.02.04 16:49:25 LOG5[10172:140602188109568]: Reading configuration from file /tmp/stunnel.conf-Jp7kuB 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Compression not enabled 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Snagged 64 random bytes from /home/dustin/.rnd 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Wrote 1024 new random bytes to /home/dustin/.rnd 2013.02.04 16:49:25 LOG7[10172:140602188109568]: PRNG seeded successfully 2013.02.04 16:49:25 LOG6[10172:140602188109568]: Initializing service [127.0.0.1] 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Certificate: /home/dustin/src/stunnel_test/snakeoil.pem 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Certificate loaded 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Key file: /home/dustin/src/stunnel_test/snakeoil.pem 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Private key loaded 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Could not load DH parameters from /home/dustin/src/stunnel_test/snakeoil.pem 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Using hardcoded DH parameters 2013.02.04 16:49:25 LOG7[10172:140602188109568]: DH initialized with 2048-bit key 2013.02.04 16:49:25 LOG7[10172:140602188109568]: ECDH initialized with curve prime256v1 2013.02.04 16:49:25 LOG7[10172:140602188109568]: SSL options set: 0x01400004 2013.02.04 16:49:25 LOG5[10172:140602188109568]: Configuration successful 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Service [127.0.0.1] (FD=7) bound to 127.0.0.1:4443 2013.02.04 16:49:25 LOG7[10172:140602188109568]: Created pid file /tmp/ATa4qfkteO.pid 2013.02.04 16:49:26 LOG7[10172:140602188109568]: Service [127.0.0.1] accepted (FD=3) from 127.0.0.1:53712 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Service [127.0.0.1] started 2013.02.04 16:49:26 LOG5[10172:140602188240640]: Service [127.0.0.1] accepted connection from 127.0.0.1:53712 2013.02.04 16:49:26 LOG6[10172:140602188240640]: connect_blocking: connecting localhost:/tmp/oG0Om_dihw.sock 2013.02.04 16:49:26 LOG5[10172:140602188240640]: connect_blocking: connected localhost:/tmp/oG0Om_dihw.sock 2013.02.04 16:49:26 LOG5[10172:140602188240640]: Service [127.0.0.1] connected remote server from unnamed socket 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Remote socket (FD=8) initialized 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Option TCP_NODELAY not supported on remote socket 2013.02.04 16:49:26 LOG6[10172:140602188240640]: Server-mode proxy protocol negotiations started 2013.02.04 16:49:26 LOG7[10172:140602188240640]: -> PROXY TCP4 127.0.0.1 127.0.0.1 53712 4443 2013.02.04 16:49:26 LOG6[10172:140602188240640]: Server-mode proxy protocol negotiations succeeded 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): before/accept initialization 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 read client hello A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write server hello A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write certificate A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write key exchange A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write server done A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 flush data 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 read client key exchange A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 read finished A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write change cipher spec A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 write finished A 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL state (accept): SSLv3 flush data 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 1 items in the session cache 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 client connects (SSL_connect()) 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 client connects that finished 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 client renegotiations requested 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 1 server connects (SSL_accept()) 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 1 server connects that finished 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 server renegotiations requested 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 session cache hits 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 external session cache hits 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 session cache misses 2013.02.04 16:49:26 LOG7[10172:140602188240640]: 0 session cache timeouts 2013.02.04 16:49:26 LOG6[10172:140602188240640]: SSL accepted: new session negotiated 2013.02.04 16:49:26 LOG6[10172:140602188240640]: Negotiated TLSv1/SSLv3 ciphersuite: ECDHE-RSA-RC4-SHA (128-bit encryption) 2013.02.04 16:49:26 LOG6[10172:140602188240640]: Compression: null, expansion: null 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Socket closed on read 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Sending close_notify alert 2013.02.04 16:49:26 LOG7[10172:140602188240640]: SSL alert (write): warning: close notify 2013.02.04 16:49:26 LOG6[10172:140602188240640]: SSL_shutdown successfully sent close_notify alert 2013.02.04 16:49:26 LOG3[10172:140602188240640]: transfer() loop executes not transferring any data 2013.02.04 16:49:26 LOG3[10172:140602188240640]: please report the problem to Michal.Trojnara@mirt.net 2013.02.04 16:49:26 LOG3[10172:140602188240640]: stunnel 4.54 on x86_64-unknown-linux-gnu platform 2013.02.04 16:49:26 LOG3[10172:140602188240640]: Compiled/running with OpenSSL 1.0.1c 10 May 2012 2013.02.04 16:49:26 LOG3[10172:140602188240640]: Threading:PTHREAD SSL:+ENGINE+OCSP Auth:none Sockets:POLL+IPv6 2013.02.04 16:49:26 LOG3[10172:140602188240640]: protocol=TLSv1.2, SSL_pending=0 2013.02.04 16:49:26 LOG3[10172:140602188240640]: sock_open_rd=n, sock_open_wr=Y 2013.02.04 16:49:26 LOG3[10172:140602188240640]: SSL_RECEIVED_SHUTDOWN=n, SSL_SENT_SHUTDOWN=Y 2013.02.04 16:49:26 LOG3[10172:140602188240640]: sock_can_rd=Y, sock_can_wr=n 2013.02.04 16:49:26 LOG3[10172:140602188240640]: ssl_can_rd=n, ssl_can_wr=n 2013.02.04 16:49:26 LOG3[10172:140602188240640]: read_wants_read=Y, read_wants_write=n 2013.02.04 16:49:26 LOG3[10172:140602188240640]: write_wants_read=n, write_wants_write=n 2013.02.04 16:49:26 LOG3[10172:140602188240640]: shutdown_wants_read=n, shutdown_wants_write=n 2013.02.04 16:49:26 LOG3[10172:140602188240640]: socket input buffer: 0 byte(s), ssl input buffer: 0 byte(s) 2013.02.04 16:49:26 LOG5[10172:140602188240640]: Connection reset: 56459 byte(s) sent to SSL, 78 byte(s) sent to socket 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Remote socket (FD=8) closed 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Local socket (FD=3) closed 2013.02.04 16:49:26 LOG7[10172:140602188240640]: Service [127.0.0.1] finished (0 left) Cleaning up ... 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Dispatching signals from the signal pipe 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Processing SIGNAL_TERMINATE 2013.02.04 16:49:27 LOG5[10172:140602188109568]: Terminated 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Closing service [127.0.0.1] 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Service [127.0.0.1] closed (FD=7) 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Sessions cached before flush: 1 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Sessions cached after flush: 0 2013.02.04 16:49:27 LOG7[10172:140602188109568]: Service [127.0.0.1] closed 2013.02.04 16:49:27 LOG7[10172:140602188109568]: str_stats: 12 block(s), 1069 data byte(s), 696 control byte(s) 2013.02.04 16:49:27 LOG7[10172:140602188109568]: removing pid file /tmp/ATa4qfkteO.pid