[rtems-test] riscv32/rv32i: RTEMS_POSIX_API: Passed:543 Failed:20 Timeout:17 Invalid:2 Wrong:0

joel at rtems.org joel at rtems.org
Thu Mar 26 07:17:14 UTC 2020


Testing time     : 0:22:30.771988
Average test time: 0:00:02.285570

Host
====
Linux-3.10.0-1062.12.1.el7.x86_64-x86_64-with-centos-7.7.1908-Core (Linux devel.oarcorp.com 3.10.0-1062.12.1.el7.x86_64 #1 SMP Tue Feb 4 23:02:59 UTC 2020 x86_64 x86_64)

Configuration
=============
Version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
Build  : RTEMS_POSIX_API
Tools  : 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)

Summary
=======

Passed:        543
Failed:         20
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        17
Invalid:         2
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         591

Failures:
 spintrcritical01.exe
 spintrcritical23.exe
 sp42.exe
 spintrcritical03.exe
 dl07.exe
 spintrcritical21.exe
 spintrcritical02.exe
 dl09.exe
 dl08.exe
 dl02.exe
 mdosfs_fserror.exe
 spintrcritical16.exe
 spintrcritical10.exe
 dl05.exe
 spintrcritical04.exe
 spintrcritical22.exe
 spintrcritical05.exe
 psxfenv01.exe
 dl06.exe
 spsysinit01.exe
User Input:
 termios.exe
 top.exe
 capture.exe
 dl10.exe
 monitor.exe
 fileio.exe
Benchmark:
 whetstone.exe
 dhrystone.exe
 linpack.exe
Timeouts:
 spintrcritical15.exe
 spintrcritical18.exe
 sp04.exe
 spintrcritical07.exe
 spintrcritical24.exe
 stackchk.exe
 sp20.exe
 flashdisk01.exe
 psxintrcritical01.exe
 psxtimer01.exe
 crypt01.exe
 malloctest.exe
 sp30.exe
 block08.exe
 sp19.exe
 sp24.exe
 sp01.exe
Invalid:
 rhtaskpreempt.exe
 rhtaskswitch.exe
Log
===

RTEMS Testing - Tester, 5 (9b9e0dd47fe7)
 Command Line: /home/joel/rtems-cron-5/rtems-tools//tester/rtems-test --rtems-tools=/home/joel/rtems-cron-5/tools/5 --rtems-bsp=rv32i_spike --log=run.log --mail --mail-from=joel at rtems.org --mail-to=build at rtems.org .
 Host: Linux devel.oarcorp.com 3.10.0-1062.12.1.el7.x86_64 #1 SMP Tue Feb 4 23:02:59 UTC 2020 x86_64
 Python: 2.7.5 (default, Aug  7 2019, 00:51:29) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]
Host: Linux-3.10.0-1062.12.1.el7.x86_64-x86_64-with-centos-7.7.1908-Core (Linux devel.oarcorp.com 3.10.0-1062.12.1.el7.x86_64 #1 SMP Tue Feb 4 23:02:59 UTC 2020 x86_64 x86_64)
error: spike.cfg:58: execute failed: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/fstests/mdosfs_fserror.exe: exit-code:255
[  1/591] p:0   f:0   u:0   e:0   I:0   B:0   t:0   i:0   W:0   | riscv32/rv32i: dhrystone.exe
 <<skipping passes>>
[ 36/591] p:27  f:0   u:0   e:0   I:0   B:1   t:0   i:0   W:0   | riscv32/rv32i: mdosfs_fserror.exe
Result: failed     Time: 0:00:01.037059 mdosfs_fserror.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/fstests/mdosfs_fserror.exe
] 
] 
=>  test start: FSERROR DOSFS
] *** BEGIN OF TEST FSERROR DOSFS ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Initializing filesystem DOSFS
] Testing open       with arguments: "name01, O_CREAT | O_EXCL" EXPECT "EEXIST"
] PASS
] Testing mkdir      with arguments: "name01, mode"       EXPECT "EEXIST"
] PASS
] Testing open       with arguments: "name02, O_WRONLY"   EXPECT "EISDIR"
] PASS
] Testing open       with arguments: "name02, O_RDWR"     EXPECT "EISDIR"
] PASS
] Testing open       with arguments: "name, O_WRONLY"     EXPECT "ENOENT"
] PASS
] Testing open       with arguments: "\"\", O_WRONLY"     EXPECT "ENOENT"
] PASS
] Testing open       with arguments: "name03, O_WRONLY"   EXPECT "ENOENT"
] PASS
] Testing mkdir      with arguments: "name, mode"         EXPECT "ENOENT"
] PASS
] Testing mkdir      with arguments: "\"\", mode"         EXPECT "ENOENT"
] PASS
] Testing open       with arguments: "name, O_WRONLY"     EXPECT "ENOTDIR"
] PASS
] Testing mkdir      with arguments: "name, mode"         EXPECT "ENOTDIR"
] PASS
] Testing close      with arguments: "-1"                 EXPECT "EBADF"
] PASS
] Testing close      with arguments: "100"                EXPECT "EBADF"
] PASS
] Testing rename     with arguments: "name01, name"       EXPECT "EINVAL"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 159 
] Testing rename     with arguments: "name03, name02"     EXPECT "EISDIR"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 167 
] Testing rename     with arguments: "nonexistence, name01" EXPECT "ENOENT"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 174 
] Testing rename     with arguments: "\"\", name01"       EXPECT "ENOENT"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 175 
] Testing rename     with arguments: "name01, \"\""       EXPECT "ENOENT"
] PASS
] Testing rename     with arguments: "name, name03"       EXPECT "ENOTDIR"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 185 
] Testing rename     with arguments: "name03, name"       EXPECT "ENOTDIR"
] PASS
] Testing rename     with arguments: "name02, name03"     EXPECT "ENOTDIR"
] FAIL   ../../../../../../rtems/c/src/../../testsuites/fstests/fserror/test.c: 187 
] terminate called after throwing an instance of 'trap_load_access_fault'
[ 37/591] p:28  f:0   u:0   e:0   I:0   B:1   t:0   i:0   W:0   | riscv32/rv32i: mdosfs_fspatheval.exe
 <<skipping passes>>
[ 67/591] p:56  f:1   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: block08.exe
Result: timeout    Time: 0:03:00.185665 block08.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/block08.exe
] 
] 
=>  test start: BLOCK 8
] *** BEGIN OF TEST BLOCK 8 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TEST DISK - OK
] Test 1.1 - STARTED
] Thread #1 started
] DISK_DRV: R [0] 
] Test 1.1: Step 2 - OK
] DISK_DRV: R [10] 
] Test 1.1: Step 4 - OK
] DISK_DRV: R [10] 
] Test 1.1: Step 6 - OK
] TEST PASSED
] Test 1.2 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [20] 
] Test 1.2: Step 3 - OK
] DISK_DRV: R [20] 
] Test 1.2: Step 5 - OK
] TEST PASSED
] Test 1.3 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [30] 
] Test 1.3: Step 3 - OK
] DISK_DRV: R [30] 
] Test 1.3: Step 5 - OK
] TEST PASSED
] Test 1.4 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [40] 
] Test 1.4: Step 3 - OK
] Test 1.4: Step 5 - OK
] TEST PASSED
] Test 1.5 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [50] 
] Test 1.5: Step 1 - OK
] Test 1.5: Step 4 - OK
] TEST PASSED
] Test 2.1 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [60] 
] Test 2.1: Step 3 - OK
] Test 2.1: Step 5 - OK
] *** TIMEOUT TIMEOUT
[ 68/591] p:57  f:1   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: block09.exe
 <<skipping passes>>
