[Pkg-utopia-maintainers] Bug#897607: dbus: Please raise timeout for a few test cases (or disable) in riscv64

Sat May 5 00:46:19 BST 2018

2018-05-04 0:49 GMT+02:00 Manuel A. Fernandez Montecelo
<manuel.montezelo at gmail.com>:
> 2018-05-03 19:09 GMT+02:00 Simon McVittie <smcv at debian.org>:
>
>> Please could you try the build on a representative
>> riscv64 emulator with the attached hack, and send
>> the resulting debian/build-main/test/test-monitor.log and
>> debian/build-main/test/test-relay.log to this bug? If it fails, increase
>> the numbers as desired (they're an arbitrary number of minutes per
>> test-case), but either way I'd like to see the logs so that I can tell
>> how much margin of error we get.
>
> Thanks for the quick feedback, I'll try overnight.

So the build failed in other tests now.

==============================================================
ERROR: test-dbus-daemon
=======================
...
[many lines like these]
dbus-daemon[4174]: [session uid=1000 pid=4174] The maximum number of
pending replies for ":1.0" (uid=1000 pid=4094
comm="/<<PKGBUILDDIR>>/debian/build-debug/") has been reached
(max_replies_per_connection=128)
../../../build-aux/tap-driver.sh: line 639:  4094 Aborted                 "$@"
# random seed: R02Sf9146ddabfc9fd50b71fb474add3ca89
1..31
# Resetting test timeout (reference: 0x2aaaacdcf0; factor: 1)
# ProcessID of this process is 4094
# UnixUserID of this process is 1000
# Time since timeout reset 0x2aaaacdcf0: 1.157 seconds
ok 1 /creds
PASS: test-dbus-daemon 1 /creds
# Resetting test timeout (reference: 0x2aaaacf1d0; factor: 1)
# GetConnectionUnixProcessID returned 4094
# Time since timeout reset 0x2aaaacf1d0: 1.239 seconds
ok 2 /processid
PASS: test-dbus-daemon 2 /processid
# Resetting test timeout (reference: 0x2aaaad5c50; factor: 1)
# Bug Reference: https://bugs.freedesktop.org/show_bug.cgi?id=61303
# max perf: 2000 messages / 15.252061 seconds
# Time since timeout reset 0x2aaaad5c50: 16.087 seconds
ok 3 /unix-runtime-is-default
PASS: test-dbus-daemon 3 /unix-runtime-is-default
# Start of echo tests
# Resetting test timeout (reference: 0x2aaaaf48e0; factor: 1)
# max perf: 2000 messages / 14.492696 seconds
# Time since timeout reset 0x2aaaaf48e0: 15.351 seconds
ok 4 /echo/session
PASS: test-dbus-daemon 4 /echo/session
# Resetting test timeout (reference: 0x2aaac19cb0; factor: 1)
# Bug Reference: https://bugs.freedesktop.org/show_bug.cgi?id=34393

Bail out! Test timed out (SIGALRM received)
ERROR: test-dbus-daemon - Bail out! Test timed out (SIGALRM received)
==============================================================

==============================================================
ERROR: test-header-fields
=========================

../../../build-aux/tap-driver.sh: line 639:  4249 Aborted                 "$@"
# random seed: R02S1ae01519f2b8fdb3e66f5e49563999ed
1..5
# Start of message tests
# Start of weird-header-field tests
# Resetting test timeout (reference: 0x2aaaacb070; factor: 1)
# Running "/message/weird-header-field/none" once to count mallocs
# "/message/weird-header-field/none" has about 604 mallocs in total
# testing "/message/weird-header-field/none" with up to 2 consecutive
malloc failures
# testing "/message/weird-header-field/none" with 2 consecutive malloc failures
# Time since timeout reset 0x2aaaacb070: 41.593 seconds
ok 1 /message/weird-header-field/none
PASS: test-header-fields 1 /message/weird-header-field/none
# Resetting test timeout (reference: 0x2aaaae5910; factor: 1)
# Running "/message/weird-header-field/append" once to count mallocs
# "/message/weird-header-field/append" has about 617 mallocs in total
# testing "/message/weird-header-field/append" with up to 2
consecutive malloc failures
# testing "/message/weird-header-field/append" with 2 consecutive
malloc failures
# Time since timeout reset 0x2aaaae5910: 47.164 seconds
ok 2 /message/weird-header-field/append
PASS: test-header-fields 2 /message/weird-header-field/append
# Resetting test timeout (reference: 0x2aaaacbf40; factor: 1)
# Running "/message/weird-header-field/change" once to count mallocs
# "/message/weird-header-field/change" has about 612 mallocs in total
# testing "/message/weird-header-field/change" with up to 2
consecutive malloc failures
# testing "/message/weird-header-field/change" with 2 consecutive
malloc failures

Bail out! Test timed out (SIGALRM received)
ERROR: test-header-fields - Bail out! Test timed out (SIGALRM received)
==============================================================

The log files of the previous ones that failed:

