[rtems-test] riscv32/rv32i: RTEMS_POSIX_API: Passed:522 Failed:9 Timeout:27 Test-Too-long:20 Invalid:0 Wrong:0

joel at rtems.org joel at rtems.org
Sun Jan 24 00:23:30 UTC 2021


Testing time     : 1:27:36.482646
Average test time: 0:00:08.954826

Host
====
FreeBSD-12.2-RELEASE-amd64-64bit-ELF (FreeBSD rtbf64b 12.2-RELEASE FreeBSD 12.2-RELEASE r366954 GENERIC amd64 amd64)

Configuration
=============
Version: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
Build  : RTEMS_POSIX_API
Tools  : 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)

Summary
=======

Passed:        522
Failed:          9
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        27
Test too long:  20
Invalid:         0
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         587

Failures:
 dl02.exe
 dl05.exe
 dl06.exe
 dl07.exe
 dl08.exe
 dl09.exe
 psxfenv01.exe
 minimum.exe
 spsysinit01.exe
User Input:
 dl10.exe
 monitor.exe
 termios.exe
 top.exe
 capture.exe
 fileio.exe
Benchmark:
 whetstone.exe
 linpack.exe
 dhrystone.exe
Timeouts:
 fsdosfsformat01.exe
 block05.exe
 capture01.exe
 cpuuse.exe
 ttest02.exe
 psxclock01.exe
 rhsemshuffle.exe
 sp04.exe
 sp14.exe
 sp19.exe
 sp32.exe
 sp35.exe
 spedfsched04.exe
 spintrcritical08.exe
 spintrcritical11.exe
 spintrcritical12.exe
 spintrcritical20.exe
 spintrcritical21.exe
 spintrcritical22.exe
 spintrcritical23.exe
 spintrcritical24.exe
 spqreslib.exe
 sprmsched01.exe
 sptimecounter02.exe
 sptimecounter03.exe
 tmfine01.exe
 tmonetoone.exe
Test too long:
 block08.exe
 crypt01.exe
 psx07.exe
 psx09.exe
 psx11.exe
 psxrwlock01.exe
 psxsignal01.exe
 psxstat.exe
 psxtime.exe
 ticker.exe
 sp01.exe
 sp05.exe
 sp20.exe
 sp24.exe
 spcbssched01.exe
 spcbssched02.exe
 spcbssched03.exe
 spcontext01.exe
 spedfsched03.exe
 spsimplesched01.exe
Log
===

RTEMS Testing - Tester, 6.0.not_released
 Command Line: /home/joel/rtems-cron-6/tools/6/bin/rtems-test --rtems-tools=/home/joel/rtems-cron-6/tools/6 --rtems-bsp=rv32i_spike --log=run.log --mail --mail-from=joel at rtems.org --mail-to=build at rtems.org .
 Host: FreeBSD rtbf64b 12.2-RELEASE FreeBSD 12.2-RELEASE r366954 GENERIC amd64
 Python: 3.6.9 (default, Oct 24 2019, 01:18:01) [GCC 4.2.1 Compatible FreeBSD Clang 6.0.1 (tags/RELEASE_601/final 335540)]
Host: FreeBSD-12.2-RELEASE-amd64-64bit-ELF (FreeBSD rtbf64b 12.2-RELEASE FreeBSD 12.2-RELEASE r366954 GENERIC amd64 amd64)
[  1/587] p:0   f:0   u:0   e:0   I:0   B:0   t:0   L:0   i:0   W:0   | riscv32/rv32i: dhrystone.exe
 <<skipping passes>>
[  6/587] p:0   f:0   u:0   e:0   I:0   B:3   t:0   L:0   i:0   W:0   | riscv32/rv32i: fsdosfsformat01.exe
Result: timeout    Time: 0:03:02.014849 fsdosfsformat01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/fstests/fsdosfsformat01.exe
] 
] 
=>  test start: FSDOSFSFORMAT 1
] *** BEGIN OF TEST FSDOSFSFORMAT 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[  7/587] p:0   f:0   u:0   e:0   I:0   B:3   t:0   L:0   i:0   W:0   | riscv32/rv32i: fsdosfsname01.exe
 <<skipping passes>>
[ 64/587] p:56  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: block05.exe
Result: timeout    Time: 0:03:02.074062 block05.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/block05.exe
] 
] 
=>  test start: BLOCK 5
] *** BEGIN OF TEST BLOCK 5 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[ 65/587] p:57  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: block06.exe
 <<skipping passes>>
[ 67/587] p:59  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: block08.exe
Result: test-too-long Time: 0:05:02.161791 block08.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/block08.exe
] 
] 
=>  test start: BLOCK 8
] *** BEGIN OF TEST BLOCK 8 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] *** TEST TOO LONG
[ 68/587] p:60  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: block09.exe
 <<skipping passes>>
[ 78/587] p:70  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: capture01.exe
Result: timeout    Time: 0:03:02.330215 capture01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/capture01.exe
] 
] 
=>  test start: CAPTURE 1
] *** BEGIN OF TEST CAPTURE 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] watch priority ceiling is 100
] watch priority floor is 102
] global watch is enabled
] total 1
]  00000000 ???? g-  T:S------ F:-----
] *** TIMEOUT TIMEOUT
[ 79/587] p:71  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: complex.exe
[ 80/587] p:72  f:0   u:0   e:0   I:0   B:3   t:1   L:0   i:0   W:0   | riscv32/rv32i: cpuuse.exe
Result: timeout    Time: 0:03:02.062506 cpuuse.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/cpuuse.exe
] 
] 
=>  test start: CPUUSE
] *** BEGIN OF TEST CPUUSE ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] *** TIMEOUT TIMEOUT
[ 81/587] p:72  f:0   u:0   e:0   I:0   B:3   t:2   L:0   i:0   W:0   | riscv32/rv32i: crypt01.exe
Result: test-too-long Time: 0:05:02.164576 crypt01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/crypt01.exe
] 
] 
=>  test start: CRYPT 1
] *** BEGIN OF TEST CRYPT 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] *** TEST TOO LONG
[ 82/587] p:72  f:0   u:0   e:0   I:0   B:3   t:3   L:0   i:0   W:0   | riscv32/rv32i: defaultconfig01.exe
 <<skipping passes>>
