[rtems-test] riscv32/rv32im: RTEMS_POSIX_API: Passed:544 Failed:21 Timeout:17 Invalid:0 Wrong:0

joel at rtems.org joel at rtems.org
Thu Mar 26 06:52:44 UTC 2020


Testing time     : 0:19:35.749690
Average test time: 0:00:01.989424

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

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

Summary
=======

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

Failures:
 spintrcritical05.exe
 spintrcritical22.exe
 spintrcritical21.exe
 spintrcritical04.exe
 dl02.exe
 spintrcritical10.exe
 spintrcritical16.exe
 spintrcritical02.exe
 spsysinit01.exe
 spintrcritical20.exe
 psxfenv01.exe
 spintrcritical03.exe
 spintrcritical08.exe
 dl05.exe
 spintrcritical23.exe
 dl06.exe
 dl08.exe
 spintrcritical24.exe
 dl09.exe
 dl07.exe
 spintrcritical01.exe
User Input:
 termios.exe
 monitor.exe
 dl10.exe
 top.exe
 fileio.exe
 capture.exe
Benchmark:
 linpack.exe
 whetstone.exe
 dhrystone.exe
Timeouts:
 psxmsgq01.exe
 crypt01.exe
 block08.exe
 sp32.exe
 sp12.exe
 sp05.exe
 sp30.exe
 sp04.exe
 spcbssched01.exe
 ticker.exe
 spsimplesched01.exe
 psxrwlock01.exe
 flashdisk01.exe
 psxtime.exe
 sp20.exe
 spedfsched01.exe
 psxstat.exe
Log
===

RTEMS Testing - Tester, 5 (9b9e0dd47fe7)
 Command Line: /home/joel/rtems-cron-5/rtems-tools//tester/rtems-test --rtems-tools=/home/joel/rtems-cron-5/tools/5 --rtems-bsp=rv32im_spike --log=run.log --mail --mail-from=joel at rtems.org --mail-to=build at rtems.org .
 Host: Linux devel.oarcorp.com 3.10.0-1062.12.1.el7.x86_64 #1 SMP Tue Feb 4 23:02:59 UTC 2020 x86_64
 Python: 2.7.5 (default, Aug  7 2019, 00:51:29) [GCC 4.8.5 20150623 (Red Hat 4.8.5-39)]
Host: Linux-3.10.0-1062.12.1.el7.x86_64-x86_64-with-centos-7.7.1908-Core (Linux devel.oarcorp.com 3.10.0-1062.12.1.el7.x86_64 #1 SMP Tue Feb 4 23:02:59 UTC 2020 x86_64 x86_64)
[  1/591] p:0   f:0   u:0   e:0   I:0   B:0   t:0   i:0   W:0   | riscv32/rv32im: dhrystone.exe
 <<skipping passes>>
[ 67/591] p:56  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: block08.exe
Result: timeout    Time: 0:03:00.249687 block08.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/block08.exe
] 
] 
=>  test start: BLOCK 8
] *** BEGIN OF TEST BLOCK 8 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TEST DISK - OK
] Test 1.1 - STARTED
] Thread #1 started
] DISK_DRV: R [0] 
] Test 1.1: Step 2 - OK
] DISK_DRV: R [10] 
] Test 1.1: Step 4 - OK
] DISK_DRV: R [10] 
] Test 1.1: Step 6 - OK
] TEST PASSED
] Test 1.2 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [20] 
] Test 1.2: Step 3 - OK
] DISK_DRV: R [20] 
] Test 1.2: Step 5 - OK
] TEST PASSED
] Test 1.3 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [30] 
] Test 1.3: Step 3 - OK
] DISK_DRV: R [30] 
] Test 1.3: Step 5 - OK
] TEST PASSED
] Test 1.4 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [40] 
] Test 1.4: Step 3 - OK
] Test 1.4: Step 5 - OK
] TEST PASSED
] Test 1.5 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [50] 
] Test 1.5: Step 1 - OK
] Test 1.5: Step 4 - OK
] TEST PASSED
] Test 2.1 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [60] 
] Test 2.1: Step 3 - OK
] Test 2.1: Step 5 - OK
] DISK_DRV: W [60] 
] TEST PASSED
] Test 2.2 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [70] 
] Test 2.2: Step 3 - OK
] Test 2.2: Step 5 - OK
] DISK_DRV: W [70] 
] TEST PASSED
] Test 3.1 - STARTED
] Thread #1 started
] Thread #2 started
] Test 3.1: Step 3 - OK
] DISK_DRV: W [80] 
] Test 3.1: Step 5 - OK
] DISK_DRV: W [85] 
] TEST PASSED
] Test 3.2 - STARTED
] Thread #1 started
] Thread #2 started
] Thread #3 started
] DISK_DRV: R [90] 
] Thread #2 DEBLOCK
] Test 3.2: Step 5 - OK
] DISK_DRV: W [92] 
] Thread #3 DEBLOCK
] DISK_DRV: W [94] 
] TEST PASSED
] Test 3.3 - STARTED
] Thread #1 started
] Thread #2 started
] Thread #3 started
] DISK_DRV: R [96] 
] DISK_DRV: R [98] 
] Thread #2 DEBLOCK
] Test 3.3: Step 5 - OK
] DISK_DRV: R [100] 
] Thread #3 DEBLOCK
] TEST PASSED
] Test 4.1 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [112] 
] *** TIMEOUT TIMEOUT
[ 68/591] p:57  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: block09.exe
 <<skipping passes>>
[ 81/591] p:70  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: crypt01.exe
Result: timeout    Time: 0:03:00.255965 crypt01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/crypt01.exe
] 
] 
=>  test start: CRYPT 1
] *** BEGIN OF TEST CRYPT 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] test crypt_md5_r()
] test crypt_sha256_r()
] input:    Hello world!
] salt:     $5$saltstring
] expected: $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] actual:   $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] input:    Hello world!
] salt:     $5$rounds=10000$saltstringsaltstring
] expected: $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] actual:   $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] input:    This is just a test
] salt:     $5$rounds=5000$toolongsaltstring
] expected: $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] actual:   $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] input:    a very much longer text to encrypt.  This one even stretches over morethan one line.
] salt:     $5$rounds=1400$anotherlongsaltstring
] expected: $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] actual:   $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] input:    we have a short salt string but not a short password
] salt:     $5$rounds=77777$short
] expected: $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] actual:   $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] input:    a short string
] salt:     $5$rounds=123456$asaltof16chars..
] expected: $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] actual:   $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] input:    the minimum number is still observed
] salt:     $5$rounds=10$roundstoolow
] expected: $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] actual:   $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] test crypt_sha512_r()
] input:    Hello world!
] salt:     $6$saltstring
] expected: $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] actual:   $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] input:    Hello world!
] salt:     $6$rounds=10000$saltstringsaltstring
] expected: $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] actual:   $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] input:    This is just a test
] salt:     $6$rounds=5000$toolongsaltstring
] expected: $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] actual:   $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] input:    a very much longer text to encrypt.  This one even stretches over morethan one line.
] salt:     $6$rounds=1400$anotherlongsaltstring
] expected: $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] actual:   $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] input:    we have a short salt string but not a short password
] salt:     $6$rounds=77777$short
] expected: $6$rounds=77777$short$WuQyW2YR.hBNpjjRhpYD/ifIw05xdfeEyQoMxIXbkvr0gge1a1x3yRULJ5CCaUeOxFmtlcGZelFl5CxtgfiAc0
] actual:   $6$rounds=77777$short$WuQyW2YR.hBNpjjRhpYD/ifIw05xdfeEyQoMxIXbkvr0gge1a1x3yRULJ5CCaUeOxFmtlcGZelFl5CxtgfiAc0
] *** TIMEOUT TIMEOUT
[ 82/591] p:71  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: defaultconfig01.exe
 <<skipping passes>>