[ 81/591] p:70  f:1   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: crypt01.exe
Result: timeout    Time: 0:03:00.184231 crypt01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/crypt01.exe
] 
] 
=>  test start: CRYPT 1
] *** BEGIN OF TEST CRYPT 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] test crypt_md5_r()
] test crypt_sha256_r()
] input:    Hello world!
] salt:     $5$saltstring
] expected: $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] actual:   $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] input:    Hello world!
] salt:     $5$rounds=10000$saltstringsaltstring
] expected: $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] actual:   $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] input:    This is just a test
] salt:     $5$rounds=5000$toolongsaltstring
] expected: $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] actual:   $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] input:    a very much longer text to encrypt.  This one even stretches over morethan one line.
] salt:     $5$rounds=1400$anotherlongsaltstring
] expected: $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] actual:   $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] input:    we have a short salt string but not a short password
] salt:     $5$rounds=77777$short
] expected: $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] actual:   $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] input:    a short string
] salt:     $5$rounds=123456$asaltof16chars..
] expected: $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] actual:   $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] input:    the minimum number is still observed
] salt:     $5$rounds=10$roundstoolow
] expected: $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] actual:   $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] test crypt_sha512_r()
] input:    Hello world!
] salt:     $6$saltstring
] expected: $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] actual:   $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] input:    Hello world!
] salt:     $6$rounds=10000$saltstringsaltstring
] expected: $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] actual:   $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] input:    This is just a test
] salt:     $6$rounds=5000$toolongsaltstring
] expected: $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] actual:   $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] input:    a very much longer text to encrypt.  This one even stretches over morethan one line.
] salt:     $6$rounds=1400$anotherlongsaltstring
] expected: $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] actual:   $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] input:    we have a short salt string but not a short password
] salt:     $6$rounds=77777$short
] expected: $6$rounds=77777$short$WuQyW2YR.hBNpjjRhpYD/ifIw05xdfeEyQoMxIXbkvr0gge1a1x3yRULJ5CCaUeOxFmtlcGZelFl5CxtgfiAc0
] actual:   $6$rounds=77777$short$WuQyW2YR.hBNpjjRhpYD/ifIw05xdfeEyQoMxIXbkvr0gge1a1x3yRULJ5CCaUeOxFmtlcGZelFl5CxtgfiAc0
] *** TIMEOUT TIMEOUT
[ 82/591] p:71  f:1   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: defaultconfig01.exe
 <<skipping passes>>
[ 88/591] p:77  f:1   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl02.exe
Result: failed     Time: 0:00:01.030292 dl02.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl02.exe
] 
] 
=>  test start: libdl (RTL) 2
] *** BEGIN OF TEST libdl (RTL) 2 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] load: /dl02-o1.o
] handle: 0x80064700 has unresolved externals
] load: /dl02-o2.o
] handle: 0x80064eb0 has unresolved externals
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o1.c]
]   0: 1
]   1: 2
]   2: 3
]   3: 4
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o2.c]
]   0: 1
]   1: 2
]   2: 3
]   3: 4
] dl_o2_func2: d1=2147483647.00 d2=0.0 ret=0.00
] rtems_main: dl_o2_func2 returned: 0.00
] rtems_main: dl_o2_func2 returned a bad
] dlsym call failed: ret value bad
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 89/591] p:77  f:2   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl03.exe
 <<skipping passes>>
[ 91/591] p:79  f:2   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl05.exe
Result: failed     Time: 0:00:01.047486 dl05.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl05.exe
] 
] 
=>  test start: libdl (RTL) 5
] *** BEGIN OF TEST libdl (RTL) 5 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x00001880
] mcause  0x00000004
] mepc    0x80019228
] ra      0x8001793c
] sp      0x800774e0
] gp      0x8006b800
] tp      0x00000000
] t0      0xff7fffff
] t1      0x80017850
] t2      0xffffffff
] s0      0x80086e87
] s1      0x80085210
] a0      0x00000023
] a1      0x8005d2fc
] a2      0x800854c0
] a3      0x00000003
] a4      0x80019228
] a5      0x80086bd0
] a6      0xfffffd49
] a7      0x80086bd0
] s2      0x80086bd0
] s3      0x800775a0
] s4      0x00000001
] s5      0x8007eb44
] s6      0x800854c0
] s7      0x80086448
] s8      0x00000000
] s9      0x80085c40
] s10     0x80085c90
] s11     0x80077550
] t3      0x2e003738
] t4      0x31465341
] t5      0x4c2e0036
] t6      0x38314653
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 92/591] p:79  f:3   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl06.exe
Result: failed     Time: 0:00:01.027656 dl06.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl06.exe
] 
] 
=>  test start: libdl (RTL) 6
] *** BEGIN OF TEST libdl (RTL) 6 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 
] load: /dl06.rap
] dlopen failed: (null)
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 93/591] p:80  f:3   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl07.exe
Result: failed     Time: 0:00:01.038579 dl07.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl07.exe
] 
] 
=>  test start: libdl (RTL) 7
] *** BEGIN OF TEST libdl (RTL) 7 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl07/dl-load.c
] load: /dl07-o1.o
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl07/dl-load.c: 70 unresolved == 0
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 94/591] p:80  f:4   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl08.exe
Result: failed     Time: 0:00:01.043902 dl08.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl08.exe
] 
] 
=>  test start: libdl (RTL) 8
] *** BEGIN OF TEST libdl (RTL) 8 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl08/dl-load.c
] load: /dl08-o1.o
] dlo6: CONSTRUCTOR: ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl08-o6-123456789-123456789.c
] dlo6:   dl06_unresolv_1:    8: 0x80084b20: 0
] dlo6:   dl06_unresolv_2:    2: 0x80084b28: 0
] dlo6:   dl06_unresolv_3:    4: 0x80084b2c: 0
] dlo6:   dl06_unresolv_4:    1: 0x80084b30: 0
] dlo6:   dl06_unresolv_5:    8: 0x80084b38: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl-load.c: 71 unresolved == 0
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 95/591] p:80  f:5   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl09.exe
Result: failed     Time: 0:00:01.022704 dl09.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/dl09.exe
] 
] 
=>  test start: libdl (RTL) 9
] *** BEGIN OF TEST libdl (RTL) 9 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl09/dl-load.c
] load: /dl09-o1.o
] handel: 0x80076850: unresolved externals
] handle: 0x80076850 loaded
] space alloc: /dl09-o1.o: 33554432: 0x80077e20
] load: /dl09-o2.o
] handel: 0x800770f0: unresolved externals
] handle: 0x800770f0 loaded
] space alloc: /dl09-o2.o: 33554432: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl09/dl-load.c: 156 o->space != NULL
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 96/591] p:80  f:6   u:0   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: dl10.exe
 <<skipping passes>>