[149/587] p:126 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: ttest02.exe
Result: timeout    Time: 0:03:22.938863 ttest02.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/libtests/ttest02.exe
] 
] 
=>  test start: TTEST 2
] *** BEGIN OF TEST TTEST 2 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:TTEST 2
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:TestThreadSwitch
] P:0:0:UI1:init.c:224
] P:1:0:UI1:init.c:225
] P:2:0:UI1:init.c:226
] P:3:0:UI1:init.c:227
] P:4:0:UI1:init.c:231
] P:5:0:UI1:init.c:232
] P:6:0:UI1:init.c:233
] P:7:0:UI1:init.c:234
] P:8:0:UI1:init.c:238
] P:9:0:UI1:init.c:239
] P:10:0:UI1:init.c:240
] P:11:0:UI1:init.c:241
] P:12:0:UI1:init.c:247
] P:13:0:UI1:init.c:247
] P:14:0:UI1:init.c:247
] P:15:0:UI1:init.c:247
] P:16:0:UI1:init.c:247
] P:17:0:UI1:init.c:247
] P:18:0:UI1:init.c:251
] P:19:0:UI1:init.c:252
] P:20:0:UI1:init.c:253
] P:21:0:UI1:init.c:254
] P:22:0:UI1:init.c:256
] P:23:0:UI1:init.c:257
] P:24:0:UI1:init.c:259
] P:25:0:UI1:init.c:260
] P:26:0:UI1:init.c:269
] P:27:0:UI1:init.c:270
] P:28:0:UI1:init.c:271
] P:29:0:UI1:init.c:272
] P:30:0:UI1:init.c:269
] P:31:0:UI1:init.c:270
] P:32:0:UI1:init.c:271
] P:33:0:UI1:init.c:272
] P:34:0:UI1:init.c:269
] P:35:0:UI1:init.c:270
] P:36:0:UI1:init.c:271
] P:37:0:UI1:init.c:272
] P:38:0:UI1:init.c:269
] P:39:0:UI1:init.c:270
] P:40:0:UI1:init.c:271
] P:41:0:UI1:init.c:272
] P:42:0:UI1:init.c:269
] P:43:0:UI1:init.c:270
] P:44:0:UI1:init.c:271
] P:45:0:UI1:init.c:272
] P:46:0:UI1:init.c:269
] P:47:0:UI1:init.c:270
] P:48:0:UI1:init.c:271
] P:49:0:UI1:init.c:272
] P:50:0:UI1:init.c:269
] P:51:0:UI1:init.c:270
] P:52:0:UI1:init.c:271
] P:53:0:UI1:init.c:272
] P:54:0:UI1:init.c:269
] P:55:0:UI1:init.c:270
] P:56:0:UI1:init.c:271
] P:57:0:UI1:init.c:272
] P:58:0:UI1:init.c:269
] P:59:0:UI1:init.c:270
] P:60:0:UI1:init.c:271
] P:61:0:UI1:init.c:272
] E:TestThreadSwitch:N:62:F:0:D:0.018235
] B:TestInterruptTimeout
] P:0:0:UI1:init.c:130
] E:TestInterruptTimeout:N:1:F:0:D:0.039590
] B:TestInterruptFatal
] P:0.0:0:UI1:init.c:138
] E:TestInterruptFatal:N:1:F:0:D:0.000120
] B:TestInterruptDone
] *** TIMEOUT TIMEOUT
[150/587] p:127 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: tztest.exe
 <<skipping passes>>
