Package: src:golang-github-pion-sctp Version: 1.8.2-3 Severity: important Tags: ftbfs
Dear maintainer: During a rebuild of all packages in bookworm, your package failed to build: -------------------------------------------------------------------------------- [...] debian/rules binary-indep dh binary-indep --builddirectory=_build --buildsystem=golang --with=golang dh_update_autotools_config -i -O--builddirectory=_build -O--buildsystem=golang dh_autoreconf -i -O--builddirectory=_build -O--buildsystem=golang dh_auto_configure -i -O--builddirectory=_build -O--buildsystem=golang dh_auto_build -i -O--builddirectory=_build -O--buildsystem=golang cd _build && go install -trimpath -v -p 1 github.com/pion/sctp github.com/pion/sctp/examples/ping-pong internal/goarch internal/unsafeheader internal/abi internal/cpu internal/bytealg internal/goexperiment internal/goos runtime/internal/atomic runtime/internal/math runtime/internal/sys runtime/internal/syscall runtime internal/reflectlite errors internal/race sync/atomic sync io unicode unicode/utf8 bytes internal/itoa internal/oserror syscall time context hash math/bits math strconv crypto crypto/internal/subtle crypto/subtle reflect encoding/binary crypto/cipher crypto/internal/boring/sig crypto/internal/boring crypto/internal/randutil internal/syscall/unix sort internal/fmtsort internal/poll internal/safefilepath internal/syscall/execenv internal/testlog path io/fs os fmt math/rand strings math/big crypto/rand encoding/hex log github.com/pion/logging github.com/pion/randutil hash/crc32 vendor/golang.org/x/net/dns/dnsmessage internal/godebug internal/nettrace internal/singleflight internal/intern net/netip runtime/cgo net github.com/pion/sctp github.com/pion/sctp/examples/ping-pong dh_auto_test -i -O--builddirectory=_build -O--buildsystem=golang cd _build && go test -vet=off -v -p 1 github.com/pion/sctp github.com/pion/sctp/examples/ping-pong === RUN TestAckTimer === RUN TestAckTimer/start_and_close ack_timer_test.go:26: ack timed out ack_timer_test.go:26: ack timed out === RUN TestAckTimer/start_and_stop --- PASS: TestAckTimer (1.15s) --- PASS: TestAckTimer/start_and_close (0.90s) --- PASS: TestAckTimer/start_and_stop (0.25s) === RUN TestAssocStressDuplex --- PASS: TestAssocStressDuplex (0.62s) === RUN TestAssocReliable === RUN TestAssocReliable/Simple === RUN TestAssocReliable/ordered_reordered === RUN TestAssocReliable/ordered_fragmented_then_defragmented === RUN TestAssocReliable/unordered_fragmented_then_defragmented === RUN TestAssocReliable/unordered_reordered === RUN TestAssocReliable/retransmission === RUN TestAssocReliable/short_buffer --- PASS: TestAssocReliable (1.22s) --- PASS: TestAssocReliable/Simple (0.15s) --- PASS: TestAssocReliable/ordered_reordered (0.13s) --- PASS: TestAssocReliable/ordered_fragmented_then_defragmented (0.16s) --- PASS: TestAssocReliable/unordered_fragmented_then_defragmented (0.16s) --- PASS: TestAssocReliable/unordered_reordered (0.16s) --- PASS: TestAssocReliable/retransmission (0.32s) --- PASS: TestAssocReliable/short_buffer (0.15s) === RUN TestAssocUnreliable === RUN TestAssocUnreliable/Rexmit_ordered_no_fragment === RUN TestAssocUnreliable/Rexmit_ordered_fragments === RUN TestAssocUnreliable/Rexmit_unordered_no_fragment === RUN TestAssocUnreliable/Rexmit_unordered_fragments === RUN TestAssocUnreliable/Timed_ordered === RUN TestAssocUnreliable/Timed_unordered --- PASS: TestAssocUnreliable (1.02s) --- PASS: TestAssocUnreliable/Rexmit_ordered_no_fragment (0.17s) --- PASS: TestAssocUnreliable/Rexmit_ordered_fragments (0.18s) --- PASS: TestAssocUnreliable/Rexmit_unordered_no_fragment (0.17s) --- PASS: TestAssocUnreliable/Rexmit_unordered_fragments (0.17s) --- PASS: TestAssocUnreliable/Timed_ordered (0.17s) --- PASS: TestAssocUnreliable/Timed_unordered (0.17s) === RUN TestCreateForwardTSN === RUN TestCreateForwardTSN/forward_one_abandoned === RUN TestCreateForwardTSN/forward_two_abandoned_with_the_same_SI --- PASS: TestCreateForwardTSN (0.00s) --- PASS: TestCreateForwardTSN/forward_one_abandoned (0.00s) --- PASS: TestCreateForwardTSN/forward_two_abandoned_with_the_same_SI (0.00s) === RUN TestHandleForwardTSN === RUN TestHandleForwardTSN/forward_3_unreceived_chunks === RUN TestHandleForwardTSN/forward_1_for_1_missing === RUN TestHandleForwardTSN/forward_1_for_2_missing === RUN TestHandleForwardTSN/dup_forward_TSN_chunk_should_generate_sack --- PASS: TestHandleForwardTSN (0.00s) --- PASS: TestHandleForwardTSN/forward_3_unreceived_chunks (0.00s) --- PASS: TestHandleForwardTSN/forward_1_for_1_missing (0.00s) --- PASS: TestHandleForwardTSN/forward_1_for_2_missing (0.00s) --- PASS: TestHandleForwardTSN/dup_forward_TSN_chunk_should_generate_sack (0.00s) === RUN TestAssocT1InitTimer === RUN TestAssocT1InitTimer/Retransmission_success === RUN TestAssocT1InitTimer/Retransmission_failure sctp ERROR: 2023/02/09 23:43:05 [0xc00011ddc0] retransmission failure: T1-init sctp ERROR: 2023/02/09 23:43:05 [0xc00011dc00] retransmission failure: T1-init --- PASS: TestAssocT1InitTimer (0.69s) --- PASS: TestAssocT1InitTimer/Retransmission_success (0.04s) --- PASS: TestAssocT1InitTimer/Retransmission_failure (0.66s) === RUN TestAssocT1CookieTimer === RUN TestAssocT1CookieTimer/Retransmission_success === RUN TestAssocT1CookieTimer/Retransmission_failure sctp ERROR: 2023/02/09 23:43:05 [0xc0003c6380] retransmission failure: T1-cookie --- PASS: TestAssocT1CookieTimer (1.69s) --- PASS: TestAssocT1CookieTimer/Retransmission_success (0.03s) --- PASS: TestAssocT1CookieTimer/Retransmission_failure (1.66s) === RUN TestAssocCreateNewStream === RUN TestAssocCreateNewStream/acceptChSize --- PASS: TestAssocCreateNewStream (0.00s) --- PASS: TestAssocCreateNewStream/acceptChSize (0.00s) === RUN TestAssocT3RtxTimer === RUN TestAssocT3RtxTimer/Retransmission_success --- PASS: TestAssocT3RtxTimer (0.22s) --- PASS: TestAssocT3RtxTimer/Retransmission_success (0.22s) === RUN TestAssocCongestionControl === RUN TestAssocCongestionControl/Fast_retransmission association_test.go:1769: nDATAs : 5 association_test.go:1770: nSACKs : 5 association_test.go:1771: nAckTimeouts: 2 association_test.go:1772: nFastRetrans: 1 === RUN TestAssocCongestionControl/Congestion_Avoidance goroutine profile: total 10 2 @ 0x43ba36 0x44b7fc 0x5abddc 0x5bfe7e 0x46b8a1 # 0x5abddb github.com/pion/transport/test.(*bridgeConn).Read+0x11b /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/bridge.go:73 # 0x5bfe7d github.com/pion/sctp.(*Association).readLoop+0x15d /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/association.go:509 1 @ 0x430db6 0x465ce5 0x50c535 0x50c34d 0x5092ab 0x5afba5 0x46b8a1 # 0x465ce4 runtime/pprof.runtime_goroutineProfileWithLabels+0x24 /usr/lib/go-1.19/src/runtime/mprof.go:846 # 0x50c534 runtime/pprof.writeRuntimeProfile+0xb4 /usr/lib/go-1.19/src/runtime/pprof/pprof.go:723 # 0x50c34c runtime/pprof.writeGoroutine+0x4c /usr/lib/go-1.19/src/runtime/pprof/pprof.go:683 # 0x5092aa runtime/pprof.(*Profile).WriteTo+0x14a /usr/lib/go-1.19/src/runtime/pprof/pprof.go:330 # 0x5afba4 github.com/pion/transport/test.TimeOut.func1+0x44 /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/util.go:21 1 @ 0x43a15f 0x46cedb 0x47376e 0x473734 0x5ae328 0x5edbeb 0x4d5b4b 0x46b8a1 # 0x47376d sync.(*Mutex).Unlock+0x8d /usr/lib/go-1.19/src/sync/mutex.go:219 # 0x473733 sync.(*RWMutex).Unlock+0x53 /usr/lib/go-1.19/src/sync/rwmutex.go:216 # 0x5ae327 github.com/pion/transport/test.(*Bridge).Tick+0x2c7 /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/bridge.go:414 # 0x5edbea github.com/pion/sctp.TestAssocCongestionControl.func2+0x96a /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/association_test.go:1814 # 0x4d5b4a testing.tRunner+0x10a /usr/lib/go-1.19/src/testing/testing.go:1446 1 @ 0x43ba36 0x40815b 0x407c58 0x4d693a 0x4d888e 0x4d5b4b 0x4d8736 0x4d7219 0x617aea 0x43b672 0x46b8a1 # 0x4d6939 testing.(*T).Run+0x379 /usr/lib/go-1.19/src/testing/testing.go:1494 # 0x4d888d testing.runTests.func1+0x6d /usr/lib/go-1.19/src/testing/testing.go:1846 # 0x4d5b4a testing.tRunner+0x10a /usr/lib/go-1.19/src/testing/testing.go:1446 # 0x4d8735 testing.runTests+0x455 /usr/lib/go-1.19/src/testing/testing.go:1844 # 0x4d7218 testing.(*M).Run+0x5d8 /usr/lib/go-1.19/src/testing/testing.go:1726 # 0x617ae9 main.main+0x1a9 _testmain.go:193 # 0x43b671 runtime.main+0x211 /usr/lib/go-1.19/src/runtime/proc.go:250 1 @ 0x43ba36 0x40815b 0x407c58 0x4d693a 0x5ec5fe 0x4d5b4b 0x46b8a1 # 0x4d6939 testing.(*T).Run+0x379 /usr/lib/go-1.19/src/testing/testing.go:1494 # 0x5ec5fd github.com/pion/sctp.TestAssocCongestionControl+0x11d /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/association_test.go:1779 # 0x4d5b4a testing.tRunner+0x10a /usr/lib/go-1.19/src/testing/testing.go:1446 1 @ 0x43ba36 0x44b7fc 0x5bd3b4 0x46b8a1 # 0x5bd3b3 github.com/pion/sctp.(*ackTimer).start.func1+0x73 /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/ack_timer.go:56 1 @ 0x43ba36 0x44b7fc 0x5c08c6 0x46b8a1 # 0x5c08c5 github.com/pion/sctp.(*Association).writeLoop+0x205 /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/association.go:558 1 @ 0x43ba36 0x44b7fc 0x5db84b 0x46b8a1 # 0x5db84a github.com/pion/sctp.(*rtxTimer).start.func1+0xca /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/rtx_timer.go:151 1 @ 0x43ba36 0x468715 0x5acbcf 0x5abfd5 0x5c0a85 0x46b8a1 # 0x468714 time.Sleep+0x134 /usr/lib/go-1.19/src/runtime/time.go:195 # 0x5acbce github.com/pion/transport/test.(*Bridge).Push+0x8e /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/bridge.go:246 # 0x5abfd4 github.com/pion/transport/test.(*bridgeConn).Write+0xd4 /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/bridge.go:97 # 0x5c0a84 github.com/pion/sctp.(*Association).writeLoop+0x3c4 /<<PKGBUILDDIR>>/_build/src/github.com/pion/sctp/association.go:539 panic: timeout goroutine 789 [running]: github.com/pion/transport/test.TimeOut.func1() /<<PKGBUILDDIR>>/_build/src/github.com/pion/transport/test/util.go:24 +0xa5 created by time.goFunc /usr/lib/go-1.19/src/time/sleep.go:176 +0x32 FAIL github.com/pion/sctp 17.491s ? github.com/pion/sctp/examples/ping-pong [no test files] FAIL dh_auto_test: error: cd _build && go test -vet=off -v -p 1 github.com/pion/sctp github.com/pion/sctp/examples/ping-pong returned exit code 1 make: *** [debian/rules:4: binary-indep] Error 25 dpkg-buildpackage: error: debian/rules binary-indep subprocess returned exit status 2 -------------------------------------------------------------------------------- (The above is just how the build ends and not necessarily the most relevant part) Note: I've used the word "randomly" in the subject, but it's not purely random. After building several times on systems with 1 and 2 CPUs, I've noticed that the failure rate on systems with one CPU is a lot higher. Therefore, to reproduce, please try first setting GRUB_CMDLINE_LINUX="nr_cpus=1" in /etc/default/grub. If that does not work, then the general offer below still applies. --------------------------------------------------------------------- About the archive rebuild: The build was made using virtual machines from Hetzner, with enough memory, enough disk, and either one or two CPUs, using a reduced chroot with only build-essential packages (plus debhelper). If you could not reproduce the bug please contact me privately, as I am willing to provide ssh access to a virtual machine where the bug is fully reproducible. If this is really a bug in one of the build-depends, please use reassign and affects, so that this is still visible in the BTS web page for this package. Thanks.