[ 88/591] p:77  f:0   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl02.exe
Result: failed     Time: 0:00:01.047940 dl02.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl02.exe
] 
] 
=>  test start: libdl (RTL) 2
] *** BEGIN OF TEST libdl (RTL) 2 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] load: /dl02-o1.o
] handle: 0x80063690 has unresolved externals
] load: /dl02-o2.o
] handle: 0x80063e40 has unresolved externals
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o1.c]
]   0: 1
]   1: 2
]   2: 3
]   3: 4
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o2.c]
]   0: 1
]   1: 2
]   2: 3
]   3: 4
] dl_o2_func2: d1=2147483647.00 d2=0.0 ret=0.00
] rtems_main: dl_o2_func2 returned: 0.00
] rtems_main: dl_o2_func2 returned a bad
] dlsym call failed: ret value bad
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 89/591] p:77  f:1   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl03.exe
 <<skipping passes>>
[ 91/591] p:79  f:1   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl05.exe
Result: failed     Time: 0:00:01.085811 dl05.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl05.exe
] 
] 
=>  test start: libdl (RTL) 5
] *** BEGIN OF TEST libdl (RTL) 5 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x00001880
] mcause  0x00000004
] mepc    0x80018c5c
] ra      0x80017390
] sp      0x800764e0
] gp      0x8006a800
] tp      0x00000000
] t0      0xff7fffff
] t1      0x800172a4
] t2      0xffffffff
] s0      0x80085e17
] s1      0x800841a0
] a0      0x00000023
] a1      0x8005c00c
] a2      0x80084450
] a3      0x00000003
] a4      0x80018c5c
] a5      0x80085b60
] a6      0xfffffd49
] a7      0x80085b60
] s2      0x80085b60
] s3      0x800765a0
] s4      0x00000001
] s5      0x8007db44
] s6      0x80084450
] s7      0x800853d8
] s8      0x800841a0
] s9      0x80084bd0
] s10     0x80084c20
] s11     0x80076550
] t3      0x2e003738
] t4      0x31465341
] t5      0x4c2e0036
] t6      0x38314653
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 92/591] p:79  f:2   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl06.exe
Result: failed     Time: 0:00:01.067627 dl06.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl06.exe
] 
] 
=>  test start: libdl (RTL) 6
] *** BEGIN OF TEST libdl (RTL) 6 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 
] load: /dl06.rap
] dlopen failed: (null)
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 93/591] p:79  f:3   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl07.exe
Result: failed     Time: 0:00:01.049892 dl07.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl07.exe
] 
] 
=>  test start: libdl (RTL) 7
] *** BEGIN OF TEST libdl (RTL) 7 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl07/dl-load.c
] load: /dl07-o1.o
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl07/dl-load.c: 70 unresolved == 0
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 94/591] p:80  f:3   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl08.exe
Result: failed     Time: 0:00:01.064148 dl08.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl08.exe
] 
] 
=>  test start: libdl (RTL) 8
] *** BEGIN OF TEST libdl (RTL) 8 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl08/dl-load.c
] load: /dl08-o1.o
] dlo6: CONSTRUCTOR: ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl08-o6-123456789-123456789.c
] dlo6:   dl06_unresolv_1:    8: 0x80083ab0: 0
] dlo6:   dl06_unresolv_2:    2: 0x80083ab8: 0
] dlo6:   dl06_unresolv_3:    4: 0x80083abc: 0
] dlo6:   dl06_unresolv_4:    1: 0x80083ac0: 0
] dlo6:   dl06_unresolv_5:    8: 0x80083ac8: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl-load.c: 71 unresolved == 0
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 95/591] p:80  f:4   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl09.exe
Result: failed     Time: 0:00:01.047762 dl09.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl09.exe
] 
] 
=>  test start: libdl (RTL) 9
] *** BEGIN OF TEST libdl (RTL) 9 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --------------------------------------------------
]  Run: 0
] Test source (link in strstr): testsuites/libtests/dl09/dl-load.c
] load: /dl09-o1.o
] handel: 0x800757e0: unresolved externals
] handle: 0x800757e0 loaded
] space alloc: /dl09-o1.o: 33554432: 0x80076db0
] load: /dl09-o2.o
] handel: 0x80076080: unresolved externals
] handle: 0x80076080 loaded
] space alloc: /dl09-o2.o: 33554432: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl09/dl-load.c: 156 o->space != NULL
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[ 96/591] p:80  f:5   u:0   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: dl10.exe
 <<skipping passes>>