[159/587] p:136 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: psx07.exe
Result: test-too-long Time: 0:05:02.148366 psx07.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psx07.exe
] 
] 
=>  test start: PSX 7
] *** BEGIN OF TEST PSX 7 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init's ID is 0x0b010001
] Init - pthread_attr_init - EINVAL (NULL attr)
] Init - pthread_attr_init - SUCCESSFUL
] Init - initialize and destroy an attribute - SUCCESSFUL
] Init - pthread_attr_destroy - EINVAL (NULL attr)
] Init - pthread_attr_destroy - EINVAL (not initialized)
] Init - pthread_create - EINVAL (attr not initialized)
] Init - pthread_create - EINVAL (stacksize too small)
] Init - pthread_create - EAGAIN (stacksize too large)
] Init - pthread_create - EINVAL (invalid inherit scheduler)
] Init - pthread_create - ENOTSUP (unsupported system contention scope)
] Init - pthread_create - SUCCESSFUL (inherit scheduler)
] Task_1 - exitting
] 
] Init - pthread_attr_setscope - EINVAL (NULL attr)
] Init - pthread_attr_setscope - ENOTSUP
] Init - pthread_attr_setscope - EINVAL (not initialized attr)
] Init - pthread_attr_setscope - EINVAL (invalid scope)
] Init - pthread_attr_setscope - SUCCESSFUL
] Init - pthread_attr_getscope - EINVAL (NULL attr)
] Init - pthread_attr_getscope - EINVAL (NULL scope)
] Init - pthread_attr_getscope - EINVAL (not initialized attr)
] Init - pthread_attr_getscope - SUCCESSFUL
] Init - current scope attribute = 0
] 
] Init - pthread_attr_setinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_setinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_setinheritsched - ENOTSUP (invalid inheritsched)
] Init - pthread_attr_setinheritsched - SUCCESSFUL
] Init - pthread_attr_getinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_getinheritsched - EINVAL (NULL inheritsched)
] Init - pthread_attr_getinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_getinheritsched - SUCCESSFUL
] Init - current inherit scheduler attribute = 1
] 
] Init - pthread_attr_setschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_setschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_setschedpolicy - ENOTSUP (invalid schedpolicy)
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_getschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_getschedpolicy - EINVAL (NULL schedpolicy)
] Init - pthread_attr_getschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_getschedpolicy - SUCCESSFUL
] Init - current scheduler policy attribute = 2
] 
] Init - pthread_attr_setstacksize - EINVAL (NULL attr)
] Init - pthread_attr_setstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_setstacksize - SUCCESSFUL (low stacksize)
] Init - pthread_attr_setstacksize - SUCCESSFUL (high stacksize)
] Init - pthread_attr_getstacksize - EINVAL (NULL attr)
] Init - pthread_attr_getstacksize - EINVAL (NULL stacksize)
] Init - pthread_attr_getstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_getstacksize - SUCCESSFUL
] Init - current stack size attribute is OK
] 
] Init - pthread_attr_setstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_setstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_setstackaddr - SUCCESSFUL
] Init - pthread_attr_getstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_getstackaddr - EINVAL (NULL stackaddr)
] Init - pthread_attr_getstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_getstackaddr - SUCCESSFUL
] Init - current stack address attribute = 0
] 
] Init - pthread_attr_setstack- EINVAL (NULL attr)
] Init - pthread_attr_setstack- EINVAL (destroyed attr)
] Init - pthread_attr_setstack- SUCCESSFUL (< min stack)
] Init - pthread_attr_setstack- SUCCESSFUL (big stack)
] Init - pthread_attr_getstack- EINVAL (NULL attr)
] Init - pthread_attr_getstack- EINVAL (destroyed attr)
] Init - pthread_attr_getstack- EINVAL (NULL stack)
] Init - pthread_attr_getstack- EINVAL (NULL stacksize)
] Init - pthread_attr_getstack- SUCCESSFUL
] 
] Init - pthread_attr_setguardsize - EINVAL (NULL attr)
] Init - pthread_attr_setguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_setguardsize - SUCCESSFUL (low guardsize)
] Init - pthread_attr_setguardsize - SUCCESSFUL (high guardsize)
] Init - pthread_attr_getguardsize - EINVAL (NULL attr)
] Init - pthread_attr_getguardsize - EINVAL (NULL guardsize)
] Init - pthread_attr_getguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_getguardsize - SUCCESSFUL
] 
] Init - pthread_attr_setdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_setdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_setdetachstate - EINVAL (invalid detachstate)
] Init - pthread_attr_setdetachstate - SUCCESSFUL
] Init - pthread_attr_getdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_getdetachstate - EINVAL (NULL detatchstate)
] Init - pthread_attr_getdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_getdetachstate - SUCCESSFUL
] Init - current detach state attribute = 1
] 
] Init - pthread_attr_getschedparam - SUCCESSFUL
] Init - sched priority      = 2
] Init - sched_ss_low_priority     = 0
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
] Init - pthread_attr_setschedparam - EINVAL (NULL attr)
] Init - pthread_attr_setschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Init - pthread_attr_getschedparam - EINVAL (NULL attr)
] Init - pthread_attr_getschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_getschedparam - EINVAL (NULL schedparam)
] 
] Init - pthread_getschedparam - EINVAL (NULL policy)
] Init - pthread_getschedparam - EINVAL (NULL schedparam)
] Init - pthread_getschedparam - ESRCH (bad thread)
] Init - pthread_getschedparam - SUCCESSFUL
] Init - policy = 1
] Init - sched priority      = 2
] Init - sched_ss_low_priority     = 2
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
] 
] Init - pthread_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_setschedparam - EINVAL (invalid priority)
] Init - pthread_setschedparam - EINVAL (invalid policy)
] Init - pthread_setschedparam - ESRCH (invalid thread)
] Init - pthread_setschedparam - EINVAL (replenish == 0)
] Init - pthread_setschedparam - EINVAL (budget == 0)
] Init - pthread_setschedparam - EINVAL (replenish < budget)
] Init - pthread_setschedparam - EINVAL (invalid priority)
] 
] Init - pthread_attr_init - SUCCESSFUL
] Init - pthread_attr_setinheritsched - EXPLICIT - SUCCESSFUL
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Time elapsed Task_2:  0 (seconds)
] *** TEST TOO LONG
[160/587] p:137 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: psx08.exe
[161/587] p:138 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: psx09.exe
Result: test-too-long Time: 0:05:02.228171 psx09.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psx09.exe
] 
] 
=>  test start: PSX 9
] *** BEGIN OF TEST PSX 9 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init's ID is 0x0b010001
] Init: pthread_getschedparam - SUCCESSFUL
] Init: Fri May 24 11:05:00 1996 - current priority = 2
] Init: pthread_setschedparam - SUCCESSFUL (sporadic server)
] Init: Fri May 24 11:05:00 1996 - new priority = 253
] Init: Fri May 24 11:05:00 1996 - new priority = 253
] Init: Fri May 24 11:05:00 1996 - new priority = 252
] Init: Fri May 24 11:05:00 1996 - new priority = 253
] Init: Fri May 24 11:05:00 1996 - new priority = 252
] 
] Init: pthread_setschedparam - SUCCESSFUL (sporadic server)
] Init: Initializing mutex attributes for priority ceiling
] Init: Creating a mutex
] Init: Fri May 24 11:05:00 1996 - new priority = 253
] Init: pthread_mutex_lock acquire the lock
] *** TEST TOO LONG
[162/587] p:139 f:6   u:4   e:0   I:0   B:3   t:4   L:2   i:0   W:0   | riscv32/rv32i: psx10.exe
[163/587] p:139 f:6   u:4   e:0   I:0   B:3   t:5   L:2   i:0   W:0   | riscv32/rv32i: psx11.exe
Result: test-too-long Time: 0:05:02.197688 psx11.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psx11.exe
] 
] 
=>  test start: PSX 11
] *** BEGIN OF TEST PSX 11 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init's ID is 0x0b010001
] Init: Setting scheduling parameters to FIFO with priority 254
] Init: Setting scheduling parameters to RR with priority 252
] Init: Setting scheduling parameters to OTHER with priority 248
] Init: create a thread of SCHED_FIFO with priority 247
] Init: join with the other thread
] Task_1: killing time
] Task_1: exitting
] Init: create a thread of SCHED_RR with priority 247
] Init: join with the other thread
] Task_1: killing time
] *** TEST TOO LONG
[164/587] p:140 f:6   u:4   e:0   I:0   B:3   t:5   L:2   i:0   W:0   | riscv32/rv32i: psx12.exe
 <<skipping passes>>
[184/587] p:157 f:6   u:4   e:0   I:0   B:3   t:5   L:5   i:0   W:0   | riscv32/rv32i: psxclock01.exe
Result: timeout    Time: 0:03:02.049750 psxclock01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psxclock01.exe
] 
] 
=>  test start: PSXCLOCK01
] *** BEGIN OF TEST PSXCLOCK01 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[185/587] p:158 f:6   u:4   e:0   I:0   B:3   t:5   L:5   i:0   W:0   | riscv32/rv32i: psxclockrealtime01.exe
 <<skipping passes>>
[235/587] p:207 f:7   u:4   e:0   I:0   B:3   t:5   L:5   i:0   W:0   | riscv32/rv32i: psxrwlock01.exe
Result: test-too-long Time: 0:05:02.111329 psxrwlock01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psxrwlock01.exe
] 
] 
=>  test start: PSXRWLOCK 1
] *** BEGIN OF TEST PSXRWLOCK 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] clock_gettime(CLOCK_REALTIME, &abstime) -- OK
] pthread_rwlock_timedwrlock( &RWLock, &abstime) -- OK
] pthread_rwlock_timedrdlock( &RWLock, &abstime) -- ETIMEDOUT
] *** TEST TOO LONG
[236/587] p:208 f:7   u:4   e:0   I:0   B:3   t:5   L:5   i:0   W:0   | riscv32/rv32i: psxsem01.exe
 <<skipping passes>>
[239/587] p:211 f:7   u:4   e:0   I:0   B:3   t:5   L:5   i:0   W:0   | riscv32/rv32i: psxsignal01.exe
Result: test-too-long Time: 0:05:02.196060 psxsignal01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psxsignal01.exe
] 
] 
=>  test start: PSXSIGNAL 1
] *** BEGIN OF TEST PSXSIGNAL 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init's ID is 0x0b010001
] Validate signal with SIG_DFL
] Validate signal with SIG_IGN
] Init: Unblock SIGUSR1 SIGFPE SIGILL SIGSEGV
] Init: signal return value verified
] Init: send SIGUSR1 to process
] Signal: 25 caught by 0xb010001 (1)
] Init: send SIGFPE to process
] Handler_1: Signal: 8 caught by 0xb010001 (2)
] Init: send SIGILL to process
] Handler_1: Signal: 4 caught by 0xb010001 (3)
] Init: send SIGSEGV to process
] Handler_1: Signal: 11 caught by 0xb010001 (4)
] Init: send SIGUSR1 to process from a TSR (interruptible sleep)
] *** TEST TOO LONG
[240/587] p:211 f:7   u:4   e:0   I:0   B:3   t:6   L:5   i:0   W:0   | riscv32/rv32i: psxsignal02.exe
 <<skipping passes>>
