[rtems-test] riscv32/rv32imafdc: RTEMS_POSIX_API: Passed:534 Failed:23 Timeout:25 Invalid:0 Wrong:0

joel at rtems.org joel at rtems.org
Sat May 23 12:25:30 UTC 2020


Testing time     : 0:45:40.142665
Average test time: 0:00:04.636451

Host
====
FreeBSD-12.1-RELEASE-p3-amd64-64bit-ELF (FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64 amd64)

Configuration
=============
Version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
Build  : RTEMS_POSIX_API
Tools  : 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)

Summary
=======

Passed:        534
Failed:         23
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        25
Invalid:         0
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         591

Failures:
 dl01.exe
 dl02.exe
 dl05.exe
 dl06.exe
 dl07.exe
 dl08.exe
 dl09.exe
 malloctest.exe
 psxtimer01.exe
 spintrcritical01.exe
 spintrcritical02.exe
 spintrcritical03.exe
 spintrcritical04.exe
 spintrcritical05.exe
 spintrcritical08.exe
 spintrcritical10.exe
 spintrcritical16.exe
 spintrcritical20.exe
 spintrcritical21.exe
 spintrcritical23.exe
 spintrcritical22.exe
 spintrcritical24.exe
 spsysinit01.exe
User Input:
 dl10.exe
 monitor.exe
 termios.exe
 top.exe
 capture.exe
 fileio.exe
Benchmark:
 whetstone.exe
 dhrystone.exe
 linpack.exe
Timeouts:
 imfs_fstime.exe
 block08.exe
 crypt01.exe
 cpuuse.exe
 psx07.exe
 psxrwlock01.exe
 psxsignal01.exe
 psxstat.exe
 ticker.exe
 sp01.exe
 sp04.exe
 sp12.exe
 sp19.exe
 sp20.exe
 sp24.exe
 sp30.exe
 sp32.exe
 spcbssched01.exe
 spcbssched03.exe
 spcontext01.exe
 spedfsched01.exe
 spedfsched03.exe
 spsimplesched01.exe
 tmfine01.exe
 tmonetoone.exe
Log
===

RTEMS Testing - Tester, 5 (ea86d967ec0e)
 Command Line: /home/joel/rtems-cron-5/rtems-tools//tester/rtems-test --rtems-tools=/home/joel/rtems-cron-5/tools/5 --rtems-bsp=rv32imafdc_spike --log=run.log --mail --mail-from=joel at rtems.org --mail-to=build at rtems.org .
 Host: FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64
 Python: 3.6.9 (default, Oct 24 2019, 01:18:01) [GCC 4.2.1 Compatible FreeBSD Clang 6.0.1 (tags/RELEASE_601/final 335540)]
Host: FreeBSD-12.1-RELEASE-p3-amd64-64bit-ELF (FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64 amd64)
[  1/591] p:0   f:0   u:0   e:0   I:0   B:0   t:0   i:0   W:0   | riscv32/rv32imafdc: dhrystone.exe
 <<skipping passes>>
[ 27/591] p:20  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32imafdc: imfs_fstime.exe
Result: timeout    Time: 0:03:00.531060 imfs_fstime.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/fstests/imfs_fstime.exe
] 
] 
=>  test start: FSTIME ROOT IMFS
] *** BEGIN OF TEST FSTIME ROOT IMFS ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Initializing filesystem ROOT IMFS
] Sleep a few seconds
] Sleep a few seconds
] Sleep a few seconds
] *** TIMEOUT TIMEOUT
[ 28/591] p:21  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32imafdc: jffs2_fserror.exe
 <<skipping passes>>
[ 67/591] p:60  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32imafdc: block08.exe
Result: timeout    Time: 0:03:00.413637 block08.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/block08.exe
] 
] 
=>  test start: BLOCK 8
] *** BEGIN OF TEST BLOCK 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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:60  f:0   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: block09.exe
 <<skipping passes>>
[ 80/591] p:73  f:0   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: cpuuse.exe
Result: timeout    Time: 0:03:00.579791 cpuuse.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/cpuuse.exe
] 
] 
=>  test start: CPUUSE
] *** BEGIN OF TEST CPUUSE ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] *** TIMEOUT TIMEOUT
[ 81/591] p:73  f:0   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: crypt01.exe
Result: timeout    Time: 0:03:00.511650 crypt01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/crypt01.exe
] 
] 
=>  test start: CRYPT 1
] *** BEGIN OF TEST CRYPT 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] *** TIMEOUT TIMEOUT
[ 82/591] p:74  f:0   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: defaultconfig01.exe
 <<skipping passes>>
[ 87/591] p:79  f:0   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl01.exe
Result: failed     Time: 0:00:01.008723 dl01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl01.exe
] 
] 
=>  test start: libdl (RTL) 1
] *** BEGIN OF TEST libdl (RTL) 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] load: /dl01-o1.o
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x80010a26
] ra      0x8000f8c8
] sp      0x80043410
] gp      0x8003d800
] tp      0x00000000
] t0      0xffffff7f
] t1      0x8000f842
] t2      0xffffffff
] s0      0x8004c05a
] s1      0x8004b5c0
] a0      0x0000001b
] a1      0x800344fc
] a2      0x8004b740
] a3      0x00000003
] a4      0x80010a26
] a5      0x8004c0c0
] a6      0x00000066
] a7      0x8004c0c0
] s2      0x8004c0c0
] s3      0x800434d0
] s4      0x00000001
] s5      0x80046030
] s6      0x8004b740
] s7      0x8004bde8
] s8      0x8004b5c0
] s9      0x8004ba40
] s10     0x8004ba90
] s11     0x80043480
] t3      0x53414c2e
] t4      0x00303232
] t5      0x4653414c
] t6      0x2e003931
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 88/591] p:79  f:1   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl02.exe
Result: failed     Time: 0:00:01.008902 dl02.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl02.exe
] 
] 
=>  test start: libdl (RTL) 2
] *** BEGIN OF TEST libdl (RTL) 2 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] load: /dl02-o1.o
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x80010878
] ra      0x8000f924
] sp      0x8004d3f0
] gp      0x80047800
] tp      0x00000000
] t0      0xffffff7f
] t1      0x8000f89e
] t2      0xffffffff
] s0      0x80056d5a
] s1      0x80055630
] a0      0x00000012
] a1      0x8003e530
] a2      0x800557b0
] a3      0x00000003
] a4      0x80010878
] a5      0x8000ba94
] a6      0xfffb4d3a
] a7      0x8000ba94
] s2      0x8000ba94
] s3      0x8004d4b0
] s4      0x00000001
] s5      0x80050090
] s6      0x800557b0
] s7      0x800548b4
] s8      0x80055630
] s9      0x80055c50
] s10     0x80055ca0
] s11     0x8004d460
] t3      0x4c2e0031
] t4      0x30324653
] t5      0x414c2e00
] t6      0x30303246
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 89/591] p:79  f:2   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl03.exe
 <<skipping passes>>
