LTP syscalls statx06 fails on NFS mounted devices using external hard drives for testing and running on Linux next 6.4.0-rc3-next-20230524.
Test case fails on x86_64, i386 and arm64 Juno-r2.
Reported-by: Linux Kernel Functional Testing lkft@linaro.org
Linux version 6.4.0-rc3-next-20230524 (tuxmake@tuxmake) (x86_64-linux-gnu-gcc (Debian 11.3.0-12) 11.3.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT_DYNAMIC @1684908723 ...
[ 1.396191] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.397234] sysctl table check failed: kernel/usermodehelper Not a file [ 1.398166] sysctl table check failed: kernel/usermodehelper No proc_handler [ 1.399165] sysctl table check failed: kernel/usermodehelper bogus .mode 0555 [ 1.400166] sysctl table check failed: kernel/keys Not a file [ 1.401165] sysctl table check failed: kernel/keys No proc_handler [ 1.402165] sysctl table check failed: kernel/keys bogus .mode 0555 [ 1.403166] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.4.0-rc3-next-20230524 #1 [ 1.404165] Hardware name: Supermicro SYS-5019S-ML/X11SSH-F, BIOS 2.5 11/26/2020 [ 1.404165] Call Trace: [ 1.404165] <TASK> [ 1.404165] dump_stack_lvl+0x72/0x90 [ 1.404165] dump_stack+0x14/0x20 [ 1.404165] __register_sysctl_table+0x570/0x840 [ 1.404165] __register_sysctl_init+0x29/0x60 [ 1.404165] sysctl_init_bases+0x27/0x80 [ 1.404165] proc_sys_init+0x37/0x40 [ 1.404165] proc_root_init+0x7b/0x90 [ 1.404165] start_kernel+0x403/0x6a0 [ 1.404165] x86_64_start_reservations+0x1c/0x30 [ 1.404165] x86_64_start_kernel+0xcb/0xe0 [ 1.404165] secondary_startup_64_no_verify+0x179/0x17b [ 1.404165] </TASK> [ 1.404165] failed when register_sysctl kern_table to kernel
.... ./runltp -f syscalls -d /scratch
...
[ 1192.088987] loop0: detected capacity change from 0 to 614400 tst_device.c:93: TINFO: Found free device 0 '/dev/loop0' tst_test.c:1093: TINFO: Formatting /dev/loop0 with ext4 opts='-I 256' extra opts='' mke2fs 1.46.5 (30-Dec-2021) [ 1192.337350] EXT4-fs (loop0): mounted filesystem dfe9283c-5d2f-43f8-840e-a2bbbff5b202 r/w with ordered data mode. Quota mode: none. tst_test.c:1558: TINFO: Timeout per run is 0h 05m 00s
statx06.c:140: TPASS: Birth time Passed statx06.c:138: TFAIL: Modified time > after_time statx06.c:140: TPASS: Access time Passed statx06.c:140: TPASS: Change time Passed
links, - https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes... - https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes... - https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes...
-- Linaro LKFT https://lkft.linaro.org
I am pretty sure this is caused by commit 7eec88986dce ("sysctl: Refactor base paths registrations"). Add Joel to the CC list.
Before we used to use register_sysctl_table() to register that table.
regards, dan carpenter
On Wed, May 24, 2023 at 04:18:42PM +0530, Naresh Kamboju wrote:
LTP syscalls statx06 fails on NFS mounted devices using external hard drives for testing and running on Linux next 6.4.0-rc3-next-20230524.
Test case fails on x86_64, i386 and arm64 Juno-r2.
Reported-by: Linux Kernel Functional Testing lkft@linaro.org
Linux version 6.4.0-rc3-next-20230524 (tuxmake@tuxmake) (x86_64-linux-gnu-gcc (Debian 11.3.0-12) 11.3.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT_DYNAMIC @1684908723 ...
[ 1.396191] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.397234] sysctl table check failed: kernel/usermodehelper Not a file [ 1.398166] sysctl table check failed: kernel/usermodehelper No proc_handler [ 1.399165] sysctl table check failed: kernel/usermodehelper bogus .mode 0555 [ 1.400166] sysctl table check failed: kernel/keys Not a file [ 1.401165] sysctl table check failed: kernel/keys No proc_handler [ 1.402165] sysctl table check failed: kernel/keys bogus .mode 0555 [ 1.403166] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.4.0-rc3-next-20230524 #1 [ 1.404165] Hardware name: Supermicro SYS-5019S-ML/X11SSH-F, BIOS 2.5 11/26/2020 [ 1.404165] Call Trace: [ 1.404165] <TASK> [ 1.404165] dump_stack_lvl+0x72/0x90 [ 1.404165] dump_stack+0x14/0x20 [ 1.404165] __register_sysctl_table+0x570/0x840 [ 1.404165] __register_sysctl_init+0x29/0x60 [ 1.404165] sysctl_init_bases+0x27/0x80 [ 1.404165] proc_sys_init+0x37/0x40 [ 1.404165] proc_root_init+0x7b/0x90 [ 1.404165] start_kernel+0x403/0x6a0 [ 1.404165] x86_64_start_reservations+0x1c/0x30 [ 1.404165] x86_64_start_kernel+0xcb/0xe0 [ 1.404165] secondary_startup_64_no_verify+0x179/0x17b [ 1.404165] </TASK> [ 1.404165] failed when register_sysctl kern_table to kernel
.... ./runltp -f syscalls -d /scratch
...
[ 1192.088987] loop0: detected capacity change from 0 to 614400 tst_device.c:93: TINFO: Found free device 0 '/dev/loop0' tst_test.c:1093: TINFO: Formatting /dev/loop0 with ext4 opts='-I 256' extra opts='' mke2fs 1.46.5 (30-Dec-2021) [ 1192.337350] EXT4-fs (loop0): mounted filesystem dfe9283c-5d2f-43f8-840e-a2bbbff5b202 r/w with ordered data mode. Quota mode: none. tst_test.c:1558: TINFO: Timeout per run is 0h 05m 00s
statx06.c:140: TPASS: Birth time Passed statx06.c:138: TFAIL: Modified time > after_time statx06.c:140: TPASS: Access time Passed statx06.c:140: TPASS: Change time Passed
links,
- https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes...
- https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes...
- https://qa-reports.linaro.org/lkft/linux-next-master/build/next-20230524/tes...
-- Linaro LKFT https://lkft.linaro.org
On Wed, May 24, 2023 at 02:23:16PM +0300, Dan Carpenter wrote:
I am pretty sure this is caused by commit 7eec88986dce ("sysctl: Refactor base paths registrations"). Add Joel to the CC list.
Before we used to use register_sysctl_table() to register that table.
regards, dan carpenter
On Wed, May 24, 2023 at 04:18:42PM +0530, Naresh Kamboju wrote:
LTP syscalls statx06 fails on NFS mounted devices using external hard drives for testing and running on Linux next 6.4.0-rc3-next-20230524.
Test case fails on x86_64, i386 and arm64 Juno-r2.
Reported-by: Linux Kernel Functional Testing lkft@linaro.org
Linux version 6.4.0-rc3-next-20230524 (tuxmake@tuxmake) (x86_64-linux-gnu-gcc (Debian 11.3.0-12) 11.3.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT_DYNAMIC @1684908723 ...
[ 1.396191] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear) [ 1.397234] sysctl table check failed: kernel/usermodehelper Not a file [ 1.398166] sysctl table check failed: kernel/usermodehelper No proc_handler [ 1.399165] sysctl table check failed: kernel/usermodehelper bogus .mode 0555 [ 1.400166] sysctl table check failed: kernel/keys Not a file [ 1.401165] sysctl table check failed: kernel/keys No proc_handler [ 1.402165] sysctl table check failed: kernel/keys bogus .mode 0555
This should all be fixed with https://lore.kernel.org/all/20230523122220.1610825-1-j.granados@samsung.com/
[ 1.403166] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.4.0-rc3-next-20230524 #1 [ 1.404165] Hardware name: Supermicro SYS-5019S-ML/X11SSH-F, BIOS 2.5 11/26/2020 [ 1.404165] Call Trace: [ 1.404165] <TASK> [ 1.404165] dump_stack_lvl+0x72/0x90 [ 1.404165] dump_stack+0x14/0x20 [ 1.404165] __register_sysctl_table+0x570/0x840 [ 1.404165] __register_sysctl_init+0x29/0x60 [ 1.404165] sysctl_init_bases+0x27/0x80 [ 1.404165] proc_sys_init+0x37/0x40 [ 1.404165] proc_root_init+0x7b/0x90 [ 1.404165] start_kernel+0x403/0x6a0 [ 1.404165] x86_64_start_reservations+0x1c/0x30 [ 1.404165] x86_64_start_kernel+0xcb/0xe0 [ 1.404165] secondary_startup_64_no_verify+0x179/0x17b [ 1.404165] </TASK> [ 1.404165] failed when register_sysctl kern_table to kernel
.... ./runltp -f syscalls -d /scratch
...
[ 1192.088987] loop0: detected capacity change from 0 to 614400 tst_device.c:93: TINFO: Found free device 0 '/dev/loop0' tst_test.c:1093: TINFO: Formatting /dev/loop0 with ext4 opts='-I 256' extra opts='' mke2fs 1.46.5 (30-Dec-2021) [ 1192.337350] EXT4-fs (loop0): mounted filesystem dfe9283c-5d2f-43f8-840e-a2bbbff5b202 r/w with ordered data mode. Quota mode: none. tst_test.c:1558: TINFO: Timeout per run is 0h 05m 00s
statx06.c:140: TPASS: Birth time Passed statx06.c:138: TFAIL: Modified time > after_time statx06.c:140: TPASS: Access time Passed statx06.c:140: TPASS: Change time Passed
links,
- https://protect2.fireeye.com/v1/url?k=cdaccb27-acd761af-cdad4068-74fe4860018...
- https://protect2.fireeye.com/v1/url?k=04c58bbf-65be2137-04c400f0-74fe4860018...
- https://protect2.fireeye.com/v1/url?k=b2e23b58-d39991d0-b2e3b017-74fe4860018...
-- Linaro LKFT https://protect2.fireeye.com/v1/url?k=f45a98bf-95213237-f45b13f0-74fe4860018...
On Wed, May 24, 2023, at 12:48, Naresh Kamboju wrote:
...
[ 1192.088987] loop0: detected capacity change from 0 to 614400 tst_device.c:93: TINFO: Found free device 0 '/dev/loop0' tst_test.c:1093: TINFO: Formatting /dev/loop0 with ext4 opts='-I 256' extra opts='' mke2fs 1.46.5 (30-Dec-2021) [ 1192.337350] EXT4-fs (loop0): mounted filesystem dfe9283c-5d2f-43f8-840e-a2bbbff5b202 r/w with ordered data mode. Quota mode: none. tst_test.c:1558: TINFO: Timeout per run is 0h 05m 00s
statx06.c:140: TPASS: Birth time Passed statx06.c:138: TFAIL: Modified time > after_time statx06.c:140: TPASS: Access time Passed statx06.c:140: TPASS: Change time Passed
I found a description in
https://lwn.net/ml/linux-kernel/20230503142037.153531-1-jlayton@kernel.org/
which indicates that this is expected. Added Jeff to Cc in case I'm misreading his explanation.
Arnd
Hi!
[ 1192.088987] loop0: detected capacity change from 0 to 614400 tst_device.c:93: TINFO: Found free device 0 '/dev/loop0' tst_test.c:1093: TINFO: Formatting /dev/loop0 with ext4 opts='-I 256' extra opts='' mke2fs 1.46.5 (30-Dec-2021) [ 1192.337350] EXT4-fs (loop0): mounted filesystem dfe9283c-5d2f-43f8-840e-a2bbbff5b202 r/w with ordered data mode. Quota mode: none. tst_test.c:1558: TINFO: Timeout per run is 0h 05m 00s
statx06.c:140: TPASS: Birth time Passed statx06.c:138: TFAIL: Modified time > after_time statx06.c:140: TPASS: Access time Passed statx06.c:140: TPASS: Change time Passed
I found a description in
https://lwn.net/ml/linux-kernel/20230503142037.153531-1-jlayton@kernel.org/
which indicates that this is expected. Added Jeff to Cc in case I'm misreading his explanation.
We even have in-flight patch from Jeff to fix the test with fine-grained timestamps in LTP:
http://patchwork.ozlabs.org/project/ltp/patch/20230518113216.126233-1-jlayto...
-
Arnd Bergmann -
Cyril Hrubis -
Dan Carpenter -
Joel Granados -
Naresh Kamboju