[LTP] ee
Petr Vorel
pvorel@suse.cz
Tue Jun 29 22:22:23 CEST 2021
Hi Richie,
sporadically tst_fuzzy_sync01 fails. I wonder if we can relax it somehow.
I found it while working on enabling API tests in CI, I'll have to disable this
one to avoid false positives.
Kind regards,
Petr
./tst_fuzzy_sync01
tst_test.c:1311: TINFO: Timeout per run is 0h 05m 00s
tst_fuzzy_sync01.c:224: TPASS: acs:0 act:0 art:0 | =:101 -:148 +:65
tst_fuzzy_sync01.c:224: TPASS: acs:0 act:1 art:0 | =:101 -:0 +:0
tst_fuzzy_sync01.c:224: TPASS: acs:1 act:1 art:1 | =:101 -:0 +:0
tst_fuzzy_sync01.c:224: TPASS: acs:3 act:1 art:1 | =:101 -:5 +:1
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -17ns, avg_dev = 4ns, dev_ratio = 0.25 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 20773ns, avg_dev = 4714ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 20849ns, avg_dev = 4710ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -94ns, avg_dev = 24ns, dev_ratio = 0.26 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 54 , avg_dev = 17 , dev_ratio = 0.31 }
../../include/tst_fuzzy_sync.h:684: TINFO: Exceeded execution loops, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:3 act:1 art:1 | =:0 -:1 +:2999999
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -18ns, avg_dev = 8ns, dev_ratio = 0.46 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 21475ns, avg_dev = 4558ns, dev_ratio = 0.21 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 19960ns, avg_dev = 4702ns, dev_ratio = 0.24 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 1497ns, avg_dev = 1956ns, dev_ratio = 1.31 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 43 , avg_dev = 17 , dev_ratio = 0.39 }
../../include/tst_fuzzy_sync.h:684: TINFO: Exceeded execution loops, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:1 act:1 art:3 | =:3 -:2999996 +:1
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = 1529ns, avg_dev = 1930ns, dev_ratio = 1.26 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 18630ns, avg_dev = 4565ns, dev_ratio = 0.25 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 8430ns, avg_dev = 4163ns, dev_ratio = 0.49 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 11729ns, avg_dev = 2725ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6115 , avg_dev = 33 , dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:684: TINFO: Exceeded execution loops, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:3 act:1 art:1 | =:1 -:1 +:2999998
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -126ns, avg_dev = 256ns, dev_ratio = 2.03 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 19028ns, avg_dev = 4655ns, dev_ratio = 0.24 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 5548ns, avg_dev = 1172ns, dev_ratio = 0.21 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 13354ns, avg_dev = 4411ns, dev_ratio = 0.33 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6070 , avg_dev = 157 , dev_ratio = 0.03 }
tst_fuzzy_sync01.c:224: TPASS: acs:1 act:1 art:3 | =:101 -:69713 +:82
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -1ns, avg_dev = 35ns, dev_ratio = 41.69 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 5178ns, avg_dev = 496ns, dev_ratio = 0.10 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 20746ns, avg_dev = 4711ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -15569ns, avg_dev = 4639ns, dev_ratio = 0.30 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6127 , avg_dev = 48 , dev_ratio = 0.01 }
tst_fuzzy_sync01.c:224: TPASS: acs:2 act:1 art:1 | =:101 -:67 +:103496
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -174ns, avg_dev = 515ns, dev_ratio = 2.95 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 5382ns, avg_dev = 1036ns, dev_ratio = 0.19 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 19221ns, avg_dev = 4722ns, dev_ratio = 0.25 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -14014ns, avg_dev = 4570ns, dev_ratio = 0.33 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6141 , avg_dev = 57 , dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:678: TINFO: Exceeded execution time, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:1 act:1 art:2 | =:6 -:2311522 +:7
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -16ns, avg_dev = 3ns, dev_ratio = 0.20 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 20317ns, avg_dev = 4728ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 20374ns, avg_dev = 4707ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -73ns, avg_dev = 31ns, dev_ratio = 0.42 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 58 , avg_dev = 18 , dev_ratio = 0.31 }
../../include/tst_fuzzy_sync.h:532: TINFO: Reached deviation ratios < 0.10, introducing randomness
../../include/tst_fuzzy_sync.h:535: TINFO: Delay range is [-14037, 8587]
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 663327, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -43ns, avg_dev = 3ns, dev_ratio = 0.08 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 17713ns, avg_dev = 59ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 28954ns, avg_dev = 31ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -11283ns, avg_dev = 43ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 5471 , avg_dev = 38 , dev_ratio = 0.01 }
tst_fuzzy_sync01.c:224: TPASS: acs:3 act:1 art:0 | =:101 -:186 +:666740
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -12ns, avg_dev = 6ns, dev_ratio = 0.47 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 20287ns, avg_dev = 4717ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 20310ns, avg_dev = 4685ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -35ns, avg_dev = 41ns, dev_ratio = 1.18 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 18 , avg_dev = 14 , dev_ratio = 0.77 }
../../include/tst_fuzzy_sync.h:678: TINFO: Exceeded execution time, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:0 act:1 art:3 | =:3 -:837016 +:1
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -30ns, avg_dev = 8ns, dev_ratio = 0.28 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 20287ns, avg_dev = 4703ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 4954ns, avg_dev = 1134ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 15303ns, avg_dev = 4468ns, dev_ratio = 0.29 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6042 , avg_dev = 34 , dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:532: TINFO: Reached deviation ratios < 0.10, introducing randomness
../../include/tst_fuzzy_sync.h:535: TINFO: Delay range is [-2861, 8786]
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 402095, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -18ns, avg_dev = 2ns, dev_ratio = 0.09 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 14168ns, avg_dev = 585ns, dev_ratio = 0.04 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 4615ns, avg_dev = 10ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 9535ns, avg_dev = 587ns, dev_ratio = 0.06 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 5913 , avg_dev = 157 , dev_ratio = 0.03 }
tst_fuzzy_sync01.c:224: TPASS: acs:3 act:1 art:0 | =:101 -:95 +:403404
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -8ns, avg_dev = 0ns, dev_ratio = 0.06 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 20354ns, avg_dev = 4775ns, dev_ratio = 0.23 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 4607ns, avg_dev = 8ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 15739ns, avg_dev = 4783ns, dev_ratio = 0.30 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6109 , avg_dev = 66 , dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:678: TINFO: Exceeded execution time, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:0 act:1 art:3 | =:31 -:210089 +:83
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -1ns, avg_dev = 6ns, dev_ratio = 5.49 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 4594ns, avg_dev = 185ns, dev_ratio = 0.04 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 18613ns, avg_dev = 4594ns, dev_ratio = 0.25 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -14020ns, avg_dev = 4509ns, dev_ratio = 0.32 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 6192 , avg_dev = 44 , dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:678: TINFO: Exceeded execution time, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:2 act:1 art:0 | =:7 -:0 +:142178
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = 314ns, avg_dev = 251ns, dev_ratio = 0.80 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 4606ns, avg_dev = 27ns, dev_ratio = 0.01 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 14040ns, avg_dev = 44ns, dev_ratio = 0.00 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = -9119ns, avg_dev = 234ns, dev_ratio = 0.03 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 5928 , avg_dev = 146 , dev_ratio = 0.02 }
../../include/tst_fuzzy_sync.h:678: TINFO: Exceeded execution time, requesting exit
tst_fuzzy_sync01.c:224: TFAIL: acs:0 act:1 art:2 | =:0 -:47266 +:0
../../include/tst_fuzzy_sync.h:522: TINFO: Minimum sampling period ended
../../include/tst_fuzzy_sync.h:345: TINFO: loop = 10000, delay_bias = 0
../../include/tst_fuzzy_sync.h:333: TINFO: start_a - start_b: { avg = -7ns, avg_dev = 7ns, dev_ratio = 0.98 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - start_a : { avg = 19278ns, avg_dev = 4713ns, dev_ratio = 0.24 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_b - start_b : { avg = 646ns, avg_dev = 82ns, dev_ratio = 0.13 }
../../include/tst_fuzzy_sync.h:333: TINFO: end_a - end_b : { avg = 18625ns, avg_dev = 4725ns, dev_ratio = 0.25 }
../../include/tst_fuzzy_sync.h:333: TINFO: spins : { avg = 8988 , avg_dev = 20 , dev_ratio = 0.00 }
Test timeouted, sending SIGKILL!
tst_test.c:1357: TINFO: If you are running on slow machine, try exporting LTP_TIMEOUT_MUL > 1
tst_test.c:1359: TBROK: Test killed! (timeout?)
Summary:
passed 8
failed 8
broken 1
skipped 0
warnings 0
More information about the ltp
mailing list