Tue Aug 9 07:59:15 2011 1312873155080357 741568 515: RPCSECURE::RPCSECURE thread 515 Tue Aug 9 07:59:15 2011 1312873155085153 741568 515: RPCSECURE::Init thread 515 Tue Aug 9 07:59:15 2011 1312873155087396 741568 515: RPCSECURE::Init checkpoint 0 Tue Aug 9 07:59:15 2011 1312873155089603 741568 515: RPCSECURE::Init checkpoint 1 Tue Aug 9 07:59:15 2011 1312873155092690 741568 515: RPCSECURE::Init checkpoint 2 Tue Aug 9 07:59:15 2011 1312873155095433 741568 515: RPCSECURE::Init checkpoint 3 Tue Aug 9 07:59:15 2011 1312873155097767 741568 515: RPCSECURE::Init checkpoint 4 Tue Aug 9 07:59:15 2011 1312873155100258 741568 515: RPCSECURE::InitClient thread 515 Tue Aug 9 07:59:15 2011 1312873155105428 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Allocating epoch #0 Tue Aug 9 07:59:15 2011 1312873155106619 741568 515: Wait sem 20173a5c count 1 Tue Aug 9 07:59:15 2011 1312873155108512 741568 515: Wait sem 20173a5c released 0 count 1 Tue Aug 9 07:59:15 2011 1312873155112978 741568 515: Release sem 20173a5c count 0 Tue Aug 9 07:59:15 2011 1312873155115432 741568 515: RPCSECURE::InitClient end thread 515 Tue Aug 9 07:59:15 2011 1312873155118208 741568 515: RPCSECURE::Init checkpoint 5 Tue Aug 9 07:59:15 2011 1312873155120559 741568 515: RPCSECURE::Init checkpoint 6 Tue Aug 9 07:59:15 2011 1312873155124448 741568 515: RPCSECURE::Init checkpoint 7 Tue Aug 9 07:59:15 2011 1312873155155719 741568 515: RPCSECURE::Init checkpoint 8 Tue Aug 9 07:59:15 2011 1312873155157573 741568 515: RPCSECURE::Init checkpoint 9 Tue Aug 9 07:59:15 2011 1312873155159399 741568 515: RPCSECURE::Init checkpoint 10 Tue Aug 9 07:59:15 2011 1312873155162549 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_constate.c:695 Tue Aug 9 07:59:15 2011 1312873155165788 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Allocating epoch #1 Tue Aug 9 07:59:15 2011 1312873155168446 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_AES_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155169855 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_AES_128_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155173997 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_CAMELLIA_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155175851 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_AES_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155177269 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_AES_256_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155179189 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_CAMELLIA_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155180740 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_RSA_3DES_EDE_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155184792 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_AES_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155186641 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_AES_128_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155188476 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_CAMELLIA_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155190303 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_AES_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155194068 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_AES_256_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155196142 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_CAMELLIA_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155197637 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_3DES_EDE_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155199523 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: DHE_DSS_ARCFOUR_SHA1 Tue Aug 9 07:59:15 2011 1312873155202409 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_AES_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155205286 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_AES_128_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155206704 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_CAMELLIA_128_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155208584 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_AES_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155210512 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_AES_256_CBC_SHA256 Tue Aug 9 07:59:15 2011 1312873155214559 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_CAMELLIA_256_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155215989 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_3DES_EDE_CBC_SHA1 Tue Aug 9 07:59:15 2011 1312873155217832 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_ARCFOUR_SHA1 Tue Aug 9 07:59:15 2011 1312873155245383 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Keeping ciphersuite: RSA_ARCFOUR_MD5 Tue Aug 9 07:59:15 2011 1312873155246879 741568 515: RPCSECURE: thread 515 : EXT[2021e0d8]: Sending extension SAFE RENEGOTIATION (1 bytes) Tue Aug 9 07:59:15 2011 1312873155248799 741568 515: RPCSECURE: thread 515 : EXT[SIGA]: sent signature algo (4.2) DSA-SHA256 Tue Aug 9 07:59:15 2011 1312873155250659 741568 515: RPCSECURE: thread 515 : EXT[SIGA]: sent signature algo (4.1) RSA-SHA256 Tue Aug 9 07:59:15 2011 1312873155254796 741568 515: RPCSECURE: thread 515 : EXT[SIGA]: sent signature algo (2.1) RSA-SHA1 Tue Aug 9 07:59:15 2011 1312873155256336 741568 515: RPCSECURE: thread 515 : EXT[SIGA]: sent signature algo (2.2) DSA-SHA1 Tue Aug 9 07:59:15 2011 1312873155258195 741568 515: RPCSECURE: thread 515 : EXT[2021e0d8]: Sending extension SIGNATURE ALGORITHMS (10 bytes) Tue Aug 9 07:59:15 2011 1312873155260048 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: CLIENT HELLO was sent [112 bytes] Tue Aug 9 07:59:15 2011 1312873155264012 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Inserted 112 bytes of Data Tue Aug 9 07:59:15 2011 1312873155264938 741568 515: RPCSECURE: thread 515 : HWRITE: enqueued 112. Total 112 bytes. Tue Aug 9 07:59:15 2011 1312873155266854 741568 515: RPCSECURE: thread 515 : HWRITE FLUSH: 112 bytes in buffer. Tue Aug 9 07:59:15 2011 1312873155268680 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sending Packet[0] Handshake(22) with length: 112 Tue Aug 9 07:59:15 2011 1312873155270507 741568 515: RPCSECURE: thread 515 : WRITE: enqueued 117 bytes for a. Total 117 bytes. Tue Aug 9 07:59:15 2011 1312873155274579 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sent Packet[1] Handshake(22) with length: 117 Tue Aug 9 07:59:15 2011 1312873155276004 741568 515: RPCSECURE: thread 515 : HWRITE: wrote 112 bytes, 0 bytes left. Tue Aug 9 07:59:15 2011 1312873155277898 741568 515: RPCSECURE: thread 515 : WRITE FLUSH: 117 bytes in buffer. Tue Aug 9 07:59:15 2011 1312873155279760 741568 515: RPCSECURE: thread 515 : WRITE: wrote 117 bytes, 0 bytes left. Tue Aug 9 07:59:15 2011 1312873155284256 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155286307 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155287718 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155389887 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155394021 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155395864 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155497885 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155499805 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155502732 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155606266 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155608183 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155609554 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155712697 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155715789 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155717743 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155820001 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155825962 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155827871 741568 515: Delay 0 100000000 Tue Aug 9 07:59:15 2011 1312873155929976 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:15 2011 1312873155934240 741568 515: Micro 100000 Tue Aug 9 07:59:15 2011 1312873155936249 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156037892 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156039417 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156042523 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156145777 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156147744 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156149792 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156254657 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156256080 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156257893 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156359905 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156362913 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156367130 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156469389 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156470470 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156474194 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156576338 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156577772 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156579677 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156684289 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156686283 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156688149 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156790510 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156794190 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156796029 741568 515: Delay 0 100000000 Tue Aug 9 07:59:16 2011 1312873156897924 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:16 2011 1312873156899976 741568 515: Micro 100000 Tue Aug 9 07:59:16 2011 1312873156904018 741568 515: Delay 0 100000000 Tue Aug 9 07:59:17 2011 1312873157185262 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:17 2011 1312873157186853 741568 515: Micro 100000 Tue Aug 9 07:59:17 2011 1312873157188393 741568 515: Delay 0 100000000 Tue Aug 9 07:59:17 2011 1312873157292584 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:17 2011 1312873157295640 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158089079 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158192574 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158195814 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158197810 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158300309 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158304670 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158306024 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158408372 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158410273 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158414601 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158516796 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158518718 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158520570 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158624790 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158626253 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158628079 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158730263 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158734163 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158736017 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158837810 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158839719 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158844027 741568 515: Delay 0 100000000 Tue Aug 9 07:59:18 2011 1312873158946215 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:18 2011 1312873158948138 741568 515: Micro 100000 Tue Aug 9 07:59:18 2011 1312873158949522 741568 515: Delay 0 100000000 Tue Aug 9 07:59:19 2011 1312873159054739 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:19 2011 1312873159056659 741568 515: Micro 100000 Tue Aug 9 07:59:19 2011 1312873159058482 741568 515: Delay 0 100000000 Tue Aug 9 07:59:19 2011 1312873159160924 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:19 2011 1312873159165461 741568 515: Micro 100000 Tue Aug 9 07:59:19 2011 1312873159167312 741568 515: Delay 0 100000000 Tue Aug 9 07:59:19 2011 1312873159269370 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:19 2011 1312873159272402 741568 515: Micro 100000 Tue Aug 9 07:59:19 2011 1312873159274830 741568 515: Delay 0 100000000 Tue Aug 9 07:59:19 2011 1312873159376780 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160094138 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160096019 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160198029 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160200078 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160204228 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160306239 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160308190 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160309614 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160455779 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160457290 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160459175 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160562569 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160565116 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160566976 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160669310 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160672410 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160676799 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160778405 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160780321 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160784632 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160886804 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160888726 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160890573 741568 515: Delay 0 100000000 Tue Aug 9 07:59:20 2011 1312873160995219 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:20 2011 1312873160996694 741568 515: Micro 100000 Tue Aug 9 07:59:20 2011 1312873160998563 741568 515: Delay 0 100000000 Tue Aug 9 07:59:21 2011 1312873161100845 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:21 2011 1312873161105325 741568 515: Micro 100000 Tue Aug 9 07:59:21 2011 1312873161106728 741568 515: Delay 0 100000000 Tue Aug 9 07:59:21 2011 1312873161208868 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:21 2011 1312873161210795 741568 515: Micro 100000 Tue Aug 9 07:59:21 2011 1312873161215259 741568 515: Delay 0 100000000 Tue Aug 9 07:59:21 2011 1312873161317235 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:21 2011 1312873161318728 741568 515: Micro 100000 Tue Aug 9 07:59:21 2011 1312873161320581 741568 515: Delay 0 100000000 Tue Aug 9 07:59:21 2011 1312873161425261 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:21 2011 1312873161427222 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162021469 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162125232 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162127156 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162129012 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162232502 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162234981 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162236374 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162338819 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162340278 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162344166 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162446286 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162448198 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162450019 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162554234 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162556200 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162557586 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162659794 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162662402 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162664842 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162767346 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162769361 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162772415 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162875302 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162877260 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162879156 741568 515: Delay 0 100000000 Tue Aug 9 07:59:22 2011 1312873162982501 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:22 2011 1312873162984979 741568 515: Micro 100000 Tue Aug 9 07:59:22 2011 1312873162986385 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163088387 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163089343 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163092406 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163195182 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163197173 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163199046 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163302575 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163305258 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163306686 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163409301 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163412414 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163415337 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163517912 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163519843 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163524055 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163706349 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163708249 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163709620 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163814795 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163816269 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163875889 741568 515: Delay 0 100000000 Tue Aug 9 07:59:23 2011 1312873163978827 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:23 2011 1312873163980733 741568 515: Micro 100000 Tue Aug 9 07:59:23 2011 1312873163984650 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164086268 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164087716 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164089543 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164192677 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164195621 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164197441 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164299973 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164304000 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164305902 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164408256 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164410202 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164414085 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164516349 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164518261 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164520106 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164624293 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164626242 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164628136 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164729924 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164734502 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164736007 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164838488 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164839025 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164839998 741568 515: Delay 0 100000000 Tue Aug 9 07:59:24 2011 1312873164944730 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:24 2011 1312873164946754 741568 515: Micro 100000 Tue Aug 9 07:59:24 2011 1312873164948628 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165052606 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165055392 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165057504 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165160175 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165177685 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165180023 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165284736 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165286209 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165287811 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165389457 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165392432 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165395349 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165497922 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165499832 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165503990 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165605853 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165607760 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165608674 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165710897 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165714872 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165716741 741568 515: Delay 0 100000000 Tue Aug 9 07:59:25 2011 1312873165818425 741568 515: RPCSECURE: thread 515 : READ: Got 5 bytes from a Tue Aug 9 07:59:25 2011 1312873165822304 741568 515: RPCSECURE: thread 515 : READ: read 5 bytes from a Tue Aug 9 07:59:25 2011 1312873165825980 741568 515: RPCSECURE: thread 515 : RB: Have 0 bytes into buffer. Adding 5 bytes. Tue Aug 9 07:59:25 2011 1312873165827121 741568 515: RPCSECURE: thread 515 : RB: Requested 5 bytes Tue Aug 9 07:59:25 2011 1312873165827785 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Expected Packet[0] Handshake(22) with length: 1 Tue Aug 9 07:59:25 2011 1312873165828429 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Received Packet[0] Handshake(22) with length: 81 Tue Aug 9 07:59:25 2011 1312873165830526 741568 515: RPCSECURE: thread 515 : READ: Got 81 bytes from a Tue Aug 9 07:59:25 2011 1312873165834030 741568 515: RPCSECURE: thread 515 : READ: read 81 bytes from a Tue Aug 9 07:59:25 2011 1312873165835035 741568 515: RPCSECURE: thread 515 : RB: Have 5 bytes into buffer. Adding 81 bytes. Tue Aug 9 07:59:25 2011 1312873165835967 741568 515: RPCSECURE: thread 515 : RB: Requested 86 bytes Tue Aug 9 07:59:25 2011 1312873165836994 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Decrypted Packet[0] Handshake(22) with length: 81 Tue Aug 9 07:59:25 2011 1312873165838532 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Inserted 81 bytes of Data(22) Tue Aug 9 07:59:25 2011 1312873165839451 741568 515: RPCSECURE: thread 515 : BUF[REC][HD]: Read 1 bytes of Data(22) Tue Aug 9 07:59:25 2011 1312873165839995 741568 515: RPCSECURE: thread 515 : BUF[REC][HD]: Read 3 bytes of Data(22) Tue Aug 9 07:59:25 2011 1312873165840489 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: SERVER HELLO was received [81 bytes] Tue Aug 9 07:59:25 2011 1312873165840979 741568 515: RPCSECURE: thread 515 : BUF[REC][HD]: Read 77 bytes of Data(22) Tue Aug 9 07:59:25 2011 1312873165841421 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Inserted 4 bytes of Data Tue Aug 9 07:59:25 2011 1312873165845142 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Inserted 77 bytes of Data Tue Aug 9 07:59:25 2011 1312873165846148 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Server's version: 3.3 Tue Aug 9 07:59:25 2011 1312873165847179 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: SessionID length: 32 Tue Aug 9 07:59:25 2011 1312873165847758 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: SessionID: e246f236228600ff61cf789f5e461bfdbef569dece98f7d6a2a769400d0d6339 Tue Aug 9 07:59:25 2011 1312873165848554 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Selected cipher suite: RSA_AES_128_CBC_SHA1 Tue Aug 9 07:59:25 2011 1312873165849670 741568 515: RPCSECURE: thread 515 : EXT[2021e0d8]: Parsing extension 'SAFE RENEGOTIATION/65281' (1 bytes) Tue Aug 9 07:59:25 2011 1312873165850313 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Safe renegotiation succeeded Tue Aug 9 07:59:25 2011 1312873165854360 741568 515: RPCSECURE: thread 515 : HWRITE FLUSH: 0 bytes in buffer. Tue Aug 9 07:59:25 2011 1312873165854821 741568 515: RPCSECURE: thread 515 : WRITE FLUSH: 0 bytes in buffer. Tue Aug 9 07:59:25 2011 1312873165855275 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_buffers.c:729 Tue Aug 9 07:59:25 2011 1312873165855722 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sent ChangeCipherSpec Tue Aug 9 07:59:25 2011 1312873165856193 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sending Packet[1] Change Cipher Spec(20) with length: 1 Tue Aug 9 07:59:25 2011 1312873165856652 741568 515: RPCSECURE: thread 515 : WRITE: enqueued 6 bytes for a. Total 6 bytes. Tue Aug 9 07:59:25 2011 1312873165857128 741568 515: RPCSECURE: thread 515 : WRITE FLUSH: 6 bytes in buffer. Tue Aug 9 07:59:25 2011 1312873165859869 741568 515: RPCSECURE: thread 515 : WRITE: wrote 6 bytes, 0 bytes left. Tue Aug 9 07:59:25 2011 1312873165860467 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sent Packet[2] Change Cipher Spec(20) with length: 6 Tue Aug 9 07:59:25 2011 1312873165861043 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Initializing epoch #1 Tue Aug 9 07:59:25 2011 1312873165862645 741568 515: RPCSECURE: thread 515 : INT: KEY BLOCK[104]: 12eeab869621d7070d3faf1aa7bf37a03a1ae1956e6261def4330b1e008e6ea0 Tue Aug 9 07:59:25 2011 1312873165863132 741568 515: RPCSECURE: thread 515 : INT: CLIENT WRITE KEY [16]: bb2a713e057e1063c4f60ccc393170d6 Tue Aug 9 07:59:25 2011 1312873165863585 741568 515: RPCSECURE: thread 515 : INT: SERVER WRITE KEY [16]: 5564cc511ef61e529546976885379edf Tue Aug 9 07:59:25 2011 1312873165870147 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Epoch #1 ready Tue Aug 9 07:59:25 2011 1312873165881123 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Cipher Suite: RSA_AES_128_CBC_SHA1 Tue Aug 9 07:59:25 2011 1312873165888442 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Initializing internal [write] cipher sessions Tue Aug 9 07:59:25 2011 1312873165894952 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Start of epoch cleanup Tue Aug 9 07:59:25 2011 1312873165896903 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: End of epoch cleanup Tue Aug 9 07:59:25 2011 1312873165898743 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Peeked 193 bytes of Data Tue Aug 9 07:59:25 2011 1312873165900153 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Emptied buffer Tue Aug 9 07:59:25 2011 1312873165904244 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: FINISHED was sent [16 bytes] Tue Aug 9 07:59:25 2011 1312873165906126 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Peeked 0 bytes of Data Tue Aug 9 07:59:25 2011 1312873165907959 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Emptied buffer Tue Aug 9 07:59:25 2011 1312873165909877 741568 515: RPCSECURE: thread 515 : HWRITE: enqueued 16. Total 16 bytes. Tue Aug 9 07:59:25 2011 1312873165912415 741568 515: RPCSECURE: thread 515 : HWRITE FLUSH: 16 bytes in buffer. Tue Aug 9 07:59:25 2011 1312873165914807 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sending Packet[0] Handshake(22) with length: 16 Tue Aug 9 07:59:25 2011 1312873165916931 741568 515: RPCSECURE: thread 515 : WRITE: enqueued 101 bytes for a. Total 101 bytes. Tue Aug 9 07:59:25 2011 1312873165918795 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Sent Packet[1] Handshake(22) with length: 101 Tue Aug 9 07:59:25 2011 1312873165920622 741568 515: RPCSECURE: thread 515 : HWRITE: wrote 16 bytes, 0 bytes left. Tue Aug 9 07:59:25 2011 1312873165924604 741568 515: RPCSECURE: thread 515 : WRITE FLUSH: 101 bytes in buffer. Tue Aug 9 07:59:25 2011 1312873165926520 741568 515: RPCSECURE: thread 515 : WRITE: wrote 101 bytes, 0 bytes left. Tue Aug 9 07:59:25 2011 1312873165928361 741568 515: RPCSECURE: thread 515 : ASSERT: ext_session_ticket.c:711 Tue Aug 9 07:59:25 2011 1312873165930223 741568 515: RPCSECURE: thread 515 : READ: Got 5 bytes from a Tue Aug 9 07:59:25 2011 1312873165932647 741568 515: RPCSECURE: thread 515 : READ: read 5 bytes from a Tue Aug 9 07:59:25 2011 1312873165935520 741568 515: RPCSECURE: thread 515 : RB: Have 0 bytes into buffer. Adding 5 bytes. Tue Aug 9 07:59:25 2011 1312873165936929 741568 515: RPCSECURE: thread 515 : RB: Requested 5 bytes Tue Aug 9 07:59:25 2011 1312873165938860 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Expected Packet[1] Change Cipher Spec(20) with length: 1 Tue Aug 9 07:59:25 2011 1312873165940778 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Received Packet[1] Change Cipher Spec(20) with length: 1 Tue Aug 9 07:59:25 2011 1312873165944365 741568 515: RPCSECURE: thread 515 : READ: Got 1 bytes from a Tue Aug 9 07:59:25 2011 1312873165945967 741568 515: RPCSECURE: thread 515 : READ: read 1 bytes from a Tue Aug 9 07:59:25 2011 1312873165947899 741568 515: RPCSECURE: thread 515 : RB: Have 5 bytes into buffer. Adding 1 bytes. Tue Aug 9 07:59:25 2011 1312873165949772 741568 515: RPCSECURE: thread 515 : RB: Requested 6 bytes Tue Aug 9 07:59:25 2011 1312873165954104 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: ChangeCipherSpec Packet was received Tue Aug 9 07:59:25 2011 1312873165955589 741568 515: RPCSECURE: thread 515 : HSK[2021e0d8]: Cipher Suite: (NULL) Tue Aug 9 07:59:25 2011 1312873165956988 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Start of epoch cleanup Tue Aug 9 07:59:25 2011 1312873165958400 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Epoch #0 freed Tue Aug 9 07:59:25 2011 1312873165960251 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: End of epoch cleanup Tue Aug 9 07:59:25 2011 1312873165964266 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:25 2011 1312873165966229 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:754 Tue Aug 9 07:59:25 2011 1312873165968121 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:2961 Tue Aug 9 07:59:25 2011 1312873165970019 741568 515: Micro 100000 Tue Aug 9 07:59:25 2011 1312873165974028 741568 515: Delay 0 100000000 Tue Aug 9 07:59:26 2011 1312873166075322 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:26 2011 1312873166077382 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:754 Tue Aug 9 07:59:26 2011 1312873166078770 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:2961 Tue Aug 9 07:59:26 2011 1312873166080639 741568 515: Micro 100000 Tue Aug 9 07:59:26 2011 1312873166084983 741568 515: Delay 0 100000000 Tue Aug 9 07:59:26 2011 1312873166186780 741568 515: RPCSECURE: thread 515 : READ: -1 returned from a, errno=0 gerrno=0 Tue Aug 9 07:59:26 2011 1312873166188226 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:754 Tue Aug 9 07:59:26 2011 1312873166190054 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:2961 Tue Aug 9 07:59:26 2011 1312873166193992 741568 515: Micro 100000 Tue Aug 9 07:59:26 2011 1312873166196441 741568 515: Delay 0 100000000 Tue Aug 9 07:59:26 2011 1312873166298301 741568 515: RPCSECURE: thread 515 : READ: Got 5 bytes from a Tue Aug 9 07:59:26 2011 1312873166299744 741568 515: RPCSECURE: thread 515 : READ: read 5 bytes from a Tue Aug 9 07:59:26 2011 1312873166304016 741568 515: RPCSECURE: thread 515 : RB: Have 0 bytes into buffer. Adding 5 bytes. Tue Aug 9 07:59:26 2011 1312873166305848 741568 515: RPCSECURE: thread 515 : RB: Requested 5 bytes Tue Aug 9 07:59:26 2011 1312873166307703 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_record.c:669 Tue Aug 9 07:59:26 2011 1312873166309528 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: INVALID VERSION PACKET: (20) 255.255 Tue Aug 9 07:59:26 2011 1312873166312431 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_record.c:1004 Tue Aug 9 07:59:26 2011 1312873166314979 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:754 Tue Aug 9 07:59:26 2011 1312873166316811 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:2961 Tue Aug 9 07:59:26 2011 1312873166318666 741568 515: RPCSECURE: thread 515 : ASSERT: gnutls_handshake.c:3139 Tue Aug 9 07:59:26 2011 1312873166320519 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Cleared Data from buffer Tue Aug 9 07:59:26 2011 1312873166324140 741568 515: RPCSECURE::Init checkpoint 11 Tue Aug 9 07:59:26 2011 1312873166325510 741568 515: Deleting Connection/Client Tue Aug 9 07:59:26 2011 1312873166327335 741568 515: RPCSECURE::~RPCSECURE thread 515 Tue Aug 9 07:59:26 2011 1312873166329190 741568 515: RPCSECURE: thread 515 : BUF[HSK]: Cleared Data from buffer Tue Aug 9 07:59:26 2011 1312873166346009 741568 515: RPCSECURE: thread 515 : REC[2021e0d8]: Epoch #1 freed Tue Aug 9 07:59:26 2011 1312873166347931 741568 515: Socket closed a Tue Aug 9 07:59:26 2011 1312873166349762 741568 515: Deleting RpcObject