[ 91/591] p:81  f:2   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl05.exe
Result: failed     Time: 0:00:01.008825 dl05.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl05.exe
] 
] 
=>  test start: libdl (RTL) 5
] *** BEGIN OF TEST libdl (RTL) 5 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x800109be
] ra      0x8000fa40
] sp      0x800625a0
] gp      0x80056800
] tp      0x00000000
] t0      0x0000006f
] t1      0x8000f9ba
] t2      0xffffffff
] s0      0x800719f6
] s1      0x80070060
] a0      0x0000001a
] a1      0x80048f54
] a2      0x80070250
] a3      0x00000003
] a4      0x800109be
] a5      0x80071b90
] a6      0x0000019a
] a7      0x80071b90
] s2      0x80071b90
] s3      0x80062660
] s4      0x00000001
] s5      0x80069bb5
] s6      0x80070250
] s7      0x800711f8
] s8      0x80070060
] s9      0x80070a90
] s10     0x80070ae0
] s11     0x80062610
] t3      0x00000000
] t4      0x00006127
] t5      0x0000006f
] t6      0x00000000
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 92/591] p:81  f:3   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl06.exe
Result: failed     Time: 0:00:01.008766 dl06.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl06.exe
] 
] 
=>  test start: libdl (RTL) 6
] *** BEGIN OF TEST libdl (RTL) 6 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 93/591] p:81  f:4   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl07.exe
Result: failed     Time: 0:00:01.009680 dl07.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl07.exe
] 
] 
=>  test start: libdl (RTL) 7
] *** BEGIN OF TEST libdl (RTL) 7 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl07/dl-load.c
] load: /dl07-o1.o
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x80010a84
] ra      0x8000fb30
] sp      0x80064400
] gp      0x8005e800
] tp      0x00000000
] t0      0xffffff7f
] t1      0x8000faaa
] t2      0xffffffff
] s0      0x8006d7a2
] s1      0x8006c780
] a0      0x00000012
] a1      0x80055110
] a2      0x8006c960
] a3      0x00000003
] a4      0x80010a84
] a5      0x8000bca0
] a6      0xfff9e4fe
] a7      0x8000bca0
] s2      0x8000bca0
] s3      0x800644c0
] s4      0x00000001
] s5      0x800671e0
] s6      0x8006c960
] s7      0x8006ba04
] s8      0x8006c780
] s9      0x8006cdf0
] s10     0x8006ce40
] s11     0x80064470
] t3      0x2e003839
] t4      0x31465341
] t5      0x4c2e0037
] t6      0x39314653
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 94/591] p:81  f:5   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl08.exe
Result: failed     Time: 0:00:01.007707 dl08.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl08.exe
] 
] 
=>  test start: libdl (RTL) 8
] *** BEGIN OF TEST libdl (RTL) 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl08/dl-load.c
] load: /dl08-o1.o
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x80010894
] ra      0x8000f940
] sp      0x80066410
] gp      0x80060800
] tp      0x00000000
] t0      0xffffff7f
] t1      0x8000f8ba
] t2      0xffffffff
] s0      0x8006fbd2
] s1      0x8006ebd0
] a0      0x00000012
] a1      0x80057618
] a2      0x8006ed70
] a3      0x00000003
] a4      0x80010894
] a5      0x8000bab0
] a6      0xfff9bede
] a7      0x8000bab0
] s2      0x8000bab0
] s3      0x800664d0
] s4      0x00000001
] s5      0x800691d0
] s6      0x8006ed70
] s7      0x8006d9f4
] s8      0x8006ebd0
] s9      0x8006f200
] s10     0x8006f240
] s11     0x80066480
] t3      0x0000015b
] t4      0x00000000
] t5      0x00006801
] t6      0x00000156
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 95/591] p:81  f:6   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl09.exe
Result: failed     Time: 0:00:01.008873 dl09.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/dl09.exe
] 
] 
=>  test start: libdl (RTL) 9
] *** BEGIN OF TEST libdl (RTL) 9 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl09/dl-load.c
] load: /dl09-o1.o
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x80007880
] mcause  0x00000004
] mepc    0x800109bc
] ra      0x8000fa68
] sp      0x8005f380
] gp      0x80059800
] tp      0x00000000
] t0      0xffffff7f
] t1      0x8000f9e2
] t2      0xffffffff
] s0      0x8006883a
] s1      0x80067780
] a0      0x00000012
] a1      0x80050038
] a2      0x80067960
] a3      0x00000003
] a4      0x800109bc
] a5      0x8000bbd8
] a6      0xfffa339e
] a7      0x8000bbd8
] s2      0x8000bbd8
] s3      0x8005f440
] s4      0x00000001
] s5      0x800621e0
] s6      0x80067960
] s7      0x80066a04
] s8      0x80067780
] s9      0x80067df0
] s10     0x80067e40
] s11     0x8005f3f0
] t3      0x31465341
] t4      0x4c2e0035
] t5      0x39314653
] t6      0x414c2e00
] fcsr    0x00000000
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 96/591] p:81  f:7   u:0   e:0   I:0   B:3   t:1   i:0   W:0   | riscv32/rv32imafdc: dl10.exe
 <<skipping passes>>
[108/591] p:91  f:7   u:1   e:0   I:0   B:3   t:2   i:0   W:0   | riscv32/rv32imafdc: malloc04.exe
error: spike.cfg:58: execute failed: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/malloctest.exe: exit-code:255
[109/591] p:92  f:7   u:1   e:0   I:0   B:3   t:2   i:0   W:0   | riscv32/rv32imafdc: malloctest.exe
Result: failed     Time: 0:02:47.352842 malloctest.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/libtests/malloctest.exe
] 
] 
=>  test start: MALLOCTEST
] *** BEGIN OF TEST MALLOCTEST ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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: 0x8003f260 != realloc(0x8003f300,45)
] realloc - failed non-in place: realloc(0x8003f300,64) = 0x8003f300
] 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
] TA5  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 85 bytes
] TA3  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 31 bytes
] TA1  - rtems_clock_get_tod - 09:00:18   12/31/1988
] mallocing 443 bytes
] TA4  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 507 bytes
] TA2  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 949 bytes
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 55 bytes
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 777 bytes
] TA3  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 858 bytes
] TA2  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 307 bytes
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] mallocing 594 bytes
[110/591] p:93  f:7   u:1   e:0   I:0   B:3   t:2   i:0   W:0   | riscv32/rv32imafdc: math.exe
 <<skipping passes>>