[100/591] p:82  f:6   u:1   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: flashdisk01.exe
Result: timeout    Time: 0:03:00.191807 flashdisk01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/flashdisk01.exe
] 
] 
=>  test start: FLASHDISK 1
] *** BEGIN OF TEST FLASHDISK 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] [00]: start
] [00]: mount: /dev/fdda -> /mnt
] [00]: init root: /mnt
] [00]: create dir: 1804928587
] [00]: create dir: 959030623
] [00]: create dir: 1903590565
] [00]: open file: file
] [00]: sleep: 700 ms
] [00]: close file
] [00]: sleep: 200 ms
] [00]: open dir: 959030623
] [00]: create dir: 838545539
] [00]: create file: 1594243340
] [00]: create file: 162216788
] [00]: create file: 1841205112
] [00]: sleep: 700 ms
] [00]: remove dir: 838545539
] [00]: create dir: 1143741253
] [00]: remove file: 1594243340
] [00]: sleep: 400 ms
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: create file: 832100416
] [00]: open dir: 1903590565
] [00]: create file: 1401208270
] [00]: create dir: 2032315143
] [00]: create dir: 2026989069
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: sleep: 100 ms
] [00]: create dir: 650320721
] [00]: sleep: 500 ms
] [00]: create dir: 1857409239
] [00]: create file: 2060801678
] [00]: create dir: 490998763
] [00]: create dir: 644928527
] [00]: create file: 1758287264
] [00]: close dir
] [00]: sleep: 500 ms
] [00]: open file: file
] [00]: read from file
] [00]: read from file
] [00]: read from file
] [00]: sleep: 700 ms
] [00]: read from file
] [00]: sleep: 200 ms
] [00]: sleep: 300 ms
] [00]: read from file
] [00]: append to file
] [00]: read from file
] [00]: close file
] [00]: remove dir: 1804928587
] [00]: create file: 2073894790
] [00]: sleep: 900 ms
] [00]: create dir: 472737403
] [00]: remove dir: 1903590565
] [00]: create dir: 689486081
] [00]: create dir: 373636079
] [00]: remove file: file
] [00]: create dir: 1506727461
] [00]: open dir: 959030623
] [00]: create dir: 1029668001
] [00]: remove file: 162216788
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: open dir: 959030623
] [00]: remove file: 1841205112
] [00]: create file: 378843792
] [00]: sleep: 1000 ms
] [00]: create file: 1871951748
] [00]: open dir: 1143741253
] [00]: create file: 855915646
] [00]: sleep: 700 ms
] [00]: create file: 2008730550
] [00]: close dir
] [00]: create file: 1327563176
] [00]: remove dir: 1143741253
] [00]: create file: 1384249492
] [00]: close dir
] [00]: remove dir: 959030623
] [00]: open file: 832100416
] [00]: read from file
] [00]: sleep: 400 ms
] [00]: close file
] [00]: open file: 832100416
] [00]: close file
] [00]: create dir: 2025552021
] [00]: remove dir: 959030623
] [00]: create dir: 1178339711
] [00]: remove file: 832100416
] [00]: remove file: 2073894790
] [00]: open dir: 1506727461
] [00]: sleep: 700 ms
] [00]: close dir
] [00]: sleep: 300 ms
] [00]: open dir: 1506727461
] [00]: create dir: 1625748679
] [00]: close dir
] [00]: remove dir: 689486081
] [00]: remove dir: 959030623
] [00]: open dir: 959030623
] [00]: sleep: 1000 ms
] [00]: close dir
] [00]: sleep: 100 ms
] [00]: open dir: 959030623
] [00]: create dir: 1128727833
] [00]: create file: 1203746106
] [00]: open dir: 1128727833
] [00]: create dir: 58221889
] [00]: create file: 611814452
] [00]: create dir: 420219909
] [00]: close dir
] [00]: remove file: 1384249492
] [00]: close dir
] [00]: open dir: 959030623
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: remove dir: 1506727461
] [00]: create file: 550820384
] [00]: create file: 833699694
] [00]: remove dir: 1506727461
] [00]: create dir: 861614531
] [00]: remove dir: 1506727461
] [00]: create dir: 846638047
] [00]: remove dir: 1506727461
] [00]: create dir: 1766470371
] [00]: remove dir: 959030623
] [00]: create file: 1969337196
] [00]: remove dir: 1506727461
] [00]: create file: 1937189238
] [00]: remove dir: 959030623
] [00]: create dir: 1615521955
] [00]: remove dir: 959030623
] [00]: sleep: 500 ms
] [00]: open dir: 1506727461
] [00]: create file: 926653184
] [00]: remove dir: 1625748679
] [00]: close dir
] [00]: create dir: 975747319
] [00]: open dir: 959030623
] [00]: open file: 1871951748
] [00]: sleep: 600 ms
] [00]: close file
] [00]: sleep: 800 ms
] [00]: remove file: 378843792
] [00]: open file: 1203746106
] [00]: read from file
] [00]: append to file
] [00]: sleep: 600 ms
] [00]: close file
] [00]: open file: 1871951748
] [00]: append to file
] [00]: close file
] [00]: remove file: 1871951748
] [00]: sleep: 400 ms
] [00]: create file: 1835979858
] [00]: open dir: 1128727833
] [00]: create dir: 862728993
] [00]: sleep: 700 ms
] [00]: remove dir: 862728993
] [00]: close dir
] [00]: close dir
] [00]: open dir: 975747319
] [00]: sleep: 400 ms
] [00]: create dir: 1840098529
] [00]: create file: 231405798
] [00]: remove dir: 1840098529
] [00]: close dir
] [00]: remove file: 550820384
] [00]: create file: 1020303340
] [00]: create dir: 895068705
] [00]: open dir: 975747319
] [00]: close dir
] [00]: open file: 1020303340
] [00]: read from file
] [00]: close file
] [00]: create dir: 1993404773
] [00]: remove file: 1020303340
] [00]: create dir: 2112395285
] [00]: create dir: 81202983
] [00]: remove dir: 975747319
] [00]: remove dir: 959030623
] [00]: create dir: 467069459
] [00]: open dir: 1506727461
] [00]: create file: 612609068
] [00]: create dir: 1793174441
] [00]: create file: 710808000
] [00]: sleep: 300 ms
] [00]: create file: 897370450
] [00]: create file: 1901152134
] [00]: sleep: 200 ms
] [00]: close dir
] [00]: open dir: 1506727461
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: create file: 906254788
] [00]: remove dir: 467069459
] [00]: remove dir: 1506727461
] [00]: open dir: 895068705
] [00]: close dir
] [00]: create file: 1216543556
] [00]: create file: 37176518
] [00]: open dir: 2112395285
] [00]: close dir
] [00]: create dir: 659416143
] [00]: remove file: 37176518
] [00]: sleep: 500 ms
] [00]: remove dir: 895068705
] [00]: create dir: 1507289677
] [00]: open dir: 959030623
] [00]: create file: 1766335976
] [00]: close dir
] [00]: sleep: 400 ms
] *** TIMEOUT TIMEOUT
[101/591] p:83  f:6   u:1   e:0   I:0   B:3   t:0   i:0   W:0   | riscv32/rv32im: getentropy01.exe
 <<skipping passes>>
[195/591] p:171 f:6   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxfenv01.exe
Result: failed     Time: 0:00:01.023154 psxfenv01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxfenv01.exe
] 
] 
=>  test start: PSXFENV 01
] *** BEGIN OF TEST PSXFENV 01 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] fesetenv(FE_DFL_ENV).
] feclearexcept(FE_ALL_EXCEPT).
] Divide by zero and confirm fetestexcept()
] ../../../../../../rtems/c/src/../../testsuites/psxtests/psxfenv01/init.c: 99 fetestexcept( FE_DIVBYZERO )
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[196/591] p:172 f:6   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxfile01.exe
 <<skipping passes>>