[100/591] p:82  f:7   u:1   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: flashdisk01.exe
Result: timeout    Time: 0:03:00.194539 flashdisk01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/flashdisk01.exe
] 
] 
=>  test start: FLASHDISK 1
] *** BEGIN OF TEST FLASHDISK 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] [00]: start
] [00]: mount: /dev/fdda -> /mnt
] [00]: init root: /mnt
] [00]: create dir: 1804928587
] [00]: create dir: 959030623
] [00]: create dir: 1903590565
] [00]: open file: file
] [00]: sleep: 700 ms
] [00]: close file
] [00]: sleep: 200 ms
] [00]: open dir: 959030623
] [00]: create dir: 838545539
] [00]: create file: 1594243340
] [00]: create file: 162216788
] [00]: create file: 1841205112
] [00]: sleep: 700 ms
] [00]: remove dir: 838545539
] [00]: create dir: 1143741253
] [00]: remove file: 1594243340
] [00]: sleep: 400 ms
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: create file: 832100416
] [00]: open dir: 1903590565
] [00]: create file: 1401208270
] [00]: create dir: 2032315143
] [00]: create dir: 2026989069
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: sleep: 100 ms
] [00]: create dir: 650320721
] [00]: sleep: 500 ms
] [00]: create dir: 1857409239
] [00]: create file: 2060801678
] [00]: create dir: 490998763
] [00]: create dir: 644928527
] [00]: create file: 1758287264
] [00]: close dir
] [00]: sleep: 500 ms
] [00]: open file: file
] [00]: read from file
] [00]: read from file
] [00]: read from file
] [00]: sleep: 700 ms
] [00]: read from file
] [00]: sleep: 200 ms
] [00]: sleep: 300 ms
] [00]: read from file
] [00]: append to file
] [00]: read from file
] [00]: close file
] [00]: remove dir: 1804928587
] [00]: create file: 2073894790
] [00]: sleep: 900 ms
] [00]: create dir: 472737403
] [00]: remove dir: 1903590565
] [00]: create dir: 689486081
] [00]: create dir: 373636079
] [00]: remove file: file
] [00]: create dir: 1506727461
] [00]: open dir: 959030623
] [00]: create dir: 1029668001
] [00]: remove file: 162216788
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: open dir: 959030623
] [00]: remove file: 1841205112
] [00]: create file: 378843792
] [00]: sleep: 1000 ms
] [00]: create file: 1871951748
] [00]: open dir: 1143741253
] [00]: create file: 855915646
] [00]: sleep: 700 ms
] [00]: create file: 2008730550
] [00]: close dir
] [00]: create file: 1327563176
] [00]: remove dir: 1143741253
] [00]: create file: 1384249492
] [00]: close dir
] [00]: remove dir: 959030623
] [00]: open file: 832100416
] [00]: read from file
] [00]: sleep: 400 ms
] [00]: close file
] [00]: open file: 832100416
] [00]: close file
] [00]: create dir: 2025552021
] [00]: remove dir: 959030623
] [00]: create dir: 1178339711
] [00]: remove file: 832100416
] [00]: remove file: 2073894790
] [00]: open dir: 1506727461
] [00]: sleep: 700 ms
] [00]: close dir
] [00]: sleep: 300 ms
] [00]: open dir: 1506727461
] [00]: create dir: 1625748679
] [00]: close dir
] [00]: remove dir: 689486081
] [00]: remove dir: 959030623
] [00]: open dir: 959030623
] [00]: sleep: 1000 ms
] [00]: close dir
] [00]: sleep: 100 ms
] [00]: open dir: 959030623
] [00]: create dir: 1128727833
] [00]: create file: 1203746106
] [00]: open dir: 1128727833
] [00]: create dir: 58221889
] [00]: create file: 611814452
] [00]: create dir: 420219909
] [00]: close dir
] [00]: remove file: 1384249492
] [00]: close dir
] [00]: open dir: 959030623
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: remove dir: 1506727461
] [00]: create file: 550820384
] [00]: create file: 833699694
] [00]: remove dir: 1506727461
] [00]: create dir: 861614531
] [00]: remove dir: 1506727461
] [00]: create dir: 846638047
] [00]: remove dir: 1506727461
] [00]: create dir: 1766470371
] [00]: remove dir: 959030623
] [00]: create file: 1969337196
] [00]: remove dir: 1506727461
] [00]: create file: 1937189238
] [00]: remove dir: 959030623
] [00]: create dir: 1615521955
] [00]: remove dir: 959030623
] [00]: sleep: 500 ms
] [00]: open dir: 1506727461
] [00]: create file: 926653184
] [00]: remove dir: 1625748679
] [00]: close dir
] [00]: create dir: 975747319
] [00]: open dir: 959030623
] [00]: open file: 1871951748
] [00]: sleep: 600 ms
] [00]: close file
] [00]: sleep: 800 ms
] [00]: remove file: 378843792
] [00]: open file: 1203746106
] [00]: read from file
] [00]: append to file
] [00]: sleep: 600 ms
] [00]: close file
] [00]: open file: 1871951748
] [00]: append to file
] [00]: close file
] [00]: remove file: 1871951748
] [00]: sleep: 400 ms
] [00]: create file: 1835979858
] [00]: open dir: 1128727833
] [00]: create dir: 862728993
] [00]: sleep: 700 ms
] [00]: remove dir: 862728993
] [00]: close dir
] [00]: close dir
] [00]: open dir: 975747319
] [00]: sleep: 400 ms
] [00]: create dir: 1840098529
] [00]: create file: 231405798
] [00]: remove dir: 1840098529
] [00]: close dir
] [00]: remove file: 550820384
] [00]: create file: 1020303340
] [00]: create dir: 895068705
] [00]: open dir: 975747319
] [00]: close dir
] [00]: open file: 1020303340
] [00]: read from file
] [00]: close file
] [00]: create dir: 1993404773
] [00]: remove file: 1020303340
] [00]: create dir: 2112395285
] [00]: create dir: 81202983
] [00]: remove dir: 975747319
] [00]: remove dir: 959030623
] [00]: create dir: 467069459
] [00]: open dir: 1506727461
] [00]: create file: 612609068
] [00]: create dir: 1793174441
] [00]: create file: 710808000
] [00]: sleep: 300 ms
] [00]: create file: 897370450
] [00]: create file: 1901152134
] [00]: sleep: 200 ms
] [00]: close dir
] [00]: open dir: 1506727461
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: create file: 906254788
] [00]: remove dir: 467069459
] [00]: remove dir: 1506727461
] [00]: open dir: 895068705
] [00]: close dir
] [00]: create file: 1216543556
] [00]: create file: 37176518
] [00]: open dir: 2112395285
] [00]: close dir
] [00]: create dir: 659416143
] [00]: remove file: 37176518
] [00]: sleep: 500 ms
] [00]: remove dir: 895068705
] [00]: create dir: 1507289677
] [00]: open dir: 959030623
] [00]: create file: 1766335976
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: open dir: 2112395285
] [00]: create dir: 1476817327
] [00]: close dir
] [00]: create dir: 1841667551
] [00]: remove dir: 2112395285
] [00]: open dir: 1507289677
] [00]: close dir
] [00]: create file: 1610238546
] [00]: create file: 220151308
] [00]: remove dir: 1507289677
] [00]: open file: 1216543556
] [00]: append to file
] [00]: append to file
] [00]: close file
] [00]: remove file: 1216543556
] [00]: open dir: 959030623
] [00]: sleep: 500 ms
] [00]: create file: 1508553554
] [00]: create file: 1742399670
] [00]: sleep: 100 ms
] [00]: close dir
] [00]: create dir: 2113094209
] [00]: remove dir: 959030623
] [00]: remove file: 1610238546
] [00]: create dir: 2146380029
] [00]: sleep: 700 ms
] *** TIMEOUT TIMEOUT
[101/591] p:83  f:7   u:1   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: getentropy01.exe
 <<skipping passes>>