[250/587] p:221 f:7   u:4   e:0   I:0   B:3   t:6   L:5   i:0   W:0   | riscv32/rv32i: psxstat.exe
Result: test-too-long Time: 0:05:02.092591 psxstat.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psxstat.exe
] 
] 
=>  test start: PSXSTAT
] *** BEGIN OF TEST PSXSTAT ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] --->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:0x4001f318)
] ...st_ino     8003e6f0
] ...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:0x4001f318)
] ...st_ino     8003ea50
] ...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:0x4001f318)
] ...st_ino     8003eac0
] ...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:0x4001f318)
] ...st_ino     8003eb30
] ...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:0x4001f318)
] ...st_ino     8003eba0
] ...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:0x4001f318)
] ...st_ino     8003ec10
] ...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:0x4001f318)
] ...st_ino     8003ec80
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003e7b0
] ...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:0x4001f318)
] ...st_ino     8003e810
] ...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:0x4001f318)
] ...st_ino     8003e870
] ...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:0x4001f318)
] ...st_ino     8003e8d0
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...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:0x4001f318)
] ...st_ino     8003e990
] ...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:0x4001f318)
] ...st_ino     8003e6f0
] ...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:0x4001f318)
] ...st_ino     8003ea50
] ...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:0x4001f318)
] ...st_ino     8003eac0
] ...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:0x4001f318)
] ...st_ino     8003eb30
] ...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:0x4001f318)
] ...st_ino     8003eba0
] ...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:0x4001f318)
] ...st_ino     8003ec10
] ...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:0x4001f318)
] ...st_ino     8003ec80
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003e7b0
] ...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:0x4001f318)
] ...st_ino     8003e810
] ...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:0x4001f318)
] ...st_ino     8003e870
] ...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:0x4001f318)
] ...st_ino     8003e8d0
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...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:0x4001f318)
] ...st_ino     8003ecf0
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003e7b0
] ...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:0x4001f318)
] ...st_ino     8003e810
] ...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:0x4001f318)
] ...st_ino     8003e870
] ...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:0x4001f318)
] ...st_ino     8003e8d0
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...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:0x4001f318)
] ...st_ino     8003e990
] ...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:0x4001f318)
] ...st_ino     8003ea50
] ...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:0x4001f318)
] ...st_ino     8003eac0
] ...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:0x4001f318)
] ...st_ino     8003eb30
] ...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:0x4001f318)
] ...st_ino     8003eba0
] ...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:0x4001f318)
] ...st_ino     8003ec10
] ...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:0x4001f318)
] ...st_ino     8003ec80
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003e7b0
] ...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:0x4001f318)
] ...st_ino     8003e810
] ...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:0x4001f318)
] ...st_ino     8003e870
] ...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:0x4001f318)
] ...st_ino     8003e8d0
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...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:0x4001f318)
] ...st_ino     8003e990
] ...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:0x4001f318)
] ...st_ino     8003ea50
] ...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:0x4001f318)
] ...st_ino     8003eac0
] ...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:0x4001f318)
] ...st_ino     8003eb30
] ...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:0x4001f318)
] ...st_ino     8003eba0
] ...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:0x4001f318)
] ...st_ino     8003ec10
] ...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:0x4001f318)
] ...st_ino     8003ec80
] ...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:0x4001f318)
] ...st_ino     8003ea50
] ...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:0x4001f318)
] ...st_ino     8003f720
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003f7a0
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003f820
] ...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:0x4001f318)
] ...st_ino     8003f8a0
] ...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:0x4001f318)
] ...st_ino     8003e750
] ...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:0x4001f318)
] ...st_ino     8003f900
] ...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:0x4001f318)
] ...st_ino     8003fa00
] ...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:0x4001f318)
] ...st_ino     8003fa60
] ...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:0x4001f318)
] ...st_ino     8003fac0
] ...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:0x4001f318)
] ...st_ino     8003fb20
] ...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:0x4001f318)
] ...st_ino     8003fb80
] ...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:0x4001f318)
] ...st_ino     8003fbe0
] ...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:0x4001f318)
] ...st_ino     8003fc40
] ...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:0x4001f318)
] ...st_ino     8003fca0
] ...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:0x4001f318)
] ...st_ino     8003fd00
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...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:0x4001f318)
] ...st_ino     8003e930
] ...st_mode    40700
] ...st_nlink   2
] ...st_uid     0
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks  0
] Chdir to links/dir1_ dir1
] Chdir to .. should fail with ENOENT
] mkdir ../t should fail with ENOENT
] mkdir t
] chdir to /my_mount_point
] rmdir links/dir1_ dir1
] unlink links//links_dir1 d1 should fail with ENOTEMPTY
] rmdir links//links_dir1 d1/t
] unlink links//links_dir1 d1
] Attempting to mount IMFS file system at /dir1/my_mount_point 
] rmdir /dir1/my_mount_point should fail with EBUSY
] Unmount /my_mount_point/dir1/my_mount_point
] chmod of /////my_mount_point/dir1/\//file1 to group and other execute
] Open /////my_mount_point/dir1/\//file1 for write should fail with EACCES
] chmod of /my_mount_point/dir4 to User Execute and Read
] Mkdir of /my_mount_point/dir4/NewFile should fail with EACCES
] Making too many hard links.
] Making file /LinkName1
] Making file /LinkName2
] Making file /LinkName3
] Making file /LinkName4
] Making file /LinkName5
] Making file /LinkName6
] Making file /LinkName7
] Making file /LinkName8
] chdir to /my_mount_point 
] Change group of /////my_mount_point/dir1/\//file1
] stat( /////my_mount_point/dir1/\//file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ea50
] ...st_mode    100011
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /////my_mount_point/dir1/\//file1
] stat( /////my_mount_point/dir1/\//file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ea50
] ...st_mode    100011
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file2
] stat( /my_mount_point/dir1/file2 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eac0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file2
] stat( /my_mount_point/dir1/file2 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eac0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file3
] stat( /my_mount_point/dir1/file3 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eb30
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file3
] stat( /my_mount_point/dir1/file3 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eb30
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/file4
] stat( /my_mount_point/dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eba0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/file4
] stat( /my_mount_point/dir1/file4 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003eba0
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of /my_mount_point/dir1/dir1/file1
] stat( /my_mount_point/dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ec10
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of /my_mount_point/dir1/dir1/file1
] stat( /my_mount_point/dir1/dir1/file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ec10
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of ../../..//my_mount_point/dir1/./././dir1/ file1
] stat( ../../..//my_mount_point/dir1/./././dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ec80
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of ../../..//my_mount_point/dir1/./././dir1/ file1
] stat( ../../..//my_mount_point/dir1/./././dir1/ file1 ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ec80
] ...st_mode    100004
] ...st_nlink   3
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change group of main.c
] stat( main.c ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ecf0
] ...st_mode    100004
] ...st_nlink   1
] ...st_uid     0
] ...st_gid     1
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] Change owner of main.c
] stat( main.c ) returned 
] ...st_dev     (0x80000000:0x4001f318)
] ...st_ino     8003ecf0
] ...st_mode    100004
] ...st_nlink   1
] ...st_uid     1
] ...st_gid     0
] ...st_rdev    (0x0:0x0)
] ...st_size    0
] ...st_atime   Sat Dec 31 09:00:00 1988
] ...st_mtime   Sat Dec 31 09:00:00 1988
] ...st_ctime   Sat Dec 31 09:00:25 1988
] ...st_blksize 80
] ...st_blocks  0
] *** TEST TOO LONG
[251/587] p:222 f:7   u:4   e:0   I:0   B:3   t:6   L:5   i:0   W:0   | riscv32/rv32i: psxstrsignal01.exe
 <<skipping passes>>