[221/591] p:196 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxmsgq01.exe
Result: timeout    Time: 0:03:00.191282 psxmsgq01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxmsgq01.exe
] 
] 
=>  test start: PSXMSGQ 1
] *** BEGIN OF TEST PSXMSGQ 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] _______________mq_open errors
] Init: mq_open - Create with maxmsg (-1) (EINVAL)
] Init: mq_open - Create with msgsize (-1) (EINVAL)
] Init: mq_open - Open new mq without create flag (ENOENT)
] Init: mq_open - Open with too long of a name (ENAMETOOLONG)
] Init: mq_open - Create an Existing mq (EEXIST)
] Init: mq_open - SUCCESSFUL
] Init: mq_open - system is out of resources (ENFILE)
] Init: mq_close and mq_unlink (mq3...mqn) - SUCCESSFUL
] Init: Open Test Queues
] _______________verify_blocking_mq_timedsend
] _______________mq_unlink errors
] Init: mq_unlink - mq_unlink with too long of a name (ENAMETOOLONG)
] Init: mq_unlink - A Queue not opened  (ENOENT)
] Init: mq_unlink (NULL) - EINVAL
] Init: mq_unlink ("") - ENOENT
] _______________mq_close errors
] Init: mq_close - unopened queue (EBADF)
] _______________mq_unlink functionality
] Init: Unlink and Open without closing SUCCESSFUL
] Task1:mq_setattr - unopened queue (EBADF)
] Task1:mq_setattr - NULL attributes (EINVAL)
] Init: set_attr all queues to blocking
] Init: Init: mq_timedreceive - on queue Qnoblock Init: 1 sec 7250 us
] Init: Init: mq_timedreceive - on queue Qblock Init: 1 sec 9670 us
] Init: Init: mq_timedreceive - on queue Qdefault Init: 1 sec 9660 us
] _______________mq_send errors
] Init: mq_send - Closed message queue (EBADF)
] Init: mq_send - Read only message queue (EBADF)
] Init: mq_send - Priority out of range (EINVAL)
] Init: mq_send - Message longer than msg_len (EMSGSIZE)
] Init: Verify Queues are empty
] Init: Fill Queues with messages
] Init: Verify Queues are full
] Init: mq_send - on a FULL non-blocking queue with (EAGAIN)
] _______________mq_getattr errors
] Init: mq_getattr - unopened queue (EBADF)
] Init: mq_getattr - NULL attributes (EINVAL)
] _______________mq_timedsend
] Init: mq_timedsend - on queue Qnoblock Init: 0 sec 0 us
] Init: mq_timedsend - on queue Qblock Init: 1 sec 6755 us
] Init: mq_timedsend - on queue Qdefault Init: 0 sec 0 us
] _______________mq_receive errors
] Init: mq_receive - Unopened message queue (EBADF)
] Init: mq_receive - Write only queue (EBADF)
] Init: mq_receive - Size is less than the message (EMSGSIZE)
] Init: Verify Queues are full
] Init: Empty all Queues
] Init: mq_receive - Queue is empty (EAGAIN)
] _______________mq_timedreceive
] Init: Init: mq_timedreceive - on queue Qnoblock Init: 0 sec 0 us
] Init: Init: mq_timedreceive - on queue Qblock Init: 1 sec 7430 us
] Init: Init: mq_timedreceive - on queue Qdefault Init: 1 sec 9660 us
] _______________mq_open functionality
] Init: mq_open - Open an existing mq ( same id )
] _______________mq_notify
] Init: mq_notify - Unopened message queue (EBADF)
] _____mq_notify - notify when Qnoblock gets a message
] waiting on any signal for 3 seconds.
] Init: Verify Signal when send
] Init: mq_send -  to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] Init: Verify No Signal when send
] Init: mq_send -  to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] ____mq_notify - notify when Qread gets a message
] waiting on any signal for 3 seconds.
] Init: mq_notify -  (EBUSY)
] Init: mq_notify - Remove notification with null
] Init: Verify No Signal when send
] Init: mq_send -  to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] *** TIMEOUT TIMEOUT
[222/591] p:197 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxmsgq02.exe
 <<skipping passes>>
[234/591] p:209 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxrwlock01.exe
Result: timeout    Time: 0:03:00.238231 psxrwlock01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxrwlock01.exe
] 
] 
=>  test start: PSXRWLOCK 1
] *** BEGIN OF TEST PSXRWLOCK 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 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
] pthread_rwlock_tryrdlock(&RWLock) -- EBUSY
] pthread_rwlock_trywrlock(&RWLock) -- EBUSY
] pthread_rwlock_unlock(&RWLock) -- OK
] WriteThread - pthread_rwlock_wrlock(RWLock) unblocked -- OK
] WriteThread - pthread_rwlock_unlock(RWLock) -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] *** TIMEOUT TIMEOUT
[235/591] p:210 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxsem01.exe
 <<skipping passes>>
[249/591] p:224 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxstat.exe
Result: timeout    Time: 0:03:00.190278 psxstat.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxstat.exe
] 
] 
=>  test start: PSXSTAT
] *** BEGIN OF TEST PSXSTAT ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] --->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:0x4001e2d8)
] ...st_ino     8003c670
] ...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:0x4001e2d8)
] ...st_ino     8003c9d0
] ...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:0x4001e2d8)
] ...st_ino     8003ca40
] ...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:0x4001e2d8)
] ...st_ino     8003cab0
] ...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:0x4001e2d8)
] ...st_ino     8003cb20
] ...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:0x4001e2d8)
] ...st_ino     8003cb90
] ...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:0x4001e2d8)
] ...st_ino     8003cc00
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003c730
] ...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:0x4001e2d8)
] ...st_ino     8003c790
] ...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:0x4001e2d8)
] ...st_ino     8003c7f0
] ...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:0x4001e2d8)
] ...st_ino     8003c850
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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:0x4001e2d8)
] ...st_ino     8003c910
] ...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:0x4001e2d8)
] ...st_ino     8003c670
] ...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:0x4001e2d8)
] ...st_ino     8003c9d0
] ...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:0x4001e2d8)
] ...st_ino     8003ca40
] ...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:0x4001e2d8)
] ...st_ino     8003cab0
] ...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:0x4001e2d8)
] ...st_ino     8003cb20
] ...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:0x4001e2d8)
] ...st_ino     8003cb90
] ...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:0x4001e2d8)
] ...st_ino     8003cc00
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003c730
] ...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:0x4001e2d8)
] ...st_ino     8003c790
] ...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:0x4001e2d8)
] ...st_ino     8003c7f0
] ...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:0x4001e2d8)
] ...st_ino     8003c850
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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:0x4001e2d8)
] ...st_ino     8003cc70
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003c730
] ...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:0x4001e2d8)
] ...st_ino     8003c790
] ...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:0x4001e2d8)
] ...st_ino     8003c7f0
] ...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:0x4001e2d8)
] ...st_ino     8003c850
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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:0x4001e2d8)
] ...st_ino     8003c910
] ...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:0x4001e2d8)
] ...st_ino     8003c9d0
] ...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:0x4001e2d8)
] ...st_ino     8003ca40
] ...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:0x4001e2d8)
] ...st_ino     8003cab0
] ...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:0x4001e2d8)
] ...st_ino     8003cb20
] ...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:0x4001e2d8)
] ...st_ino     8003cb90
] ...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:0x4001e2d8)
] ...st_ino     8003cc00
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003c730
] ...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:0x4001e2d8)
] ...st_ino     8003c790
] ...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:0x4001e2d8)
] ...st_ino     8003c7f0
] ...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:0x4001e2d8)
] ...st_ino     8003c850
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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:0x4001e2d8)
] ...st_ino     8003c910
] ...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:0x4001e2d8)
] ...st_ino     8003c9d0
] ...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:0x4001e2d8)
] ...st_ino     8003ca40
] ...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:0x4001e2d8)
] ...st_ino     8003cab0
] ...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:0x4001e2d8)
] ...st_ino     8003cb20
] ...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:0x4001e2d8)
] ...st_ino     8003cb90
] ...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:0x4001e2d8)
] ...st_ino     8003cc00
] ...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:0x4001e2d8)
] ...st_ino     8003c9d0
] ...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:0x4001e2d8)
] ...st_ino     8003d6a0
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003d720
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003d7a0
] ...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:0x4001e2d8)
] ...st_ino     8003d820
] ...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:0x4001e2d8)
] ...st_ino     8003c6d0
] ...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:0x4001e2d8)
] ...st_ino     8003d880
] ...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:0x4001e2d8)
] ...st_ino     8003d980
] ...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:0x4001e2d8)
] ...st_ino     8003d9e0
] ...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:0x4001e2d8)
] ...st_ino     8003da40
] ...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:0x4001e2d8)
] ...st_ino     8003daa0
] ...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:0x4001e2d8)
] ...st_ino     8003db00
] ...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:0x4001e2d8)
] ...st_ino     8003db60
] ...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:0x4001e2d8)
] ...st_ino     8003dbc0
] ...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:0x4001e2d8)
] ...st_ino     8003dc20
] ...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:0x4001e2d8)
] ...st_ino     8003dc80
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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:0x4001e2d8)
] ...st_ino     8003c8b0
] ...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 
] *** TIMEOUT TIMEOUT
[250/591] p:225 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxstrsignal01.exe
 <<skipping passes>>