[158/591] p:135 f:8   u:4   e:0   I:0   B:3   t:4   i:0   W:0   | riscv32/rv32imafdc: psx07.exe
Result: timeout    Time: 0:03:00.455096 psx07.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psx07.exe
] 
] 
=>  test start: PSX 7
] *** BEGIN OF TEST PSX 7 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init's ID is 0x0b010001
] Init - pthread_attr_init - EINVAL (NULL attr)
] Init - pthread_attr_init - SUCCESSFUL
] Init - initialize and destroy an attribute - SUCCESSFUL
] Init - pthread_attr_destroy - EINVAL (NULL attr)
] Init - pthread_attr_destroy - EINVAL (not initialized)
] Init - pthread_create - EINVAL (attr not initialized)
] Init - pthread_create - EINVAL (stacksize too small)
] Init - pthread_create - EAGAIN (stacksize too large)
] Init - pthread_create - EINVAL (invalid inherit scheduler)
] Init - pthread_create - ENOTSUP (unsupported system contention scope)
] Init - pthread_create - SUCCESSFUL (inherit scheduler)
] Task_1 - exitting
] 
] Init - pthread_attr_setscope - EINVAL (NULL attr)
] Init - pthread_attr_setscope - ENOTSUP
] Init - pthread_attr_setscope - EINVAL (not initialized attr)
] Init - pthread_attr_setscope - EINVAL (invalid scope)
] Init - pthread_attr_setscope - SUCCESSFUL
] Init - pthread_attr_getscope - EINVAL (NULL attr)
] Init - pthread_attr_getscope - EINVAL (NULL scope)
] Init - pthread_attr_getscope - EINVAL (not initialized attr)
] Init - pthread_attr_getscope - SUCCESSFUL
] Init - current scope attribute = 0
] 
] Init - pthread_attr_setinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_setinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_setinheritsched - ENOTSUP (invalid inheritsched)
] Init - pthread_attr_setinheritsched - SUCCESSFUL
] Init - pthread_attr_getinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_getinheritsched - EINVAL (NULL inheritsched)
] Init - pthread_attr_getinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_getinheritsched - SUCCESSFUL
] Init - current inherit scheduler attribute = 1
] 
] Init - pthread_attr_setschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_setschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_setschedpolicy - ENOTSUP (invalid schedpolicy)
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_getschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_getschedpolicy - EINVAL (NULL schedpolicy)
] Init - pthread_attr_getschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_getschedpolicy - SUCCESSFUL
] Init - current scheduler policy attribute = 2
] 
] Init - pthread_attr_setstacksize - EINVAL (NULL attr)
] Init - pthread_attr_setstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_setstacksize - SUCCESSFUL (low stacksize)
] Init - pthread_attr_setstacksize - SUCCESSFUL (high stacksize)
] Init - pthread_attr_getstacksize - EINVAL (NULL attr)
] Init - pthread_attr_getstacksize - EINVAL (NULL stacksize)
] Init - pthread_attr_getstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_getstacksize - SUCCESSFUL
] Init - current stack size attribute is OK
] 
] Init - pthread_attr_setstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_setstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_setstackaddr - SUCCESSFUL
] Init - pthread_attr_getstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_getstackaddr - EINVAL (NULL stackaddr)
] Init - pthread_attr_getstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_getstackaddr - SUCCESSFUL
] Init - current stack address attribute = 0
] 
] Init - pthread_attr_setstack- EINVAL (NULL attr)
] Init - pthread_attr_setstack- EINVAL (destroyed attr)
] Init - pthread_attr_setstack- SUCCESSFUL (< min stack)
] Init - pthread_attr_setstack- SUCCESSFUL (big stack)
] Init - pthread_attr_getstack- EINVAL (NULL attr)
] Init - pthread_attr_getstack- EINVAL (destroyed attr)
] Init - pthread_attr_getstack- EINVAL (NULL stack)
] Init - pthread_attr_getstack- EINVAL (NULL stacksize)
] Init - pthread_attr_getstack- SUCCESSFUL
] 
] Init - pthread_attr_setguardsize - EINVAL (NULL attr)
] Init - pthread_attr_setguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_setguardsize - SUCCESSFUL (low guardsize)
] Init - pthread_attr_setguardsize - SUCCESSFUL (high guardsize)
] Init - pthread_attr_getguardsize - EINVAL (NULL attr)
] Init - pthread_attr_getguardsize - EINVAL (NULL guardsize)
] Init - pthread_attr_getguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_getguardsize - SUCCESSFUL
] 
] Init - pthread_attr_setdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_setdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_setdetachstate - EINVAL (invalid detachstate)
] Init - pthread_attr_setdetachstate - SUCCESSFUL
] Init - pthread_attr_getdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_getdetachstate - EINVAL (NULL detatchstate)
] Init - pthread_attr_getdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_getdetachstate - SUCCESSFUL
] Init - current detach state attribute = 1
] 
] Init - pthread_attr_getschedparam - SUCCESSFUL
] Init - sched priority      = 2
] Init - sched_ss_low_priority     = 0
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
] Init - pthread_attr_setschedparam - EINVAL (NULL attr)
] Init - pthread_attr_setschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Init - pthread_attr_getschedparam - EINVAL (NULL attr)
] Init - pthread_attr_getschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_getschedparam - EINVAL (NULL schedparam)
] 
] Init - pthread_getschedparam - EINVAL (NULL policy)
] Init - pthread_getschedparam - EINVAL (NULL schedparam)
] Init - pthread_getschedparam - ESRCH (bad thread)
] Init - pthread_getschedparam - SUCCESSFUL
] Init - policy = 1
] Init - sched priority      = 2
] Init - sched_ss_low_priority     = 2
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
] 
] Init - pthread_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_setschedparam - EINVAL (invalid priority)
] Init - pthread_setschedparam - EINVAL (invalid policy)
] Init - pthread_setschedparam - ESRCH (invalid thread)
] Init - pthread_setschedparam - EINVAL (replenish == 0)
] Init - pthread_setschedparam - EINVAL (budget == 0)
] Init - pthread_setschedparam - EINVAL (replenish < budget)
] Init - pthread_setschedparam - EINVAL (invalid priority)
] 
] Init - pthread_attr_init - SUCCESSFUL
] Init - pthread_attr_setinheritsched - EXPLICIT - SUCCESSFUL
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Time elapsed Task_2:  0 (seconds)
] Time elapsed Task_2:  1 (seconds)
] Time elapsed Task_2:  2 (seconds)
] Time elapsed Task_2:  3 (seconds)
] Time elapsed Task_2:  4 (seconds)
] Time elapsed Task_2:  5 (seconds)
] Time elapsed Task_2:  6 (seconds)
] Time elapsed Task_2:  7 (seconds)
] Time elapsed Task_2:  8 (seconds)
] Time elapsed Task_2:  9 (seconds)
] *** TIMEOUT TIMEOUT
[159/591] p:136 f:8   u:4   e:0   I:0   B:3   t:4   i:0   W:0   | riscv32/rv32imafdc: psx08.exe
 <<skipping passes>>
[234/591] p:210 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxrwlock01.exe
Result: timeout    Time: 0:03:00.557203 psxrwlock01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psxrwlock01.exe
] 
] 
=>  test start: PSXRWLOCK 1
] *** BEGIN OF TEST PSXRWLOCK 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] pthread_rwlockattr_init( NULL ) -- EINVAL
] pthread_rwlockattr_setpshared( NULL, private ) -- EINVAL
] pthread_rwlockattr_setpshared( NULL, shared ) -- EINVAL
] pthread_rwlockattr_getpshared( NULL, &p ) -- EINVAL
] pthread_rwlockattr_destroy( NULL ) -- EINVAL
] pthread_rwlockattr_setpshared( &attr, shared ) -- EINVAL
] pthread_rwlockattr_getpshared( &attr, NULL ) -- EINVAL
] pthread_rwlockattr_destroy( &attr ) -- EINVAL
] pthread_rwlockattr_setpshared( &attr, private ) -- EINVAL
] pthread_rwlockattr_init( &attr ) -- OK
] pthread_rwlockattr_setpshared( &attr, private ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) -- OK
] pthread_rwlockattr_setpshared( &attr, shared ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) -- OK
] pthread_rwlockattr_destroy( &attr ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) destroyed -- EINVAL
] pthread_rwlock_init(NULL, &attr) -- EINVAL
] pthread_rwlock_destroy(NULL) -- EINVAL
] pthread_rwlock_rdlock(NULL) -- EINVAL
] pthread_rwlock_timedrdlock( NULL, &abstime) -- EINVAL
] pthread_rwlock_timedrdlock( &rwlock, NULL) -- EINVAL
] pthread_rwlock_tryrdlock(NULL) -- EINVAL
] pthread_rwlock_wrlock(NULL) -- EINVAL
] pthread_rwlock_timedwrlock( NULL, &abstime) -- EINVAL
] pthread_rwlock_timedwrlock( &rwlock, NULL) -- EINVAL
] pthread_rwlock_trywrlock(NULL) -- EINVAL
] pthread_rwlock_unlock(NULL) -- EINVAL
] clock_gettime(CLOCK_REALTIME, &abstime) -- OK
] pthread_rwlock_destroy(BadId) -- EINVAL
] pthread_rwlock_rdlock(BadId) -- EINVAL
] pthread_rwlock_timedrdlock(BadId, &abstime) -- EINVAL
] pthread_rwlock_tryrdlock(BadId) -- EINVAL
] pthread_rwlock_wrlock(BadId) -- EINVAL
] pthread_rwlock_timedwrlock(BadId, &abstime) -- EINVAL
] pthread_rwlock_trywrlock(BadId) -- EINVAL
] pthread_rwlock_unlock(BadId) -- EINVAL
] pthread_rwlockattr_init( &attr ) -- OK
] pthread_rwlock_init( &rwlock, &attr ) -- OK
] pthread_rwlock_destroy( &rwlock ) -- OK
] pthread_rwlock_init( &rwlock, NULL ) -- OK
] pthread_rwlock_destroy( &rwlock ) -- OK
] pthread_rwlock_init( &RWLock, &attr ) -- OK
] pthread_rwlock_tryrdlock(RWLock) -- OK
] Init: pthread_create - thread 1 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] Init: pthread_create - thread 2 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] pthread_rwlock_unlock(RWLock) -- OK
] pthread_rwlock_trywrlock(RWLock) -- OK
] pthread_rwlock_tryrdlock(&RWLock) -- EBUSY
] Init: pthread_create - thread 1 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] Init: pthread_create - thread 2 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] pthread_rwlock_destroy( &RWLock ) -- EBUSY
] pthread_rwlock_unlock(RWLock) -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] 
] pthread_rwlock_trywrlock(RWLock) -- OK
] pthread_rwlock_trywrlock(&RWLock) -- EBUSY
] Init: pthread_create - thread 1 OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] Init: pthread_create - thread 2 OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] pthread_rwlock_unlock(RWLock) -- OK
] WriteThread - pthread_rwlock_wrlock(RWLock) unblocked -- OK
] WriteThread - pthread_rwlock_unlock(RWLock) -- OK
] WriteThread - pthread_rwlock_wrlock(RWLock) unblocked -- OK
] WriteThread - pthread_rwlock_unlock(RWLock) -- OK
] 
] pthread_rwlock_tryrdlock(&RWLock) -- OK
] Init: pthread_create - thread reader & writer OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] *** TIMEOUT TIMEOUT
[235/591] p:211 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxsem01.exe
 <<skipping passes>>