[254/587] p:225 f:7   u:4   e:0   I:0   B:3   t:6   L:5   i:0   W:0   | riscv32/rv32i: psxtime.exe
Result: test-too-long Time: 0:05:02.127307 psxtime.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/psxtests/psxtime.exe
] 
] 
=>  test start: PSXTIME
] *** BEGIN OF TEST PSXTIME ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] 
] *** TEST TOO LONG
[255/587] p:225 f:7   u:4   e:0   I:0   B:3   t:6   L:6   i:0   W:0   | riscv32/rv32i: psxtimer01.exe
 <<skipping passes>>
[319/587] p:286 f:7   u:4   e:0   I:0   B:3   t:6   L:9   i:0   W:0   | riscv32/rv32i: rhsemshuffle.exe
Result: timeout    Time: 0:03:02.062629 rhsemshuffle.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/rhealstone/rhsemshuffle.exe
] 
] 
=>  test start: RHSEMSHUFFLE
] *** BEGIN OF TEST RHSEMSHUFFLE ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[320/587] p:287 f:7   u:4   e:0   I:0   B:3   t:6   L:9   i:0   W:0   | riscv32/rv32i: rhtaskpreempt.exe
 <<skipping passes>>
[331/587] p:295 f:8   u:6   e:0   I:0   B:3   t:6   L:9   i:0   W:0   | riscv32/rv32i: ticker.exe
Result: test-too-long Time: 0:05:02.104142 ticker.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/samples/ticker.exe
] 
] 
=>  test start: CLOCK TICK
] *** BEGIN OF TEST CLOCK TICK ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] *** TEST TOO LONG
[332/587] p:296 f:8   u:6   e:0   I:0   B:3   t:6   L:9   i:0   W:0   | riscv32/rv32i: unlimited.exe
[333/587] p:297 f:8   u:6   e:0   I:0   B:3   t:6   L:9   i:0   W:0   | riscv32/rv32i: sp01.exe
Result: test-too-long Time: 0:05:02.126116 sp01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp01.exe
] 
] 
=>  test start: SP 1
] *** BEGIN OF TEST SP 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] TA1  - rtems_clock_get_tod - 09:00:34   12/31/1988
] *** TEST TOO LONG
[334/587] p:297 f:8   u:6   e:0   I:0   B:3   t:7   L:9   i:0   W:0   | riscv32/rv32i: sp02.exe
 <<skipping passes>>
[336/587] p:299 f:8   u:6   e:0   I:0   B:3   t:7   L:9   i:0   W:0   | riscv32/rv32i: sp04.exe
Result: timeout    Time: 0:03:02.005975 sp04.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp04.exe
] 
] 
=>  test start: SP 4
] *** BEGIN OF TEST SP 4 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] *** TIMEOUT TIMEOUT
[337/587] p:300 f:8   u:6   e:0   I:0   B:3   t:7   L:9   i:0   W:0   | riscv32/rv32i: sp05.exe
Result: test-too-long Time: 0:05:02.066161 sp05.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp05.exe
] 
] 
=>  test start: SP 5
] *** BEGIN OF TEST SP 5 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] 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
] *** TEST TOO LONG
[338/587] p:300 f:8   u:6   e:0   I:0   B:3   t:7   L:10  i:0   W:0   | riscv32/rv32i: sp06.exe
 <<skipping passes>>
[344/587] p:304 f:8   u:6   e:0   I:0   B:3   t:8   L:11  i:0   W:0   | riscv32/rv32i: sp14.exe
Result: timeout    Time: 0:03:02.516459 sp14.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp14.exe
] 
] 
=>  test start: SP 14
] *** BEGIN OF TEST SP 14 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] TA1 - rtems_signal_catch - RTEMS_INTERRUPT_LEVEL( 3 )
] TA1 - rtems_signal_send - RTEMS_SIGNAL_16 to self
] ASR - ENTRY - signal => 00010000
] ASR - EXIT  - signal => 00010000
] TA1 - rtems_signal_send - RTEMS_SIGNAL_0 to self
] ASR - ENTRY - signal => 00000001
] ASR - rtems_task_wake_after - yield processor
] ASR - EXIT  - signal => 00000001
] TA1 - rtems_signal_catch - RTEMS_NO_ASR
] TA1 - rtems_signal_send - RTEMS_SIGNAL_1 to self
] ASR - ENTRY - signal => 00000002
] ASR - rtems_task_wake_after - yield processor
] ASR - EXIT  - signal => 00000002
] TA1 - rtems_task_mode - disable ASRs
] TA1 - sending signal to RTEMS_SELF from timer
] TA1 - waiting for signal to arrive
] *** TIMEOUT TIMEOUT
[345/587] p:305 f:8   u:6   e:0   I:0   B:3   t:8   L:11  i:0   W:0   | riscv32/rv32i: sp15.exe
 <<skipping passes>>
