Hay
Date
April 20, 2025, 11:14 p.m.
Failure - readahead01
readahead01 readahead01
readahead01: [  460.201873] /usr/local/bin/kirk[355]: starting test readahead01 (readahead01)
readahead01.c:36: TPASS: readahead() with fd = -1 : EBADF (9)
readahead01.c[ 1812.725921] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=readlinkat02 RESULT=pass>
readahead01.c:64: TPASS: readahead() on O_PATH file : EBADF (9)
readahead01.c:64: TPASS: readahead() on directory : EINVAL (22)
readahead01.c:64: TPASS: readahead() on pipe read end : EINVAL (22)
readahead01.c:64: TPASS: readahead() on pipe write end : EBADF (9)
readahead01.c:64: TPASS: readahead() on unix socket : EINVAL (2[ 1812.776672] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=readv02 RESULT=pass>
readahead01.c:64: TPASS: readahead() on inet socket : EINVAL (22)
readahead01.c:64: TPASS: readahead() on epoll : EINVAL (22)
readahead01.c:64: TPASS: readahead() on eventfd : EINVAL (22[ 1812.802429] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=recvmsg01 RESULT=pass>
readahead01.c:64: TPASS: readahead() on signalfd : EINVAL (22)
readahead01.c:64: TPASS: readahead() on timerfd : EINVAL (22)
readahead01.c:64: TPASS: readahead() on fanotify : EINVAL (22)[ 1812.824340] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=recvmsg02 RESULT=pass>
readahead01.c:64: TPASS: readahead() on inotify : EINVAL (22)
readahead01.c:64: TPASS: readahead() on perf event : EINVAL (22)
readahead01.c:64: TPASS: readahead() on io uring : EINVAL (22)
readahead01.c:64: TPASS: readahead() on fsopen : EINVAL (22)
readahead01.c:64: TPASS: readahead() on fspick : EINVAL (22)
readahead01.c:64: TPASS: readahead() on open_tree : EBADF (9)
Failure - msgctl05
msgctl05 msgctl05
msgctl05: [  237.198272] /usr/local/bin/kirk[355]: starting test msgctl05 (msgctl05)
msgctl05.c:35: TFAIL: time_high fields aren't cleared by the kernel
Failure - getxattr04
getxattr04 getxattr04
getxattr04: [  745.640289] /usr/local/bin/kirk[355]: starting test getxattr04 (getxattr04)
Failure - fallocate06
fallocate06 fallocate06
fallocate06: [  680.861297] /usr/local/bin/kirk[355]: starting test fallocate06 (fallocate06)
Failure - cachestat04
cachestat04.c:44: TINFO: directory -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: /dev/zero -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: /proc/self/maps -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: pipe read end -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: pipe write end -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: unix socket -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: inet socket -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: epoll -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: eventfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: signalfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0[ 1819.701232] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=cachestat04 RESULT=fail>
)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: timerfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache =[ 1819.725311] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01 RESULT=pass>
= 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_r[ 1819.747619] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01A RESULT=pass>
ecently_evicted == 0 (0)
cachestat04.c:44: TINFO: pidfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr[ 1819.770996] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod01A RESULT=pass>
_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: fanotify -> ...
cachestat04.c:34: TP[ 1819.793853] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod03 RESULT=pass>
ASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04 cachestat04
cachestat04: [  639.123687] /usr/local/bin/kirk[355]: starting test cachestat04 (cachestat04)
cachestat04.c:44: TINFO: file -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: O_PATH file -> ...
cachestat04.c:30: TPASS: errno == EBADF (9)
cachestat04.c:44: TINFO: directory -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: /dev/zero -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: /proc/self/maps -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: pipe read end -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: pipe write end -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: unix socket -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: inet socket -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: epoll -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: eventfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: signalfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0[ 1819.701232] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=cachestat04 RESULT=fail>
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: timerfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache =[ 1819.725311] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01 RESULT=pass>
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_r[ 1819.747619] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chdir01A RESULT=pass>
cachestat04.c:44: TINFO: pidfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr[ 1819.770996] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod01A RESULT=pass>
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: fanotify -> ...
cachestat04.c:34: TP[ 1819.793853] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod03 RESULT=pass>
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:[ 1819.816802] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod05 RESULT=pass>
cachestat04.c:44: TINFO: inotify -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: perf event -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_write[ 1819.886230] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chmod09 RESULT=pass>
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: io uring -> ...
cachestat04.c:34: TPASS: c[ 1819.909149] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown01_16 RESULT=pass>
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TP[ 1819.932800] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown02 RESULT=pass>
cachestat04.c:44: TINFO: fsopen -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c[ 1819.955535] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown02_16 RESULT=pass>
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: TINFO: fspick -> ...
cachestat04.c:34: TP[ 1819.982940] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown03 RESULT=pass>
cachestat04.c:35: TPASS: cs->nr_dirty == 0 (0)
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
cachestat04.c:44: T[ 1820.010345] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown03_16 RESULT=pass>
cachestat04.c:30: TPASS: errno == EBADF (9)
cachestat04.c:44: TINFO: memfd -> ...
cachestat04.c:34: TPASS: cs->nr_cache == 0 (0)
cachestat04.c:35: TPASS: cs->nr_dirt[ 1820.036376] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=chown04 RESULT=pass>
cachestat04.c:36: TPASS: cs->nr_writeback == 0 (0)
cachestat04.c:37: TPASS: cs->nr_evicted == 0 (0)
cachestat04.c:38: TPASS: cs->nr_recently_evicted == 0 (0)
Failure - futex_wait05
futex_wait05 futex_wait05
futex_wait05: [  616.629577] /usr/local/bin/kirk[355]: starting test futex_wait05 (futex_wait05)
Failure - splice07
splice07 splice07
splice07: [  525.581268] /usr/local/bin/kirk[355]: starting test splice07 (splice07)
splice07.c:64: TINFO: file -> ...
splice07.c:56: TPASS: splice() on file -> file : EINVAL (22)
splice07.c:56: TPASS: splice() on file -> O_PATH file : E[ 1816.307403] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=splice09 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> directory : EBADF (9)
splice07.c:56: TPASS: splice() on file -> /dev/zero : EBADF (9)
splice07.c:56: TPASS: splice() on file -> /proc/self[ 1816.330780] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=tee01 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> pipe read end : EBADF (9)
splice07.c:56: TPASS: splice() on file -> unix socket : EINVAL (22)
splice07.c:56: TPASS: splice() on f[ 1816.353820] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=tee02 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> epoll : EINVAL (22)
splice07.c:56: TPASS: splice() on file -> eventfd : EINVAL (22)
splice07.c:56: TPASS: splice()[ 1816.376434] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=stat02 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> timerfd : EINVAL (22)
splice07.c:56: TPASS: splice() on file -> pidfd : EINVAL (22)
splice07.c:56: TPASS: splice[ 1816.399475] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=statmount03 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> inotify : EBADF (9)
splice07.c:56: TPASS: splice() on f[ 1816.423156] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=statfs02 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> io uring : EINVAL (22)
splice07.c:56: TPASS: splice() on file ->[ 1816.445983] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=statvfs02 RESULT=pass>
splice07.c:56: TPASS: splice() on file -> fspick : EINVAL (22)
splice07.c:56: TPASS: splice() on file -> open_tree : EBADF (9)
splice07.c:56: TPASS: splice() on file -[ 1816.469146] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=symlink02 RESULT=pass>
Failure - semctl08
semctl08 semctl08
semctl08: [  503.001342] /usr/local/bin/kirk[355]: starting test semctl08 (semctl08)
semctl08.c:38: TFAIL: time_high fields aren't cleared by the kernel
Failure - select02
tst_timer_test.c:305: TINFO: min 2075us, max 2136us, median 2106us, trunc mean 2093.80us (discarded 25)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 5000us 300 iterations, threshold 450.04us
tst_timer_test.c:305: TINFO: min 5066us, max 5157us, median 5096us, trunc mean 5097.48us (discarded 15)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 10000us 100 iterations, threshold 450.33us
tst_timer_test.c:305: TINFO: min 10071us, max 10132us, median 10101us, trunc mean 10104.65us (discarded 5)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 25000us 50 iterations, threshold 451.29us
tst_timer_test.c:305: TINFO: min 25085us, max 26917us, median 25116us, trunc mean 25118.40us (discarded 2)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 100000us 10 iterations, threshold 537.00us
tst_timer_test.c:305: TINFO: min 100128us, max 100220us, median 100189us, trunc mean 100182.56us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 1000000us 2 iterations, threshold 4400.00us
tst_timer_test.c:305: TINFO: min 1000153us, max 1001068us, median 1000153us, trunc mean 1000153.00us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
select_var.h:112: TINFO: Testing SYS_select syscall
tst_timer_test.c:357: TINFO: CLOCK_MONOTONIC resolution 1ns
tst_timer_test.c:369: TINFO: prctl(PR_GET_TIMERSLACK) = 50us
tst_test.c:1743: TINFO: Updating runtime to 0h 00m 09s
tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 45s
tst_timer_test.c:263: TINFO: select() sleeping for 1000us 500 iterations, threshold 450.01us
select_var.h:40: TCONF: syscall(-1) __NR_select not supported on your arch
select_var.h:115: TINFO: Testing SYS_pselect6 syscall
tst_timer_test.c:357: TINFO: CLOCK_MONOTONIC resolution 1ns
tst_timer_test.c:369: TINFO: prctl(PR_GET_TIMERSLACK) = 50us
tst_test.c:1743: TINFO: Updating runtime to 0h 00m 09s
tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 45s
tst_timer_test.c:263: TINFO: select() sleeping for 1000us 500 iterations, threshold 450.01us
tst_timer_test.c:305: TINFO: min 1068us, max 2319us, median 1099us, trunc mean 1088.43us (discarded 25)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 2000us 500 iterations, threshold 450.01us
tst_timer_test.c:305: TINFO: min 2075us, max 2136us, median 2106us, trunc mean 2091.90us (discarded 25)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 5000us 300 iterations, threshold 450.04us
tst_timer_test.c:305: TINFO: min 5066us, max 6256us, median 5096us, trunc mean 5096.61us (discarded 15)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 10000us 100 iterations, threshold 450.33us
tst_timer_test.c:305: TINFO: min 10071us, max 10162us, median 10101us, trunc mean 10104.96us (discarded 5)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 25000us 50 iterations, threshold 451.29us
tst_timer_test.c:305: TINFO: min 25085us, max 25177us, median 25116us, trunc mean 25117.10us (discarded 2)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 100000us 10 iterations, threshold 537.00us
tst_timer_test.c:305: TINFO: min 100128us, max 100220us, median 100189us, trunc mean 100172.22us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 1000000us 2 iterations, threshold 4400.00us
tst_timer_test.c:305: TINFO: min 1001556us, max 1001617us, median 1001556us, trunc mean 1001556.00us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
select_var.h:118: TINFO: Testing SYS_pselect6 time64 syscall
tst_timer_test.c:357: TINFO: CLOCK_MONOTONIC resolution 1ns
tst_timer_test.c:369: TINFO: prctl(PR_GET_TIMERSLACK) = 50us
tst_test.c:1743: TINFO: Updating runtime to 0h 00m 09s
tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 45s
tst_timer_test.c:263: TINFO: select() sleeping for 1000us 500 iterations, threshold 450.01us
tst_timer_test.c:305: TINFO: min 1068us, max 1160us, median 1099us, trunc mean 1088.56us (discarded 25)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 2000us 500 iterations, threshold 450.01us
tst_timer_test.c:305: TINFO: min 2075us, max 2136us, median 2106us, trunc mean 2090.92us (discarded 25)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 5000us 300 iterations, threshold 450.04us
tst_timer_test.c:305: TINFO: min 5066us, max 5157us, median 5096us, trunc mean 5096.00us (discarded 15)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 10000us 100 iterations, threshold 450.33us
tst_timer_test.c:305: TINFO: min 10071us, max 10162us, median 10101us, trunc mean 10104.34us (discarded 5)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 25000us 50 iterations, threshold 451.29us
tst_timer_test.c:305: TINFO: min 25085us, max 25177us, median 25116us, trunc mean 25118.96us (discarded 2)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 100000us 10 iterations, threshold 537.00us
tst_timer_test.c:305: TINFO: min 100128us, max 100250us, median 100189us, trunc mean 100185.78us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
tst_timer_test.c:263: TINFO: select() sleeping for 1000000us 2 iterations, threshold 4400.00us
tst_timer_test.c:305: TINFO: min 1001068us, max 1001648us, median 1001068us, trunc mean 1001068.00us (discarded 1)
tst_timer_test.c:326: TPASS: Measured times are within thresholds
select_var.h:121: TINFO: Testing SYS__newselect syscall
tst_timer_test.c:357: TINFO: CLOCK_MONOTONIC resolution 1ns
tst_timer_test.c:369: TINFO: prctl(PR_GET_TIMERSLACK) = 50us
tst_test.c:1743: TINFO: Updating runtime to 0h 00m 09s
tst_test.c:1722: TINFO: Overall timeout per run is 0h 21m 45s
tst_timer_test.c:263: TINFO: select() sleeping for 1000us 500 iterations, threshold 450.01us
tst_timer_test.c:292: TFAIL: select() woken up early 500 times range: [31,0]
tst_timer_test.c:305: TINFO: min 0us, max 31us, median 0us, trunc mean 1.76us (disc[ 1814.319274] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=select02 RESULT=fail>
arded 25)
tst_timer_test.c:263: TINFO: select() sleeping for 2000us 500 iterations, threshold 450.01us
tst_timer_test.c:292: TFAIL: select() woken up early 500 times range: [31,0]
tst_timer[ 1814.343536] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=select03 RESULT=pass>
_test.c:305: TINFO: min 0us, max 31us, median 0us, trunc mean 1.24us (discarded 25)
tst_timer_test.c:263: TINFO: select() sleeping for 5000us 300 iterations, threshold 450.04us
tst_timer_tes[ 1814.365631] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=select04 RESULT=pass>
t.c:292: TFAIL: select() woken up early 300 times range: [31,0]
tst_timer_test.c:305: TINFO: min 0us, max 31us, median 0us, trunc mean 1.41us (discarded 15)
tst_timer_test.c:263: TINFO: select() sleeping for 10000us 100 iterations, threshold 450.33us
ts[ 1814.393127] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=semctl01 RESULT=pass>
t_timer_test.c:292: TFAIL: select() woken up early 100 times range: [31,0]
tst_timer_test.c:305: TINFO: min 0us, max 31us, median 0us, trunc mean 0.65us (discarded 5)
tst_timer_test.c:263: TINFO: select() sleeping for 25000us 50 iterations, threshold 451[ 1814.420166] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=semctl03 RESULT=pass>
.29us
select02 select02
select02: [  475.010925] /usr/local/bin/kirk[355]: starting test select02 (select02)
Failure - recvmmsg01
recvmmsg01 recvmmsg01
recvmmsg01: [  460.782775] /usr/local/bin/kirk[355]: starting test recvmmsg01 (recvmmsg01)
recvmmsg01.c:133: TINFO: Testing variant: vDSO or syscall with libc spec
recvmmsg01.c:86: TPASS: recvmmsg() bad socket file descriptor : EBADF [ 1813.047424] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=request_key06 RESULT=pass>
Failure - accept03
accept03 accept03
accept03: [   45.898925] /usr/local/bin/kirk[355]: starting test accept03 (accept03)
accept03.c:48: TPASS: accept() on file : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on O_PATH file : EBADF (9)
accept03.c:48: TPASS: accept() on directory : ENOTSOCK (8[ 1802.091552] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=alarm02 RESULT=pass>
accept03.c:48: TPASS: accept() on /dev/zero : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on /proc/self/maps : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on pipe read end : ENOTSOCK ([ 1802.112915] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=alarm03 RESULT=pass>
accept03.c:48: TPASS: accept() on pipe write end : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on epoll : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on eventfd : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on timerfd : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on pidfd : ENOTSOCK (88)
accept03.c:48: TPASS:[ 1802.158660] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=alarm06 RESULT=pass>
accept03.c:48: TPASS: accept() on inotify : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on perf[ 1802.182006] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=alarm07 RESULT=pass>
accept03.c:48: TPASS: accept() on io uring : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on fsopen : ENOTSOCK (88)[ 1802.206756] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=arch_prctl01 RESULT=skip>
accept03.c:48: TPASS: accept() on fspick : ENOTSOCK (88)
accept03.c:48: TPASS: accept() on open_tree : EBADF (9)
accept03.c:48: TPASS: accept() on memfd : ENOTSOCK (88)
Failure - accept02
accept02 accept02
accept02: [   45.837890] /usr/local/bin/kirk[355]: starting test accept02 (accept02)
accept02.c:131: TINFO: Starting listener on port: 57215
accept02.c:54: TBROK: setsockopt(3, 0, 42, 0xb6f38f7c, 132) failed: ENODEV (19)
ioctl_loop06 ioctl_loop06
ioctl_loop06: [  753.515533] /usr/local/bin/kirk[355]: starting test ioctl_loop06 (ioctl_loop06)
ioctl_loop06.c:76: TINFO: Using LOOP_SET_BLOCK_SIZE with arg < 512
ioctl_loop06.c:67: TPASS: Set block size failed as expected: EINVAL (22)
ioctl_loop06.c:76: TINFO: Using LOOP_SET_BLOCK_SIZE with arg > PAG[ 1825.239776] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ioctl_ns06 RESULT=pass>
ioctl_loop06.c:59: TFAIL: Set block size succeed unexpectedly
ioctl_loop06.c:76: TINFO: Using LOOP_SET_BLOCK_SIZE with arg != power_of_2
ioctl_loop06.c:67: TPASS: Set block size fail[ 1825.266052] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ioctl_ficlone01 RESULT=pass>
ioctl_loop06.c:76: TINFO: Using LOOP_CONFIGURE with block_size < 512
ioctl_loop06.c:67: TPASS: Set block size failed as expected: EINVAL (22)
ioctl_loop06.c:76: [ 1825.289916] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ioctl_ficlone02 RESULT=pass>
ioctl_loop06.c:59: TFAIL: Set block size succeed unexpectedly
ioctl_loop06.c:76: TINFO: Using LOOP_CONFIGURE with block_size != power_[ 1825.313873] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ioctl_ficlone03 RESULT=pass>
ioctl_loop06.c:67: TPASS: Set block size failed as expected: EINVAL (22)