[rtems-test] riscv32/rv32im: RTEMS_POSIX_API: Passed:533 Failed:21 Timeout:28 Invalid:0 Wrong:0
joel at rtems.org
joel at rtems.org
Sat May 23 14:07:02 UTC 2020
Testing time : 0:45:50.131871
Average test time: 0:00:04.653353
Host
====
FreeBSD-12.1-RELEASE-p3-amd64-64bit-ELF (FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64 amd64)
Configuration
=============
Version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
Build : RTEMS_POSIX_API
Tools : 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
Summary
=======
Passed: 533
Failed: 21
User Input: 6
Expected Fail: 0
Indeterminate: 0
Benchmark: 3
Timeout: 28
Invalid: 0
Wrong Version: 0
Wrong Build: 0
Wrong Tools: 0
------------------
Total: 591
Failures:
dl02.exe
dl05.exe
dl06.exe
dl07.exe
dl08.exe
dl09.exe
psxfenv01.exe
spintrcritical01.exe
spintrcritical02.exe
spintrcritical03.exe
spintrcritical04.exe
spintrcritical05.exe
spintrcritical08.exe
spintrcritical10.exe
spintrcritical16.exe
spintrcritical20.exe
spintrcritical21.exe
spintrcritical22.exe
spintrcritical23.exe
spintrcritical24.exe
spsysinit01.exe
User Input:
dl10.exe
monitor.exe
termios.exe
top.exe
capture.exe
fileio.exe
Benchmark:
dhrystone.exe
whetstone.exe
linpack.exe
Timeouts:
block08.exe
cpuuse.exe
crypt01.exe
flashdisk01.exe
psx07.exe
psxmsgq01.exe
psxrwlock01.exe
psxstat.exe
psxtime.exe
psxtimer01.exe
ticker.exe
sp01.exe
sp04.exe
sp05.exe
sp12.exe
sp19.exe
sp20.exe
sp24.exe
sp30.exe
sp32.exe
spcbssched01.exe
spcbssched03.exe
spcontext01.exe
spedfsched01.exe
spedfsched03.exe
spsimplesched01.exe
tmfine01.exe
tmonetoone.exe
Log
===
RTEMS Testing - Tester, 5 (ea86d967ec0e)
Command Line: /home/joel/rtems-cron-5/rtems-tools//tester/rtems-test --rtems-tools=/home/joel/rtems-cron-5/tools/5 --rtems-bsp=rv32im_spike --log=run.log --mail --mail-from=joel at rtems.org --mail-to=build at rtems.org .
Host: FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64
Python: 3.6.9 (default, Oct 24 2019, 01:18:01) [GCC 4.2.1 Compatible FreeBSD Clang 6.0.1 (tags/RELEASE_601/final 335540)]
Host: FreeBSD-12.1-RELEASE-p3-amd64-64bit-ELF (FreeBSD rtbf64b 12.1-RELEASE-p3 FreeBSD 12.1-RELEASE-p3 GENERIC amd64 amd64)
[ 1/591] p:0 f:0 u:0 e:0 I:0 B:0 t:0 i:0 W:0 | riscv32/rv32im: dhrystone.exe
<<skipping passes>>
[ 67/591] p:60 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: block08.exe
Result: timeout Time: 0:03:00.689183 block08.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/block08.exe
]
]
=> test start: BLOCK 8
] *** BEGIN OF TEST BLOCK 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TEST DISK - OK
] Test 1.1 - STARTED
] Thread #1 started
] DISK_DRV: R [0]
] Test 1.1: Step 2 - OK
] DISK_DRV: R [10]
] Test 1.1: Step 4 - OK
] DISK_DRV: R [10]
] Test 1.1: Step 6 - OK
] TEST PASSED
] Test 1.2 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [20]
] Test 1.2: Step 3 - OK
] DISK_DRV: R [20]
] Test 1.2: Step 5 - OK
] TEST PASSED
] Test 1.3 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [30]
] Test 1.3: Step 3 - OK
] DISK_DRV: R [30]
] Test 1.3: Step 5 - OK
] TEST PASSED
] Test 1.4 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [40]
] Test 1.4: Step 3 - OK
] Test 1.4: Step 5 - OK
] TEST PASSED
] Test 1.5 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [50]
] Test 1.5: Step 1 - OK
] Test 1.5: Step 4 - OK
] TEST PASSED
] Test 2.1 - STARTED
] Thread #1 started
] Thread #2 started
] DISK_DRV: R [60]
] Test 2.1: Step 3 - OK
] Test 2.1: Step 5 - OK
] 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
] *** TIMEOUT TIMEOUT
[ 68/591] p:61 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: block09.exe
<<skipping passes>>
[ 80/591] p:73 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: cpuuse.exe
Result: timeout Time: 0:03:00.473222 cpuuse.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/cpuuse.exe
]
]
=> test start: CPUUSE
] *** BEGIN OF TEST CPUUSE ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] TA1 - rtems_task_resume - on Task 2
] TA1 - rtems_task_resume - on Task 3
] TA1 - rtems_task_mode - change mode to NO RTEMS_PREEMPT
] TA1 - 09:15:09 12/31/1988
] TA1 - 09:15:10 12/31/1988
] TA1 - 09:15:11 12/31/1988
] *** TIMEOUT TIMEOUT
[ 81/591] p:74 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: crypt01.exe
Result: timeout Time: 0:03:00.418262 crypt01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/crypt01.exe
]
]
=> test start: CRYPT 1
] *** BEGIN OF TEST CRYPT 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] test crypt_md5_r()
] test crypt_sha256_r()
] input: Hello world!
] salt: $5$saltstring
] expected: $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] actual: $5$saltstring$5B8vYYiY.CVt1RlTTf8KbXBH3hsxY/GNooZaBBGWEc5
] input: Hello world!
] salt: $5$rounds=10000$saltstringsaltstring
] expected: $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] actual: $5$rounds=10000$saltstringsaltst$3xv.VbSHBb41AL9AvLeujZkZRBAwqFMz2.opqey6IcA
] input: This is just a test
] salt: $5$rounds=5000$toolongsaltstring
] expected: $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] actual: $5$rounds=5000$toolongsaltstrin$Un/5jzAHMgOGZ5.mWJpuVolil07guHPvOW8mGRcvxa5
] input: a very much longer text to encrypt. This one even stretches over morethan one line.
] salt: $5$rounds=1400$anotherlongsaltstring
] expected: $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] actual: $5$rounds=1400$anotherlongsalts$Rx.j8H.h8HjEDGomFU8bDkXm3XIUnzyxf12oP84Bnq1
] input: we have a short salt string but not a short password
] salt: $5$rounds=77777$short
] expected: $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] actual: $5$rounds=77777$short$JiO1O3ZpDAxGJeaDIuqCoEFysAe1mZNJRs3pw0KQRd/
] input: a short string
] salt: $5$rounds=123456$asaltof16chars..
] expected: $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] actual: $5$rounds=123456$asaltof16chars..$gP3VQ/6X7UUEW3HkBn2w1/Ptq2jxPyzV/cZKmF/wJvD
] input: the minimum number is still observed
] salt: $5$rounds=10$roundstoolow
] expected: $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] actual: $5$rounds=1000$roundstoolow$yfvwcWrQ8l/K0DAWyuPMDNHpIVlTQebY9l/gL972bIC
] test crypt_sha512_r()
] input: Hello world!
] salt: $6$saltstring
] expected: $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] actual: $6$saltstring$svn8UoSVapNtMuq1ukKS4tPQd8iKwSMHWjl/O817G3uBnIFNjnQJuesI68u4OTLiBFdcbYEdFCoEOfaS35inz1
] input: Hello world!
] salt: $6$rounds=10000$saltstringsaltstring
] expected: $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] actual: $6$rounds=10000$saltstringsaltst$OW1/O6BYHV6BcXZu8QVeXbDWra3Oeqh0sbHbbMCVNSnCM/UrjmM0Dp8vOuZeHBy/YTBmSK6H9qs/y3RnOaw5v.
] input: This is just a test
] salt: $6$rounds=5000$toolongsaltstring
] expected: $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] actual: $6$rounds=5000$toolongsaltstrin$lQ8jolhgVRVhY4b5pZKaysCLi0QBxGoNeKQzQ3glMhwllF7oGDZxUhx1yxdYcz/e1JSbq3y6JMxxl8audkUEm0
] input: a very much longer text to encrypt. This one even stretches over morethan one line.
] salt: $6$rounds=1400$anotherlongsaltstring
] expected: $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] actual: $6$rounds=1400$anotherlongsalts$POfYwTEok97VWcjxIiSOjiykti.o/pQs.wPvMxQ6Fm7I6IoYN3CmLs66x9t0oSwbtEW7o7UmJEiDwGqd8p4ur1
] *** TIMEOUT TIMEOUT
[ 82/591] p:75 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: defaultconfig01.exe
<<skipping passes>>
[ 88/591] p:81 f:0 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl02.exe
Result: failed Time: 0:00:01.008782 dl02.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl02.exe
]
]
=> test start: libdl (RTL) 2
] *** BEGIN OF TEST libdl (RTL) 2 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] load: /dl02-o1.o
] handle: 0x80063690 has unresolved externals
] load: /dl02-o2.o
] handle: 0x80063e40 has unresolved externals
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o1.c]
] 0: 1
] 1: 2
] 2: 3
] 3: 4
] Loaded module: argc:4 [../../../../../../rtems/c/src/../../testsuites/libtests/dl02/dl02-o2.c]
] 0: 1
] 1: 2
] 2: 3
] 3: 4
] dl_o2_func2: d1=2147483647.00 d2=0.0 ret=0.00
] rtems_main: dl_o2_func2 returned: 0.00
] rtems_main: dl_o2_func2 returned a bad
] dlsym call failed: ret value bad
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 89/591] p:81 f:1 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl03.exe
<<skipping passes>>
[ 91/591] p:83 f:1 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl05.exe
Result: failed Time: 0:00:01.008640 dl05.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl05.exe
]
]
=> test start: libdl (RTL) 5
] *** BEGIN OF TEST libdl (RTL) 5 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
]
] *** FATAL ***
] fatal source: 9 (RTEMS_FATAL_SOURCE_EXCEPTION)
] mstatus 0x00001880
] mcause 0x00000004
] mepc 0x80018c5c
] ra 0x80017390
] sp 0x800764e0
] gp 0x8006a800
] tp 0x00000000
] t0 0xff7fffff
] t1 0x800172a4
] t2 0xffffffff
] s0 0x80085e17
] s1 0x800841a0
] a0 0x00000023
] a1 0x8005c004
] a2 0x80084450
] a3 0x00000003
] a4 0x80018c5c
] a5 0x80085b60
] a6 0xfffffd49
] a7 0x80085b60
] s2 0x80085b60
] s3 0x800765a0
] s4 0x00000001
] s5 0x8007db44
] s6 0x80084450
] s7 0x800853d8
] s8 0x800841a0
] s9 0x80084bd0
] s10 0x80084c20
] s11 0x80076550
] t3 0x2e003738
] t4 0x31465341
] t5 0x4c2e0036
] t6 0x38314653
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 92/591] p:83 f:2 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl06.exe
Result: failed Time: 0:00:01.009178 dl06.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl06.exe
]
]
=> test start: libdl (RTL) 6
] *** BEGIN OF TEST libdl (RTL) 6 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
]
] load: /dl06.rap
] dlopen failed: (null)
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 93/591] p:83 f:3 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl07.exe
Result: failed Time: 0:00:01.008906 dl07.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl07.exe
]
]
=> test start: libdl (RTL) 7
] *** BEGIN OF TEST libdl (RTL) 7 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
] Run: 0
] Test source (link in strstr): testsuites/libtests/dl07/dl-load.c
] load: /dl07-o1.o
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl07/dl-load.c: 70 unresolved == 0
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 94/591] p:83 f:4 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl08.exe
Result: failed Time: 0:00:01.008805 dl08.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl08.exe
]
]
=> test start: libdl (RTL) 8
] *** BEGIN OF TEST libdl (RTL) 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
] Run: 0
] Test source (link in strstr): testsuites/libtests/dl08/dl-load.c
] load: /dl08-o1.o
] dlo6: CONSTRUCTOR: ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl08-o6-123456789-123456789.c
] dlo6: dl06_unresolv_1: 8: 0x80083ab0: 0
] dlo6: dl06_unresolv_2: 2: 0x80083ab8: 0
] dlo6: dl06_unresolv_3: 4: 0x80083abc: 0
] dlo6: dl06_unresolv_4: 1: 0x80083ac0: 0
] dlo6: dl06_unresolv_5: 8: 0x80083ac8: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl08/dl-load.c: 71 unresolved == 0
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 95/591] p:83 f:5 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl09.exe
Result: failed Time: 0:00:01.008868 dl09.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/dl09.exe
]
]
=> test start: libdl (RTL) 9
] *** BEGIN OF TEST libdl (RTL) 9 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --------------------------------------------------
] Run: 0
] Test source (link in strstr): testsuites/libtests/dl09/dl-load.c
] load: /dl09-o1.o
] handel: 0x800757e0: unresolved externals
] handle: 0x800757e0 loaded
] space alloc: /dl09-o1.o: 33554432: 0x80076db0
] load: /dl09-o2.o
] handel: 0x80076080: unresolved externals
] handle: 0x80076080 loaded
] space alloc: /dl09-o2.o: 33554432: 0
] ../../../../../../rtems/c/src/../../testsuites/libtests/dl09/dl-load.c: 156 o->space != NULL
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[ 96/591] p:83 f:6 u:0 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: dl10.exe
<<skipping passes>>
[100/591] p:86 f:6 u:1 e:0 I:0 B:3 t:0 i:0 W:0 | riscv32/rv32im: flashdisk01.exe
Result: timeout Time: 0:03:00.648672 flashdisk01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/libtests/flashdisk01.exe
]
]
=> test start: FLASHDISK 1
] *** BEGIN OF TEST FLASHDISK 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] [00]: start
] [00]: mount: /dev/fdda -> /mnt
] [00]: init root: /mnt
] [00]: create dir: 1804928587
] [00]: create dir: 959030623
] [00]: create dir: 1903590565
] [00]: open file: file
] [00]: sleep: 700 ms
] [00]: close file
] [00]: sleep: 200 ms
] [00]: open dir: 959030623
] [00]: create dir: 838545539
] [00]: create file: 1594243340
] [00]: create file: 162216788
] [00]: create file: 1841205112
] [00]: sleep: 700 ms
] [00]: remove dir: 838545539
] [00]: create dir: 1143741253
] [00]: remove file: 1594243340
] [00]: sleep: 400 ms
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: create file: 832100416
] [00]: open dir: 1903590565
] [00]: create file: 1401208270
] [00]: create dir: 2032315143
] [00]: create dir: 2026989069
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: close dir
] [00]: open dir: 1804928587
] [00]: sleep: 100 ms
] [00]: create dir: 650320721
] [00]: sleep: 500 ms
] [00]: create dir: 1857409239
] [00]: create file: 2060801678
] [00]: create dir: 490998763
] [00]: create dir: 644928527
] [00]: create file: 1758287264
] [00]: close dir
] [00]: sleep: 500 ms
] [00]: open file: file
] [00]: read from file
] [00]: read from file
] [00]: read from file
] [00]: sleep: 700 ms
] [00]: read from file
] [00]: sleep: 200 ms
] [00]: sleep: 300 ms
] [00]: read from file
] [00]: append to file
] [00]: read from file
] [00]: close file
] [00]: remove dir: 1804928587
] [00]: create file: 2073894790
] [00]: sleep: 900 ms
] [00]: create dir: 472737403
] [00]: remove dir: 1903590565
] [00]: create dir: 689486081
] [00]: create dir: 373636079
] [00]: remove file: file
] [00]: create dir: 1506727461
] [00]: open dir: 959030623
] [00]: create dir: 1029668001
] [00]: remove file: 162216788
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: open dir: 959030623
] [00]: remove file: 1841205112
] [00]: create file: 378843792
] [00]: sleep: 1000 ms
] [00]: create file: 1871951748
] [00]: open dir: 1143741253
] [00]: create file: 855915646
] [00]: sleep: 700 ms
] [00]: create file: 2008730550
] [00]: close dir
] [00]: create file: 1327563176
] [00]: remove dir: 1143741253
] [00]: create file: 1384249492
] [00]: close dir
] [00]: remove dir: 959030623
] [00]: open file: 832100416
] [00]: read from file
] [00]: sleep: 400 ms
] [00]: close file
] [00]: open file: 832100416
] [00]: close file
] [00]: create dir: 2025552021
] [00]: remove dir: 959030623
] [00]: create dir: 1178339711
] [00]: remove file: 832100416
] [00]: remove file: 2073894790
] [00]: open dir: 1506727461
] [00]: sleep: 700 ms
] [00]: close dir
] [00]: sleep: 300 ms
] [00]: open dir: 1506727461
] [00]: create dir: 1625748679
] [00]: close dir
] [00]: remove dir: 689486081
] [00]: remove dir: 959030623
] [00]: open dir: 959030623
] [00]: sleep: 1000 ms
] [00]: close dir
] [00]: sleep: 100 ms
] [00]: open dir: 959030623
] [00]: create dir: 1128727833
] [00]: create file: 1203746106
] [00]: open dir: 1128727833
] [00]: create dir: 58221889
] [00]: create file: 611814452
] [00]: create dir: 420219909
] [00]: close dir
] [00]: remove file: 1384249492
] [00]: close dir
] [00]: open dir: 959030623
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: remove dir: 1506727461
] [00]: create file: 550820384
] [00]: create file: 833699694
] [00]: remove dir: 1506727461
] [00]: create dir: 861614531
] [00]: remove dir: 1506727461
] [00]: create dir: 846638047
] [00]: remove dir: 1506727461
] [00]: create dir: 1766470371
] [00]: remove dir: 959030623
] [00]: create file: 1969337196
] [00]: remove dir: 1506727461
] [00]: create file: 1937189238
] [00]: remove dir: 959030623
] [00]: create dir: 1615521955
] [00]: remove dir: 959030623
] [00]: sleep: 500 ms
] [00]: open dir: 1506727461
] [00]: create file: 926653184
] [00]: remove dir: 1625748679
] [00]: close dir
] [00]: create dir: 975747319
] [00]: open dir: 959030623
] [00]: open file: 1871951748
] [00]: sleep: 600 ms
] [00]: close file
] [00]: sleep: 800 ms
] [00]: remove file: 378843792
] [00]: open file: 1203746106
] [00]: read from file
] [00]: append to file
] [00]: sleep: 600 ms
] [00]: close file
] [00]: open file: 1871951748
] [00]: append to file
] [00]: close file
] [00]: remove file: 1871951748
] [00]: sleep: 400 ms
] [00]: create file: 1835979858
] [00]: open dir: 1128727833
] [00]: create dir: 862728993
] [00]: sleep: 700 ms
] [00]: remove dir: 862728993
] [00]: close dir
] [00]: close dir
] [00]: open dir: 975747319
] [00]: sleep: 400 ms
] [00]: create dir: 1840098529
] [00]: create file: 231405798
] [00]: remove dir: 1840098529
] [00]: close dir
] [00]: remove file: 550820384
] [00]: create file: 1020303340
] [00]: create dir: 895068705
] [00]: open dir: 975747319
] [00]: close dir
] [00]: open file: 1020303340
] [00]: read from file
] [00]: close file
] [00]: create dir: 1993404773
] [00]: remove file: 1020303340
] [00]: create dir: 2112395285
] [00]: create dir: 81202983
] [00]: remove dir: 975747319
] [00]: remove dir: 959030623
] [00]: create dir: 467069459
] [00]: open dir: 1506727461
] [00]: create file: 612609068
] [00]: create dir: 1793174441
] [00]: create file: 710808000
] [00]: sleep: 300 ms
] [00]: create file: 897370450
] [00]: create file: 1901152134
] [00]: sleep: 200 ms
] [00]: close dir
] [00]: open dir: 1506727461
] [00]: close dir
] [00]: sleep: 800 ms
] [00]: create file: 906254788
] [00]: remove dir: 467069459
] [00]: remove dir: 1506727461
] [00]: open dir: 895068705
] [00]: close dir
] [00]: create file: 1216543556
] [00]: create file: 37176518
] [00]: open dir: 2112395285
] [00]: close dir
] [00]: create dir: 659416143
] [00]: remove file: 37176518
] [00]: sleep: 500 ms
] [00]: remove dir: 895068705
] [00]: create dir: 1507289677
] [00]: open dir: 959030623
] [00]: create file: 1766335976
] [00]: close dir
] [00]: sleep: 400 ms
] [00]: open dir: 2112395285
] [00]: create dir: 1476817327
] [00]: close dir
] [00]: create dir: 1841667551
] [00]: remove dir: 2112395285
] [00]: open dir: 1507289677
] [00]: close dir
] [00]: create file: 1610238546
] [00]: create file: 220151308
] [00]: remove dir: 1507289677
] [00]: open file: 1216543556
] [00]: append to file
] [00]: append to file
] [00]: close file
] [00]: remove file: 1216543556
] [00]: open dir: 959030623
] [00]: sleep: 500 ms
] *** TIMEOUT TIMEOUT
[101/591] p:86 f:6 u:1 e:0 I:0 B:3 t:1 i:0 W:0 | riscv32/rv32im: getentropy01.exe
<<skipping passes>>
[158/591] p:137 f:6 u:4 e:0 I:0 B:3 t:4 i:0 W:0 | riscv32/rv32im: psx07.exe
Result: timeout Time: 0:03:00.472742 psx07.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psx07.exe
]
]
=> test start: PSX 7
] *** BEGIN OF TEST PSX 7 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init's ID is 0x0b010001
] Init - pthread_attr_init - EINVAL (NULL attr)
] Init - pthread_attr_init - SUCCESSFUL
] Init - initialize and destroy an attribute - SUCCESSFUL
] Init - pthread_attr_destroy - EINVAL (NULL attr)
] Init - pthread_attr_destroy - EINVAL (not initialized)
] Init - pthread_create - EINVAL (attr not initialized)
] Init - pthread_create - EINVAL (stacksize too small)
] Init - pthread_create - EAGAIN (stacksize too large)
] Init - pthread_create - EINVAL (invalid inherit scheduler)
] Init - pthread_create - ENOTSUP (unsupported system contention scope)
] Init - pthread_create - SUCCESSFUL (inherit scheduler)
] Task_1 - exitting
]
] Init - pthread_attr_setscope - EINVAL (NULL attr)
] Init - pthread_attr_setscope - ENOTSUP
] Init - pthread_attr_setscope - EINVAL (not initialized attr)
] Init - pthread_attr_setscope - EINVAL (invalid scope)
] Init - pthread_attr_setscope - SUCCESSFUL
] Init - pthread_attr_getscope - EINVAL (NULL attr)
] Init - pthread_attr_getscope - EINVAL (NULL scope)
] Init - pthread_attr_getscope - EINVAL (not initialized attr)
] Init - pthread_attr_getscope - SUCCESSFUL
] Init - current scope attribute = 0
]
] Init - pthread_attr_setinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_setinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_setinheritsched - ENOTSUP (invalid inheritsched)
] Init - pthread_attr_setinheritsched - SUCCESSFUL
] Init - pthread_attr_getinheritsched - EINVAL (NULL attr)
] Init - pthread_attr_getinheritsched - EINVAL (NULL inheritsched)
] Init - pthread_attr_getinheritsched - EINVAL (not initialized attr)
] Init - pthread_attr_getinheritsched - SUCCESSFUL
] Init - current inherit scheduler attribute = 1
]
] Init - pthread_attr_setschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_setschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_setschedpolicy - ENOTSUP (invalid schedpolicy)
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_getschedpolicy - EINVAL (NULL attr)
] Init - pthread_attr_getschedpolicy - EINVAL (NULL schedpolicy)
] Init - pthread_attr_getschedpolicy - EINVAL (not initialized attr)
] Init - pthread_attr_getschedpolicy - SUCCESSFUL
] Init - current scheduler policy attribute = 2
]
] Init - pthread_attr_setstacksize - EINVAL (NULL attr)
] Init - pthread_attr_setstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_setstacksize - SUCCESSFUL (low stacksize)
] Init - pthread_attr_setstacksize - SUCCESSFUL (high stacksize)
] Init - pthread_attr_getstacksize - EINVAL (NULL attr)
] Init - pthread_attr_getstacksize - EINVAL (NULL stacksize)
] Init - pthread_attr_getstacksize - EINVAL (not initialized attr)
] Init - pthread_attr_getstacksize - SUCCESSFUL
] Init - current stack size attribute is OK
]
] Init - pthread_attr_setstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_setstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_setstackaddr - SUCCESSFUL
] Init - pthread_attr_getstackaddr - EINVAL (NULL attr)
] Init - pthread_attr_getstackaddr - EINVAL (NULL stackaddr)
] Init - pthread_attr_getstackaddr - EINVAL (not initialized attr)
] Init - pthread_attr_getstackaddr - SUCCESSFUL
] Init - current stack address attribute = 0
]
] Init - pthread_attr_setstack- EINVAL (NULL attr)
] Init - pthread_attr_setstack- EINVAL (destroyed attr)
] Init - pthread_attr_setstack- SUCCESSFUL (< min stack)
] Init - pthread_attr_setstack- SUCCESSFUL (big stack)
] Init - pthread_attr_getstack- EINVAL (NULL attr)
] Init - pthread_attr_getstack- EINVAL (destroyed attr)
] Init - pthread_attr_getstack- EINVAL (NULL stack)
] Init - pthread_attr_getstack- EINVAL (NULL stacksize)
] Init - pthread_attr_getstack- SUCCESSFUL
]
] Init - pthread_attr_setguardsize - EINVAL (NULL attr)
] Init - pthread_attr_setguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_setguardsize - SUCCESSFUL (low guardsize)
] Init - pthread_attr_setguardsize - SUCCESSFUL (high guardsize)
] Init - pthread_attr_getguardsize - EINVAL (NULL attr)
] Init - pthread_attr_getguardsize - EINVAL (NULL guardsize)
] Init - pthread_attr_getguardsize - EINVAL (not initialized attr)
] Init - pthread_attr_getguardsize - SUCCESSFUL
]
] Init - pthread_attr_setdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_setdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_setdetachstate - EINVAL (invalid detachstate)
] Init - pthread_attr_setdetachstate - SUCCESSFUL
] Init - pthread_attr_getdetachstate - EINVAL (NULL attr)
] Init - pthread_attr_getdetachstate - EINVAL (NULL detatchstate)
] Init - pthread_attr_getdetachstate - EINVAL (not initialized attr)
] Init - pthread_attr_getdetachstate - SUCCESSFUL
] Init - current detach state attribute = 1
]
] Init - pthread_attr_getschedparam - SUCCESSFUL
] Init - sched priority = 2
] Init - sched_ss_low_priority = 0
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
] Init - pthread_attr_setschedparam - EINVAL (NULL attr)
] Init - pthread_attr_setschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Init - pthread_attr_getschedparam - EINVAL (NULL attr)
] Init - pthread_attr_getschedparam - EINVAL (not initialized attr)
] Init - pthread_attr_getschedparam - EINVAL (NULL schedparam)
]
] Init - pthread_getschedparam - EINVAL (NULL policy)
] Init - pthread_getschedparam - EINVAL (NULL schedparam)
] Init - pthread_getschedparam - ESRCH (bad thread)
] Init - pthread_getschedparam - SUCCESSFUL
] Init - policy = 1
] Init - sched priority = 2
] Init - sched_ss_low_priority = 2
] Init - sched_ss_replenish_period = (0, 0)
] Init - sched_sched_ss_initial_budget = (0, 0)
]
] Init - pthread_setschedparam - EINVAL (NULL schedparam)
] Init - pthread_setschedparam - EINVAL (invalid priority)
] Init - pthread_setschedparam - EINVAL (invalid policy)
] Init - pthread_setschedparam - ESRCH (invalid thread)
] Init - pthread_setschedparam - EINVAL (replenish == 0)
] Init - pthread_setschedparam - EINVAL (budget == 0)
] Init - pthread_setschedparam - EINVAL (replenish < budget)
] Init - pthread_setschedparam - EINVAL (invalid priority)
]
] Init - pthread_attr_init - SUCCESSFUL
] Init - pthread_attr_setinheritsched - EXPLICIT - SUCCESSFUL
] Init - pthread_attr_setschedpolicy - SUCCESSFUL
] Init - pthread_attr_setschedparam - SUCCESSFUL
] Time elapsed Task_2: 0 (seconds)
] Time elapsed Task_2: 1 (seconds)
] Time elapsed Task_2: 2 (seconds)
] Time elapsed Task_2: 3 (seconds)
] Time elapsed Task_2: 4 (seconds)
] Time elapsed Task_2: 5 (seconds)
] Time elapsed Task_2: 6 (seconds)
] *** TIMEOUT TIMEOUT
[159/591] p:138 f:6 u:4 e:0 I:0 B:3 t:4 i:0 W:0 | riscv32/rv32im: psx08.exe
<<skipping passes>>
[195/591] p:173 f:6 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxfenv01.exe
Result: failed Time: 0:00:01.117142 psxfenv01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxfenv01.exe
]
]
=> test start: PSXFENV 01
] *** BEGIN OF TEST PSXFENV 01 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] fesetenv(FE_DFL_ENV).
] feclearexcept(FE_ALL_EXCEPT).
] Divide by zero and confirm fetestexcept()
] ../../../../../../rtems/c/src/../../testsuites/psxtests/psxfenv01/init.c: 99 fetestexcept( FE_DIVBYZERO )
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[196/591] p:175 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxfile01.exe
<<skipping passes>>
[221/591] p:198 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxmsgq01.exe
Result: timeout Time: 0:03:00.332527 psxmsgq01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxmsgq01.exe
]
]
=> test start: PSXMSGQ 1
] *** BEGIN OF TEST PSXMSGQ 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] _______________mq_open errors
] Init: mq_open - Create with maxmsg (-1) (EINVAL)
] Init: mq_open - Create with msgsize (-1) (EINVAL)
] Init: mq_open - Open new mq without create flag (ENOENT)
] Init: mq_open - Open with too long of a name (ENAMETOOLONG)
] Init: mq_open - Create an Existing mq (EEXIST)
] Init: mq_open - SUCCESSFUL
] Init: mq_open - system is out of resources (ENFILE)
] Init: mq_close and mq_unlink (mq3...mqn) - SUCCESSFUL
] Init: Open Test Queues
] _______________verify_blocking_mq_timedsend
] _______________mq_unlink errors
] Init: mq_unlink - mq_unlink with too long of a name (ENAMETOOLONG)
] Init: mq_unlink - A Queue not opened (ENOENT)
] Init: mq_unlink (NULL) - EINVAL
] Init: mq_unlink ("") - ENOENT
] _______________mq_close errors
] Init: mq_close - unopened queue (EBADF)
] _______________mq_unlink functionality
] Init: Unlink and Open without closing SUCCESSFUL
] Task1:mq_setattr - unopened queue (EBADF)
] Task1:mq_setattr - NULL attributes (EINVAL)
] Init: set_attr all queues to blocking
] Init: Init: mq_timedreceive - on queue Qnoblock Init: 1 sec 7250 us
] Init: Init: mq_timedreceive - on queue Qblock Init: 1 sec 9670 us
] Init: Init: mq_timedreceive - on queue Qdefault Init: 1 sec 9660 us
] _______________mq_send errors
] Init: mq_send - Closed message queue (EBADF)
] Init: mq_send - Read only message queue (EBADF)
] Init: mq_send - Priority out of range (EINVAL)
] Init: mq_send - Message longer than msg_len (EMSGSIZE)
] Init: Verify Queues are empty
] Init: Fill Queues with messages
] Init: Verify Queues are full
] Init: mq_send - on a FULL non-blocking queue with (EAGAIN)
] _______________mq_getattr errors
] Init: mq_getattr - unopened queue (EBADF)
] Init: mq_getattr - NULL attributes (EINVAL)
] _______________mq_timedsend
] Init: mq_timedsend - on queue Qnoblock Init: 0 sec 0 us
] Init: mq_timedsend - on queue Qblock Init: 1 sec 6755 us
] Init: mq_timedsend - on queue Qdefault Init: 0 sec 0 us
] _______________mq_receive errors
] Init: mq_receive - Unopened message queue (EBADF)
] Init: mq_receive - Write only queue (EBADF)
] Init: mq_receive - Size is less than the message (EMSGSIZE)
] Init: Verify Queues are full
] Init: Empty all Queues
] Init: mq_receive - Queue is empty (EAGAIN)
] _______________mq_timedreceive
] Init: Init: mq_timedreceive - on queue Qnoblock Init: 0 sec 0 us
] Init: Init: mq_timedreceive - on queue Qblock Init: 1 sec 7430 us
] Init: Init: mq_timedreceive - on queue Qdefault Init: 1 sec 9660 us
] _______________mq_open functionality
] Init: mq_open - Open an existing mq ( same id )
] _______________mq_notify
] Init: mq_notify - Unopened message queue (EBADF)
] _____mq_notify - notify when Qnoblock gets a message
] waiting on any signal for 3 seconds.
] Init: Verify Signal when send
] Init: mq_send - to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] Init: Verify No Signal when send
] Init: mq_send - to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] ____mq_notify - notify when Qread gets a message
] waiting on any signal for 3 seconds.
] Init: mq_notify - (EBUSY)
] Init: mq_notify - Remove notification with null
] Init: Verify No Signal when send
] Init: mq_send - to Qnoblock msg: 12345678 priority 31
] waiting on any signal for 3 seconds.
] *** TIMEOUT TIMEOUT
[222/591] p:199 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxmsgq02.exe
<<skipping passes>>
[234/591] p:211 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxrwlock01.exe
Result: timeout Time: 0:03:00.381593 psxrwlock01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxrwlock01.exe
]
]
=> test start: PSXRWLOCK 1
] *** BEGIN OF TEST PSXRWLOCK 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] pthread_rwlockattr_init( NULL ) -- EINVAL
] pthread_rwlockattr_setpshared( NULL, private ) -- EINVAL
] pthread_rwlockattr_setpshared( NULL, shared ) -- EINVAL
] pthread_rwlockattr_getpshared( NULL, &p ) -- EINVAL
] pthread_rwlockattr_destroy( NULL ) -- EINVAL
] pthread_rwlockattr_setpshared( &attr, shared ) -- EINVAL
] pthread_rwlockattr_getpshared( &attr, NULL ) -- EINVAL
] pthread_rwlockattr_destroy( &attr ) -- EINVAL
] pthread_rwlockattr_setpshared( &attr, private ) -- EINVAL
] pthread_rwlockattr_init( &attr ) -- OK
] pthread_rwlockattr_setpshared( &attr, private ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) -- OK
] pthread_rwlockattr_setpshared( &attr, shared ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) -- OK
] pthread_rwlockattr_destroy( &attr ) -- OK
] pthread_rwlockattr_getpshared( &attr, &p ) destroyed -- EINVAL
] pthread_rwlock_init(NULL, &attr) -- EINVAL
] pthread_rwlock_destroy(NULL) -- EINVAL
] pthread_rwlock_rdlock(NULL) -- EINVAL
] pthread_rwlock_timedrdlock( NULL, &abstime) -- EINVAL
] pthread_rwlock_timedrdlock( &rwlock, NULL) -- EINVAL
] pthread_rwlock_tryrdlock(NULL) -- EINVAL
] pthread_rwlock_wrlock(NULL) -- EINVAL
] pthread_rwlock_timedwrlock( NULL, &abstime) -- EINVAL
] pthread_rwlock_timedwrlock( &rwlock, NULL) -- EINVAL
] pthread_rwlock_trywrlock(NULL) -- EINVAL
] pthread_rwlock_unlock(NULL) -- EINVAL
] clock_gettime(CLOCK_REALTIME, &abstime) -- OK
] pthread_rwlock_destroy(BadId) -- EINVAL
] pthread_rwlock_rdlock(BadId) -- EINVAL
] pthread_rwlock_timedrdlock(BadId, &abstime) -- EINVAL
] pthread_rwlock_tryrdlock(BadId) -- EINVAL
] pthread_rwlock_wrlock(BadId) -- EINVAL
] pthread_rwlock_timedwrlock(BadId, &abstime) -- EINVAL
] pthread_rwlock_trywrlock(BadId) -- EINVAL
] pthread_rwlock_unlock(BadId) -- EINVAL
] pthread_rwlockattr_init( &attr ) -- OK
] pthread_rwlock_init( &rwlock, &attr ) -- OK
] pthread_rwlock_destroy( &rwlock ) -- OK
] pthread_rwlock_init( &rwlock, NULL ) -- OK
] pthread_rwlock_destroy( &rwlock ) -- OK
] pthread_rwlock_init( &RWLock, &attr ) -- OK
] pthread_rwlock_tryrdlock(RWLock) -- OK
] Init: pthread_create - thread 1 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] Init: pthread_create - thread 2 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] pthread_rwlock_unlock(RWLock) -- OK
] pthread_rwlock_trywrlock(RWLock) -- OK
] pthread_rwlock_tryrdlock(&RWLock) -- EBUSY
] Init: pthread_create - thread 1 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] Init: pthread_create - thread 2 OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] pthread_rwlock_destroy( &RWLock ) -- EBUSY
] pthread_rwlock_unlock(RWLock) -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) unblocked -- OK
]
] pthread_rwlock_trywrlock(RWLock) -- OK
] pthread_rwlock_trywrlock(&RWLock) -- EBUSY
] Init: pthread_create - thread 1 OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] Init: pthread_create - thread 2 OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] pthread_rwlock_unlock(RWLock) -- OK
] WriteThread - pthread_rwlock_wrlock(RWLock) unblocked -- OK
] WriteThread - pthread_rwlock_unlock(RWLock) -- OK
] WriteThread - pthread_rwlock_wrlock(RWLock) unblocked -- OK
] WriteThread - pthread_rwlock_unlock(RWLock) -- OK
]
] pthread_rwlock_tryrdlock(&RWLock) -- OK
] Init: pthread_create - thread reader & writer OK
] WriteThread - pthread_rwlock_wrlock(RWLock) blocking -- OK
] ReadThread - pthread_rwlock_rdlock(RWLock) blocking -- OK
] pthread_rwlock_tryrdlock(&RWLock) -- EBUSY
] pthread_rwlock_trywrlock(&RWLock) -- EBUSY
] *** TIMEOUT TIMEOUT
[235/591] p:212 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxsem01.exe
<<skipping passes>>
[249/591] p:226 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxstat.exe
Result: timeout Time: 0:03:00.394830 psxstat.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxstat.exe
]
]
=> test start: PSXSTAT
] *** BEGIN OF TEST PSXSTAT ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] --->Current Time: - rtems_clock_get_tod - 09:00:00 12/31/1988
] Making directory /my_mount_point/dir1\\//
] Making directory /my_mount_point/dir2
] Making directory /my_mount_point/dir3
] Making directory /my_mount_point/dir4
] Making directory /my_mount_point/dir1/dir1
] Making directory /./././my_mount_point/dir1/ dir1
] Making directory /./././my_mount_point/links
] Making directory ///my_mount_point/dir1/dir1/../../dir1/../symlinks/////
]
] Making file /////my_mount_point/dir1/\//file1
] Making file /my_mount_point/dir1/file2
] Making file /my_mount_point/dir1/file3
] Making file /my_mount_point/dir1/file4
] Making file /my_mount_point/dir1/dir1/file1
] Making file ../../..//my_mount_point/dir1/./././dir1/ file1
] Making file main.c
]
] Making file dir1/dir1/../../links/dir1
] Making file links/dir2
] Making file links/dir3
] Making file links/dir4
] Making file links/dir1_dir1
] Making file links/dir1_ dir1
] Making file links/../links/../links/links
]
] Making file links/dir1_file1
] Making file links/dir1_file2
] Making file links/dir1_file3
] Making file links/dir1_file4
] Making file links/dir1_dir1_f1
] Making file links/dir1_dir1 f1
]
] Making file links/links/links/links_dir1
] Making file links//links_dir2
] Making file links//links_dir3
] Making file links//links_dir4
] Making file links//links_dir1_d1
] Making file links//links_dir1 d1
] Making file links//links_links
]
] Making file links///links_d1_file1
] Making file links///links_d1_file2
] Making file links///links_d1_file3
] Making file links///links_d1_file4
] Making file links///links_d1_d1_f1
] Making file links///links_r1_d1 f1
]
] Doing the stat() on all the good absolute paths
] stat( /my_mount_point/dev ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c670
] ...st_mode 40700
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:00 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( ////my_mount_point/dir1/\//file1\\// ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c9d0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1/\\/file2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003ca40
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1/file3/////\\\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cab0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1/file4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb20
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1/dir1/file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb90
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1/dir1/ file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cc00
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( /my_mount_point/dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1680
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/dir2//////\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c730
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/dir3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c790
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/dir4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c7f0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/dir1/dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c850
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 560
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/dir1/ dir1///\\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c8b0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/\/\/\/\/\/\/links\/\/\/\/\/\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c910
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 7280
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
]
] Doing the stat() on all the good relative paths
] stat( dev ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c670
] ...st_mode 40700
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:00 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir1/\//file1\\// ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c9d0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1/\\/file2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003ca40
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1/file3/////\\\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cab0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1/file4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb20
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1/dir1/file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb90
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1/dir1/ file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cc00
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1680
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir2//////\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c730
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c790
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c7f0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir1/dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c850
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 560
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( dir1/ dir1///\\ ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c8b0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( main.c ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cc70
] ...st_mode 100004
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:00 1988
] ...st_blksize 80
] ...st_blocks 0
]
] chdir to dev
]
] stat relative paths that are now bad
] stat( dev ) returned : No such file or directory
] stat( dir1/\//file1\\// ) returned : No such file or directory
] stat( dir1/\\/file2 ) returned : No such file or directory
] stat( dir1/file3/////\\\ ) returned : No such file or directory
] stat( dir1/file4 ) returned : No such file or directory
] stat( dir1/dir1/file1 ) returned : No such file or directory
] stat( dir1/dir1/ file1 ) returned : No such file or directory
] stat( dir1 ) returned : No such file or directory
] stat( dir2//////\ ) returned : No such file or directory
] stat( dir3 ) returned : No such file or directory
] stat( dir4 ) returned : No such file or directory
] stat( dir1/dir1 ) returned : No such file or directory
] stat( dir1/ dir1///\\ ) returned : No such file or directory
] stat( main.c ) returned : No such file or directory
]
] chdir to ../links
] Doing the stat() on good links
]
] stat( dir1/dir1/../../links/dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1680
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c730
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c790
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c7f0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir1_dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c850
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 560
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir1_ dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c8b0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/../links/../links/links ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c910
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 7280
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links/dir1_file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c9d0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/dir1_file2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003ca40
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/dir1_file3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cab0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/dir1_file4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb20
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/dir1_dir1_f1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb90
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/dir1_dir1 f1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cc00
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links/links/links/links_dir1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1680
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_dir2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c730
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_dir3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c790
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_dir4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c7f0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_dir1_d1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c850
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 560
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_dir1 d1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c8b0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links//links_links ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c910
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 7280
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( links///links_d1_file1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c9d0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links///links_d1_file2 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003ca40
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links///links_d1_file3 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cab0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links///links_d1_file4 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb20
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links///links_d1_d1_f1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cb90
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] stat( links///links_r1_d1 f1 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003cc00
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] chmod of /my_mount_point/dir1/dir1 to Read/Write
]
] Doing the stat() on all the bad paths
] stat( /my_mount_point/links/ENAMETOOLONG____________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________ ) returned : No such file or directory
] stat( /my_mount_point/dir1/file4/NOTADIR ) returned : Not a directory
] stat( /my_mount_point/dir1/dir1/EACCES__ ) returned : Permission denied
] Making file /my_mount_point/links/ENAMETOOLONG____________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________ : File or path name too long
] Making file /my_mount_point/dir1/file4/NOTADIR : Not a directory
] Making file /my_mount_point/dir1/dir1/EACCES__ : Permission denied
]
] Return /my_mount_point/dir1/dir1 to RWX
] Making file /my_mount_point/symlinks/a_file_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/a_dir_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/a_link_symlink
] Verify with readlink
] Making file ../symlinks/no_file
] Verify with readlink
] Making file /my_mount_point/symlinks/a_dir_symlink/a_file_symlink
] Verify with readlink
] Making file /my_mount_point/symlinks/links
] Verify with readlink
] stat( /my_mount_point/symlinks/a_file_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c9d0
] ...st_mode 100004
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 0
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:09 1988
] ...st_blksize 80
] ...st_blocks 0
] lstat( /my_mount_point/symlinks/a_file_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d6a0
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 33
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/symlinks/a_dir_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1960
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] lstat( /my_mount_point/symlinks/a_dir_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d720
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 24
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/symlinks/a_link_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1960
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] lstat( /my_mount_point/symlinks/a_link_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d7a0
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 28
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( ../symlinks/no_file ) returned : No such file or directory
] lstat( ../symlinks/no_file ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d820
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 7
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( /my_mount_point/symlinks/a_dir_symlink/a_file_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003c6d0
] ...st_mode 40700
] ...st_nlink 3
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 1960
] ...st_atime Sat Dec 31 09:00:00 1988
] ...st_mtime Sat Dec 31 09:00:00 1988
] ...st_ctime Sat Dec 31 09:00:04 1988
] ...st_blksize 0
] ...st_blocks 0
] lstat( /my_mount_point/symlinks/a_dir_symlink/a_file_symlink ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d880
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 38
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] Making file 0001
] Verify with readlink
] Making file 0002
] Verify with readlink
] Making file 0003
] Verify with readlink
] Making file 0004
] Verify with readlink
] Making file 0005
] Verify with readlink
] Making file 0006
] Verify with readlink
] Making file 0007
] Verify with readlink
] Making file 0008
] Verify with readlink
] Making file 0009
] Verify with readlink
] stat( 0001 ) returned : No such file or directory
] lstat( 0001 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d980
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 9
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0002 ) returned : No such file or directory
] lstat( 0002 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003d9e0
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0003 ) returned : No such file or directory
] lstat( 0003 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003da40
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0004 ) returned : No such file or directory
] lstat( 0004 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003daa0
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0005 ) returned : No such file or directory
] lstat( 0005 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003db00
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0006 ) returned : No such file or directory
] lstat( 0006 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003db60
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0007 ) returned : No such file or directory
] lstat( 0007 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003dbc0
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0008 ) returned : No such file or directory
] lstat( 0008 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003dc20
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] stat( 0009 ) returned : No such file or directory
] lstat( 0009 ) returned
] ...st_dev (0x80000000:0x4001e2d8)
] ...st_ino 8003dc80
] ...st_mode 120777
] ...st_nlink 1
] ...st_uid 0
] ...st_gid 0
] ...st_rdev (0x0:0x0)
] ...st_size 4
] ...st_atime Sat Dec 31 09:00:15 1988
] ...st_mtime Sat Dec 31 09:00:15 1988
] ...st_ctime Sat Dec 31 09:00:15 1988
] ...st_blksize 0
] ...st_blocks 0
] *** TIMEOUT TIMEOUT
[250/591] p:227 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxstrsignal01.exe
<<skipping passes>>
[253/591] p:230 f:7 u:4 e:0 I:0 B:3 t:5 i:0 W:0 | riscv32/rv32im: psxtime.exe
Result: timeout Time: 0:03:00.627979 psxtime.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxtime.exe
]
]
=> test start: PSXTIME
] *** BEGIN OF TEST PSXTIME ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] gettimeofday( NULL, NULL ) - EFAULT
] rtems_clock_set 12:45:00 01/01/1988
] adjtime - NULL delta - EINVAL
] adjtime - delta out of range - EINVAL
] adjtime - delta range of 0 - OK
] adjtime - delta too small - do nothing
] adjtime - delta too small - do nothing, olddelta=NULL
] adjtime - delta of one second forward, olddelta=NULL
] adjtime - delta of one second forward
] adjtime - delta of almost two seconds forward
] adjtime - delta of almost one second forward which bumps second
] rtems_clock_get_tod 12:45:05 01/01/1988
] rtems_clock_set 12:45:00 01/01/1988
] rtems_clock_get_tod 12:45:00 01/01/1988
] gettimeofday: Fri Jan 1 12:45:00 1988
] time: Fri Jan 1 12:45:00 1988
] localtime: Fri Jan 1 12:45:00 1988
] gmtime: Fri Jan 1 12:45:00 1988
]
] rtems_clock_get_tod 12:45:00 01/01/1988
] gettimeofday: Fri Jan 1 12:45:00 1988
] time: Fri Jan 1 12:45:00 1988
] localtime: Fri Jan 1 12:45:00 1988
] gmtime: Fri Jan 1 12:45:00 1988
]
] rtems_clock_get_tod 12:45:01 01/01/1988
] gettimeofday: Fri Jan 1 12:45:01 1988
] time: Fri Jan 1 12:45:01 1988
] localtime: Fri Jan 1 12:45:01 1988
] gmtime: Fri Jan 1 12:45:01 1988
]
] rtems_clock_get_tod 12:45:02 01/01/1988
] gettimeofday: Fri Jan 1 12:45:02 1988
] time: Fri Jan 1 12:45:02 1988
] localtime: Fri Jan 1 12:45:02 1988
] gmtime: Fri Jan 1 12:45:02 1988
]
] rtems_clock_set 09:00:00 12/31/1988
] rtems_clock_get_tod 09:00:00 12/31/1988
] gettimeofday: Sat Dec 31 09:00:00 1988
] time: Sat Dec 31 09:00:00 1988
] localtime: Sat Dec 31 09:00:00 1988
] gmtime: Sat Dec 31 09:00:00 1988
]
] rtems_clock_get_tod 09:00:00 12/31/1988
] gettimeofday: Sat Dec 31 09:00:01 1988
] time: Sat Dec 31 09:00:01 1988
] localtime: Sat Dec 31 09:00:01 1988
] gmtime: Sat Dec 31 09:00:01 1988
]
] rtems_clock_get_tod 09:00:01 12/31/1988
] gettimeofday: Sat Dec 31 09:00:02 1988
] time: Sat Dec 31 09:00:02 1988
] localtime: Sat Dec 31 09:00:02 1988
] gmtime: Sat Dec 31 09:00:02 1988
]
] rtems_clock_get_tod 09:00:02 12/31/1988
] gettimeofday: Sat Dec 31 09:00:03 1988
] time: Sat Dec 31 09:00:03 1988
] localtime: Sat Dec 31 09:00:03 1988
] gmtime: Sat Dec 31 09:00:03 1988
]
] rtems_clock_set 23:55:59 12/31/1999
] rtems_clock_get_tod 23:55:59 12/31/1999
] gettimeofday: Fri Dec 31 23:55:59 1999
] time: Fri Dec 31 23:55:59 1999
] localtime: Fri Dec 31 23:55:59 1999
] gmtime: Fri Dec 31 23:55:59 1999
]
] rtems_clock_get_tod 23:55:59 12/31/1999
] gettimeofday: Fri Dec 31 23:56:00 1999
] time: Fri Dec 31 23:56:00 1999
] localtime: Fri Dec 31 23:56:00 1999
] gmtime: Fri Dec 31 23:56:00 1999
]
] rtems_clock_get_tod 23:56:00 12/31/1999
] gettimeofday: Fri Dec 31 23:56:01 1999
] time: Fri Dec 31 23:56:01 1999
] localtime: Fri Dec 31 23:56:01 1999
] gmtime: Fri Dec 31 23:56:01 1999
]
] rtems_clock_get_tod 23:56:01 12/31/1999
] gettimeofday: Fri Dec 31 23:56:02 1999
] time: Fri Dec 31 23:56:02 1999
] localtime: Fri Dec 31 23:56:02 1999
] gmtime: Fri Dec 31 23:56:02 1999
]
] rtems_clock_set 00:01:30 06/30/1999
] rtems_clock_get_tod 00:01:30 06/30/1999
] gettimeofday: Wed Jun 30 00:01:30 1999
] time: Wed Jun 30 00:01:30 1999
] localtime: Wed Jun 30 00:01:30 1999
] gmtime: Wed Jun 30 00:01:30 1999
]
] rtems_clock_get_tod 00:01:30 06/30/1999
] gettimeofday: Wed Jun 30 00:01:31 1999
] time: Wed Jun 30 00:01:31 1999
] localtime: Wed Jun 30 00:01:31 1999
] gmtime: Wed Jun 30 00:01:31 1999
]
] rtems_clock_get_tod 00:01:31 06/30/1999
] gettimeofday: Wed Jun 30 00:01:32 1999
] time: Wed Jun 30 00:01:32 1999
] localtime: Wed Jun 30 00:01:32 1999
] gmtime: Wed Jun 30 00:01:32 1999
]
] rtems_clock_get_tod 00:01:32 06/30/1999
] gettimeofday: Wed Jun 30 00:01:33 1999
] time: Wed Jun 30 00:01:33 1999
] localtime: Wed Jun 30 00:01:33 1999
] gmtime: Wed Jun 30 00:01:33 1999
]
] rtems_clock_set 00:15:59 01/01/2000
] rtems_clock_get_tod 00:15:59 01/01/2000
] gettimeofday: Sat Jan 1 00:15:59 2000
] time: Sat Jan 1 00:15:59 2000
] localtime: Sat Jan 1 00:15:59 2000
] gmtime: Sat Jan 1 00:15:59 2000
]
] rtems_clock_get_tod 00:15:59 01/01/2000
] gettimeofday: Sat Jan 1 00:16:00 2000
] time: Sat Jan 1 00:16:00 2000
] localtime: Sat Jan 1 00:16:00 2000
] gmtime: Sat Jan 1 00:16:00 2000
]
] rtems_clock_get_tod 00:16:00 01/01/2000
] gettimeofday: Sat Jan 1 00:16:01 2000
] time: Sat Jan 1 00:16:01 2000
] localtime: Sat Jan 1 00:16:01 2000
] gmtime: Sat Jan 1 00:16:01 2000
]
] *** TIMEOUT TIMEOUT
[254/591] p:230 f:7 u:4 e:0 I:0 B:3 t:6 i:0 W:0 | riscv32/rv32im: psxtimer01.exe
Result: timeout Time: 0:03:00.627905 psxtimer01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/psxtests/psxtimer01.exe
]
]
=> test start: PSXTIMER 1
] *** BEGIN OF TEST PSXTIMER 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] task A: timer_settime - value=0:0 interval=0:0
] Executing task B with count = 10 Fri Jan 1 00:00:02 1988
] Executing task A with count = 20 Fri Jan 1 00:00:02 1988
] Executing task A with count = 19 Fri Jan 1 00:00:03 1988
] Executing task B with count = 9 Fri Jan 1 00:00:04 1988
] Executing task A with count = 18 Fri Jan 1 00:00:04 1988
] Executing task A with count = 17 Fri Jan 1 00:00:05 1988
] Executing task B with count = 8 Fri Jan 1 00:00:06 1988
] Executing task C with count = 6 Fri Jan 1 00:00:06 1988
] Executing task A with count = 16 Fri Jan 1 00:00:06 1988
] Executing task A with count = 15 Fri Jan 1 00:00:07 1988
] Executing task B with count = 7 Fri Jan 1 00:00:08 1988
] Executing task A with count = 14 Fri Jan 1 00:00:08 1988
] Executing task C with count = 5 Fri Jan 1 00:00:09 1988
] Executing task A with count = 13 Fri Jan 1 00:00:09 1988
] Executing task B with count = 6 Fri Jan 1 00:00:10 1988
] Executing task A with count = 12 Fri Jan 1 00:00:10 1988
] Executing task A with count = 11 Fri Jan 1 00:00:11 1988
] Executing task B with count = 5 Fri Jan 1 00:00:12 1988
] Executing task C with count = 4 Fri Jan 1 00:00:12 1988
] Executing task A with count = 10 Fri Jan 1 00:00:12 1988
] Executing task A with count = 9 Fri Jan 1 00:00:13 1988
] Executing task B with count = 4 Fri Jan 1 00:00:14 1988
] Executing task A with count = 8 Fri Jan 1 00:00:14 1988
] Executing task C with count = 3 Fri Jan 1 00:00:15 1988
] Executing task A with count = 7 Fri Jan 1 00:00:15 1988
] Executing task B with count = 3 Fri Jan 1 00:00:16 1988
] Executing task A with count = 6 Fri Jan 1 00:00:16 1988
] Executing task A with count = 5 Fri Jan 1 00:00:17 1988
] Executing task B with count = 2 Fri Jan 1 00:00:18 1988
] Executing task C with count = 2 Fri Jan 1 00:00:18 1988
] Executing task A with count = 4 Fri Jan 1 00:00:18 1988
] Executing task A with count = 3 Fri Jan 1 00:00:19 1988
] Executing task B with count = 1 Fri Jan 1 00:00:20 1988
] Executing task A with count = 2 Fri Jan 1 00:00:20 1988
] Executing task C with count = 1 Fri Jan 1 00:00:21 1988
] Executing task A with count = 1 Fri Jan 1 00:00:21 1988
] task C: timer_getoverrun - overruns=0
] task C: timer_gettime - 1:990000000 remaining from 3:0
] starting C again with 0.5 second periodicity
] Executing task C with count = 6 Fri Jan 1 00:00:25 1988
] Executing task C with count = 5 Fri Jan 1 00:00:26 1988
] Executing task C with count = 4 Fri Jan 1 00:00:26 1988
] Executing task C with count = 3 Fri Jan 1 00:00:27 1988
] Executing task C with count = 2 Fri Jan 1 00:00:27 1988
] Executing task C with count = 1 Fri Jan 1 00:00:28 1988
] task C: timer_getoverrun - overruns=0
] task C: timer_gettime - 0:490000000 remaining from 0:500000000
] Error in Task A timer_gettime:
] re-armed timer: 0:490000000 does not match interval: 0:500000000
] Executing task C with count = 0 Fri Jan 1 00:00:29 1988
] *** TIMEOUT TIMEOUT
[255/591] p:230 f:7 u:4 e:0 I:0 B:3 t:7 i:0 W:0 | riscv32/rv32im: psxtimer02.exe
<<skipping passes>>
[330/591] p:302 f:7 u:6 e:0 I:0 B:3 t:8 i:0 W:0 | riscv32/rv32im: ticker.exe
Result: timeout Time: 0:03:00.354801 ticker.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/samples/ticker.exe
]
]
=> test start: CLOCK TICK
] *** BEGIN OF TEST CLOCK TICK ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:19 12/31/1988
] *** TIMEOUT TIMEOUT
[331/591] p:302 f:7 u:6 e:0 I:0 B:3 t:9 i:0 W:0 | riscv32/rv32im: unlimited.exe
[332/591] p:302 f:7 u:6 e:0 I:0 B:3 t:10 i:0 W:0 | riscv32/rv32im: sp01.exe
Result: timeout Time: 0:03:00.381948 sp01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp01.exe
]
]
=> test start: SP 1
] *** BEGIN OF TEST SP 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:24 12/31/1988
] *** TIMEOUT TIMEOUT
[333/591] p:303 f:7 u:6 e:0 I:0 B:3 t:10 i:0 W:0 | riscv32/rv32im: sp02.exe
<<skipping passes>>
[335/591] p:305 f:7 u:6 e:0 I:0 B:3 t:10 i:0 W:0 | riscv32/rv32im: sp04.exe
Result: timeout Time: 0:03:00.391217 sp04.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp04.exe
]
]
=> test start: SP 4
] *** BEGIN OF TEST SP 4 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_task_suspend - on Task 2
] TA1 - rtems_task_suspend - on Task 3
] TA1 - killing time
] TA1 - rtems_task_resume - on Task 2
] TA1 - rtems_task_resume - on Task 3
] TA1 - rtems_task_mode - change mode to NO RTEMS_PREEMPT
] TA1 - 09:15:09 12/31/1988
] TA1 - 09:15:10 12/31/1988
] TA1 - 09:15:11 12/31/1988
] *** TIMEOUT TIMEOUT
[336/591] p:305 f:7 u:6 e:0 I:0 B:3 t:11 i:0 W:0 | riscv32/rv32im: sp05.exe
Result: timeout Time: 0:03:00.429475 sp05.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp05.exe
]
]
=> test start: SP 5
] *** BEGIN OF TEST SP 5 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_task_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
] *** TIMEOUT TIMEOUT
[337/591] p:305 f:7 u:6 e:0 I:0 B:3 t:12 i:0 W:0 | riscv32/rv32im: sp06.exe
<<skipping passes>>
[341/591] p:308 f:7 u:6 e:0 I:0 B:3 t:13 i:0 W:0 | riscv32/rv32im: sp12.exe
Result: timeout Time: 0:03:00.504507 sp12.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp12.exe
]
]
=> test start: SP 12
] *** BEGIN OF TEST SP 12 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] INIT - Forward priority queue test
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] INIT - Backward priority queue test
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] INIT - Binary Semaphore and Priority Inheritance Test
] INIT - rtems_semaphore_create - allocated binary semaphore
] INIT - rtems_semaphore_release - allocated binary semaphore
] INIT - rtems_semaphore_delete - allocated binary semaphore
] PRI5 - rtems_semaphore_obtain - wait forever on SM2
] Set priority of self while holding resource
] PRI5 - rtems_task_suspend - until all priority tasks blocked
] PDRV - priority of PRI5 is 8
] PRI4 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - change priority of PRI5 from 8 to 9
] PDRV - priority of PRI5 is 8
] PRI3 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 8
] PRI2 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 7
] PRI1 - rtems_semaphore_obtain - wait forever on SM2
] PDRV - priority of PRI5 is 6
] PDRV - rtems_task_resume - PRI5
] PRI5 - rtems_task_delete - all tasks waiting on SM2
] PRI5 - rtems_semaphore_obtain - nested
] PRI5 - rtems_semaphore_release - nested
] PRI5 - rtems_semaphore_release - restore priority
] PRI5 - priority of PRI5 is 9
] TA1 - rtems_semaphore_ident - smid => 1a010001
] TA1 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - got SM2
] TA1 - rtems_semaphore_obtain - wait forever on SM3
] TA1 - got SM3
] TA1 - rtems_semaphore_obtain - get SM1 - RTEMS_NO_WAIT
] TA1 - got SM1
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA2 - rtems_semaphore_obtain - wait forever on SM1
] TA3 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - rtems_semaphore_release - release SM1
] TA1 - rtems_semaphore_obtain - waiting for SM1 with 10 second timeout
] TA2 - got SM1
] TA2 - rtems_semaphore_release - release SM1
] TA2 - rtems_task_set_priority - make self highest priority task
] TA2 - rtems_semaphore_obtain - wait forever on SM2
] TA1 - got SM1
] TA1 - rtems_semaphore_release - release SM2
] TA2 - got SM2
] TA2 - rtems_semaphore_release - release SM2
] TA2 - rtems_task_exit
] TA1 - rtems_task_wake_after - sleep 5 seconds
] TA3 - got SM2
] TA3 - rtems_semaphore_release - release SM2
] TA3 - rtems_semaphore_obtain - wait forever on SM3
] *** TIMEOUT TIMEOUT
[342/591] p:309 f:7 u:6 e:0 I:0 B:3 t:13 i:0 W:0 | riscv32/rv32im: sp13.exe
<<skipping passes>>
[348/591] p:315 f:7 u:6 e:0 I:0 B:3 t:13 i:0 W:0 | riscv32/rv32im: sp19.exe
Result: timeout Time: 0:03:00.465558 sp19.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp19.exe
]
]
=> test start: SP 19
] *** BEGIN OF TEST SP 19 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] FP1 - integer base = (0x6000)
] FP1 - float base = (NA)
] FP1 - integer base = (0x6000)
] FP1 - float base = (NA)
] TA1 - integer base = (0x1000)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - integer base = (0x2000)
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - integer base = (0x3000)
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA4 - integer base = (0x4000)
] TA4 - float base = (4000.4)
] TA4 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:01 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:02 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:03 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA5 - integer base = (0x5000)
] TA5 - float base = (5000.5)
] TA5 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:05 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:05 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:06 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:06 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:07 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:07 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:08 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:08 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:10 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:10 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:11 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:11 12/31/1988
] TA4 - rtems_clock_get_tod - 09:00:12 12/31/1988
] TA5 - rtems_clock_get_tod - 09:00:12 12/31/1988
] *** TIMEOUT TIMEOUT
[349/591] p:315 f:7 u:6 e:0 I:0 B:3 t:14 i:0 W:0 | riscv32/rv32im: sp20.exe
Result: timeout Time: 0:03:00.391941 sp20.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp20.exe
]
]
=> test start: SP 20
] *** BEGIN OF TEST SP 20 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_rate_monotonic_create id = 0x42010001
] TA1 - rtems_rate_monotonic_ident id = 0x42010001
] TA1 - (0x42010001) period 2
] TA2 - rtems_rate_monotonic_create id = 0x42010002
] TA2 - rtems_rate_monotonic_ident id = 0x42010002
] TA2 - (0x42010002) period 2
] TA3 - rtems_rate_monotonic_create id = 0x42010003
] TA3 - rtems_rate_monotonic_ident id = 0x42010003
] TA3 - (0x42010003) period 2
] TA4 - rtems_rate_monotonic_create id = 0x42010004
] TA4 - rtems_rate_monotonic_ident id = 0x42010004
] TA4 - (0x42010004) period 2
] TA5 - rtems_rate_monotonic_create id = 0x42010005
] TA5 - rtems_rate_monotonic_ident id = 0x42010005
] TA5 - (0x42010005) period 100
] TA6 - rtems_rate_monotonic_create id = 0x42010006
] TA6 - rtems_rate_monotonic_ident id = 0x42010006
] TA6 - (0x42010006) period 0
] TA5 - PERIODS CHECK OK (1)
] *** TIMEOUT TIMEOUT
[350/591] p:316 f:7 u:6 e:0 I:0 B:3 t:14 i:0 W:0 | riscv32/rv32im: sp2038.exe
<<skipping passes>>
[354/591] p:319 f:7 u:6 e:0 I:0 B:3 t:15 i:0 W:0 | riscv32/rv32im: sp24.exe
Result: timeout Time: 0:03:00.411917 sp24.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp24.exe
]
]
=> test start: SP 24
] *** BEGIN OF TEST SP 24 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:24 12/31/1988
] *** TIMEOUT TIMEOUT
[355/591] p:320 f:7 u:6 e:0 I:0 B:3 t:15 i:0 W:0 | riscv32/rv32im: sp25.exe
<<skipping passes>>
[360/591] p:324 f:7 u:6 e:0 I:0 B:3 t:16 i:0 W:0 | riscv32/rv32im: sp30.exe
Result: timeout Time: 0:03:00.420598 sp30.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp30.exe
]
]
=> test start: SP 30
] *** BEGIN OF TEST SP 30 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] timer_initiate_server -- INVALID_PRIORITY
] timer_initiate_server -- OK
] timer_initiate_server -- already started
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] *** TIMEOUT TIMEOUT
[361/591] p:324 f:7 u:6 e:0 I:0 B:3 t:17 i:0 W:0 | riscv32/rv32im: sp31.exe
[362/591] p:325 f:7 u:6 e:0 I:0 B:3 t:17 i:0 W:0 | riscv32/rv32im: sp32.exe
Result: timeout Time: 0:03:00.446443 sp32.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/sp32.exe
]
]
=> test start: SP 32
] *** BEGIN OF TEST SP 32 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] *** TIMEOUT TIMEOUT
[363/591] p:326 f:7 u:6 e:0 I:0 B:3 t:17 i:0 W:0 | riscv32/rv32im: sp33.exe
<<skipping passes>>
[408/591] p:368 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spcbssched01.exe
Result: timeout Time: 0:03:00.521545 spcbssched01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spcbssched01.exe
]
]
=> test start: SPCBSSCHED 1
] *** BEGIN OF TEST SPCBSSCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:19 12/31/1988
] *** TIMEOUT TIMEOUT
[409/591] p:369 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spcbssched02.exe
[410/591] p:370 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spcbssched03.exe
Result: timeout Time: 0:03:00.551786 spcbssched03.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spcbssched03.exe
]
]
=> test start: SPCBSSCHED 3
] *** BEGIN OF TEST SPCBSSCHED 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] P3-F ticks:32
] P1-S ticks:32
] P1-F ticks:42
] P4-S ticks:42
] P4-F ticks:52
] P2-S ticks:52
] P1-S ticks:62
] P1-F ticks:72
] P2-F ticks:72
] P3-S ticks:72
] P3-F ticks:82
] AT6-S ticks:82
] P6-F ticks:87
] Killing task 6
] AT5-S ticks:87
] P1-S ticks:92
] P1-F ticks:102
] P2-S ticks:102
] P2-F ticks:112
] P4-S ticks:112
] P1-S ticks:122
] P1-F ticks:132
] P2-S ticks:132
] P2-F ticks:142
] P3-S ticks:142
] P1-S ticks:152
] P1-F ticks:162
] P3-F ticks:162
] P4-F ticks:162
] P2-S ticks:172
] P1-S ticks:182
] P1-F ticks:192
] P2-F ticks:192
] P3-S ticks:192
] P3-F ticks:202
] P4-S ticks:202
] P1-S ticks:212
] P1-F ticks:222
] P2-S ticks:222
] P2-F ticks:232
] P3-S ticks:232
] P1-S ticks:242
] P1-F ticks:252
] P2-S ticks:252
] P2-F ticks:262
] P3-F ticks:262
] Signal overrun, fixing the task
] P1-S ticks:272
] P1-F ticks:282
] P3-S ticks:282
] P2-S ticks:292
] P1-S ticks:302
] P1-F ticks:312
] P2-F ticks:312
] P3-F ticks:312
] P3-S ticks:322
] P1-S ticks:332
] P1-F ticks:342
] P2-S ticks:342
] P2-F ticks:352
] P3-F ticks:352
] P1-S ticks:362
] P1-F ticks:372
] P2-S ticks:372
] P2-F ticks:382
] P1-S ticks:392
] P1-F ticks:402
] P2-S ticks:412
] P1-S ticks:422
] P1-F ticks:432
] P2-F ticks:432
] P3-S ticks:432
] P1-S ticks:452
] P1-F ticks:462
] P2-S ticks:462
] P2-F ticks:472
] P3-F ticks:472
] P1-S ticks:482
] P1-F ticks:492
] P2-S ticks:492
] P2-F ticks:502
] P1-S ticks:512
] P1-F ticks:522
] P3-S ticks:522
] P2-S ticks:532
] P1-S ticks:542
] P1-F ticks:552
] P2-F ticks:552
] P3-F ticks:552
] P1-S ticks:572
] P1-F ticks:582
] P2-S ticks:582
] P2-F ticks:592
] P1-S ticks:602
] P1-F ticks:612
] P2-S ticks:612
] P2-F ticks:622
] P3-S ticks:622
] P1-S ticks:632
] P1-F ticks:642
] P3-F ticks:642
] P2-S ticks:652
] P1-S ticks:662
] P1-F ticks:672
] P2-F ticks:672
] P1-S ticks:692
] P1-F ticks:702
] P2-S ticks:702
] P2-F ticks:712
] P1-S ticks:722
] *** TIMEOUT TIMEOUT
[411/591] p:371 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spchain.exe
<<skipping passes>>
[418/591] p:378 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spcontext01.exe
Result: timeout Time: 0:03:00.442763 spcontext01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spcontext01.exe
]
]
=> test start: SPCONTEXT 1
] *** BEGIN OF TEST SPCONTEXT 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Test configuration N N N... done
] Test configuration N N F... done
] Test configuration N F N... done
] Test configuration N F F... done
] Test configuration F N N... done
] Test configuration F N F... done
] *** TIMEOUT TIMEOUT
] Test configuration F F N...
] Test configuration F F N...
[419/591] p:379 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spcoverage.exe
<<skipping passes>>
[423/591] p:383 f:7 u:6 e:0 I:0 B:3 t:20 i:0 W:0 | riscv32/rv32im: spedfsched01.exe
Result: timeout Time: 0:03:00.436368 spedfsched01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spedfsched01.exe
]
]
=> test start: SPEDFSCHED 1
] *** BEGIN OF TEST SPEDFSCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:19 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:19 12/31/1988
] *** TIMEOUT TIMEOUT
[424/591] p:383 f:7 u:6 e:0 I:0 B:3 t:21 i:0 W:0 | riscv32/rv32im: spedfsched02.exe
[425/591] p:383 f:7 u:6 e:0 I:0 B:3 t:22 i:0 W:0 | riscv32/rv32im: spedfsched03.exe
Result: timeout Time: 0:03:00.459759 spedfsched03.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spedfsched03.exe
]
]
=> test start: SPEDFSCHED 3
] *** BEGIN OF TEST SPEDFSCHED 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] PT1 - rtems_rate_monotonic_create id = 0x42010001
] PT1 - rtems_rate_monotonic_ident id = 0x42010001
] PT1 - (0x42010001) period 30
] PT2 - rtems_rate_monotonic_create id = 0x42010002
] PT2 - rtems_rate_monotonic_ident id = 0x42010002
] PT2 - (0x42010002) period 40
] PT3 - rtems_rate_monotonic_create id = 0x42010003
] PT3 - rtems_rate_monotonic_ident id = 0x42010003
] PT3 - (0x42010003) period 50
] PT4 - rtems_rate_monotonic_create id = 0x42010004
] PT4 - rtems_rate_monotonic_ident id = 0x42010004
] PT4 - (0x42010004) period 70
] AT5 AT6 P1-S ticks:2
] P1-F ticks:12
] P2-S ticks:12
] P2-F ticks:22
] P3-S ticks:22
] P1-S ticks:32
] P1-F ticks:42
] P3-F ticks:42
] P4-S ticks:42
] P2-S ticks:52
] P2-F ticks:62
] P1-S ticks:62
] P1-F ticks:72
] P4-F ticks:72
] P3-S ticks:72
] P3-F ticks:82
] AT6-S ticks:82
] P6-F ticks:87
] Killing task 6
] AT5-S ticks:87
] P1-S ticks:92
] P1-F ticks:102
] P2-S ticks:102
] P2-F ticks:112
] P4-S ticks:112
] P1-S ticks:122
] P1-F ticks:132
] P3-S ticks:132
] P3-F ticks:142
] P2-S ticks:142
] P2-F ticks:152
] P4-F ticks:152
] P1-S ticks:152
] P1-F ticks:162
] P2-S ticks:172
] P2-F ticks:182
] P1-S ticks:182
] P1-F ticks:192
] P3-S ticks:192
] P3-F ticks:202
] P4-S ticks:202
] P1-S ticks:212
] P1-F ticks:222
] P4-F ticks:222
] P2-S ticks:222
] P2-F ticks:232
] P3-S ticks:232
] P3-F ticks:242
] P1-S ticks:242
] P1-F ticks:252
] P2-S ticks:252
] P2-F ticks:262
] P4-S ticks:262
] P1-S ticks:272
] P1-F ticks:282
] P4-F ticks:282
] P3-S ticks:282
] P3-F ticks:292
] P2-S ticks:292
] P2-F ticks:302
] P1-S ticks:302
] P1-F ticks:312
] P5-F ticks:312
] Killing task 5
] P3-S ticks:322
] P1-S ticks:332
] P1-F ticks:342
] P3-F ticks:342
] P2-S ticks:342
] P2-F ticks:352
] P4-S ticks:352
] P4-F ticks:362
] P1-S ticks:362
] P1-F ticks:372
] P2-S ticks:372
] P2-F ticks:382
] P3-S ticks:382
] P3-F ticks:392
] P1-S ticks:392
] P1-F ticks:402
] P4-S ticks:402
] P2-S ticks:412
] P2-F ticks:422
] P1-S ticks:422
] P1-F ticks:432
] P4-F ticks:432
] P3-S ticks:432
] P3-F ticks:442
] P1-S ticks:452
] P1-F ticks:462
] P2-S ticks:462
] P2-F ticks:472
] P3-S ticks:472
] P1-S ticks:482
] P1-F ticks:492
] P3-F ticks:492
] P4-S ticks:492
] P4-F ticks:502
] P2-S ticks:502
] P2-F ticks:512
] P1-S ticks:512
] P1-F ticks:522
] P3-S ticks:522
] P3-F ticks:532
] P2-S ticks:532
] P2-F ticks:542
] P1-S ticks:542
] P1-F ticks:552
] P4-S ticks:552
] P4-F ticks:562
] P1-S ticks:572
] P1-F ticks:582
] P2-S ticks:582
] P2-F ticks:592
] P3-S ticks:592
] P3-F ticks:602
] P1-S ticks:602
] P1-F ticks:612
] P2-S ticks:612
] *** TIMEOUT TIMEOUT
[426/591] p:383 f:7 u:6 e:0 I:0 B:3 t:23 i:0 W:0 | riscv32/rv32im: spedfsched04.exe
<<skipping passes>>
[466/591] p:422 f:7 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical01.exe
Result: failed Time: 0:00:01.009771 spintrcritical01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical01.exe
]
]
=> test start: SPINTRCRITICAL 1
] *** BEGIN OF TEST SPINTRCRITICAL 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/Without Timeout
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[467/591] p:422 f:8 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical02.exe
Result: failed Time: 0:00:01.009670 spintrcritical02.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical02.exe
]
]
=> test start: SPINTRCRITICAL 2
] *** BEGIN OF TEST SPINTRCRITICAL 2 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: FIFO/With Timeout
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[468/591] p:422 f:9 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical03.exe
Result: failed Time: 0:00:01.009776 spintrcritical03.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical03.exe
]
]
=> test start: SPINTRCRITICAL 3
] *** BEGIN OF TEST SPINTRCRITICAL 3 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[469/591] p:422 f:10 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical04.exe
Result: failed Time: 0:00:01.008567 spintrcritical04.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical04.exe
]
]
=> test start: SPINTRCRITICAL 4
] *** BEGIN OF TEST SPINTRCRITICAL 4 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/With Timeout
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[470/591] p:422 f:11 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical05.exe
Result: failed Time: 0:00:01.019715 spintrcritical05.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical05.exe
]
]
=> test start: SPINTRCRITICAL 5
] *** BEGIN OF TEST SPINTRCRITICAL 5 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate semaphore release from ISR while blocking
] Init - Variation is: Priority/Without Timeout (Reverse)
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[471/591] p:422 f:12 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical06.exe
<<skipping passes>>
[473/591] p:424 f:12 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical08.exe
Result: failed Time: 0:00:01.014893 spintrcritical08.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical08.exe
]
]
=> test start: SPINTRCRITICAL 8
] *** BEGIN OF TEST SPINTRCRITICAL 8 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate period ending while blocking
] Init - rtems_rate_monotonic_create - OK
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[474/591] p:425 f:12 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical09.exe
[475/591] p:425 f:13 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical10.exe
Result: failed Time: 0:00:01.016438 spintrcritical10.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical10.exe
]
]
=> test start: SPINTRCRITICAL 10
] *** BEGIN OF TEST SPINTRCRITICAL 10 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate any satisfied before timeout while blocking on event
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical10/init.c: 144 ctx->hit
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[476/591] p:426 f:13 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical11.exe
<<skipping passes>>
[481/591] p:430 f:14 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical16.exe
Result: failed Time: 0:00:01.012201 spintrcritical16.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical16.exe
]
]
=> test start: SPINTRCRITICAL 16
] *** BEGIN OF TEST SPINTRCRITICAL 16 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Init - Trying to generate timeout of a thread that had its blocking
] Init - request satisfied while blocking but before time timeout
] Init - rtems_semaphore_create - OK
] Init - Case not hit - ran too long
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[482/591] p:431 f:14 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical18.exe
[483/591] p:432 f:15 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical20.exe
Result: failed Time: 0:00:01.010461 spintrcritical20.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical20.exe
]
]
=> test start: SPINTRCRITICAL 20
] *** BEGIN OF TEST SPINTRCRITICAL 20 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical20/init.c: 149 ctx->thread_queue_was_null
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[484/591] p:432 f:15 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical21.exe
Result: failed Time: 0:00:01.040923 spintrcritical21.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical21.exe
]
]
=> test start: SPINTRCRITICAL 21
] *** BEGIN OF TEST SPINTRCRITICAL 21 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] Event sent from ISR hitting synchronization point has NOT occurred
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical21/init.c: 157 case_hit
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[485/591] p:433 f:15 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical22.exe
Result: failed Time: 0:00:01.020565 spintrcritical22.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical22.exe
]
]
=> test start: SPINTRCRITICAL 22
] *** BEGIN OF TEST SPINTRCRITICAL 22 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical22/init.c: 118 ctx->done
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[486/591] p:433 f:16 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical23.exe
Result: failed Time: 0:00:01.009055 spintrcritical23.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical23.exe
]
]
=> test start: SPINTRCRITICAL 23
] *** BEGIN OF TEST SPINTRCRITICAL 23 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical23/init.c: 133 ctx->done
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[487/591] p:433 f:17 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: spintrcritical24.exe
Result: failed Time: 0:00:01.042424 spintrcritical24.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spintrcritical24.exe
]
]
=> test start: SPINTRCRITICAL 24
] *** BEGIN OF TEST SPINTRCRITICAL 24 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] ../../../../../../rtems/c/src/../../testsuites/sptests/spintrcritical24/init.c: 118 ctx->append_count > 0
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[488/591] p:433 f:18 u:6 e:0 I:0 B:3 t:24 i:0 W:0 | riscv32/rv32im: splinkersets01.exe
<<skipping passes>>
[518/591] p:460 f:20 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: spsimplesched01.exe
Result: timeout Time: 0:03:00.544173 spsimplesched01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spsimplesched01.exe
]
]
=> test start: SPSIMPLESCHED 1
] *** BEGIN OF TEST SPSIMPLESCHED 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] TA1 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:00 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:04 12/31/1988
] TA2 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:09 12/31/1988
] TA3 - rtems_clock_get_tod - 09:00:14 12/31/1988
] TA1 - rtems_clock_get_tod - 09:00:14 12/31/1988
] *** TIMEOUT TIMEOUT
[519/591] p:461 f:20 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: spsimplesched02.exe
<<skipping passes>>
[525/591] p:467 f:20 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: spsysinit01.exe
Result: failed Time: 0:00:01.014901 spsysinit01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/sptests/spsysinit01.exe
] sysinit: begin
] sysinit: stack pointer: 0x800321e0
] sysinit: memory area 0: begin = 0x80032200, size = 0x03fcde00
] sysinit: DIRTY_MEMORY: done
] sysinit: ISR_STACK: done
] sysinit: memory area 0: free begin = 0x800365c6, free size = 0x03fc9a3a
] sysinit: WORKSPACE: done
] sysinit: memory area 0: free begin = 0x84000000, free size = 0x00000000
] sysinit: MALLOC: done
]
]
=> test start: SPSYSINIT 1
] *** BEGIN OF TEST SPSYSINIT 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] sysinit: BSP_START: done
] sysinit: CPU_COUNTER: done
] sysinit: INITIAL_EXTENSIONS: done
] sysinit: DATA_STRUCTURES: done
] sysinit: USER_EXTENSIONS: done
] sysinit: CLASSIC_TASKS: done
] sysinit: CLASSIC_TIMER: done
] sysinit: CLASSIC_MESSAGE_QUEUE: done
] sysinit: CLASSIC_SEMAPHORE: done
] sysinit: CLASSIC_PARTITION: done
] sysinit: CLASSIC_REGION: done
] sysinit: CLASSIC_DUAL_PORTED_MEMORY: done
] sysinit: CLASSIC_RATE_MONOTONIC: done
] sysinit: CLASSIC_BARRIER: done
] sysinit: POSIX_SIGNALS: done
] sysinit: POSIX_THREADS: done
] sysinit: POSIX_MESSAGE_QUEUE: done
] sysinit: POSIX_SEMAPHORE: done
] sysinit: POSIX_TIMER: done
] sysinit: POSIX_SHM: done
] sysinit: POSIX_KEYS: done
] sysinit: POSIX_CLEANUP: done
] sysinit: IDLE_THREADS: done
] sysinit: LIBIO: done
] sysinit: USER_ENVIRONMENT: done
] sysinit: ROOT_FILESYSTEM: done
] sysinit: BSP_PRE_DRIVERS: done
] sysinit: DEVICE_DRIVERS: done
] sysinit: CLASSIC_USER_TASKS: done
] sysinit: POSIX_USER_THREADS: done
] sysinit: STD_FILE_DESCRIPTORS: done
] sysinit: done
] ../../../../../../rtems/c/src/../../testsuites/sptests/spsysinit01/init.c: 902 sem != SEM_FAILED
]
] *** FATAL ***
] fatal source: 5 (RTEMS_FATAL_SOURCE_EXIT)
] fatal code: 0 (0x00000000)
] RTEMS version: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] RTEMS tools: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] executing thread ID: 0x08a010001
] executing thread name: UI1
] executing thread name: UI1
[526/591] p:467 f:21 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: spsyslock01.exe
<<skipping passes>>
[588/591] p:529 f:21 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: tmfine01.exe
Result: timeout Time: 0:03:00.428272 tmfine01.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/tmtests/tmfine01.exe
]
]
=> test start: TMFINE 1
] *** BEGIN OF TEST TMFINE 1 ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] <TestTimeFine01>
] <SelfEvent activeWorker="1">
] <Counter worker="0">7677979</Counter>
] </SelfEvent>
] <AllToOneEvent activeWorker="1">
] <Counter worker="0">7455277</Counter>
] </AllToOneEvent>
] <OneMutex activeWorker="1">
] <Counter worker="0">7238901</Counter>
] </OneMutex>
] <ManyMutex activeWorker="1">
] <Counter worker="0">7239261</Counter>
] </ManyMutex>
] <SelfMsg activeWorker="1">
] <Counter worker="0">3222616</Counter>
] </SelfMsg>
] <ManyToOneMsg activeWorker="1">
] <Counter worker="0">3212318</Counter>
] </ManyToOneMsg>
] *** TIMEOUT TIMEOUT
[589/591] p:530 f:21 u:6 e:0 I:0 B:3 t:25 i:0 W:0 | riscv32/rv32im: tmonetoone.exe
Result: timeout Time: 0:03:00.490482 tmonetoone.exe
=> run: spike --isa=RV32IM ./riscv-rtems5/c/rv32im/testsuites/tmtests/tmonetoone.exe
]
]
=> test start: TMONETOONE
] *** BEGIN OF TEST TMONETOONE ***
] *** TEST VERSION: 5.0.0.222d687969e008cdd464b1f92c79e83671094231
] *** TEST STATE: EXPECTED_PASS
] *** TEST BUILD: RTEMS_POSIX_API
] *** TEST TOOLS: 9.3.0 20200312 (RTEMS 5, RSB 5 (78c6e159d467), Newlib 7947581)
] yield
] a 1729172
] b 1729172
] event
] a 920312
] b 920311
] self-contained binary semaphore
] a 799566
] b 799566
] Classic binary semaphore (FIFO)
] *** TIMEOUT TIMEOUT
[590/591] p:530 f:21 u:6 e:0 I:0 B:3 t:26 i:0 W:0 | riscv32/rv32im: tmoverhd.exe
[591/591] p:531 f:21 u:6 e:0 I:0 B:3 t:26 i:0 W:0 | riscv32/rv32im: tmtimer01.exe
Passed: 533
Failed: 21
User Input: 6
Expected Fail: 0
Indeterminate: 0
Benchmark: 3
Timeout: 28
Invalid: 0
Wrong Version: 0
Wrong Build: 0
Wrong Tools: 0
------------------
Total: 591
Failures:
dl02.exe
dl05.exe
dl06.exe
dl07.exe
dl08.exe
dl09.exe
psxfenv01.exe
spintrcritical01.exe
spintrcritical02.exe
spintrcritical03.exe
spintrcritical04.exe
spintrcritical05.exe
spintrcritical08.exe
spintrcritical10.exe
spintrcritical16.exe
spintrcritical20.exe
spintrcritical21.exe
spintrcritical22.exe
spintrcritical23.exe
spintrcritical24.exe
spsysinit01.exe
User Input:
dl10.exe
monitor.exe
termios.exe
top.exe
capture.exe
fileio.exe
Benchmark:
dhrystone.exe
whetstone.exe
linpack.exe
Timeouts:
block08.exe
cpuuse.exe
crypt01.exe
flashdisk01.exe
psx07.exe
psxmsgq01.exe
psxrwlock01.exe
psxstat.exe
psxtime.exe
psxtimer01.exe
ticker.exe
sp01.exe
sp04.exe
sp05.exe
sp12.exe
sp19.exe
sp20.exe
sp24.exe
sp30.exe
sp32.exe
spcbssched01.exe
spcbssched03.exe
spcontext01.exe
spedfsched01.exe
spedfsched03.exe
spsimplesched01.exe
tmfine01.exe
tmonetoone.exe
Average test time: 0:00:04.653353
Testing time : 0:45:50.131871
More information about the build
mailing list