[253/591] p:228 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxtime.exe
Result: timeout    Time: 0:03:00.187366 psxtime.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxtime.exe
] 
] 
=>  test start: PSXTIME
] *** BEGIN OF TEST PSXTIME ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] gettimeofday( NULL, NULL ) - EFAULT
] rtems_clock_set          12:45:00   01/01/1988
] adjtime - NULL delta - EINVAL
] adjtime - delta out of range - EINVAL
] adjtime - delta range of 0 - OK
] adjtime - delta too small - do nothing
] adjtime - delta too small - do nothing, olddelta=NULL
] adjtime - delta of one second forward, olddelta=NULL
] adjtime - delta of one second forward
] adjtime - delta of almost two seconds forward
] adjtime - delta of almost one second forward which bumps second
] rtems_clock_get_tod          12:45:05   01/01/1988
] rtems_clock_set          12:45:00   01/01/1988
] rtems_clock_get_tod          12:45:00   01/01/1988
] gettimeofday: Fri Jan  1 12:45:00 1988
] time:         Fri Jan  1 12:45:00 1988
] localtime:    Fri Jan  1 12:45:00 1988
] gmtime:       Fri Jan  1 12:45:00 1988
] 
] rtems_clock_get_tod          12:45:00   01/01/1988
] gettimeofday: Fri Jan  1 12:45:00 1988
] time:         Fri Jan  1 12:45:00 1988
] localtime:    Fri Jan  1 12:45:00 1988
] gmtime:       Fri Jan  1 12:45:00 1988
] 
] rtems_clock_get_tod          12:45:01   01/01/1988
] gettimeofday: Fri Jan  1 12:45:01 1988
] time:         Fri Jan  1 12:45:01 1988
] localtime:    Fri Jan  1 12:45:01 1988
] gmtime:       Fri Jan  1 12:45:01 1988
] 
] rtems_clock_get_tod          12:45:02   01/01/1988
] gettimeofday: Fri Jan  1 12:45:02 1988
] time:         Fri Jan  1 12:45:02 1988
] localtime:    Fri Jan  1 12:45:02 1988
] gmtime:       Fri Jan  1 12:45:02 1988
] 
] rtems_clock_set          09:00:00   12/31/1988
] rtems_clock_get_tod          09:00:00   12/31/1988
] gettimeofday: Sat Dec 31 09:00:00 1988
] time:         Sat Dec 31 09:00:00 1988
] localtime:    Sat Dec 31 09:00:00 1988
] gmtime:       Sat Dec 31 09:00:00 1988
] 
] rtems_clock_get_tod          09:00:00   12/31/1988
] gettimeofday: Sat Dec 31 09:00:01 1988
] time:         Sat Dec 31 09:00:01 1988
] localtime:    Sat Dec 31 09:00:01 1988
] gmtime:       Sat Dec 31 09:00:01 1988
] 
] rtems_clock_get_tod          09:00:01   12/31/1988
] gettimeofday: Sat Dec 31 09:00:02 1988
] time:         Sat Dec 31 09:00:02 1988
] localtime:    Sat Dec 31 09:00:02 1988
] gmtime:       Sat Dec 31 09:00:02 1988
] 
] rtems_clock_get_tod          09:00:02   12/31/1988
] gettimeofday: Sat Dec 31 09:00:03 1988
] time:         Sat Dec 31 09:00:03 1988
] localtime:    Sat Dec 31 09:00:03 1988
] gmtime:       Sat Dec 31 09:00:03 1988
] 
] rtems_clock_set          23:55:59   12/31/1999
] rtems_clock_get_tod          23:55:59   12/31/1999
] gettimeofday: Fri Dec 31 23:55:59 1999
] time:         Fri Dec 31 23:55:59 1999
] localtime:    Fri Dec 31 23:55:59 1999
] gmtime:       Fri Dec 31 23:55:59 1999
] 
] rtems_clock_get_tod          23:55:59   12/31/1999
] gettimeofday: Fri Dec 31 23:56:00 1999
] time:         Fri Dec 31 23:56:00 1999
] localtime:    Fri Dec 31 23:56:00 1999
] gmtime:       Fri Dec 31 23:56:00 1999
] 
] rtems_clock_get_tod          23:56:00   12/31/1999
] gettimeofday: Fri Dec 31 23:56:01 1999
] time:         Fri Dec 31 23:56:01 1999
] localtime:    Fri Dec 31 23:56:01 1999
] gmtime:       Fri Dec 31 23:56:01 1999
] 
] rtems_clock_get_tod          23:56:01   12/31/1999
] gettimeofday: Fri Dec 31 23:56:02 1999
] time:         Fri Dec 31 23:56:02 1999
] localtime:    Fri Dec 31 23:56:02 1999
] gmtime:       Fri Dec 31 23:56:02 1999
] 
] rtems_clock_set          00:01:30   06/30/1999
] rtems_clock_get_tod          00:01:30   06/30/1999
] gettimeofday: Wed Jun 30 00:01:30 1999
] time:         Wed Jun 30 00:01:30 1999
] localtime:    Wed Jun 30 00:01:30 1999
] gmtime:       Wed Jun 30 00:01:30 1999
] 
] rtems_clock_get_tod          00:01:30   06/30/1999
] gettimeofday: Wed Jun 30 00:01:31 1999
] time:         Wed Jun 30 00:01:31 1999
] localtime:    Wed Jun 30 00:01:31 1999
] gmtime:       Wed Jun 30 00:01:31 1999
] 
] rtems_clock_get_tod          00:01:31   06/30/1999
] gettimeofday: Wed Jun 30 00:01:32 1999
] time:         Wed Jun 30 00:01:32 1999
] localtime:    Wed Jun 30 00:01:32 1999
] gmtime:       Wed Jun 30 00:01:32 1999
] 
] rtems_clock_get_tod          00:01:32   06/30/1999
] gettimeofday: Wed Jun 30 00:01:33 1999
] time:         Wed Jun 30 00:01:33 1999
] localtime:    Wed Jun 30 00:01:33 1999
] gmtime:       Wed Jun 30 00:01:33 1999
] 
] rtems_clock_set          00:15:59   01/01/2000
] rtems_clock_get_tod          00:15:59   01/01/2000
] gettimeofday: Sat Jan  1 00:15:59 2000
] time:         Sat Jan  1 00:15:59 2000
] localtime:    Sat Jan  1 00:15:59 2000
] gmtime:       Sat Jan  1 00:15:59 2000
] 
] rtems_clock_get_tod          00:15:59   01/01/2000
] gettimeofday: Sat Jan  1 00:16:00 2000
] time:         Sat Jan  1 00:16:00 2000
] localtime:    Sat Jan  1 00:16:00 2000
] gmtime:       Sat Jan  1 00:16:00 2000
] 
] rtems_clock_get_tod          00:16:00   01/01/2000
] gettimeofday: Sat Jan  1 00:16:01 2000
] time:         Sat Jan  1 00:16:01 2000
] localtime:    Sat Jan  1 00:16:01 2000
] gmtime:       Sat Jan  1 00:16:01 2000
] 
] rtems_clock_get_tod          00:16:01   01/01/2000
] gettimeofday: Sat Jan  1 00:16:02 2000
] time:         Sat Jan  1 00:16:02 2000
] localtime:    Sat Jan  1 00:16:02 2000
] gmtime:       Sat Jan  1 00:16:02 2000
] 
] rtems_clock_set          05:10:59   02/02/2005
] rtems_clock_get_tod          05:10:59   02/02/2005
] gettimeofday: Wed Feb  2 05:10:59 2005
] time:         Wed Feb  2 05:10:59 2005
] localtime:    Wed Feb  2 05:10:59 2005
] gmtime:       Wed Feb  2 05:10:59 2005
] 
] rtems_clock_get_tod          05:10:59   02/02/2005
] gettimeofday: Wed Feb  2 05:11:00 2005
] time:         Wed Feb  2 05:11:00 2005
] localtime:    Wed Feb  2 05:11:00 2005
] gmtime:       Wed Feb  2 05:11:00 2005
] 
] rtems_clock_get_tod          05:11:00   02/02/2005
] gettimeofday: Wed Feb  2 05:11:01 2005
] time:         Wed Feb  2 05:11:01 2005
] localtime:    Wed Feb  2 05:11:01 2005
] gmtime:       Wed Feb  2 05:11:01 2005
] 
] rtems_clock_get_tod          05:11:01   02/02/2005
] gettimeofday: Wed Feb  2 05:11:02 2005
] time:         Wed Feb  2 05:11:02 2005
] localtime:    Wed Feb  2 05:11:02 2005
] gmtime:       Wed Feb  2 05:11:02 2005
] 
] rtems_clock_set          10:05:59   03/03/2010
] rtems_clock_get_tod          10:05:59   03/03/2010
] gettimeofday: Wed Mar  3 10:05:59 2010
] time:         Wed Mar  3 10:05:59 2010
] localtime:    Wed Mar  3 10:05:59 2010
] gmtime:       Wed Mar  3 10:05:59 2010
] 
] rtems_clock_get_tod          10:05:59   03/03/2010
] gettimeofday: Wed Mar  3 10:06:00 2010
] time:         Wed Mar  3 10:06:00 2010
] localtime:    Wed Mar  3 10:06:00 2010
] gmtime:       Wed Mar  3 10:06:00 2010
] 
] *** TIMEOUT TIMEOUT
[254/591] p:229 f:7   u:4   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: psxtimer01.exe
 <<skipping passes>>