[109/591] p:91  f:7   u:1   e:0   I:0   B:2   t:0   i:0   W:0   | riscv32/rv32i: malloctest.exe
Result: timeout    Time: 0:03:00.210755 malloctest.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/malloctest.exe
] 
] 
=>  test start: MALLOCTEST
] *** BEGIN OF TEST MALLOCTEST ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] run tests for _Heap_Initialize()
] run tests for _Heap_Block_allocate()
] 	allocate block at the beginning
] 	allocate block full space
] 	allocate block in the middle
] 	allocate block at the end
] 	allocate block at the beginning
] 	allocate block full space
] 	allocate block in the middle
] 	allocate block at the end
] 	allocate block at the beginning
] 	allocate block full space
] 	allocate block in the middle
] 	allocate block at the end
] 	allocate block at the beginning
] 	allocate block full space
] 	allocate block in the middle
] 	allocate block at the end
] run tests for _Heap_Allocate_aligned_with_boundary()
] 	check if NULL will be returned if size causes integer overflow
] 	try to allocate more space than the one which fits in the boundary
] 	check if alignment will be set to page size if only a boundary is given
] 	create a block which is bigger then the first free space
] 	set boundary before allocation begin
] 	set boundary between allocation begin and end
] 	set boundary after allocation end
] 	set boundary on allocation end
] 	align the allocation to different positions in the block header
] 	allocate last block with different boundarys
] 	break the boundaries and aligns more than one time
] 	different combinations, so that there is no valid block at the end
] 	try to create a block, which is not possible because of the alignment and boundary
] run tests for _Heap_Resize_Block()
] 	give a block outside the heap to the function
] 	increase size
] 		let the next block be used alredy and try to get a size bigger than the actual block
] 		next block not used and try to set the new allocation size between the page-alignments
] 		let the block after the next be used and try to allocate more then one pagesize more
] 	try to resize to the same size
] 	decrease size
] 		decrease a block with two pages to one page
] 		resize the block to the size 0
] realloc - failed grow in place: 0x80046fa0 != realloc(0x80047040,45)
] realloc - failed non-in place: realloc(0x80047040,64) = 0x80047040
] malloc_walk - normal path
] malloc_walk - in critical section path
] Heap Initialized
] heap extend - link below
] heap extend - merge below overlap
] heap extend - merge below
] heap extend - merge above overlap
] heap extend - merge above
] heap extend - link above
] heap extend - area too small
] heap extend - invalid area
] heap extend - merge below with align up
] malloc_free_space - check malloc space drops after malloc
] malloc_free_space - verify free space returns to previous value
] malloc_info - called with NULL
] 
] malloc_info - check free space drops after malloc
] malloc_info - verify free space returns to previous value
] _Heap_Size_with_overhead
] _Protected_heap_Get_information - NULL heap
] _Protected_heap_Get_information - NULL info
] posix_memalign - NULL return pointer -- EINVAL
] posix_memalign - alignment of 0 -- EINVAL
] posix_memalign - alignment  of 2-- EINVAL
] posix_memalign - alignment of 16 -- OK
] posix_memalign - alignment of 32 -- OK
] posix_memalign - alignment of 64 -- OK
] posix_memalign - alignment of 128 -- OK
] posix_memalign - alignment of 256 -- OK
] posix_memalign - alignment of 512 -- OK
] posix_memalign - alignment of 1024 -- OK
] posix_memalign - alignment of 2048 -- OK
] posix_memalign - alignment of 4096 -- OK
] posix_memalign - alignment of 8192 -- OK
] posix_memalign - alignment of 16384 -- OK
] posix_memalign - alignment of 32768 -- OK
] posix_memalign - alignment of 65536 -- OK
] posix_memalign - alignment of 131072 -- OK
] posix_memalign - alignment of 262144 -- OK
] posix_memalign - alignment of 524288 -- OK
] posix_memalign - alignment of 1048576 -- OK
] posix_memalign - alignment of 2097152 -- OK
] posix_memalign - alignment of 4194304 -- OK
] posix_memalign - alignment of 8388608 -- OK
] posix_memalign - alignment of 16777216 -- OK
] posix_memalign - alignment of 33554432 -- OK
] posix_memalign - alignment of 67108864 -- OK
] posix_memalign - ran out of memory trying 67108864
] posix_memalign - alignment of 67108864 -- SKIPPED
] posix_memalign - alignment of 134217728 -- SKIPPED
] posix_memalign - alignment of 268435456 -- SKIPPED
] posix_memalign - alignment of 536870912 -- SKIPPED
] posix_memalign - alignment of 1073741824 -- SKIPPED
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 690 bytes
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 690 bytes
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 690 bytes
] TA4  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 690 bytes
] TA5  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 690 bytes
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 505 bytes
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 505 bytes
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 591 bytes
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 505 bytes
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] mallocing 554 bytes
] TA4  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 505 bytes
] TA2  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 591 bytes
] TA1  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 378 bytes
] TA5  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 505 bytes
] TA1  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 257 bytes
] TA3  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 591 bytes
] TA2  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 554 bytes
] TA1  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 207 bytes
] TA1  - rtems_clock_get_tod - 09:00:01   12/31/1988
] mallocing 626 bytes
] TA4  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 591 bytes
] TA2  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 378 bytes
] TA1  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 340 bytes
] TA3  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 554 bytes
] TA1  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 843 bytes
] TA5  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 591 bytes
] TA2  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 257 bytes
] TA1  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 68 bytes
] TA1  - rtems_clock_get_tod - 09:00:02   12/31/1988
] mallocing 409 bytes
] TA4  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 554 bytes
] TA3  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 378 bytes
] TA2  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 207 bytes
] TA1  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 879 bytes
] TA1  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 319 bytes
] TA2  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 626 bytes
] TA1  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 980 bytes
] TA5  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 554 bytes
] TA3  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 257 bytes
] TA1  - rtems_clock_get_tod - 09:00:03   12/31/1988
] mallocing 85 bytes
] TA4  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 378 bytes
] TA2  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 340 bytes
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 907 bytes
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 102 bytes
] TA3  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 207 bytes
] TA2  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 843 bytes
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 921 bytes
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] mallocing 507 bytes
] TA5  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 378 bytes
] TA4  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 257 bytes
] TA2  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 68 bytes
] TA1  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 872 bytes
] TA3  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 626 bytes
] TA1  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 333 bytes
] TA2  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 409 bytes
] TA1  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 692 bytes
] TA1  - rtems_clock_get_tod - 09:00:05   12/31/1988
] mallocing 556 bytes
] TA4  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 207 bytes
] TA3  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 340 bytes
] TA2  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 879 bytes
] TA1  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 361 bytes
] TA5  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 257 bytes
] TA1  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 31 bytes
] TA2  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 319 bytes
] TA1  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 858 bytes
] TA3  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 843 bytes
] TA1  - rtems_clock_get_tod - 09:00:06   12/31/1988
] mallocing 98 bytes
] TA4  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 626 bytes
] TA2  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 980 bytes
] TA1  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 877 bytes
] TA1  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 449 bytes
] TA5  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 207 bytes
] TA3  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 68 bytes
] TA2  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 85 bytes
] TA1  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 432 bytes
] TA1  - rtems_clock_get_tod - 09:00:07   12/31/1988
] mallocing 606 bytes
] TA4  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 340 bytes
] TA2  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 907 bytes
] TA1  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 927 bytes
] TA3  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 409 bytes
] TA1  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 664 bytes
] TA2  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 102 bytes
] TA1  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 395 bytes
] TA5  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 626 bytes
] TA1  - rtems_clock_get_tod - 09:00:08   12/31/1988
] mallocing 438 bytes
] TA4  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 843 bytes
] TA3  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 879 bytes
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 921 bytes
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 652 bytes
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 928 bytes
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 507 bytes
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 949 bytes
] TA3  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 319 bytes
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] mallocing 307 bytes
] TA5  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 340 bytes
] TA4  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 68 bytes
] TA2  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 872 bytes
] TA1  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 596 bytes
] TA1  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 783 bytes
] TA3  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 980 bytes
] TA2  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 333 bytes
] TA1  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 338 bytes
] TA1  - rtems_clock_get_tod - 09:00:10   12/31/1988
] mallocing 805 bytes
] TA4  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 409 bytes
] TA2  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 692 bytes
] TA1  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 942 bytes
] TA5  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 843 bytes
] TA3  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 85 bytes
] TA1  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 66 bytes
] TA2  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 556 bytes
] TA1  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 857 bytes
] TA1  - rtems_clock_get_tod - 09:00:11   12/31/1988
] mallocing 977 bytes
] TA4  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 879 bytes
] TA3  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 907 bytes
] TA2  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 361 bytes
] TA1  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 889 bytes
] TA1  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 545 bytes
] TA5  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 68 bytes
] TA2  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 31 bytes
] TA1  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 864 bytes
] TA3  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 102 bytes
] TA1  - rtems_clock_get_tod - 09:00:12   12/31/1988
] mallocing 457 bytes
] TA4  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 319 bytes
] TA2  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 858 bytes
] TA1  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 800 bytes
] TA1  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 873 bytes
] TA3  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 921 bytes
] TA2  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 98 bytes
] TA1  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 821 bytes
] TA5  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 409 bytes
] TA1  - rtems_clock_get_tod - 09:00:13   12/31/1988
] mallocing 185 bytes
] TA4  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 980 bytes
] TA2  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 877 bytes
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 86 bytes
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 507 bytes
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 638 bytes
] TA2  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 449 bytes
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 233 bytes
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] mallocing 462 bytes
] TA5  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 879 bytes
] TA4  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 85 bytes
] TA3  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 872 bytes
] TA2  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 432 bytes
] TA1  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 7 bytes
] TA1  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 635 bytes
] TA2  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 606 bytes
] TA1  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 421 bytes
] TA3  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 333 bytes
] TA1  - rtems_clock_get_tod - 09:00:15   12/31/1988
] mallocing 953 bytes
] TA4  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 907 bytes
] TA2  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 927 bytes
] TA1  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 210 bytes
] TA5  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 319 bytes
] TA1  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 970 bytes
] TA3  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 692 bytes
] TA2  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 664 bytes
] TA1  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 261 bytes
] TA1  - rtems_clock_get_tod - 09:00:16   12/31/1988
] mallocing 857 bytes
] TA4  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 102 bytes
] TA2  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 395 bytes
] TA1  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 581 bytes
] TA3  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 556 bytes
] TA1  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 707 bytes
] TA5  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 980 bytes
] TA2  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 438 bytes
] TA1  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 285 bytes
] TA1  - rtems_clock_get_tod - 09:00:17   12/31/1988
] mallocing 318 bytes
] TA4  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 921 bytes
] TA3  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 361 bytes
] TA2  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 652 bytes
] TA1  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 643 bytes
] TA1  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 858 bytes
] TA2  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 928 bytes
] TA1  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 668 bytes
] *** TIMEOUT TIMEOUT
[110/591] p:92  f:7   u:1   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32i: math.exe
 <<skipping passes>>
