https://blogs.gentoo.org/ago/2020/07/04/gentoo-tinderbox/ Issue: dev-perl/Event-RPC-1.100.0-r1 fails tests (hang). Discovered on: amd64 (internal ref: tinderbox) NOTE: I had to kill the process.
Created attachment 689481 [details] build.log build log and emerge --info
It doesnt hang here. It fails though, and badly. huettel@pinacolada /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10 $ prove -vl t/01.use.t ............................... 1..2 ok 1 - use Event::RPC::Server; ok 2 - use Event::RPC::Client; ok t/02.cnct.t .............................. 1..5 ok 1 - use Event::RPC::Client; CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 4/5 subtests t/03.cnct-auth.t ......................... 1..6 ok 1 - use Event::RPC::Client; ok 2 - connection failed with wrong pw CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 4/6 subtests t/04.cnct-auth-ssl-verifypeer-noca.t ..... 1..4 ok 1 - use Event::RPC::Client; ok 2 - ssl connection failed due to unsigned server key ok 3 - killing server process at PID 3104370 ok 4 - server stopped ok t/04.cnct-auth-ssl-verifypeer-wrongca.t .. 1..5 ok 1 - use Event::RPC::Client; ok 2 - ssl connection failed with wrong ca CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 3/5 subtests t/04.cnct-auth-ssl-verifypeer.t .......... 1..6 ok 1 - use Event::RPC::Client; ok 2 - connection failed with wrong pw Can't open SSL connection to localhost:27858: IO::Socket::IP configuration failed at t/04.cnct-auth-ssl-verifypeer.t line 59. # Looks like your test exited with 111 just after 2. Dubious, test returned 111 (wstat 28416, 0x6f00) Failed 4/6 subtests t/04.cnct-auth-ssl.t ..................... 1..6 ok 1 - use Event::RPC::Client; ok 2 - connection failed with wrong pw Can't open SSL connection to localhost:27860: IO::Socket::IP configuration failed at t/04.cnct-auth-ssl.t line 58. # Looks like your test exited with 111 just after 2. Dubious, test returned 111 (wstat 28416, 0x6f00) Failed 4/6 subtests t/05.func.t .............................. 1..18 ok 1 - use Event::RPC::Client; CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 17/18 subtests t/06.object2.t ........................... 1..10 ok 1 - use Event::RPC::Client; CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 9/10 subtests t/07.maxpacket.t ......................... 1..9 ok 1 - use Event::RPC::Client; CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 8/9 subtests t/08.msg_formats.t ....................... 1..56 ok 1 - use Event::RPC::Client; ok 2 - Started server at 3104396 with format 'SERL' CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 54/56 subtests Test Summary Report ------------------- t/02.cnct.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 1. t/03.cnct-auth.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 6 tests but ran 2. t/04.cnct-auth-ssl-verifypeer-wrongca.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 2. t/04.cnct-auth-ssl-verifypeer.t (Wstat: 28416 Tests: 2 Failed: 0) Non-zero exit status: 111 Parse errors: Bad plan. You planned 6 tests but ran 2. t/04.cnct-auth-ssl.t (Wstat: 28416 Tests: 2 Failed: 0) Non-zero exit status: 111 Parse errors: Bad plan. You planned 6 tests but ran 2. t/05.func.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 18 tests but ran 1. t/06.object2.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 10 tests but ran 1. t/07.maxpacket.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 9 tests but ran 1. t/08.msg_formats.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 56 tests but ran 2. Files=11, Tests=20, 4 wallclock secs ( 0.05 usr 0.02 sys + 0.90 cusr 0.17 csys = 1.14 CPU) Result: FAIL huettel@pinacolada /tmp/portage/dev-perl/Event-RPC-1.100.0-r1/work/Event-RPC-1.10 $
This is not portage-specific. Something is wrong with package or dependencies. huettel@pinacolada ~/tmp/Event-RPC-1.10 $ perl Makefile.PL Checking if your kit is complete... Warning: the following files are missing in your kit: t/ssl/server.csr Please inform the author. Generating a Unix-style Makefile Writing Makefile for Event::RPC Writing MYMETA.yml and MYMETA.json huettel@pinacolada ~/tmp/Event-RPC-1.10 $ make cp lib/Event/RPC/Message/Negotiate.pm blib/lib/Event/RPC/Message/Negotiate.pm cp lib/Event/RPC/AuthPasswdHash.pm blib/lib/Event/RPC/AuthPasswdHash.pm cp lib/Event/RPC/Message/CBOR.pm blib/lib/Event/RPC/Message/CBOR.pm cp lib/Event/RPC.pm blib/lib/Event/RPC.pm cp lib/Event/RPC/Message.pm blib/lib/Event/RPC/Message.pm cp lib/Event/RPC/LogConnection.pm blib/lib/Event/RPC/LogConnection.pm cp lib/Event/RPC/Loop.pm blib/lib/Event/RPC/Loop.pm cp lib/Event/RPC/Connection.pm blib/lib/Event/RPC/Connection.pm cp lib/Event/RPC/Message/SerialiserBase.pm blib/lib/Event/RPC/Message/SerialiserBase.pm cp lib/Event/RPC/Logger.pm blib/lib/Event/RPC/Logger.pm cp lib/Event/RPC/Client.pm blib/lib/Event/RPC/Client.pm cp lib/Event/RPC/Loop/Glib.pm blib/lib/Event/RPC/Loop/Glib.pm cp lib/Event/RPC/Message/JSON.pm blib/lib/Event/RPC/Message/JSON.pm cp lib/Event/RPC/Loop/Event.pm blib/lib/Event/RPC/Loop/Event.pm cp lib/Event/RPC/Server.pm blib/lib/Event/RPC/Server.pm cp lib/Event/RPC/Loop/AnyEvent.pm blib/lib/Event/RPC/Loop/AnyEvent.pm cp lib/Event/RPC/Message/Storable.pm blib/lib/Event/RPC/Message/Storable.pm cp lib/Event/RPC/Message/Sereal.pm blib/lib/Event/RPC/Message/Sereal.pm Manifying 17 pod documents huettel@pinacolada ~/tmp/Event-RPC-1.10 $ make test PERL_DL_NONLAZY=1 "/usr/bin/perl" "-MExtUtils::Command::MM" "-MTest::Harness" "-e" "undef *Test::Harness::Switches; test_harness(0, 'blib/lib', 'blib/arch')" t/*.t t/01.use.t ............................... ok t/02.cnct.t .............................. 1/5 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. t/02.cnct.t .............................. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 4/5 subtests t/03.cnct-auth.t ......................... 1/6 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. t/03.cnct-auth.t ......................... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 4/6 subtests t/04.cnct-auth-ssl-verifypeer-noca.t ..... ok t/04.cnct-auth-ssl-verifypeer-wrongca.t .. 1/5 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. t/04.cnct-auth-ssl-verifypeer-wrongca.t .. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 3/5 subtests t/04.cnct-auth-ssl-verifypeer.t .......... 2/6 Can't open SSL connection to localhost:27818: IO::Socket::IP configuration failed at t/04.cnct-auth-ssl-verifypeer.t line 59. # Looks like your test exited with 111 just after 2. t/04.cnct-auth-ssl-verifypeer.t .......... Dubious, test returned 111 (wstat 28416, 0x6f00) Failed 4/6 subtests t/04.cnct-auth-ssl.t ..................... 1/6 Can't open SSL connection to localhost:27820: IO::Socket::IP configuration failed at t/04.cnct-auth-ssl.t line 58. # Looks like your test exited with 111 just after 2. t/04.cnct-auth-ssl.t ..................... Dubious, test returned 111 (wstat 28416, 0x6f00) Failed 4/6 subtests t/05.func.t .............................. 1/18 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. t/05.func.t .............................. Dubious, test returned 255 (wstat 65280, 0xff00) Failed 17/18 subtests t/06.object2.t ........................... 1/10 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. t/06.object2.t ........................... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 9/10 subtests t/07.maxpacket.t ......................... 1/9 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 1. t/07.maxpacket.t ......................... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 8/9 subtests t/08.msg_formats.t ....................... 1/70 CATCHED Unhandled error in client/server communication: Sereal: Error: Bad Sereal header: Not a valid Sereal document. at offset 1 of input at srl_decoder.c line 600 at /home/huettel/tmp/Event-RPC-1.10/blib/lib/Event/RPC/Message/Sereal.pm line 24. # Looks like your test exited with 255 just after 2. t/08.msg_formats.t ....................... Dubious, test returned 255 (wstat 65280, 0xff00) Failed 68/70 subtests Test Summary Report ------------------- t/02.cnct.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 1. t/03.cnct-auth.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 6 tests but ran 2. t/04.cnct-auth-ssl-verifypeer-wrongca.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 5 tests but ran 2. t/04.cnct-auth-ssl-verifypeer.t (Wstat: 28416 Tests: 2 Failed: 0) Non-zero exit status: 111 Parse errors: Bad plan. You planned 6 tests but ran 2. t/04.cnct-auth-ssl.t (Wstat: 28416 Tests: 2 Failed: 0) Non-zero exit status: 111 Parse errors: Bad plan. You planned 6 tests but ran 2. t/05.func.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 18 tests but ran 1. t/06.object2.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 10 tests but ran 1. t/07.maxpacket.t (Wstat: 65280 Tests: 1 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 9 tests but ran 1. t/08.msg_formats.t (Wstat: 65280 Tests: 2 Failed: 0) Non-zero exit status: 255 Parse errors: Bad plan. You planned 70 tests but ran 2. Files=11, Tests=20, 3 wallclock secs ( 0.06 usr 0.02 sys + 0.91 cusr 0.21 csys = 1.20 CPU) Result: FAIL Failed 9/11 test programs. 0/20 subtests failed. make: *** [Makefile:899: test_dynamic] Fehler 255 huettel@pinacolada ~/tmp/Event-RPC-1.10 $
This appears to be fixed.