[330/591] p:303 f:7   u:6   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: ticker.exe
Result: timeout    Time: 0:03:00.246547 ticker.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/samples/ticker.exe
] 
] 
=>  test start: CLOCK TICK
] *** BEGIN OF TEST CLOCK TICK ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] 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
[331/591] p:304 f:7   u:6   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: unlimited.exe
 <<skipping passes>>
[335/591] p:308 f:7   u:6   e:0   I:0   B:3   t:3   i:0   W:0   | riscv32/rv32im: sp04.exe
Result: timeout    Time: 0:03:00.251698 sp04.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp04.exe
] 
] 
=>  test start: SP 4
] *** BEGIN OF TEST SP 4 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] TA1 - rtems_task_resume - on Task 2
] TA1 - rtems_task_resume - on Task 3
] TA1 - rtems_task_mode - change mode to NO RTEMS_PREEMPT
] TA1 - 09:15:09   12/31/1988
] TA1 - 09:15:10   12/31/1988
] TA1 - 09:15:11   12/31/1988
] TA1 - 09:15:12   12/31/1988
] TA1 - 09:15:13   12/31/1988
] TA1 - 09:15:14   12/31/1988
] TA1 - rtems_task_mode - change mode to RTEMS_PREEMPT
] *** TIMEOUT TIMEOUT
[336/591] p:308 f:7   u:6   e:0   I:0   B:3   t:4   i:0   W:0   | riscv32/rv32im: sp05.exe
Result: timeout    Time: 0:03:00.246241 sp05.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp05.exe
] 
] 
=>  test start: SP 5
] *** BEGIN OF TEST SP 5 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA2 - rtems_task_suspend - suspend self
] TA3 - rtems_task_suspend - suspend self
] TA1 - rtems_task_suspend - suspend TA3
] TA1 - rtems_task_resume - resume TA2
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA1 - rtems_task_suspend - suspend TA2
] TA1 - rtems_task_resume - resume TA3
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] TA1 - rtems_task_suspend - suspend TA3
] TA1 - rtems_task_resume - resume TA2
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA2 - rtems_task_wake_after - sleep 1 second
] TA1 - rtems_task_suspend - suspend TA2
] TA1 - rtems_task_resume - resume TA3
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] TA3 - rtems_task_wake_after - sleep 1 second
] *** TIMEOUT TIMEOUT
[337/591] p:308 f:7   u:6   e:0   I:0   B:3   t:5   i:0   W:0   | riscv32/rv32im: sp06.exe
 <<skipping passes>>