[238/591] p:214 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxsignal01.exe
Result: timeout    Time: 0:03:00.529099 psxsignal01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psxsignal01.exe
] 
] 
=>  test start: PSXSIGNAL 1
] *** BEGIN OF TEST PSXSIGNAL 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init's ID is 0x0b010001
] Validate signal with SIG_DFL
] Validate signal with SIG_IGN
] Init: Unblock SIGUSR1 SIGFPE SIGILL SIGSEGV
] Init: signal return value verified
] Init: send SIGUSR1 to process
] Signal: 25 caught by 0xb010001 (1)
] Init: send SIGFPE to process
] Handler_1: Signal: 8 caught by 0xb010001 (2)
] Init: send SIGILL to process
] Handler_1: Signal: 4 caught by 0xb010001 (3)
] *** TIMEOUT TIMEOUT
[239/591] p:215 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxsignal02.exe
 <<skipping passes>>
[249/591] p:225 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxstat.exe
Result: timeout    Time: 0:03:00.551960 psxstat.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psxstat.exe
] 
] 
=>  test start: PSXSTAT
] *** BEGIN OF TEST PSXSTAT ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --->Current Time:  - rtems_clock_get_tod - 09:00:00   12/31/1988
] Making directory /my_mount_point/dir1\\//
] Making directory /my_mount_point/dir2
] Making directory /my_mount_point/dir3
] Making directory /my_mount_point/dir4
] Making directory /my_mount_point/dir1/dir1
] Making directory /./././my_mount_point/dir1/ dir1
] Making directory /./././my_mount_point/links
] Making directory ///my_mount_point/dir1/dir1/../../dir1/../symlinks/////
] 
] Making file /////my_mount_point/dir1/\//file1
] Making file /my_mount_point/dir1/file2
] Making file /my_mount_point/dir1/file3
] Making file /my_mount_point/dir1/file4
] Making file /my_mount_point/dir1/dir1/file1
] Making file ../../..//my_mount_point/dir1/./././dir1/ file1
] Making file main.c
] 
] Making file dir1/dir1/../../links/dir1
] Making file links/dir2
] Making file links/dir3
] Making file links/dir4
] Making file links/dir1_dir1
] Making file links/dir1_ dir1
] Making file links/../links/../links/links
] 
] Making file links/dir1_file1
] Making file links/dir1_file2
] Making file links/dir1_file3
] Making file links/dir1_file4
] Making file links/dir1_dir1_f1
] Making file links/dir1_dir1 f1
] 
] Making file links/links/links/links_dir1
] Making file links//links_dir2
] Making file links//links_dir3
] Making file links//links_dir4
] Making file links//links_dir1_d1
] Making file links//links_dir1 d1
] Making file links//links_links
] 
] Making file links///links_d1_file1
] Making file links///links_d1_file2
] Making file links///links_d1_file3
] Making file links///links_d1_file4
] Making file links///links_d1_d1_f1
] Making file links///links_r1_d1 f1
] 
] Doing the stat() on all the good absolute paths
] stat( /my_mount_point/dev ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031730
] ...st_mode    40700
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:00 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( ////my_mount_point/dir1/\//file1\\// ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1/\\/file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1/file3/////\\\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1/dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( /my_mount_point/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1680
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/dir2//////\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/dir1/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/dir1/ dir1///\\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/\/\/\/\/\/\/links\/\/\/\/\/\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800319d0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    7280
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] 
] Doing the stat() on all the good relative paths
] stat( dev ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031730
] ...st_mode    40700
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:00 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir1/\//file1\\// ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1/\\/file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1/file3/////\\\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1/dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1680
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir2//////\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir1/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( dir1/ dir1///\\ ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( main.c ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031d30
] ...st_mode    100004
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:00 1988
] ...st_blksize 80
] ...st_blocks  0
] 
] chdir to dev
] 
] stat relative paths that are now bad
] stat( dev ) returned : No such file or directory
] stat( dir1/\//file1\\// ) returned : No such file or directory
] stat( dir1/\\/file2 ) returned : No such file or directory
] stat( dir1/file3/////\\\ ) returned : No such file or directory
] stat( dir1/file4 ) returned : No such file or directory
] stat( dir1/dir1/file1 ) returned : No such file or directory
] stat( dir1/dir1/ file1 ) returned : No such file or directory
] stat( dir1 ) returned : No such file or directory
] stat( dir2//////\ ) returned : No such file or directory
] stat( dir3 ) returned : No such file or directory
] stat( dir4 ) returned : No such file or directory
] stat( dir1/dir1 ) returned : No such file or directory
] stat( dir1/ dir1///\\ ) returned : No such file or directory
] stat( main.c ) returned : No such file or directory
] 
] chdir to ../links
] Doing the stat() on good links
] 
] stat( dir1/dir1/../../links/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1680
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir1_dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir1_ dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/../links/../links/links ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800319d0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    7280
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links/dir1_file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/dir1_file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/dir1_file3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/dir1_file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/dir1_dir1_f1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/dir1_dir1 f1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links/links/links/links_dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1680
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir1_d1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir1 d1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_links ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800319d0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    7280
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links///links_d1_file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links///links_d1_file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links///links_d1_file3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links///links_d1_file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links///links_d1_d1_f1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] stat( links///links_r1_d1 f1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] chmod of /my_mount_point/dir1/dir1 to Read/Write
] 
] Doing the stat() on all the bad paths
] stat( /my_mount_point/links/ENAMETOOLONG____________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________ ) returned : No such file or directory
] stat( /my_mount_point/dir1/file4/NOTADIR ) returned : Not a directory
] stat( /my_mount_point/dir1/dir1/EACCES__ ) returned : Permission denied
] Making file /my_mount_point/links/ENAMETOOLONG____________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________ : File or path name too long
] Making file /my_mount_point/dir1/file4/NOTADIR : Not a directory
] Making file /my_mount_point/dir1/dir1/EACCES__ : Permission denied
] 
] Return /my_mount_point/dir1/dir1 to RWX
] Making file /my_mount_point/symlinks/a_file_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/a_dir_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/a_link_symlink
] Verify with readlink
] Making file ../symlinks/no_file
] Verify with readlink
] Making file /my_mount_point/symlinks/a_dir_symlink/a_file_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/links
] Verify with readlink
] stat( /my_mount_point/symlinks/a_file_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks  0
] lstat( /my_mount_point/symlinks/a_file_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032760
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    33
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/symlinks/a_dir_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1960
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] lstat( /my_mount_point/symlinks/a_dir_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800327e0
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    24
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/symlinks/a_link_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1960
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] lstat( /my_mount_point/symlinks/a_link_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032860
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    28
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( ../symlinks/no_file ) returned : No such file or directory
] lstat( ../symlinks/no_file ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800328e0
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    7
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( /my_mount_point/symlinks/a_dir_symlink/a_file_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1960
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] lstat( /my_mount_point/symlinks/a_dir_symlink/a_file_symlink ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032940
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    38
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] Making file 0001
] Verify with readlink
] Making file 0002
] Verify with readlink
] Making file 0003
] Verify with readlink
] Making file 0004
] Verify with readlink
] Making file 0005
] Verify with readlink
] Making file 0006
] Verify with readlink
] Making file 0007
] Verify with readlink
] Making file 0008
] Verify with readlink
] Making file 0009
] Verify with readlink
] stat( 0001 ) returned : No such file or directory
] lstat( 0001 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032a40
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    9
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0002 ) returned : No such file or directory
] lstat( 0002 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032aa0
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0003 ) returned : No such file or directory
] lstat( 0003 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032b00
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0004 ) returned : No such file or directory
] lstat( 0004 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032b60
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0005 ) returned : No such file or directory
] lstat( 0005 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032bc0
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0006 ) returned : No such file or directory
] lstat( 0006 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032c20
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0007 ) returned : No such file or directory
] lstat( 0007 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032c80
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0008 ) returned : No such file or directory
] lstat( 0008 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032ce0
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( 0009 ) returned : No such file or directory
] lstat( 0009 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80032d40
] ...st_mode    120777
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    4
] ...st_atime   Sat Dec 31 09:00:15 1988
] ...st_mtime   Sat Dec 31 09:00:15 1988
] ...st_ctime   Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks  0
] chdir to a file should fail with ENOTDIR
] Verify RWX permission on /my_mount_point/dir1\\// via access
] chmod of /my_mount_point/dir1\\// to Read/Write
] chmod fred should fail with ENOENT
] Create under /my_mount_point/dir1\\// should fail with EACCES
] chdir to /my_mount_point/dir1/dir1 should fail with EACCES
] mkdir /my_mount_point/dir1\\///BADNAME should fail with EACCESS
] 
] /my_mount_point/dir1\\// Should exist ( access )
] 
] /my_mount_point/dir1\\// Should have read  permission( access )
] 
] /my_mount_point/dir1\\// Should have write permission( access )
] 
] /my_mount_point/dir1\\// Should not have execute permission( access )
] 
] Restore /my_mount_point/dir1\\// to RWX
] chdir to /my_mount_point 
] Remove /./././my_mount_point/dir1/ dir1
] stat( /./././my_mount_point/dir1/ dir1 ) returned : No such file or directory
] stat( links/dir1_ dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   2
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] stat( links//links_dir1 d1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031970
] ...st_mode    40700
] ...st_nlink   2
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] Chdir to links/dir1_ dir1
] Chdir to .. should fail with ENOENT
] mkdir ../t should fail with ENOENT
] mkdir t
] chdir to /my_mount_point
] rmdir links/dir1_ dir1
] unlink links//links_dir1 d1 should fail with ENOTEMPTY
] rmdir links//links_dir1 d1/t
] unlink links//links_dir1 d1
] Attempting to mount IMFS file system at /dir1/my_mount_point 
] rmdir /dir1/my_mount_point should fail with EBUSY
] Unmount /my_mount_point/dir1/my_mount_point
] chmod of /////my_mount_point/dir1/\//file1 to group and other execute
] Open /////my_mount_point/dir1/\//file1 for write should fail with EACCES
] chmod of /my_mount_point/dir4 to User Execute and Read
] Mkdir of /my_mount_point/dir4/NewFile should fail with EACCES
] Making too many hard links.
] Making file /LinkName1
] Making file /LinkName2
] Making file /LinkName3
] Making file /LinkName4
] Making file /LinkName5
] Making file /LinkName6
] Making file /LinkName7
] Making file /LinkName8
] chdir to /my_mount_point 
] Change group of /////my_mount_point/dir1/\//file1
] stat( /////my_mount_point/dir1/\//file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100011
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /////my_mount_point/dir1/\//file1
] stat( /////my_mount_point/dir1/\//file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031a90
] ...st_mode    100011
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file2
] stat( /my_mount_point/dir1/file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file2
] stat( /my_mount_point/dir1/file2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b00
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file3
] stat( /my_mount_point/dir1/file3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file3
] stat( /my_mount_point/dir1/file3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031b70
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file4
] stat( /my_mount_point/dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file4
] stat( /my_mount_point/dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031be0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/dir1/file1
] stat( /my_mount_point/dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/dir1/file1
] stat( /my_mount_point/dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031c50
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of ../../..//my_mount_point/dir1/./././dir1/ file1
] stat( ../../..//my_mount_point/dir1/./././dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of ../../..//my_mount_point/dir1/./././dir1/ file1
] stat( ../../..//my_mount_point/dir1/./././dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031cc0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of main.c
] stat( main.c ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031d30
] ...st_mode    100004
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of main.c
] stat( main.c ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031d30
] ...st_mode    100004
] ...st_nlink   1
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of dir1/dir1/../../links/dir1
] stat( dir1/dir1/../../links/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    1960
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:20 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of dir1/dir1/../../links/dir1
] stat( dir1/dir1/../../links/dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031790
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    1960
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:20 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change group of links/dir2
] stat( links/dir2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of links/dir2
] stat( links/dir2 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800317f0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change group of links/dir3
] stat( links/dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of links/dir3
] stat( links/dir3 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031850
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change group of links/dir4
] stat( links/dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40500
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of links/dir4
] stat( links/dir4 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800318b0
] ...st_mode    40500
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change group of links/dir1_dir1
] stat( links/dir1_dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of links/dir1_dir1
] stat( links/dir1_dir1 ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     80031910
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    560
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change group of links/dir1_ dir1
] stat( links/dir1_ dir1 ) returned : No such file or directory
] Change owner of links/dir1_ dir1
] stat( links/dir1_ dir1 ) returned : No such file or directory
] Change group of links/../links/../links/links
] stat( links/../links/../links/links ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800319d0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    9240
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] Change owner of links/../links/../links/links
] stat( links/../links/../links/links ) returned 
] ...st_dev     (0x80000000:0x40018b38)
] ...st_ino     800319d0
] ...st_mode    40700
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    9240
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:30 1988
] ...st_blksize 0
] ...st_blocks  0
] *** TIMEOUT TIMEOUT
[250/591] p:226 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxstrsignal01.exe
 <<skipping passes>>