[349/587] p:309 f:8   u:6   e:0   I:0   B:3   t:8   L:11  i:0   W:0   | riscv32/rv32i: sp19.exe
Result: timeout    Time: 0:03:02.516088 sp19.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp19.exe
] 
] 
=>  test start: SP 19
] *** BEGIN OF TEST SP 19 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] FP1  - integer base = (0x6000)
] FP1  - float base = (NA)
] FP1  - integer base = (0x6000)
] FP1  - float base = (NA)
] TA1  - integer base = (0x1000)
] TA1  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA2  - integer base = (0x2000)
] TA2  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA3  - integer base = (0x3000)
] TA3  - rtems_clock_get_tod - 09:00:00   12/31/1988
] TA4  - integer base = (0x4000)
] TA4  - float base = (4000.4)
] TA4  - rtems_clock_get_tod - 09:00:00   12/31/1988
] *** TIMEOUT TIMEOUT
[350/587] p:310 f:8   u:6   e:0   I:0   B:3   t:8   L:11  i:0   W:0   | riscv32/rv32i: sp20.exe
Result: test-too-long Time: 0:05:02.092335 sp20.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp20.exe
] 
] 
=>  test start: SP 20
] *** BEGIN OF TEST SP 20 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] TA1 - rtems_rate_monotonic_create id = 0x42010001
] TA1 - rtems_rate_monotonic_ident id = 0x42010001
] TA1 - (0x42010001) period 2
] TA2 - rtems_rate_monotonic_create id = 0x42010002
] TA2 - rtems_rate_monotonic_ident id = 0x42010002
] TA2 - (0x42010002) period 2
] TA3 - rtems_rate_monotonic_create id = 0x42010003
] TA3 - rtems_rate_monotonic_ident id = 0x42010003
] TA3 - (0x42010003) period 2
] TA4 - rtems_rate_monotonic_create id = 0x42010004
] TA4 - rtems_rate_monotonic_ident id = 0x42010004
] TA4 - (0x42010004) period 2
] TA5 - rtems_rate_monotonic_create id = 0x42010005
] TA5 - rtems_rate_monotonic_ident id = 0x42010005
] TA5 - (0x42010005) period 100
] TA6 - rtems_rate_monotonic_create id = 0x42010006
] TA6 - rtems_rate_monotonic_ident id = 0x42010006
] TA6 - (0x42010006) period 0
] TA5 - PERIODS CHECK OK (1)
] TA5 - PERIODS CHECK OK (2)
] TA5 - PERIODS CHECK OK (3)
] TA5 - PERIODS CHECK OK (4)
] *** TEST TOO LONG
[351/587] p:310 f:8   u:6   e:0   I:0   B:3   t:9   L:11  i:0   W:0   | riscv32/rv32i: sp2038.exe
 <<skipping passes>>
[355/587] p:313 f:8   u:6   e:0   I:0   B:3   t:9   L:12  i:0   W:0   | riscv32/rv32i: sp24.exe
Result: test-too-long Time: 0:05:02.107223 sp24.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp24.exe
] 
] 
=>  test start: SP 24
] *** BEGIN OF TEST SP 24 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] *** TEST TOO LONG
[356/587] p:314 f:8   u:6   e:0   I:0   B:3   t:9   L:12  i:0   W:0   | riscv32/rv32i: sp25.exe
 <<skipping passes>>
[363/587] p:319 f:8   u:6   e:0   I:0   B:3   t:10  L:13  i:0   W:0   | riscv32/rv32i: sp32.exe
Result: timeout    Time: 0:03:02.017336 sp32.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp32.exe
] 
] 
=>  test start: SP 32
] *** BEGIN OF TEST SP 32 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[364/587] p:320 f:8   u:6   e:0   I:0   B:3   t:10  L:13  i:0   W:0   | riscv32/rv32i: sp33.exe
 <<skipping passes>>
[366/587] p:321 f:8   u:6   e:0   I:0   B:3   t:10  L:14  i:0   W:0   | riscv32/rv32i: sp35.exe
Result: timeout    Time: 0:03:02.287008 sp35.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sp35.exe
] 
] 
=>  test start: SP 35
] *** BEGIN OF TEST SP 35 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Sync Mutex Id = 0x1a010001
] Local Mutex Id = 0x1a010002
] Remote Mutex Id = 0x1a010003
] Ending Init-task
] TaMedium[0] Id = 0x0a010002
] TaMedium[1] Id = 0x0a010003
] TaMedium[2] Id = 0x0a010004
] TaHigh Id = 0x0a010005
] TaLow Id = 0x0a010006
] TaHwSim Id = 0x0a010007
] High_Exec (0) begins...
] Medium_Exec (0) begins...
] Medium_Exec (1) begins...
] Medium_Exec (2) begins...
] LocalHwSim_Exec begins...
] *** TIMEOUT TIMEOUT
[367/587] p:322 f:8   u:6   e:0   I:0   B:3   t:10  L:14  i:0   W:0   | riscv32/rv32i: sp37.exe
 <<skipping passes>>
[409/587] p:362 f:8   u:6   e:0   I:0   B:3   t:12  L:14  i:0   W:0   | riscv32/rv32i: spcbssched01.exe
Result: test-too-long Time: 0:05:02.124145 spcbssched01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spcbssched01.exe
] 
] 
=>  test start: SPCBSSCHED 1
] *** BEGIN OF TEST SPCBSSCHED 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] *** TEST TOO LONG
[410/587] p:363 f:8   u:6   e:0   I:0   B:3   t:12  L:14  i:0   W:0   | riscv32/rv32i: spcbssched02.exe
Result: test-too-long Time: 0:05:02.152227 spcbssched02.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spcbssched02.exe
] 
] 
=>  test start: SPCBSSCHED 2
] *** BEGIN OF TEST SPCBSSCHED 2 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init: Initializing the CBS
] Init: Create server and Destroy server
] Init: Attach thread
] Init: Detach thread
] Init: Set parameters and Get parameters
] Init: Get server id
] Init: Get approved budget
] Init: Get remaining budget
] Init: Get execution time
] Init: Cleaning up CBS
] Init: Initializing the CBS
] Init: Starting periodic task
] Periodic task: Create server and Attach thread
] Periodic task: ID and Get parameters
] Periodic task: Detach thread and Destroy server
] Periodic task: Remaining budget and Execution time
] Periodic task: Set parameters
] Periodic task: Approved budget
] Periodic task: Starting periodic behavior
] Periodic task: Starting periodic behavior
] P1-S ticks:1
] P1-F ticks:11
] P2-S ticks:11
] P2-F ticks:21
] P1-S ticks:31
] *** TEST TOO LONG
[411/587] p:364 f:8   u:6   e:0   I:0   B:3   t:12  L:14  i:0   W:0   | riscv32/rv32i: spcbssched03.exe
Result: test-too-long Time: 0:05:02.093668 spcbssched03.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spcbssched03.exe
] 
] 
=>  test start: SPCBSSCHED 3
] *** BEGIN OF TEST SPCBSSCHED 3 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] P3-F ticks:32
] P1-S ticks:32
] P1-F ticks:42
] P4-S ticks:42
] *** TEST TOO LONG
[412/587] p:365 f:8   u:6   e:0   I:0   B:3   t:12  L:14  i:0   W:0   | riscv32/rv32i: spchain.exe
 <<skipping passes>>