[129/591] p:109 f:7   u:2   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32i: stackchk.exe
Result: timeout    Time: 0:03:00.191964 stackchk.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/libtests/stackchk.exe
] 
] 
=>  test start: STACKCHK
] *** BEGIN OF TEST STACKCHK ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] *** TIMEOUT TIMEOUT
[130/591] p:110 f:7   u:2   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32i: stackchk01.exe
 <<skipping passes>>
[195/591] p:169 f:7   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxfenv01.exe
Result: failed     Time: 0:00:01.032735 psxfenv01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/psxtests/psxfenv01.exe
] 
] 
=>  test start: PSXFENV 01
] *** BEGIN OF TEST PSXFENV 01 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] fesetenv(FE_DFL_ENV).
] feclearexcept(FE_ALL_EXCEPT).
] Divide by zero and confirm fetestexcept()
] ../../../../../../rtems/c/src/../../testsuites/psxtests/psxfenv01/init.c: 99 fetestexcept( FE_DIVBYZERO )
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[196/591] p:169 f:7   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxfile01.exe
 <<skipping passes>>
[205/591] p:178 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psximfs02.exe
error: spike.cfg:58: execute failed: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/rhealstone/rhtaskpreempt.exe: exit-code:6
error: spike.cfg:58: execute failed: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/rhealstone/rhtaskswitch.exe: exit-code:6
[206/591] p:178 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxintrcritical01.exe
Result: timeout    Time: 0:03:00.190691 psxintrcritical01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/psxtests/psxintrcritical01.exe
] 
] 
=>  test start: PSXINTRCRITICAL 1
] *** BEGIN OF TEST PSXINTRCRITICAL 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate timer fire from ISR while firing
] Init - Variation is: POSIX Timer
] Init - There is no way for the test to know if it hits the case
] *** TIMEOUT TIMEOUT
[207/591] p:179 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxinttypes01.exe
 <<skipping passes>>