[252/591] p:228 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxthreadname01.exe
error: spike.cfg:58: execute failed: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psxtimer01.exe: exit-code:34
[253/591] p:229 f:8   u:4   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32imafdc: psxtime.exe
[254/591] p:229 f:8   u:4   e:0   I:0   B:3   t:6   i:0   W:0   | riscv32/rv32imafdc: psxtimer01.exe
Result: failed     Time: 0:02:23.437997 psxtimer01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/psxtests/psxtimer01.exe
] 
] 
=>  test start: PSXTIMER 1
] *** BEGIN OF TEST PSXTIMER 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] starting C again with 0.5 second periodicity
] Executing task C with count =  6 Fri Jan  1 00:00:25 1988
] Executing task C with count =  5 Fri Jan  1 00:00:26 1988
] Executing task C with count =  4 Fri Jan  1 00:00:26 1988
] *** FAILED *** (tohost = 34)
[255/591] p:229 f:8   u:4   e:0   I:0   B:3   t:7   i:0   W:0   | riscv32/rv32imafdc: psxtimer02.exe
 <<skipping passes>>
[330/591] p:300 f:9   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32imafdc: ticker.exe
Result: timeout    Time: 0:03:00.426090 ticker.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/samples/ticker.exe
] 
] 
=>  test start: CLOCK TICK
] *** BEGIN OF TEST CLOCK TICK ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] TA2  - rtems_clock_get_tod - 09:00:19   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] *** TIMEOUT TIMEOUT
[331/591] p:301 f:9   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32imafdc: unlimited.exe
[332/591] p:302 f:9   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32imafdc: sp01.exe
Result: timeout    Time: 0:03:00.446445 sp01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp01.exe
] 
] 
=>  test start: SP 1
] *** BEGIN OF TEST SP 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] 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
] *** TIMEOUT TIMEOUT
[333/591] p:303 f:9   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32imafdc: sp02.exe
 <<skipping passes>>