[419/587] p:371 f:8   u:6   e:0   I:0   B:3   t:12  L:15  i:0   W:0   | riscv32/rv32i: spcontext01.exe
Result: test-too-long Time: 0:05:02.078914 spcontext01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spcontext01.exe
] 
] 
=>  test start: SPCONTEXT 1
] *** BEGIN OF TEST SPCONTEXT 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Test configuration N N N... done
] Test configuration N N F... done
] *** TEST TOO LONG
[420/587] p:371 f:8   u:6   e:0   I:0   B:3   t:12  L:16  i:0   W:0   | riscv32/rv32i: spcoverage.exe
 <<skipping passes>>
[426/587] p:376 f:8   u:6   e:0   I:0   B:3   t:12  L:17  i:0   W:0   | riscv32/rv32i: spedfsched03.exe
Result: test-too-long Time: 0:05:02.108310 spedfsched03.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spedfsched03.exe
] 
] 
=>  test start: SPEDFSCHED 3
] *** BEGIN OF TEST SPEDFSCHED 3 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] *** TEST TOO LONG
[427/587] p:377 f:8   u:6   e:0   I:0   B:3   t:12  L:17  i:0   W:0   | riscv32/rv32i: spedfsched04.exe
Result: timeout    Time: 0:03:02.045865 spedfsched04.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spedfsched04.exe
] 
] 
=>  test start: SPEDFSCHED 4
] *** BEGIN OF TEST SPEDFSCHED 4 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[428/587] p:378 f:8   u:6   e:0   I:0   B:3   t:12  L:17  i:0   W:0   | riscv32/rv32i: sperror01.exe
 <<skipping passes>>
[470/587] p:419 f:8   u:6   e:0   I:0   B:3   t:12  L:18  i:0   W:0   | riscv32/rv32i: spintrcritical08.exe
Result: timeout    Time: 0:03:02.258246 spintrcritical08.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical08.exe
] 
] 
=>  test start: SPINTRCRITICAL 8
] *** BEGIN OF TEST SPINTRCRITICAL 8 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 8
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:RateMonotonicPeriodInterrupt
] P:0:0:UI1:init.c:166
] *** TIMEOUT TIMEOUT
[471/587] p:420 f:8   u:6   e:0   I:0   B:3   t:12  L:18  i:0   W:0   | riscv32/rv32i: spintrcritical09.exe
 <<skipping passes>>
[473/587] p:420 f:8   u:6   e:0   I:0   B:3   t:13  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical11.exe
Result: timeout    Time: 0:03:02.267779 spintrcritical11.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical11.exe
] 
] 
=>  test start: SPINTRCRITICAL 11
] *** BEGIN OF TEST SPINTRCRITICAL 11 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 11
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:EventReceiveInterruptAny
] *** TIMEOUT TIMEOUT
[474/587] p:421 f:8   u:6   e:0   I:0   B:3   t:13  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical12.exe
Result: timeout    Time: 0:03:02.294295 spintrcritical12.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical12.exe
] 
] 
=>  test start: SPINTRCRITICAL 12
] *** BEGIN OF TEST SPINTRCRITICAL 12 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 12
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:EventReceiveInterruptAll
] *** TIMEOUT TIMEOUT
[475/587] p:422 f:8   u:6   e:0   I:0   B:3   t:13  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical13.exe
 <<skipping passes>>
[480/587] p:425 f:8   u:6   e:0   I:0   B:3   t:15  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical20.exe
Result: timeout    Time: 0:03:02.271569 spintrcritical20.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical20.exe
] 
] 
=>  test start: SPINTRCRITICAL 20
] *** BEGIN OF TEST SPINTRCRITICAL 20 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 20
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:SemaphoreObtainTimeoutInterrupt
] P:0:0:UI1:init.c:153
] P:1:0:UI1:init.c:163
] P:2:0:UI1:init.c:170
] *** TIMEOUT TIMEOUT
[481/587] p:426 f:8   u:6   e:0   I:0   B:3   t:15  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical21.exe
Result: timeout    Time: 0:03:22.925656 spintrcritical21.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical21.exe
] 
] 
=>  test start: SPINTRCRITICAL 21
] *** BEGIN OF TEST SPINTRCRITICAL 21 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 21
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:EventWithTimeoutFromISR
] P:0:0:UI1:init.c:185
] E:EventWithTimeoutFromISR:N:1:F:0:D:0.048000
] B:EventFromISR
] P:0:0:UI1:init.c:119
] *** TIMEOUT TIMEOUT
[482/587] p:426 f:8   u:6   e:0   I:0   B:3   t:16  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical22.exe
Result: timeout    Time: 0:03:02.279904 spintrcritical22.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical22.exe
] 
] 
=>  test start: SPINTRCRITICAL 22
] *** BEGIN OF TEST SPINTRCRITICAL 22 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 22
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:InterruptSemaphoreObtain
] *** TIMEOUT TIMEOUT
[483/587] p:427 f:8   u:6   e:0   I:0   B:3   t:16  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical23.exe
Result: timeout    Time: 0:03:02.296655 spintrcritical23.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical23.exe
] 
] 
=>  test start: SPINTRCRITICAL 23
] *** BEGIN OF TEST SPINTRCRITICAL 23 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 23
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:TaskSetPriorityInterrupt
] P:0:0:UI1:init.c:152
] *** TIMEOUT TIMEOUT
[484/587] p:427 f:8   u:6   e:0   I:0   B:3   t:17  L:19  i:0   W:0   | riscv32/rv32i: spintrcritical24.exe
Result: timeout    Time: 0:03:02.315754 spintrcritical24.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spintrcritical24.exe
] 
] 
=>  test start: SPINTRCRITICAL 24
] *** BEGIN OF TEST SPINTRCRITICAL 24 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] A:SPINTRCRITICAL 24
] S:Platform:RTEMS
] S:Compiler:10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] S:Version:6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] S:BSP:rv32i
] S:RTEMS_DEBUG:0
] S:RTEMS_MULTIPROCESSING:0
] S:RTEMS_POSIX_API:1
] S:RTEMS_PROFILING:0
] S:RTEMS_SMP:0
] B:CloseInterrupt
] P:0:0:UI1:init.c:158
] *** TIMEOUT TIMEOUT
[485/587] p:427 f:8   u:6   e:0   I:0   B:3   t:18  L:19  i:0   W:0   | riscv32/rv32i: splinkersets01.exe
 <<skipping passes>>
