On 9/18/15, 15:54 , "Matt Caswell" <m...@openssl.org> wrote:
>>You can look for yourself, $proxy should be assigned like this: >> >> my $proxy = TLSProxy::Proxy->new( >> \&extension_filter, >> cmdstr(app(["openssl"])), >> top_file("apps", "server.pem"), >> 1 # <========= This is what turns on the debugging output >> ); >> > >I encountered a problem with this the other day. Something in the >translation to the new test framework has borked debugging output. It >only seems to have affected stdout. > >I had to additionally add this after the above line: >open(STDOUT, ">&STDERR"); Yes! Adding this line got the debugging output. Log file is attached, and appended here (“About to run unpack()...” is my print/addition): testing... make[1]: Entering directory `/media/uri/Src/openssl/test' make[2]: Entering directory `/media/uri/Src/openssl' making all in apps... make[3]: Entering directory `/media/uri/Src/openssl/apps' make[3]: Nothing to be done for `all'. make[3]: Leaving directory `/media/uri/Src/openssl/apps' make[2]: Leaving directory `/media/uri/Src/openssl' TOP=.. PERL=/usr/bin/perl /usr/bin/perl run_tests.pl alltests ../test/recipes/00-check_testexes.t ....... ok ../test/recipes/05-test_bf.t .............. ok ../test/recipes/05-test_cast.t ............ ok ../test/recipes/05-test_des.t ............. ok ../test/recipes/05-test_hmac.t ............ ok ../test/recipes/05-test_idea.t ............ ok ../test/recipes/05-test_md2.t ............. ok ../test/recipes/05-test_md4.t ............. ok ../test/recipes/05-test_md5.t ............. ok ../test/recipes/05-test_mdc2.t ............ ok ../test/recipes/05-test_rand.t ............ ok ../test/recipes/05-test_rc2.t ............. ok ../test/recipes/05-test_rc4.t ............. ok ../test/recipes/05-test_rc5.t ............. ok ../test/recipes/05-test_rmd.t ............. ok ../test/recipes/05-test_sha1.t ............ ok ../test/recipes/05-test_sha256.t .......... ok ../test/recipes/05-test_sha512.t .......... ok ../test/recipes/05-test_wp.t .............. ok ../test/recipes/10-test_bn.t .............. ok ../test/recipes/10-test_exp.t ............. ok ../test/recipes/15-test_dh.t .............. ok ../test/recipes/15-test_dsa.t ............. ok ../test/recipes/15-test_ec.t .............. ok ../test/recipes/15-test_ecdh.t ............ ok ../test/recipes/15-test_ecdsa.t ........... ok ../test/recipes/15-test_rsa.t ............. ok ../test/recipes/20-test_enc.t ............. ok ../test/recipes/25-test_crl.t ............. ok ../test/recipes/25-test_gen.t ............. ok ../test/recipes/25-test_pkcs7.t ........... ok ../test/recipes/25-test_req.t ............. ok ../test/recipes/25-test_sid.t ............. ok ../test/recipes/25-test_verify.t .......... ok ../test/recipes/25-test_x509.t ............ ok ../test/recipes/30-test_engine.t .......... ok ../test/recipes/30-test_evp.t ............. ok ../test/recipes/30-test_evp_extra.t ....... ok ../test/recipes/30-test_pbelu.t ........... ok ../test/recipes/40-test_rehash.t .......... ok ../test/recipes/70-test_clienthello.t ..... ok ../test/recipes/70-test_packet.t .......... ok Proxy started on port 4453 Connection opened Received client packet Packet length = 374 Processing flight 0 Record 1 (client -> server) Content type: HANDSHAKE Version: TLS1.0 Length: 369 About to run unpack()... Message length: 365 Message type: ClientHello (1) Message Length: 365 Client Version:771 Session ID Len:0 Ciphersuite len:230 Compression Method Len:2 Extensions Len:93 Forwarded packet length = 281 Received server packet Packet length = 1113 Processing flight 1 Record 1 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 81 About to run unpack()... Message length: 77 Message type: ServerHello (2) Message Length: 77 Server Version:771 Session ID Len:32 Ciphersuite:47 Compression Method:1 Extensions Len:5 Record 2 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 1013 About to run unpack()... Message length: 1009 Message type: Certificate (11) Message Length: 1009 Record 3 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 4 About to run unpack()... Message length: 0 Message type: ServerHelloDone (14) Message Length: 0 Forwarded packet length = 1113 Received client packet Packet length = 342 Processing flight 2 Record 1 (client -> server) Content type: HANDSHAKE Version: TLS1.2 Length: 262 About to run unpack()... Message length: 258 Message type: ClientKeyExchange (16) Message Length: 258 Record 2 (client -> server) Content type: CCS Version: TLS1.2 Length: 1 Record 3 (client -> server) Content type: HANDSHAKE Version: TLS1.2 Length: 64 About to run unpack()... Message length: 10228321 Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Message type: (120) Message Length: 10228321 Forwarded packet length = 342 Received server packet Packet length = 75 Processing flight 3 Record 1 (server -> client) Content type: CCS Version: TLS1.2 Length: 1 Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslextension.t .... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 1/1 subtests Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslsessiontick.t .. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 5/5 subtests ../test/recipes/70-test_sslskewith0p.t .... ok Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslvertol.t ....... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 2/2 subtests ../test/recipes/70-test_verify_extra.t .... ok ../test/recipes/80-test_ca.t .............. ok # Looks like you planned 11 tests but ran 20. # Failed test 'CMS <=> CMS consistency tests, modified key parameters # ' # at ../test/recipes/80-test_cms.t line 460. # Looks like you failed 1 test of 4. ../test/recipes/80-test_cms.t ............. Dubious, test returned 1 (wstat 256, 0x100) Failed 1/4 subtests ../test/recipes/80-test_ocsp.t ............ ok ../test/recipes/80-test_ssl.t ............. ok ../test/recipes/80-test_tsa.t ............. ok ../test/recipes/90-test_constant_time.t ... ok ../test/recipes/90-test_gmdiff.t .......... ok ../test/recipes/90-test_gost2814789.t ..... ok ../test/recipes/90-test_heartbeat.t ....... ok ../test/recipes/90-test_ige.t ............. ok ../test/recipes/90-test_jpake.t ........... ok ../test/recipes/90-test_np.t .............. ok ../test/recipes/90-test_p5_crpt2.t ........ ok ../test/recipes/90-test_secmem.t .......... ok ../test/recipes/90-test_srp.t ............. ok ../test/recipes/90-test_v3name.t .......... ok Test Summary Report ------------------- ../test/recipes/70-test_sslextension.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 1 tests but ran 0. ../test/recipes/70-test_sslsessiontick.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 0. ../test/recipes/70-test_sslvertol.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 2 tests but ran 0. ../test/recipes/80-test_cms.t (Wstat: 256 Tests: 4 Failed: 1) Failed test: 4 Non-zero exit status: 1 Files=63, Tests=324, 26 wallclock secs ( 0.33 usr 0.03 sys + 18.44 cusr 8.46 csys = 27.26 CPU) Result: FAIL Failed 4/63 test programs. 1/324 subtests failed. make[1]: *** [tests] Error 255 make[1]: Leaving directory `/media/uri/Src/openssl/test' make: *** [tests] Error 2 Thanks!
testing... make[1]: Entering directory `/media/uri/Src/openssl/test' make[2]: Entering directory `/media/uri/Src/openssl' making all in apps... make[3]: Entering directory `/media/uri/Src/openssl/apps' make[3]: Nothing to be done for `all'. make[3]: Leaving directory `/media/uri/Src/openssl/apps' make[2]: Leaving directory `/media/uri/Src/openssl' TOP=.. PERL=/usr/bin/perl /usr/bin/perl run_tests.pl alltests ../test/recipes/00-check_testexes.t ....... ok ../test/recipes/05-test_bf.t .............. ok ../test/recipes/05-test_cast.t ............ ok ../test/recipes/05-test_des.t ............. ok ../test/recipes/05-test_hmac.t ............ ok ../test/recipes/05-test_idea.t ............ ok ../test/recipes/05-test_md2.t ............. ok ../test/recipes/05-test_md4.t ............. ok ../test/recipes/05-test_md5.t ............. ok ../test/recipes/05-test_mdc2.t ............ ok ../test/recipes/05-test_rand.t ............ ok ../test/recipes/05-test_rc2.t ............. ok ../test/recipes/05-test_rc4.t ............. ok ../test/recipes/05-test_rc5.t ............. ok ../test/recipes/05-test_rmd.t ............. ok ../test/recipes/05-test_sha1.t ............ ok ../test/recipes/05-test_sha256.t .......... ok ../test/recipes/05-test_sha512.t .......... ok ../test/recipes/05-test_wp.t .............. ok ../test/recipes/10-test_bn.t .............. ok ../test/recipes/10-test_exp.t ............. ok ../test/recipes/15-test_dh.t .............. ok ../test/recipes/15-test_dsa.t ............. ok ../test/recipes/15-test_ec.t .............. ok ../test/recipes/15-test_ecdh.t ............ ok ../test/recipes/15-test_ecdsa.t ........... ok ../test/recipes/15-test_rsa.t ............. ok ../test/recipes/20-test_enc.t ............. ok ../test/recipes/25-test_crl.t ............. ok ../test/recipes/25-test_gen.t ............. ok ../test/recipes/25-test_pkcs7.t ........... ok ../test/recipes/25-test_req.t ............. ok ../test/recipes/25-test_sid.t ............. ok ../test/recipes/25-test_verify.t .......... ok ../test/recipes/25-test_x509.t ............ ok ../test/recipes/30-test_engine.t .......... ok ../test/recipes/30-test_evp.t ............. ok ../test/recipes/30-test_evp_extra.t ....... ok ../test/recipes/30-test_pbelu.t ........... ok ../test/recipes/40-test_rehash.t .......... ok ../test/recipes/70-test_clienthello.t ..... ok ../test/recipes/70-test_packet.t .......... ok Proxy started on port 4453 Connection opened Received client packet Packet length = 374 Processing flight 0 Record 1 (client -> server) Content type: HANDSHAKE Version: TLS1.0 Length: 369 About to run unpack()... Message length: 365 Message type: ClientHello (1) Message Length: 365 Client Version:771 Session ID Len:0 Ciphersuite len:230 Compression Method Len:2 Extensions Len:93 Forwarded packet length = 281 Received server packet Packet length = 1113 Processing flight 1 Record 1 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 81 About to run unpack()... Message length: 77 Message type: ServerHello (2) Message Length: 77 Server Version:771 Session ID Len:32 Ciphersuite:47 Compression Method:1 Extensions Len:5 Record 2 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 1013 About to run unpack()... Message length: 1009 Message type: Certificate (11) Message Length: 1009 Record 3 (server -> client) Content type: HANDSHAKE Version: TLS1.2 Length: 4 About to run unpack()... Message length: 0 Message type: ServerHelloDone (14) Message Length: 0 Forwarded packet length = 1113 Received client packet Packet length = 342 Processing flight 2 Record 1 (client -> server) Content type: HANDSHAKE Version: TLS1.2 Length: 262 About to run unpack()... Message length: 258 Message type: ClientKeyExchange (16) Message Length: 258 Record 2 (client -> server) Content type: CCS Version: TLS1.2 Length: 1 Record 3 (client -> server) Content type: HANDSHAKE Version: TLS1.2 Length: 64 About to run unpack()... Message length: 10228321 Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Message type: (120) Message Length: 10228321 Forwarded packet length = 342 Received server packet Packet length = 75 Processing flight 3 Record 1 (server -> client) Content type: CCS Version: TLS1.2 Length: 1 Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslextension.t .... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 1/1 subtests Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslsessiontick.t .. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 5/5 subtests ../test/recipes/70-test_sslskewith0p.t .... ok Use of uninitialized value within %message_type in concatenation (.) or string at ../util/TLSProxy/Message.pm line 204, <> line 751. Changed peer, but we still have fragment data # Looks like your test exited with 255 before it could output anything. ../test/recipes/70-test_sslvertol.t ....... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 2/2 subtests ../test/recipes/70-test_verify_extra.t .... ok ../test/recipes/80-test_ca.t .............. ok # Looks like you planned 11 tests but ran 20. # Failed test 'CMS <=> CMS consistency tests, modified key parameters # ' # at ../test/recipes/80-test_cms.t line 460. # Looks like you failed 1 test of 4. ../test/recipes/80-test_cms.t ............. Dubious, test returned 1 (wstat 256, 0x100) Failed 1/4 subtests ../test/recipes/80-test_ocsp.t ............ ok ../test/recipes/80-test_ssl.t ............. ok ../test/recipes/80-test_tsa.t ............. ok ../test/recipes/90-test_constant_time.t ... ok ../test/recipes/90-test_gmdiff.t .......... ok ../test/recipes/90-test_gost2814789.t ..... ok ../test/recipes/90-test_heartbeat.t ....... ok ../test/recipes/90-test_ige.t ............. ok ../test/recipes/90-test_jpake.t ........... ok ../test/recipes/90-test_np.t .............. ok ../test/recipes/90-test_p5_crpt2.t ........ ok ../test/recipes/90-test_secmem.t .......... ok ../test/recipes/90-test_srp.t ............. ok ../test/recipes/90-test_v3name.t .......... ok Test Summary Report ------------------- ../test/recipes/70-test_sslextension.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 1 tests but ran 0. ../test/recipes/70-test_sslsessiontick.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 0. ../test/recipes/70-test_sslvertol.t (Wstat: 65280 Tests: 0 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 2 tests but ran 0. ../test/recipes/80-test_cms.t (Wstat: 256 Tests: 4 Failed: 1) Failed test: 4 Non-zero exit status: 1 Files=63, Tests=324, 26 wallclock secs ( 0.33 usr 0.03 sys + 18.44 cusr 8.46 csys = 27.26 CPU) Result: FAIL Failed 4/63 test programs. 1/324 subtests failed. make[1]: *** [tests] Error 255 make[1]: Leaving directory `/media/uri/Src/openssl/test' make: *** [tests] Error 2
smime.p7s
Description: S/MIME cryptographic signature
_______________________________________________ openssl-dev mailing list To unsubscribe: https://mta.openssl.org/mailman/listinfo/openssl-dev