[335/591] p:305 f:9   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32imafdc: sp04.exe
Result: timeout    Time: 0:03:00.610112 sp04.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp04.exe
] 
] 
=>  test start: SP 4
] *** BEGIN OF TEST SP 4 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] *** TIMEOUT TIMEOUT
[336/591] p:305 f:9   u:6   e:0   I:0   B:3   t:9   i:0   W:0   | riscv32/rv32imafdc: sp05.exe
 <<skipping passes>>
[341/591] p:308 f:9   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32imafdc: sp12.exe
Result: timeout    Time: 0:03:00.384339 sp12.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp12.exe
] 
] 
=>  test start: SP 12
] *** BEGIN OF TEST SP 12 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] INIT - Forward priority queue test
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] INIT - Backward priority queue test
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] INIT - Binary Semaphore and Priority Inheritance Test
] INIT - rtems_semaphore_create - allocated binary semaphore
] INIT - rtems_semaphore_release - allocated binary semaphore
] INIT - rtems_semaphore_delete - allocated binary semaphore
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] Set priority of self while holding resource
] PRI5 - rtems_task_suspend - until all priority tasks blocked
] PDRV - priority of PRI5 is 8
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - change priority of PRI5 from 8 to 9
] PDRV - priority of PRI5 is 8
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 8
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 7
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 6
] PDRV - rtems_task_resume - PRI5
] PRI5 - rtems_task_delete - all tasks waiting on SM2
] PRI5 - rtems_semaphore_obtain - nested
] PRI5 - rtems_semaphore_release - nested
] PRI5 - rtems_semaphore_release - restore priority
] PRI5 - priority of PRI5 is 9
] TA1 - rtems_semaphore_ident - smid => 1a010001
] TA1 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - got SM2
] TA1 - rtems_semaphore_obtain - wait forever on SM3
] TA1 - got SM3
] TA1 - rtems_semaphore_obtain - get SM1 - RTEMS_NO_WAIT
] TA1 - got SM1
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA2 - rtems_semaphore_obtain - wait forever on SM1
] TA3 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - rtems_semaphore_release - release SM1
] TA1 - rtems_semaphore_obtain - waiting for SM1 with 10 second timeout
] TA2 - got SM1
] TA2 - rtems_semaphore_release - release SM1
] TA2 - rtems_task_set_priority - make self highest priority task
] TA2 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - got SM1
] TA1 - rtems_semaphore_release - release SM2
] TA2 - got SM2
] TA2 - rtems_semaphore_release - release SM2
] TA2 - rtems_task_exit
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA3 - got SM2
] TA3 - rtems_semaphore_release - release SM2
] TA3 - rtems_semaphore_obtain - wait forever on SM3
] *** TIMEOUT TIMEOUT
[342/591] p:309 f:9   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32imafdc: sp13.exe
 <<skipping passes>>
[348/591] p:315 f:9   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32imafdc: sp19.exe
Result: timeout    Time: 0:03:00.550726 sp19.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp19.exe
] 
] 
=>  test start: SP 19
] *** BEGIN OF TEST SP 19 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] *** TIMEOUT TIMEOUT
[349/591] p:316 f:9   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32imafdc: sp20.exe
Result: timeout    Time: 0:03:00.551192 sp20.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp20.exe
] 
] 
=>  test start: SP 20
] *** BEGIN OF TEST SP 20 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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)
] *** TIMEOUT TIMEOUT
[350/591] p:317 f:9   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32imafdc: sp2038.exe
 <<skipping passes>>
[354/591] p:320 f:9   u:6   e:0   I:0   B:3   t:12  i:0   W:0   | riscv32/rv32imafdc: sp24.exe
Result: timeout    Time: 0:03:00.353400 sp24.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp24.exe
] 
] 
=>  test start: SP 24
] *** BEGIN OF TEST SP 24 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] 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
[355/591] p:321 f:9   u:6   e:0   I:0   B:3   t:12  i:0   W:0   | riscv32/rv32imafdc: sp25.exe
 <<skipping passes>>
[360/591] p:324 f:9   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32imafdc: sp30.exe
Result: timeout    Time: 0:03:00.451625 sp30.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp30.exe
] 
] 
=>  test start: SP 30
] *** BEGIN OF TEST SP 30 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] *** TIMEOUT TIMEOUT
[361/591] p:325 f:9   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32imafdc: sp31.exe
[362/591] p:325 f:9   u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32imafdc: sp32.exe
Result: timeout    Time: 0:03:00.445699 sp32.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/sp32.exe
] 
] 
=>  test start: SP 32
] *** BEGIN OF TEST SP 32 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] *** TIMEOUT TIMEOUT
[363/591] p:326 f:9   u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32imafdc: sp33.exe
 <<skipping passes>>
[408/591] p:369 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spcbssched01.exe
Result: timeout    Time: 0:03:00.500250 spcbssched01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spcbssched01.exe
] 
] 
=>  test start: SPCBSSCHED 1
] *** BEGIN OF TEST SPCBSSCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] 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
] *** TIMEOUT TIMEOUT
[409/591] p:370 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spcbssched02.exe
[410/591] p:371 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spcbssched03.exe
Result: timeout    Time: 0:03:00.547547 spcbssched03.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spcbssched03.exe
] 
] 
=>  test start: SPCBSSCHED 3
] *** BEGIN OF TEST SPCBSSCHED 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] P3-F ticks:32
] P1-S ticks:32
] P1-F ticks:42
] P4-S ticks:42
] P4-F ticks:52
] P2-S ticks:52
] P1-S ticks:62
] P1-F ticks:72
] P2-F ticks:72
] P3-S ticks:72
] P3-F ticks:82
] AT6-S ticks:82
] P6-F ticks:87
] Killing task 6
] AT5-S ticks:87
] P1-S ticks:92
] P1-F ticks:102
] P2-S ticks:102
] P2-F ticks:112
] P4-S ticks:112
] P1-S ticks:122
] P1-F ticks:132
] P2-S ticks:132
] P2-F ticks:142
] P3-S ticks:142
] P1-S ticks:152
] P1-F ticks:162
] P3-F ticks:162
] P4-F ticks:162
] P2-S ticks:172
] P1-S ticks:182
] P1-F ticks:192
] P2-F ticks:192
] P3-S ticks:192
] P3-F ticks:202
] P4-S ticks:202
] P1-S ticks:212
] P1-F ticks:222
] P2-S ticks:222
] P2-F ticks:232
] P3-S ticks:232
] P1-S ticks:242
] P1-F ticks:252
] P2-S ticks:252
] P2-F ticks:262
] P3-F ticks:262
] Signal overrun, fixing the task
] P1-S ticks:272
] P1-F ticks:282
] P3-S ticks:282
] P2-S ticks:292
] P1-S ticks:302
] P1-F ticks:312
] P2-F ticks:312
] P3-F ticks:312
] P3-S ticks:322
] P1-S ticks:332
] P1-F ticks:342
] P2-S ticks:342
] P2-F ticks:352
] P3-F ticks:352
] P1-S ticks:362
] P1-F ticks:372
] P2-S ticks:372
] P2-F ticks:382
] P1-S ticks:392
] P1-F ticks:402
] P2-S ticks:412
] P1-S ticks:422
] P1-F ticks:432
] P2-F ticks:432
] P3-S ticks:432
] P1-S ticks:452
] P1-F ticks:462
] P2-S ticks:462
] P2-F ticks:472
] P3-F ticks:472
] P1-S ticks:482
] P1-F ticks:492
] P2-S ticks:492
] P2-F ticks:502
] P1-S ticks:512
] P1-F ticks:522
] P3-S ticks:522
] P2-S ticks:532
] P1-S ticks:542
] P1-F ticks:552
] P2-F ticks:552
] P3-F ticks:552
] P1-S ticks:572
] P1-F ticks:582
] P2-S ticks:582
] P2-F ticks:592
] P1-S ticks:602
] P1-F ticks:612
] P2-S ticks:612
] P2-F ticks:622
] P3-S ticks:622
] P1-S ticks:632
] P1-F ticks:642
] P3-F ticks:642
] P2-S ticks:652
] P1-S ticks:662
] P1-F ticks:672
] P2-F ticks:672
] P1-S ticks:692
] P1-F ticks:702
] P2-S ticks:702
] P2-F ticks:712
] P1-S ticks:722
] P1-F ticks:732
] P2-S ticks:732
] P3-S ticks:732
] *** TIMEOUT TIMEOUT
[411/591] p:372 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spchain.exe
 <<skipping passes>>