[502/587] p:442 f:8   u:6   e:0   I:0   B:3   t:20  L:19  i:0   W:0   | riscv32/rv32i: spqreslib.exe
Result: timeout    Time: 0:03:03.293428 spqreslib.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spqreslib.exe
] 
] 
=>  test start: SPQRESLIB
] *** BEGIN OF TEST SPQRESLIB ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] Init: Initializing the qres library
] Init: Create server and Destroy server
] Init: Attach thread
] Init: Detach thread
] Init: Set params and Get params
] Init: Get server id
] Init: Get approved budget
] Init: Get current budget
] Init: Get execution time
] Init: Cleaning up QRES
] Init: Initializing the QRES
] Init: Starting periodic task
] Periodic task: Create server and Attach thread
] Periodic task: ID and Get parameters
] Periodic task: Detach thread and Destroy server
] Periodic task: Current budget and Execution time
] Periodic task: Set parameters
] Periodic task: Approved budget
] Periodic task: Starting periodic behavior
] P1-S ticks:1
] *** TIMEOUT TIMEOUT
[503/587] p:443 f:8   u:6   e:0   I:0   B:3   t:20  L:19  i:0   W:0   | riscv32/rv32i: spratemon_err01.exe
 <<skipping passes>>
[506/587] p:446 f:8   u:6   e:0   I:0   B:3   t:20  L:19  i:0   W:0   | riscv32/rv32i: sprmsched01.exe
Result: timeout    Time: 0:03:02.025966 sprmsched01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sprmsched01.exe
] 
] 
=>  test start: SPRMSCHED 1
] *** BEGIN OF TEST SPRMSCHED 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[507/587] p:447 f:8   u:6   e:0   I:0   B:3   t:20  L:19  i:0   W:0   | riscv32/rv32i: sprmsched02.exe
 <<skipping passes>>
[515/587] p:454 f:8   u:6   e:0   I:0   B:3   t:21  L:19  i:0   W:0   | riscv32/rv32i: spsimplesched01.exe
Result: test-too-long Time: 0:05:02.088019 spsimplesched01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/spsimplesched01.exe
] 
] 
=>  test start: SPSIMPLESCHED 1
] *** BEGIN OF TEST SPSIMPLESCHED 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] 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
] TA1  - rtems_clock_get_tod - 09:00:34   12/31/1988
] *** TEST TOO LONG
[516/587] p:455 f:8   u:6   e:0   I:0   B:3   t:21  L:19  i:0   W:0   | riscv32/rv32i: spsimplesched02.exe
 <<skipping passes>>
[533/587] p:470 f:9   u:6   e:0   I:0   B:3   t:22  L:19  i:0   W:0   | riscv32/rv32i: sptimecounter02.exe
Result: timeout    Time: 0:03:02.002016 sptimecounter02.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sptimecounter02.exe
] 
] 
=>  test start: SPTIMECOUNTER 2
] *** BEGIN OF TEST SPTIMECOUNTER 2 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] <SPTimecounter01>
] *** TIMEOUT TIMEOUT
[534/587] p:471 f:9   u:6   e:0   I:0   B:3   t:22  L:19  i:0   W:0   | riscv32/rv32i: sptimecounter03.exe
Result: timeout    Time: 0:03:02.021390 sptimecounter03.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/sptests/sptimecounter03.exe
] 
] 
=>  test start: SPTIMECOUNTER 3
] *** BEGIN OF TEST SPTIMECOUNTER 3 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] *** TIMEOUT TIMEOUT
[535/587] p:471 f:9   u:6   e:0   I:0   B:3   t:23  L:19  i:0   W:0   | riscv32/rv32i: sptimecounter04.exe
 <<skipping passes>>
[585/587] p:520 f:9   u:6   e:0   I:0   B:3   t:24  L:19  i:0   W:0   | riscv32/rv32i: tmfine01.exe
Result: timeout    Time: 0:03:02.090927 tmfine01.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/tmtests/tmfine01.exe
] 
] 
=>  test start: TMFINE 1
] *** BEGIN OF TEST TMFINE 1 ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] <TestTimeFine01>
] *** TIMEOUT TIMEOUT
[586/587] p:521 f:9   u:6   e:0   I:0   B:3   t:24  L:19  i:0   W:0   | riscv32/rv32i: tmonetoone.exe
Result: timeout    Time: 0:03:02.125871 tmonetoone.exe
=>  exe: spike --isa=RV32I ./riscv-rtems6/c/rv32i/testsuites/tmtests/tmonetoone.exe
] 
] 
=>  test start: TMONETOONE
] *** BEGIN OF TEST TMONETOONE ***
] *** TEST VERSION: 6.0.0.7b99d7619ec3ff1143db003a541505367f8004d5
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 10.2.1 20210121 (RTEMS 6, RSB 65abc3e1f39404d1169bc4d361c6a78c937655ed, Newlib a533334)
] yield
] *** TIMEOUT TIMEOUT
[587/587] p:521 f:9   u:6   e:0   I:0   B:3   t:25  L:19  i:0   W:0   | riscv32/rv32i: tmtimer01.exe

Passed:        522
Failed:          9
User Input:      6
Expected Fail:   0
Indeterminate:   0
Benchmark:       3
Timeout:        27
Test too long:  20
Invalid:         0
Wrong Version:   0
Wrong Build:     0
Wrong Tools:     0
------------------
Total:         587
Failures:
 dl02.exe
 dl05.exe
 dl06.exe
 dl07.exe
 dl08.exe
 dl09.exe
 psxfenv01.exe
 minimum.exe
 spsysinit01.exe
User Input:
 dl10.exe
 monitor.exe
 termios.exe
 top.exe
 capture.exe
 fileio.exe
Benchmark:
 whetstone.exe
 linpack.exe
 dhrystone.exe
Timeouts:
 fsdosfsformat01.exe
 block05.exe
 capture01.exe
 cpuuse.exe
 ttest02.exe
 psxclock01.exe
 rhsemshuffle.exe
 sp04.exe
 sp14.exe
 sp19.exe
 sp32.exe
 sp35.exe
 spedfsched04.exe
 spintrcritical08.exe
 spintrcritical11.exe
 spintrcritical12.exe
 spintrcritical20.exe
 spintrcritical21.exe
 spintrcritical22.exe
 spintrcritical23.exe
 spintrcritical24.exe
 spqreslib.exe
 sprmsched01.exe
 sptimecounter02.exe
 sptimecounter03.exe
 tmfine01.exe
 tmonetoone.exe
Test too long:
 block08.exe
 crypt01.exe
 psx07.exe
 psx09.exe
 psx11.exe
 psxrwlock01.exe
 psxsignal01.exe
 psxstat.exe
 psxtime.exe
 ticker.exe
 sp01.exe
 sp05.exe
 sp20.exe
 sp24.exe
 spcbssched01.exe
 spcbssched02.exe
 spcbssched03.exe
 spcontext01.exe
 spedfsched03.exe
 spsimplesched01.exe
Average test time: 0:00:08.954826
Testing time     : 1:27:36.482646


More information about the build mailing list