[254/591] p:226 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxtimer01.exe
Result: timeout    Time: 0:03:00.195438 psxtimer01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/psxtests/psxtimer01.exe
] 
] 
=>  test start: PSXTIMER 1
] *** BEGIN OF TEST PSXTIMER 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] task A: timer_settime - value=0:0 interval=0:0
] Executing task B with count = 10 Fri Jan  1 00:00:02 1988
] Executing task A with count = 20 Fri Jan  1 00:00:02 1988
] Executing task A with count = 19 Fri Jan  1 00:00:03 1988
] Executing task B with count =  9 Fri Jan  1 00:00:04 1988
] Executing task A with count = 18 Fri Jan  1 00:00:04 1988
] Executing task A with count = 17 Fri Jan  1 00:00:05 1988
] Executing task B with count =  8 Fri Jan  1 00:00:06 1988
] Executing task C with count =  6 Fri Jan  1 00:00:06 1988
] Executing task A with count = 16 Fri Jan  1 00:00:06 1988
] Executing task A with count = 15 Fri Jan  1 00:00:07 1988
] Executing task B with count =  7 Fri Jan  1 00:00:08 1988
] Executing task A with count = 14 Fri Jan  1 00:00:08 1988
] Executing task C with count =  5 Fri Jan  1 00:00:09 1988
] Executing task A with count = 13 Fri Jan  1 00:00:09 1988
] Executing task B with count =  6 Fri Jan  1 00:00:10 1988
] Executing task A with count = 12 Fri Jan  1 00:00:10 1988
] Executing task A with count = 11 Fri Jan  1 00:00:11 1988
] Executing task B with count =  5 Fri Jan  1 00:00:12 1988
] Executing task C with count =  4 Fri Jan  1 00:00:12 1988
] Executing task A with count = 10 Fri Jan  1 00:00:12 1988
] Executing task A with count =  9 Fri Jan  1 00:00:13 1988
] Executing task B with count =  4 Fri Jan  1 00:00:14 1988
] Executing task A with count =  8 Fri Jan  1 00:00:14 1988
] Executing task C with count =  3 Fri Jan  1 00:00:15 1988
] Executing task A with count =  7 Fri Jan  1 00:00:15 1988
] Executing task B with count =  3 Fri Jan  1 00:00:16 1988
] Executing task A with count =  6 Fri Jan  1 00:00:16 1988
] Executing task A with count =  5 Fri Jan  1 00:00:17 1988
] Executing task B with count =  2 Fri Jan  1 00:00:18 1988
] Executing task C with count =  2 Fri Jan  1 00:00:18 1988
] Executing task A with count =  4 Fri Jan  1 00:00:18 1988
] Executing task A with count =  3 Fri Jan  1 00:00:19 1988
] Executing task B with count =  1 Fri Jan  1 00:00:20 1988
] Executing task A with count =  2 Fri Jan  1 00:00:20 1988
] Executing task C with count =  1 Fri Jan  1 00:00:21 1988
] Executing task A with count =  1 Fri Jan  1 00:00:21 1988
] task C: timer_getoverrun - overruns=0
] task C: timer_gettime - 1:990000000 remaining from 3:0
] *** TIMEOUT TIMEOUT
[255/591] p:227 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: psxtimer02.exe
 <<skipping passes>>
[319/591] p:291 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32i: rhtaskpreempt.exe
Result: invalid    Time: 0:00:01.009159 rhtaskpreempt.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/rhealstone/rhtaskpreempt.exe
] *** FAILED *** (tohost = 6)
[320/591] p:291 f:8   u:4   e:0   I:0   B:3   t:5   i:1   W:0   | riscv32/rv32i: rhtaskswitch.exe
Result: invalid    Time: 0:00:01.028995 rhtaskswitch.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/rhealstone/rhtaskswitch.exe
] *** FAILED *** (tohost = 6)
[321/591] p:292 f:8   u:4   e:0   I:0   B:3   t:5   i:1   W:0   | riscv32/rv32i: base_sp.exe
 <<skipping passes>>
[332/591] p:299 f:8   u:6   e:0   I:0   B:3   t:6   i:2   W:0   | riscv32/rv32i: sp01.exe
Result: timeout    Time: 0:03:00.197621 sp01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp01.exe
] 
] 
=>  test start: SP 1
] *** BEGIN OF TEST SP 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] *** TIMEOUT TIMEOUT
[333/591] p:300 f:8   u:6   e:0   I:0   B:3   t:6   i:2   W:0   | riscv32/rv32i: sp02.exe
 <<skipping passes>>
[335/591] p:302 f:8   u:6   e:0   I:0   B:3   t:6   i:2   W:0   | riscv32/rv32i: sp04.exe
Result: timeout    Time: 0:03:00.193580 sp04.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp04.exe
] 
] 
=>  test start: SP 4
] *** BEGIN OF TEST SP 4 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] TA1 - rtems_task_resume - on Task 2
] TA1 - rtems_task_resume - on Task 3
] TA1 - rtems_task_mode - change mode to NO RTEMS_PREEMPT
] TA1 - 09:15:09   12/31/1988
] TA1 - 09:15:10   12/31/1988
] TA1 - 09:15:11   12/31/1988
] TA1 - 09:15:12   12/31/1988
] TA1 - 09:15:13   12/31/1988
] TA1 - 09:15:14   12/31/1988
] TA1 - rtems_task_mode - change mode to RTEMS_PREEMPT
] TA1 - 09:15:00   12/31/1988
] TA2 - 09:15:03   12/31/1988
] TA3 - 09:15:04   12/31/1988
] TA1 - 09:15:05   12/31/1988
] TA2 - 09:15:06   12/31/1988
] TA3 - 09:15:07   12/31/1988
] TA1 - 09:15:08   12/31/1988
] TA2 - 09:15:14   12/31/1988
] TA3 - 09:15:15   12/31/1988
] TA1 - 09:15:16   12/31/1988
] TA1 - rtems_extension_delete - successful
] *** TIMEOUT TIMEOUT
[336/591] p:303 f:8   u:6   e:0   I:0   B:3   t:6   i:2   W:0   | riscv32/rv32i: sp05.exe
 <<skipping passes>>