[418/591] p:379 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spcontext01.exe
Result: timeout    Time: 0:03:00.475935 spcontext01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spcontext01.exe
] 
] 
=>  test start: SPCONTEXT 1
] *** BEGIN OF TEST SPCONTEXT 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Test configuration N N N... done
] Test configuration N N F... done
] Test configuration N F N... done
] Test configuration N F F... done
] Test configuration F N N... done
] *** TIMEOUT TIMEOUT
] Test configuration F N F... 
] Test configuration F N F... 
[419/591] p:380 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spcoverage.exe
 <<skipping passes>>
[423/591] p:384 f:9   u:6   e:0   I:0   B:3   t:17  i:0   W:0   | riscv32/rv32imafdc: spedfsched01.exe
Result: timeout    Time: 0:03:00.517663 spedfsched01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spedfsched01.exe
] 
] 
=>  test start: SPEDFSCHED 1
] *** BEGIN OF TEST SPEDFSCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
] 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
] *** TIMEOUT TIMEOUT
[424/591] p:384 f:9   u:6   e:0   I:0   B:3   t:18  i:0   W:0   | riscv32/rv32imafdc: spedfsched02.exe
[425/591] p:384 f:9   u:6   e:0   I:0   B:3   t:19  i:0   W:0   | riscv32/rv32imafdc: spedfsched03.exe
Result: timeout    Time: 0:03:00.418575 spedfsched03.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spedfsched03.exe
] 
] 
=>  test start: SPEDFSCHED 3
] *** BEGIN OF TEST SPEDFSCHED 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] P1-S ticks:32
] P1-F ticks:42
] P3-F ticks:42
] P4-S ticks:42
] P2-S ticks:52
] P2-F ticks:62
] P1-S ticks:62
] P1-F ticks:72
] P4-F ticks:72
] P3-S ticks:72
] P3-F ticks:82
] AT6-S ticks:82
] P6-F ticks:87
] Killing task 6
] AT5-S ticks:87
] P1-S ticks:92
] P1-F ticks:102
] P2-S ticks:102
] P2-F ticks:112
] P4-S ticks:112
] P1-S ticks:122
] P1-F ticks:132
] P3-S ticks:132
] P3-F ticks:142
] P2-S ticks:142
] P2-F ticks:152
] P4-F ticks:152
] P1-S ticks:152
] P1-F ticks:162
] P2-S ticks:172
] P2-F ticks:182
] P1-S ticks:182
] P1-F ticks:192
] P3-S ticks:192
] P3-F ticks:202
] P4-S ticks:202
] P1-S ticks:212
] P1-F ticks:222
] P4-F ticks:222
] P2-S ticks:222
] P2-F ticks:232
] P3-S ticks:232
] P3-F ticks:242
] P1-S ticks:242
] P1-F ticks:252
] P2-S ticks:252
] P2-F ticks:262
] P4-S ticks:262
] P1-S ticks:272
] P1-F ticks:282
] P4-F ticks:282
] P3-S ticks:282
] P3-F ticks:292
] P2-S ticks:292
] P2-F ticks:302
] P1-S ticks:302
] P1-F ticks:312
] P5-F ticks:312
] Killing task 5
] P3-S ticks:322
] P1-S ticks:332
] P1-F ticks:342
] P3-F ticks:342
] P2-S ticks:342
] P2-F ticks:352
] P4-S ticks:352
] P4-F ticks:362
] P1-S ticks:362
] P1-F ticks:372
] P2-S ticks:372
] P2-F ticks:382
] P3-S ticks:382
] P3-F ticks:392
] P1-S ticks:392
] P1-F ticks:402
] P4-S ticks:402
] P2-S ticks:412
] P2-F ticks:422
] P1-S ticks:422
] P1-F ticks:432
] P4-F ticks:432
] P3-S ticks:432
] P3-F ticks:442
] P1-S ticks:452
] P1-F ticks:462
] P2-S ticks:462
] P2-F ticks:472
] P3-S ticks:472
] P1-S ticks:482
] P1-F ticks:492
] P3-F ticks:492
] P4-S ticks:492
] P4-F ticks:502
] P2-S ticks:502
] P2-F ticks:512
] P1-S ticks:512
] P1-F ticks:522
] P3-S ticks:522
] P3-F ticks:532
] P2-S ticks:532
] P2-F ticks:542
] P1-S ticks:542
] P1-F ticks:552
] P4-S ticks:552
] P4-F ticks:562
] P1-S ticks:572
] P1-F ticks:582
] P2-S ticks:582
] P2-F ticks:592
] P3-S ticks:592
] P3-F ticks:602
] P1-S ticks:602
] P1-F ticks:612
] P2-S ticks:612
] P2-F ticks:622
] P4-S ticks:622
] *** TIMEOUT TIMEOUT
[426/591] p:385 f:9   u:6   e:0   I:0   B:3   t:19  i:0   W:0   | riscv32/rv32imafdc: spedfsched04.exe
 <<skipping passes>>
[466/591] p:423 f:9   u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical01.exe
Result: failed     Time: 0:00:01.009532 spintrcritical01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical01.exe
] 
] 
=>  test start: SPINTRCRITICAL 1
] *** BEGIN OF TEST SPINTRCRITICAL 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[467/591] p:424 f:9   u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical02.exe
Result: failed     Time: 0:00:01.009716 spintrcritical02.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical02.exe
] 
] 
=>  test start: SPINTRCRITICAL 2
] *** BEGIN OF TEST SPINTRCRITICAL 2 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[468/591] p:424 f:10  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical03.exe
Result: failed     Time: 0:00:01.010954 spintrcritical03.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical03.exe
] 
] 
=>  test start: SPINTRCRITICAL 3
] *** BEGIN OF TEST SPINTRCRITICAL 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[469/591] p:424 f:11  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical04.exe
Result: failed     Time: 0:00:01.009863 spintrcritical04.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical04.exe
] 
] 
=>  test start: SPINTRCRITICAL 4
] *** BEGIN OF TEST SPINTRCRITICAL 4 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[470/591] p:424 f:12  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical05.exe
Result: failed     Time: 0:00:01.009860 spintrcritical05.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical05.exe
] 
] 
=>  test start: SPINTRCRITICAL 5
] *** BEGIN OF TEST SPINTRCRITICAL 5 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[471/591] p:424 f:13  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical06.exe
 <<skipping passes>>