test-relay.log
=======================================================
# random seed: R02S48976acf87ad7a1d71e0cada0537b918
1..3
# Resetting test timeout (reference: 0x2aaaac5760; factor: 10)
# Time since timeout reset 0x2aaaac5760: 0.036 seconds
ok 1 /connect
PASS: test-relay 1 /connect
# Resetting test timeout (reference: 0x2aaaac8d40; factor: 10)
# Time since timeout reset 0x2aaaac8d40: 0.944 seconds
ok 2 /relay
PASS: test-relay 2 /relay
# Resetting test timeout (reference: 0x2aaaac77b0; factor: 10)
# Bug Reference: https://bugs.freedesktop.org/show_bug.cgi?id=34393
# Time since timeout reset 0x2aaaac77b0: 66.243 seconds
ok 3 /limit
PASS: test-relay 3 /limit
=======================================================

test-monitor.log
=======================================================
# random seed: R02Sfdc2070ded9282f722695e28c5925d66
1..17
# Start of monitor tests
# Resetting test timeout (reference: 0x2aaaad7a80; factor: 1)
# Time since timeout reset 0x2aaaad7a80: 1.697 seconds
ok 1 /monitor/invalid
PASS: test-monitor 1 /monitor/invalid
# Resetting test timeout (reference: 0x2aaaad8e00; factor: 1)
# Time since timeout reset 0x2aaaad8e00: 1.858 seconds
ok 2 /monitor/become
PASS: test-monitor 2 /monitor/become
# Resetting test timeout (reference: 0x2aaaae1f30; factor: 1)
# Time since timeout reset 0x2aaaae1f30: 1.956 seconds
ok 3 /monitor/broadcast
PASS: test-monitor 3 /monitor/broadcast
# Resetting test timeout (reference: 0x2aaaaec6c0; factor: 1)
# Time since timeout reset 0x2aaaaec6c0: 1.946 seconds
ok 4 /monitor/forbidden-broadcast
PASS: test-monitor 4 /monitor/forbidden-broadcast
# Resetting test timeout (reference: 0x2aaaaf0a90; factor: 1)
# Time since timeout reset 0x2aaaaf0a90: 4.621 seconds
ok 5 /monitor/unicast-signal
PASS: test-monitor 5 /monitor/unicast-signal
# Resetting test timeout (reference: 0x2aaaaf9a00; factor: 1)
# Time since timeout reset 0x2aaaaf9a00: 5.982 seconds
ok 6 /monitor/forbidden
PASS: test-monitor 6 /monitor/forbidden
# Resetting test timeout (reference: 0x2aaaaf0a90; factor: 1)
# Time since timeout reset 0x2aaaaf0a90: 4.747 seconds
ok 7 /monitor/method-call
PASS: test-monitor 7 /monitor/method-call
# Resetting test timeout (reference: 0x2aaab06790; factor: 1)
# Time since timeout reset 0x2aaab06790: 1.675 seconds
ok 8 /monitor/forbidden-method
PASS: test-monitor 8 /monitor/forbidden-method
# Resetting test timeout (reference: 0x2aaab0c9b0; factor: 1)
# Time since timeout reset 0x2aaab0c9b0: 1.800 seconds
ok 9 /monitor/dbus-daemon
PASS: test-monitor 9 /monitor/dbus-daemon
# Resetting test timeout (reference: 0x2aaab11480; factor: 1)
# Time since timeout reset 0x2aaab11480: 6.863 seconds
ok 10 /monitor/selective
PASS: test-monitor 10 /monitor/selective
# Resetting test timeout (reference: 0x2aaab19580; factor: 1)
# Time since timeout reset 0x2aaab19580: 9.677 seconds
ok 11 /monitor/well-known-destination
PASS: test-monitor 11 /monitor/well-known-destination
# Resetting test timeout (reference: 0x2aaab1f5f0; factor: 1)
# Time since timeout reset 0x2aaab1f5f0: 4.357 seconds
ok 12 /monitor/unique-destination
PASS: test-monitor 12 /monitor/unique-destination
# Resetting test timeout (reference: 0x2aaab1b890; factor: 1)
# Time since timeout reset 0x2aaab1b890: 6.014 seconds
ok 13 /monitor/wildcard
PASS: test-monitor 13 /monitor/wildcard
# Resetting test timeout (reference: 0x2aaab2b7c0; factor: 1)
# Time since timeout reset 0x2aaab2b7c0: 1.208 seconds
ok 14 /monitor/no-rule
PASS: test-monitor 14 /monitor/no-rule
# Resetting test timeout (reference: 0x2aaab318c0; factor: 1)
# Time since timeout reset 0x2aaab318c0: 1.166 seconds
ok 15 /monitor/eavesdrop
PASS: test-monitor 15 /monitor/eavesdrop
# Resetting test timeout (reference: 0x2aaab2b7c0; factor: 1)
# Time since timeout reset 0x2aaab2b7c0: 1.344 seconds
ok 16 /monitor/no-eavesdrop
PASS: test-monitor 16 /monitor/no-eavesdrop
# Resetting test timeout (reference: 0x2aaab3d5f0; factor: 1)
# Time since timeout reset 0x2aaab3d5f0: 1.361 seconds
ok 17 /monitor/activation
PASS: test-monitor 17 /monitor/activation
# End of monitor tests
=======================================================

-- 
Manuel A. Fernandez Montecelo <manuel.montezelo at gmail.com>