[348/591] p:314 f:8   u:6   e:0   I:0   B:3   t:7   i:2   W:0   | riscv32/rv32i: sp19.exe
Result: timeout    Time: 0:03:00.232530 sp19.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp19.exe
] 
] 
=>  test start: SP 19
] *** BEGIN OF TEST SP 19 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] FP1  - integer base = (0x6000)
] FP1  - float base = (NA)
] FP1  - integer base = (0x6000)
] FP1  - float base = (NA)
] TA1  - integer base = (0x1000)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - integer base = (0x2000)
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - integer base = (0x3000)
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA4  - integer base = (0x4000)
] TA4  - float base = (4000.4)
] TA4  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:01   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:02   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:03   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA5  - integer base = (0x5000)
] TA5  - float base = (5000.5)
] TA5  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:05   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:05   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:06   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:06   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:07   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:07   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:08   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:08   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:10   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:10   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:11   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:11   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:12   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:12   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:13   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:13   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA4  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA5  - rtems_clock_get_tod - 09:00:14   12/31/1988
] *** TIMEOUT TIMEOUT
[349/591] p:315 f:8   u:6   e:0   I:0   B:3   t:7   i:2   W:0   | riscv32/rv32i: sp20.exe
Result: timeout    Time: 0:03:00.219449 sp20.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp20.exe
] 
] 
=>  test start: SP 20
] *** BEGIN OF TEST SP 20 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1 - rtems_rate_monotonic_create id = 0x42010001
] TA1 - rtems_rate_monotonic_ident id = 0x42010001
] TA1 - (0x42010001) period 2
] TA2 - rtems_rate_monotonic_create id = 0x42010002
] TA2 - rtems_rate_monotonic_ident id = 0x42010002
] TA2 - (0x42010002) period 2
] TA3 - rtems_rate_monotonic_create id = 0x42010003
] TA3 - rtems_rate_monotonic_ident id = 0x42010003
] TA3 - (0x42010003) period 2
] TA4 - rtems_rate_monotonic_create id = 0x42010004
] TA4 - rtems_rate_monotonic_ident id = 0x42010004
] TA4 - (0x42010004) period 2
] TA5 - rtems_rate_monotonic_create id = 0x42010005
] TA5 - rtems_rate_monotonic_ident id = 0x42010005
] TA5 - (0x42010005) period 100
] TA6 - rtems_rate_monotonic_create id = 0x42010006
] TA6 - rtems_rate_monotonic_ident id = 0x42010006
] TA6 - (0x42010006) period 0
] TA5 - PERIODS CHECK OK (1)
] TA5 - PERIODS CHECK OK (2)
] TA5 - PERIODS CHECK OK (3)
] *** TIMEOUT TIMEOUT
[350/591] p:316 f:8   u:6   e:0   I:0   B:3   t:7   i:2   W:0   | riscv32/rv32i: sp2038.exe
 <<skipping passes>>
[353/591] p:319 f:8   u:6   e:0   I:0   B:3   t:7   i:2   W:0   | riscv32/rv32i: sp23.exe
error: spike.cfg:58: execute failed: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp42.exe: exit-code:255
[354/591] p:320 f:8   u:6   e:0   I:0   B:3   t:7   i:2   W:0   | riscv32/rv32i: sp24.exe
Result: timeout    Time: 0:03:00.249127 sp24.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp24.exe
] 
] 
=>  test start: SP 24
] *** BEGIN OF TEST SP 24 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] *** TIMEOUT TIMEOUT
[355/591] p:320 f:8   u:6   e:0   I:0   B:3   t:8   i:2   W:0   | riscv32/rv32i: sp25.exe
 <<skipping passes>>
[360/591] p:324 f:8   u:6   e:0   I:0   B:3   t:9   i:2   W:0   | riscv32/rv32i: sp30.exe
Result: timeout    Time: 0:03:00.231987 sp30.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp30.exe
] 
] 
=>  test start: SP 30
] *** BEGIN OF TEST SP 30 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] timer_initiate_server -- INVALID_PRIORITY
] timer_initiate_server -- OK
] timer_initiate_server -- already started
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:19   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:24   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:29   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:29   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:29   12/31/1988
] *** TIMEOUT TIMEOUT
[361/591] p:325 f:8   u:6   e:0   I:0   B:3   t:9   i:2   W:0   | riscv32/rv32i: sp31.exe
 <<skipping passes>>
[370/591] p:333 f:8   u:6   e:0   I:0   B:3   t:10  i:2   W:0   | riscv32/rv32i: sp42.exe
Result: failed     Time: 0:00:05.043479 sp42.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/sp42.exe
] 
] 
=>  test start: SP 42
] *** BEGIN OF TEST SP 42 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Exercising blocking discipline w/extract in FIFO order 
] Exercising blocking discipline w/unblock in FIFO order
] TA00 - unblocked - OK
] TA01 - unblocked - OK
] TA02 - unblocked - OK
] TA03 - unblocked - OK
] TA04 - unblocked - OK
] TA05 - unblocked - OK
] TA06 - unblocked - OK
] TA07 - unblocked - OK
] TA08 - unblocked - OK
] TA09 - unblocked - OK
] TA10 - unblocked - OK
] TA11 - unblocked - OK
] TA12 - unblocked - OK
] TA13 - unblocked - OK
] TA14 - unblocked - OK
] TA15 - unblocked - OK
] TA16 - unblocked - OK
] TA17 - unblocked - OK
] TA18 - unblocked - OK
] TA19 - unblocked - OK
] Exercising blocking discipline w/extract in priority order 
] Exercising blocking discipline w/unblock in priority order
] TA04 - unblocked - OK
] TA05 - unblocked - OK
] TA06 - unblocked - OK
] TA07 - unblocked - OK
] terminate called after throwing an instance of 'trap_load_access_fault'
[371/591] p:334 f:8   u:6   e:0   I:0   B:3   t:10  i:2   W:0   | riscv32/rv32i: sp43.exe
 <<skipping passes>>
[466/591] p:425 f:9   u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical01.exe
Result: failed     Time: 0:00:01.031177 spintrcritical01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical01.exe
] 
] 
=>  test start: SPINTRCRITICAL 1
] *** BEGIN OF TEST SPINTRCRITICAL 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/Without Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[467/591] p:426 f:9   u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical02.exe
Result: failed     Time: 0:00:01.044374 spintrcritical02.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical02.exe
] 
] 
=>  test start: SPINTRCRITICAL 2
] *** BEGIN OF TEST SPINTRCRITICAL 2 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/With Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[468/591] p:427 f:10  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical03.exe
Result: failed     Time: 0:00:01.094677 spintrcritical03.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical03.exe
] 
] 
=>  test start: SPINTRCRITICAL 3
] *** BEGIN OF TEST SPINTRCRITICAL 3 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[469/591] p:427 f:10  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical04.exe
Result: failed     Time: 0:00:01.087452 spintrcritical04.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical04.exe
] 
] 
=>  test start: SPINTRCRITICAL 4
] *** BEGIN OF TEST SPINTRCRITICAL 4 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/With Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[470/591] p:427 f:11  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical05.exe
Result: failed     Time: 0:00:01.027283 spintrcritical05.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical05.exe
] 
] 
=>  test start: SPINTRCRITICAL 5
] *** BEGIN OF TEST SPINTRCRITICAL 5 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout (Reverse)
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[471/591] p:427 f:13  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical06.exe
[472/591] p:427 f:13  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical07.exe
Result: timeout    Time: 0:03:00.282870 spintrcritical07.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical07.exe
] 
] 
=>  test start: SPINTRCRITICAL 7
] *** BEGIN OF TEST SPINTRCRITICAL 7 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - There is no way for the test to know if it hits the case
] Init - Variation is: Priority/Restart Search Task (Backward)
] *** TIMEOUT TIMEOUT
[473/591] p:427 f:14  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical08.exe
 <<skipping passes>>
[475/591] p:429 f:14  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical10.exe
Result: failed     Time: 0:00:01.089419 spintrcritical10.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical10.exe
] 
] 
=>  test start: SPINTRCRITICAL 10
] *** BEGIN OF TEST SPINTRCRITICAL 10 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate any satisfied before timeout while blocking on event
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical10/init.c: 144 ctx->hit
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[476/591] p:429 f:15  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical11.exe
 <<skipping passes>>