[473/591] p:425 f:14  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical08.exe
Result: failed     Time: 0:00:01.010610 spintrcritical08.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical08.exe
] 
] 
=>  test start: SPINTRCRITICAL 8
] *** BEGIN OF TEST SPINTRCRITICAL 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate period ending while blocking
] Init - rtems_rate_monotonic_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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[474/591] p:426 f:14  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical09.exe
[475/591] p:426 f:15  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical10.exe
Result: failed     Time: 0:00:01.010522 spintrcritical10.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical10.exe
] 
] 
=>  test start: SPINTRCRITICAL 10
] *** BEGIN OF TEST SPINTRCRITICAL 10 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[476/591] p:427 f:15  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical11.exe
 <<skipping passes>>
[481/591] p:431 f:16  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical16.exe
Result: failed     Time: 0:00:01.009727 spintrcritical16.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical16.exe
] 
] 
=>  test start: SPINTRCRITICAL 16
] *** BEGIN OF TEST SPINTRCRITICAL 16 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[482/591] p:433 f:16  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical18.exe
[483/591] p:433 f:16  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical20.exe
Result: failed     Time: 0:00:01.021236 spintrcritical20.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical20.exe
] 
] 
=>  test start: SPINTRCRITICAL 20
] *** BEGIN OF TEST SPINTRCRITICAL 20 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical20/init.c: 149 ctx->thread_queue_was_null
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[484/591] p:433 f:17  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical21.exe
Result: failed     Time: 0:00:01.015815 spintrcritical21.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical21.exe
] 
] 
=>  test start: SPINTRCRITICAL 21
] *** BEGIN OF TEST SPINTRCRITICAL 21 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[485/591] p:434 f:18  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical22.exe
Result: failed     Time: 0:00:01.010182 spintrcritical22.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical22.exe
] 
] 
=>  test start: SPINTRCRITICAL 22
] *** BEGIN OF TEST SPINTRCRITICAL 22 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[486/591] p:434 f:18  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical23.exe
Result: failed     Time: 0:00:01.029547 spintrcritical23.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical23.exe
] 
] 
=>  test start: SPINTRCRITICAL 23
] *** BEGIN OF TEST SPINTRCRITICAL 23 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[487/591] p:434 f:19  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: spintrcritical24.exe
Result: failed     Time: 0:00:01.010886 spintrcritical24.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spintrcritical24.exe
] 
] 
=>  test start: SPINTRCRITICAL 24
] *** BEGIN OF TEST SPINTRCRITICAL 24 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical24/init.c: 118 ctx->append_count > 0
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[488/591] p:434 f:21  u:6   e:0   I:0   B:3   t:21  i:0   W:0   | riscv32/rv32imafdc: splinkersets01.exe
 <<skipping passes>>
[518/591] p:461 f:22  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: spsimplesched01.exe
Result: timeout    Time: 0:03:00.660963 spsimplesched01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spsimplesched01.exe
] 
] 
=>  test start: SPSIMPLESCHED 1
] *** BEGIN OF TEST SPSIMPLESCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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
[519/591] p:462 f:22  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: spsimplesched02.exe
 <<skipping passes>>
[525/591] p:468 f:22  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: spsysinit01.exe
Result: failed     Time: 0:00:01.009996 spsysinit01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/sptests/spsysinit01.exe
] sysinit: begin
] sysinit: stack pointer: 0x8002b3e0
] sysinit: memory area 0: begin = 0x8002b400, size = 0x03fd4c00
] sysinit: DIRTY_MEMORY: done
] sysinit: ISR_STACK: done
] sysinit: memory area 0: free begin = 0x8002f7c6, free size = 0x03fd083a
] 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.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), 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.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[526/591] p:468 f:23  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: spsyslock01.exe
 <<skipping passes>>
[588/591] p:530 f:23  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: tmfine01.exe
Result: timeout    Time: 0:03:00.436351 tmfine01.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/tmtests/tmfine01.exe
] 
] 
=>  test start: TMFINE 1
] *** BEGIN OF TEST TMFINE 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] <TestTimeFine01>
]   <SelfEvent activeWorker="1">
]     <Counter worker="0">7677945</Counter>
]   </SelfEvent>
]   <AllToOneEvent activeWorker="1">
]     <Counter worker="0">7455244</Counter>
]   </AllToOneEvent>
]   <OneMutex activeWorker="1">
]     <Counter worker="0">7238863</Counter>
]   </OneMutex>
]   <ManyMutex activeWorker="1">
]     <Counter worker="0">7239223</Counter>
]   </ManyMutex>
]   <SelfMsg activeWorker="1">
]     <Counter worker="0">3222599</Counter>
]   </SelfMsg>
]   <ManyToOneMsg activeWorker="1">
]     <Counter worker="0">3212318</Counter>
]   </ManyToOneMsg>
]   <ManySysLockMutex activeWorker="1">
]     <Counter worker="0">39958909</Counter>
]   </ManySysLockMutex>
]   <ManyClassicCeilingMutex activeWorker="1">
]     <Counter worker="0">1359086</Counter>
]   </ManyClassicCeilingMutex>
] *** TIMEOUT TIMEOUT
[589/591] p:531 f:23  u:6   e:0   I:0   B:3   t:22  i:0   W:0   | riscv32/rv32imafdc: tmonetoone.exe
Result: timeout    Time: 0:03:00.443234 tmonetoone.exe
=>  run: spike --isa=RV32IMAFDC ./riscv-rtems5/c/rv32imafdc/testsuites/tmtests/tmonetoone.exe
] 
] 
=>  test start: TMONETOONE
] *** BEGIN OF TEST TMONETOONE ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] yield
] a 1571472
] b 1571472
] event
] a 873649
] b 873649
] self-contained binary semaphore
] a 764108
] b 764107
] Classic binary semaphore (FIFO)
] a 685500
] b 685499
] Classic binary semaphore (priority)
] *** TIMEOUT TIMEOUT
[590/591] p:531 f:23  u:6   e:0   I:0   B:3   t:23  i:0   W:0   | riscv32/rv32imafdc: tmoverhd.exe
[591/591] p:532 f:23  u:6   e:0   I:0   B:3   t:23  i:0   W:0   | riscv32/rv32imafdc: tmtimer01.exe

Passed:        534
Failed:         23
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        25
Invalid:         0
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         591
Failures:
 dl01.exe
 dl02.exe
 dl05.exe
 dl06.exe
 dl07.exe
 dl08.exe
 dl09.exe
 malloctest.exe
 psxtimer01.exe
 spintrcritical01.exe
 spintrcritical02.exe
 spintrcritical03.exe
 spintrcritical04.exe
 spintrcritical05.exe
 spintrcritical08.exe
 spintrcritical10.exe
 spintrcritical16.exe
 spintrcritical20.exe
 spintrcritical21.exe
 spintrcritical23.exe
 spintrcritical22.exe
 spintrcritical24.exe
 spsysinit01.exe
User Input:
 dl10.exe
 monitor.exe
 termios.exe
 top.exe
 capture.exe
 fileio.exe
Benchmark:
 whetstone.exe
 dhrystone.exe
 linpack.exe
Timeouts:
 imfs_fstime.exe
 block08.exe
 crypt01.exe
 cpuuse.exe
 psx07.exe
 psxrwlock01.exe
 psxsignal01.exe
 psxstat.exe
 ticker.exe
 sp01.exe
 sp04.exe
 sp12.exe
 sp19.exe
 sp20.exe
 sp24.exe
 sp30.exe
 sp32.exe
 spcbssched01.exe
 spcbssched03.exe
 spcontext01.exe
 spedfsched01.exe
 spedfsched03.exe
 spsimplesched01.exe
 tmfine01.exe
 tmonetoone.exe
Average test time: 0:00:04.636451
Testing time     : 0:45:40.142665


More information about the build mailing list