From owner-freebsd-apache@FreeBSD.ORG Sat Jan 2 09:50:50 2010 Return-Path: Delivered-To: apache@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 129DC1065698 for ; Sat, 2 Jan 2010 09:50:50 +0000 (UTC) (envelope-from david@vizion2000.net) Received: from dns1.vizion2000.net (dns1.vizion2000.net [62.49.197.50]) by mx1.freebsd.org (Postfix) with ESMTP id 943328FC19 for ; Sat, 2 Jan 2010 09:50:49 +0000 (UTC) Received: by dns1.vizion2000.net (Postfix, from userid 1001) id BB06F34D456; Sat, 2 Jan 2010 09:50:42 +0000 (GMT) From: David Southwell Organization: Voice & Vision To: apache@freebsd.org Date: Sat, 2 Jan 2010 09:50:42 +0000 User-Agent: KMail/1.12.4 (FreeBSD/7.2-RELEASE-p3; KDE/4.3.4; amd64; ; ) MIME-Version: 1.0 Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Message-Id: <201001020950.42654.david@vizion2000.net> Cc: Subject: Open SSL - debug output - BIO dump X-BeenThere: freebsd-apache@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Support of apache-related ports List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sat, 02 Jan 2010 09:50:50 -0000 Hi I increased my debug level on apache to deal with a problem which is now solved but found this in the log. Can anyone please tell me what is going on here and how to deal with it? Thanks in advance David Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1883): OpenSSL: Loop: SSLv3 read client key exchange A [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 5/5 bytes from BIO#812066860 [mem: 812353000] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 14 03 01 00 01 ..... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 1/1 bytes from BIO#812066860 [mem: 812353005] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 01 . | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 5/5 bytes from BIO#812066860 [mem: 812353000] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 16 03 01 00 30 ....0 | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 48/48 bytes from BIO#812066860 [mem: 812353005] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: fd f4 1b 6a e3 02 d8 5c-d9 39 42 cd 22 54 c2 08 ...j...\\.9B."T.. | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0010: 3f 34 ad ae 75 67 36 ea-d3 2f 46 2c ca 69 09 b2 ?4..ug6../F,.i.. | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0020: 79 bc d9 37 3c ee 4e dc-7c 01 58 b6 c1 21 bb f4 y..7<.N.|.X..!.. | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1883): OpenSSL: Loop: SSLv3 read finished A [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1883): OpenSSL: Loop: SSLv3 write change cipher spec A [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1883): OpenSSL: Loop: SSLv3 write finished A [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1883): OpenSSL: Loop: SSLv3 flush data [Sat Jan 02 05:12:08 2010] [debug] ssl_scache_shmcb.c(353): ssl_scache_shmcb_store (0x7e -> subcache 30) [Sat Jan 02 05:12:08 2010] [debug] ssl_scache_shmcb.c(645): insert happened at idx=0, data=0 [Sat Jan 02 05:12:08 2010] [debug] ssl_scache_shmcb.c(647): finished insert, subcache: idx_pos/idx_used=0/1, data_pos/data_used=0/148 [Sat Jan 02 05:12:08 2010] [debug] ssl_scache_shmcb.c(378): leaving ssl_scache_shmcb_store successfully [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1721): Inter-Process Session Cache: request=SET status=OK id=7ED320DA25610A0C4545B8EE78BD85F8F7FA4CCAB9DDB77E32A9EE3FF2FDA30D timeout=300s (session caching) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1879): OpenSSL: Handshake: done [Sat Jan 02 05:12:08 2010] [info] Connection: Client IP: 91.209.196.76, Protocol: TLSv1, Cipher: DHE-RSA-AES256-SHA (256/256 bits) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 5/5 bytes from BIO#812066860 [mem: 812353000] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 17 03 01 ... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1834): | 0005 - [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 32/32 bytes from BIO#812066860 [mem: 812353005] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 23 31 c0 19 32 2b 53 94-ae 20 d1 8b d2 b4 86 b9 #1..2+S.. ...... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0010: 6f e3 1f 19 6c 74 4d 87-8a 45 ac 02 85 78 a7 cd o...ltM..E...x.. | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 5/5 bytes from BIO#812066860 [mem: 812353000] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 17 03 01 00 80 ..... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1858): OpenSSL: read 128/128 bytes from BIO#812066860 [mem: 812353005] (BIO dump follows) [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1791): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0000: 49 dd 41 f0 15 74 d1 e3-d7 cf d1 a8 b2 a3 cd d4 I.A..t.......... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0010: e9 0c 05 1e 6d 4f 3c 92-6b 02 4e ab c3 73 46 69 ....mO<.k.N..sFi | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0020: 24 89 75 98 ff 80 dc 7d-8c cb c7 fc 38 9b 60 05 $.u....}....8.`. | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0030: 24 f0 b0 22 b0 51 05 65-1c a6 ba 6d 7c 9d c7 4a $..".Q.e...m|..J | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0040: d6 7f 02 4e a2 ff 41 a8-93 78 19 94 eb b4 5b 67 ...N..A..x....[g | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0050: 6c 7e 89 7a 89 80 5d bd-19 32 1e e5 51 c7 fa 19 l~.z..]..2..Q... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0060: 22 b7 46 cd c5 6e 4a 1c-5b 54 28 12 5f 1c f8 b2 ".F..nJ.[T(._... | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1830): | 0070: d4 ae 75 60 a9 40 5d 42-df d2 e7 e7 53 ec 09 6f ..u`.@]B....S..o | [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_io.c(1836): +-------------------------------------------------------------------------+ [Sat Jan 02 05:12:08 2010] [info] Initial (No.1) HTTPS request received for child 0 (server www.vizion2000.net:443) [Sat Jan 02 05:12:08 2010] [error] [client 91.209.196.76] client denied by server configuration: /usr/local/www/apache22/data/robots.txt [Sat Jan 02 05:12:08 2010] [debug] ssl_engine_kernel.c(1893): OpenSSL: Write: SSL negotiation finished successfully [Sat Jan 02 05:12:08 2010] [info] [client 91.209.196.76] Connection closed to child 0 with standard shutdown (server www.vizion2000.net:443)