[341/591] p:310 f:7   u:6   e:0   I:0   B:3   t:7   i:0   W:0   | riscv32/rv32im: sp12.exe
Result: timeout    Time: 0:03:00.259046 sp12.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp12.exe
] 
] 
=>  test start: SP 12
] *** BEGIN OF TEST SP 12 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] INIT - 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:311 f:7   u:6   e:0   I:0   B:3   t:7   i:0   W:0   | riscv32/rv32im: sp13.exe
 <<skipping passes>>
[349/591] p:317 f:7   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32im: sp20.exe
Result: timeout    Time: 0:03:00.229340 sp20.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp20.exe
] 
] 
=>  test start: SP 20
] *** BEGIN OF TEST SP 20 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1 - rtems_rate_monotonic_create id = 0x42010001
] TA1 - rtems_rate_monotonic_ident id = 0x42010001
] TA1 - (0x42010001) period 2
] TA2 - rtems_rate_monotonic_create id = 0x42010002
] TA2 - rtems_rate_monotonic_ident id = 0x42010002
] TA2 - (0x42010002) period 2
] TA3 - rtems_rate_monotonic_create id = 0x42010003
] TA3 - rtems_rate_monotonic_ident id = 0x42010003
] TA3 - (0x42010003) period 2
] TA4 - rtems_rate_monotonic_create id = 0x42010004
] TA4 - rtems_rate_monotonic_ident id = 0x42010004
] TA4 - (0x42010004) period 2
] TA5 - rtems_rate_monotonic_create id = 0x42010005
] TA5 - rtems_rate_monotonic_ident id = 0x42010005
] TA5 - (0x42010005) period 100
] TA6 - rtems_rate_monotonic_create id = 0x42010006
] TA6 - rtems_rate_monotonic_ident id = 0x42010006
] TA6 - (0x42010006) period 0
] TA5 - PERIODS CHECK OK (1)
] *** TIMEOUT TIMEOUT
[350/591] p:318 f:7   u:6   e:0   I:0   B:3   t:8   i:0   W:0   | riscv32/rv32im: sp2038.exe
 <<skipping passes>>
[360/591] p:327 f:7   u:6   e:0   I:0   B:3   t:9   i:0   W:0   | riscv32/rv32im: sp30.exe
Result: timeout    Time: 0:03:00.222893 sp30.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp30.exe
] 
] 
=>  test start: SP 30
] *** BEGIN OF TEST SP 30 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] timer_initiate_server -- INVALID_PRIORITY
] timer_initiate_server -- OK
] timer_initiate_server -- already started
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:19   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:19   12/31/1988
] *** TIMEOUT TIMEOUT
[361/591] p:328 f:7   u:6   e:0   I:0   B:3   t:9   i:0   W:0   | riscv32/rv32im: sp31.exe
[362/591] p:329 f:7   u:6   e:0   I:0   B:3   t:9   i:0   W:0   | riscv32/rv32im: sp32.exe
Result: timeout    Time: 0:03:00.261681 sp32.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp32.exe
] 
] 
=>  test start: SP 32
] *** BEGIN OF TEST SP 32 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] *** TIMEOUT TIMEOUT
[363/591] p:330 f:7   u:6   e:0   I:0   B:3   t:9   i:0   W:0   | riscv32/rv32im: sp33.exe
 <<skipping passes>>
[408/591] p:373 f:7   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32im: spcbssched01.exe
Result: timeout    Time: 0:03:00.190756 spcbssched01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spcbssched01.exe
] 
] 
=>  test start: SPCBSSCHED 1
] *** BEGIN OF TEST SPCBSSCHED 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] 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
[409/591] p:374 f:7   u:6   e:0   I:0   B:3   t:11  i:0   W:0   | riscv32/rv32im: spcbssched02.exe
 <<skipping passes>>
[423/591] p:386 f:7   u:6   e:0   I:0   B:3   t:13  i:0   W:0   | riscv32/rv32im: spedfsched01.exe
Result: timeout    Time: 0:03:00.187654 spedfsched01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spedfsched01.exe
] 
] 
=>  test start: SPEDFSCHED 1
] *** BEGIN OF TEST SPEDFSCHED 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] 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:387 f:7   u:6   e:0   I:0   B:3   t:13  i:0   W:0   | riscv32/rv32im: spedfsched02.exe
 <<skipping passes>>
[466/591] p:428 f:7   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical01.exe
Result: failed     Time: 0:00:01.049631 spintrcritical01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical01.exe
] 
] 
=>  test start: SPINTRCRITICAL 1
] *** BEGIN OF TEST SPINTRCRITICAL 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/Without Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[467/591] p:428 f:8   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical02.exe
Result: failed     Time: 0:00:01.039145 spintrcritical02.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical02.exe
] 
] 
=>  test start: SPINTRCRITICAL 2
] *** BEGIN OF TEST SPINTRCRITICAL 2 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/With Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[468/591] p:428 f:9   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical03.exe
Result: failed     Time: 0:00:01.075101 spintrcritical03.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical03.exe
] 
] 
=>  test start: SPINTRCRITICAL 3
] *** BEGIN OF TEST SPINTRCRITICAL 3 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[469/591] p:429 f:9   u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical04.exe
Result: failed     Time: 0:00:01.028682 spintrcritical04.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical04.exe
] 
] 
=>  test start: SPINTRCRITICAL 4
] *** BEGIN OF TEST SPINTRCRITICAL 4 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/With Timeout
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[470/591] p:429 f:10  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical05.exe
Result: failed     Time: 0:00:01.034150 spintrcritical05.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical05.exe
] 
] 
=>  test start: SPINTRCRITICAL 5
] *** BEGIN OF TEST SPINTRCRITICAL 5 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout (Reverse)
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[471/591] p:429 f:11  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical06.exe
 <<skipping passes>>
[473/591] p:430 f:12  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical08.exe
Result: failed     Time: 0:00:01.017926 spintrcritical08.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical08.exe
] 
] 
=>  test start: SPINTRCRITICAL 8
] *** BEGIN OF TEST SPINTRCRITICAL 8 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] 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.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[474/591] p:431 f:12  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical09.exe
[475/591] p:432 f:13  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical10.exe
Result: failed     Time: 0:00:01.110107 spintrcritical10.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical10.exe
] 
] 
=>  test start: SPINTRCRITICAL 10
] *** BEGIN OF TEST SPINTRCRITICAL 10 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate any satisfied before timeout while blocking on event
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical10/init.c: 144 ctx->hit
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[476/591] p:432 f:13  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical11.exe
 <<skipping passes>>