[480/591] p:433 f:15  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical15.exe
Result: timeout    Time: 0:03:00.235214 spintrcritical15.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical15.exe
] 
] 
=>  test start: SPINTRCRITICAL 15
] *** BEGIN OF TEST SPINTRCRITICAL 15 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate timeout of a thread while another is blocking
] Init -   on the same thread queue
] Init - There is no way for the test to know if it hits the case
] Init - rtems_semaphore_create - OK
] Init - rtems_task_create - OK
] *** TIMEOUT TIMEOUT
[481/591] p:434 f:15  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical16.exe
Result: failed     Time: 0:00:01.083219 spintrcritical16.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical16.exe
] 
] 
=>  test start: SPINTRCRITICAL 16
] *** BEGIN OF TEST SPINTRCRITICAL 16 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate timeout of a thread that had its blocking
] Init -   request satisfied while blocking but before time timeout
] Init - rtems_semaphore_create - OK
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[482/591] p:434 f:16  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical18.exe
Result: timeout    Time: 0:03:00.231027 spintrcritical18.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical18.exe
] 
] 
=>  test start: SPINTRCRITICAL 18
] *** BEGIN OF TEST SPINTRCRITICAL 18 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] *** TIMEOUT TIMEOUT
[483/591] p:435 f:16  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical20.exe
[484/591] p:436 f:16  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical21.exe
Result: failed     Time: 0:00:01.064493 spintrcritical21.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical21.exe
] 
] 
=>  test start: SPINTRCRITICAL 21
] *** BEGIN OF TEST SPINTRCRITICAL 21 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Event sent from ISR hitting synchronization point has NOT occurred
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical21/init.c: 157 case_hit
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[485/591] p:436 f:17  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical22.exe
Result: failed     Time: 0:00:01.052314 spintrcritical22.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical22.exe
] 
] 
=>  test start: SPINTRCRITICAL 22
] *** BEGIN OF TEST SPINTRCRITICAL 22 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical22/init.c: 118 ctx->done
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[486/591] p:436 f:18  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical23.exe
Result: failed     Time: 0:00:01.088751 spintrcritical23.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical23.exe
] 
] 
=>  test start: SPINTRCRITICAL 23
] *** BEGIN OF TEST SPINTRCRITICAL 23 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical23/init.c: 133 ctx->done
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[487/591] p:436 f:19  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spintrcritical24.exe
Result: timeout    Time: 0:03:00.222657 spintrcritical24.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spintrcritical24.exe
] 
] 
=>  test start: SPINTRCRITICAL 24
] *** BEGIN OF TEST SPINTRCRITICAL 24 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] *** TIMEOUT TIMEOUT
[488/591] p:437 f:19  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: splinkersets01.exe
 <<skipping passes>>
[525/591] p:474 f:19  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spsysinit01.exe
Result: failed     Time: 0:00:01.090313 spsysinit01.exe
=>  run: spike --isa=RV32I ./riscv-rtems5/c/rv32i/testsuites/sptests/spsysinit01.exe
] sysinit: begin
] sysinit: stack pointer: 0x800331e0
] sysinit: memory area 0: begin = 0x80033200, size = 0x03fcce00
] sysinit: DIRTY_MEMORY: done
] sysinit: ISR_STACK: done
] sysinit: memory area 0: free begin = 0x800375c6, free size = 0x03fc8a3a
] sysinit: WORKSPACE: done
] sysinit: memory area 0: free begin = 0x84000000, free size = 0x00000000
] sysinit: MALLOC: done
] 
] 
=>  test start: SPSYSINIT 1
] *** BEGIN OF TEST SPSYSINIT 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] sysinit: BSP_START: done
] sysinit: CPU_COUNTER: done
] sysinit: INITIAL_EXTENSIONS: done
] sysinit: DATA_STRUCTURES: done
] sysinit: USER_EXTENSIONS: done
] sysinit: CLASSIC_TASKS: done
] sysinit: CLASSIC_TIMER: done
] sysinit: CLASSIC_MESSAGE_QUEUE: done
] sysinit: CLASSIC_SEMAPHORE: done
] sysinit: CLASSIC_PARTITION: done
] sysinit: CLASSIC_REGION: done
] sysinit: CLASSIC_DUAL_PORTED_MEMORY: done
] sysinit: CLASSIC_RATE_MONOTONIC: done
] sysinit: CLASSIC_BARRIER: done
] sysinit: POSIX_SIGNALS: done
] sysinit: POSIX_THREADS: done
] sysinit: POSIX_MESSAGE_QUEUE: done
] sysinit: POSIX_SEMAPHORE: done
] sysinit: POSIX_TIMER: done
] sysinit: POSIX_SHM: done
] sysinit: POSIX_KEYS: done
] sysinit: POSIX_CLEANUP: done
] sysinit: IDLE_THREADS: done
] sysinit: LIBIO: done
] sysinit: USER_ENVIRONMENT: done
] sysinit: ROOT_FILESYSTEM: done
] sysinit: BSP_PRE_DRIVERS: done
] sysinit: DEVICE_DRIVERS: done
] sysinit: CLASSIC_USER_TASKS: done
] sysinit: POSIX_USER_THREADS: done
] sysinit: STD_FILE_DESCRIPTORS: done
] sysinit: done
] ../../../../../../rtems/c/src/../../testsuites/sptests/spsysinit01/init.c: 902 sem != SEM_FAILED
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[526/591] p:474 f:20  u:6   e:0   I:0   B:3   t:13  i:2   W:0   | riscv32/rv32i: spsyslock01.exe
 <<skipping passes>>
[591/591] p:536 f:20  u:6   e:0   I:0   B:3   t:16  i:2   W:0   | riscv32/rv32i: tmtimer01.exe

Passed:        543
Failed:         20
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        17
Invalid:         2
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         591
Failures:
 spintrcritical01.exe
 spintrcritical23.exe
 sp42.exe
 spintrcritical03.exe
 dl07.exe
 spintrcritical21.exe
 spintrcritical02.exe
 dl09.exe
 dl08.exe
 dl02.exe
 mdosfs_fserror.exe
 spintrcritical16.exe
 spintrcritical10.exe
 dl05.exe
 spintrcritical04.exe
 spintrcritical22.exe
 spintrcritical05.exe
 psxfenv01.exe
 dl06.exe
 spsysinit01.exe
User Input:
 termios.exe
 top.exe
 capture.exe
 dl10.exe
 monitor.exe
 fileio.exe
Benchmark:
 whetstone.exe
 dhrystone.exe
 linpack.exe
Timeouts:
 spintrcritical15.exe
 spintrcritical18.exe
 sp04.exe
 spintrcritical07.exe
 spintrcritical24.exe
 stackchk.exe
 sp20.exe
 flashdisk01.exe
 psxintrcritical01.exe
 psxtimer01.exe
 crypt01.exe
 malloctest.exe
 sp30.exe
 block08.exe
 sp19.exe
 sp24.exe
 sp01.exe
Invalid:
 rhtaskpreempt.exe
 rhtaskswitch.exe
Average test time: 0:00:02.285570
Testing time     : 0:22:30.771988


More information about the build mailing list