[481/591] p:437 f:14  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical16.exe
Result: failed     Time: 0:00:01.070091 spintrcritical16.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical16.exe
] 
] 
=>  test start: SPINTRCRITICAL 16
] *** BEGIN OF TEST SPINTRCRITICAL 16 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Init - Trying to generate timeout of a thread that had its blocking
] Init -   request satisfied while blocking but before time timeout
] Init - rtems_semaphore_create - OK
] Init - Case not hit - ran too long
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[482/591] p:437 f:14  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical18.exe
[483/591] p:438 f:14  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical20.exe
Result: failed     Time: 0:00:01.041041 spintrcritical20.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical20.exe
] 
] 
=>  test start: SPINTRCRITICAL 20
] *** BEGIN OF TEST SPINTRCRITICAL 20 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../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.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[484/591] p:439 f:15  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical21.exe
Result: failed     Time: 0:00:01.088665 spintrcritical21.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical21.exe
] 
] 
=>  test start: SPINTRCRITICAL 21
] *** BEGIN OF TEST SPINTRCRITICAL 21 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] Event sent from ISR hitting synchronization point has NOT occurred
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical21/init.c: 157 case_hit
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[485/591] p:439 f:15  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical22.exe
Result: failed     Time: 0:00:01.076071 spintrcritical22.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical22.exe
] 
] 
=>  test start: SPINTRCRITICAL 22
] *** BEGIN OF TEST SPINTRCRITICAL 22 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical22/init.c: 118 ctx->done
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[486/591] p:439 f:16  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical23.exe
Result: failed     Time: 0:00:01.051500 spintrcritical23.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical23.exe
] 
] 
=>  test start: SPINTRCRITICAL 23
] *** BEGIN OF TEST SPINTRCRITICAL 23 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical23/init.c: 133 ctx->done
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[487/591] p:439 f:18  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: spintrcritical24.exe
Result: failed     Time: 0:00:01.101232 spintrcritical24.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical24.exe
] 
] 
=>  test start: SPINTRCRITICAL 24
] *** BEGIN OF TEST SPINTRCRITICAL 24 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] ../../../../../../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.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[488/591] p:439 f:18  u:6   e:0   I:0   B:3   t:14  i:0   W:0   | riscv32/rv32im: splinkersets01.exe
 <<skipping passes>>
[518/591] p:466 f:20  u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32im: spsimplesched01.exe
Result: timeout    Time: 0:03:00.214662 spsimplesched01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spsimplesched01.exe
] 
] 
=>  test start: SPSIMPLESCHED 1
] *** BEGIN OF TEST SPSIMPLESCHED 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:04   12/31/1988
] TA2  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:09   12/31/1988
] TA3  - rtems_clock_get_tod - 09:00:14   12/31/1988
] TA1  - rtems_clock_get_tod - 09:00:14   12/31/1988
] 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
[519/591] p:467 f:20  u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32im: spsimplesched02.exe
 <<skipping passes>>
[525/591] p:473 f:20  u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32im: spsysinit01.exe
Result: failed     Time: 0:00:01.041474 spsysinit01.exe
=>  run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spsysinit01.exe
] sysinit: begin
] sysinit: stack pointer: 0x800321e0
] sysinit: memory area 0: begin = 0x80032200, size = 0x03fcde00
] sysinit: DIRTY_MEMORY: done
] sysinit: ISR_STACK: done
] sysinit: memory area 0: free begin = 0x800365c6, free size = 0x03fc9a3a
] sysinit: WORKSPACE: done
] sysinit: memory area 0: free begin = 0x84000000, free size = 0x00000000
] sysinit: MALLOC: done
] 
] 
=>  test start: SPSYSINIT 1
] *** BEGIN OF TEST SPSYSINIT 1 ***
] *** TEST VERSION: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] sysinit: BSP_START: done
] sysinit: CPU_COUNTER: done
] sysinit: INITIAL_EXTENSIONS: done
] sysinit: DATA_STRUCTURES: done
] sysinit: USER_EXTENSIONS: done
] sysinit: CLASSIC_TASKS: done
] sysinit: CLASSIC_TIMER: done
] sysinit: CLASSIC_MESSAGE_QUEUE: done
] sysinit: CLASSIC_SEMAPHORE: done
] sysinit: CLASSIC_PARTITION: done
] sysinit: CLASSIC_REGION: done
] sysinit: CLASSIC_DUAL_PORTED_MEMORY: done
] sysinit: CLASSIC_RATE_MONOTONIC: done
] sysinit: CLASSIC_BARRIER: done
] sysinit: POSIX_SIGNALS: done
] sysinit: POSIX_THREADS: done
] sysinit: POSIX_MESSAGE_QUEUE: done
] sysinit: POSIX_SEMAPHORE: done
] sysinit: POSIX_TIMER: done
] sysinit: POSIX_SHM: done
] sysinit: POSIX_KEYS: done
] sysinit: POSIX_CLEANUP: done
] sysinit: IDLE_THREADS: done
] sysinit: LIBIO: done
] sysinit: USER_ENVIRONMENT: done
] sysinit: ROOT_FILESYSTEM: done
] sysinit: BSP_PRE_DRIVERS: done
] sysinit: DEVICE_DRIVERS: done
] sysinit: CLASSIC_USER_TASKS: done
] sysinit: POSIX_USER_THREADS: done
] sysinit: STD_FILE_DESCRIPTORS: done
] sysinit: done
] ../../../../../../rtems/c/src/../../testsuites/sptests/spsysinit01/init.c: 902 sem != SEM_FAILED
] 
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.4bae9c31b408d4ddcd8f492ad2485b2a65597255-modified
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (71af2d9ced94), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1 
] executing thread name: UI1 
[526/591] p:475 f:20  u:6   e:0   I:0   B:3   t:15  i:0   W:0   | riscv32/rv32im: spsyslock01.exe
 <<skipping passes>>
[591/591] p:537 f:21  u:6   e:0   I:0   B:3   t:16  i:0   W:0   | riscv32/rv32im: tmtimer01.exe

Passed:        544
Failed:         21
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        17
Invalid:         0
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         591
Failures:
 spintrcritical05.exe
 spintrcritical22.exe
 spintrcritical21.exe
 spintrcritical04.exe
 dl02.exe
 spintrcritical10.exe
 spintrcritical16.exe
 spintrcritical02.exe
 spsysinit01.exe
 spintrcritical20.exe
 psxfenv01.exe
 spintrcritical03.exe
 spintrcritical08.exe
 dl05.exe
 spintrcritical23.exe
 dl06.exe
 dl08.exe
 spintrcritical24.exe
 dl09.exe
 dl07.exe
 spintrcritical01.exe
User Input:
 termios.exe
 monitor.exe
 dl10.exe
 top.exe
 fileio.exe
 capture.exe
Benchmark:
 linpack.exe
 whetstone.exe
 dhrystone.exe
Timeouts:
 psxmsgq01.exe
 crypt01.exe
 block08.exe
 sp32.exe
 sp12.exe
 sp05.exe
 sp30.exe
 sp04.exe
 spcbssched01.exe
 ticker.exe
 spsimplesched01.exe
 psxrwlock01.exe
 flashdisk01.exe
 psxtime.exe
 sp20.exe
 spedfsched01.exe
 psxstat.exe
Average test time: 0:00:01.989424
Testing time     : 0:19:35.749690


More information about the build mailing list