2022-07-19 16:17:49

by kernel test robot

[permalink] [raw]
Subject: [fs/lock] 7f68b5b24c: nvml.ex_libpmemlog_TEST0_check_pmem_debug.fail



Greeting,

FYI, we noticed the following commit (built with gcc-11):

commit: 7f68b5b24c3d8d371fb96ebe278dabb8c08bbf51 ("[PATCH] fs/lock: Don't allocate file_lock in flock_make_lock().")
url: https://github.com/intel-lab-lkp/linux/commits/Kuniyuki-Iwashima/fs-lock-Don-t-allocate-file_lock-in-flock_make_lock/20220716-225519
base: https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git 9b59ec8d50a1f28747ceff9a4f39af5deba9540e
patch link: https://lore.kernel.org/linux-fsdevel/[email protected]

in testcase: nvml
version: nvml-x86_64-3de7d358f-1_20211217
with following parameters:

test: pmem
group: ex
nr_pmem: 1
fs: ext4
mount_option: dax
bp_memmap: 32G!4G
ucode: 0x700001c



on test machine: 16 threads 1 sockets Intel(R) Xeon(R) CPU D-1541 @ 2.10GHz with 48G memory

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):




If you fix the issue, kindly add following tag
Reported-by: kernel test robot <[email protected]>

also found below fails which could pass on parent.

9b59ec8d50a1f287 7f68b5b24c3d8d371fb96ebe278
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
:6 100% 6:6 nvml.ex_libpmemblk_TEST0_check_pmem_debug.fail
:6 100% 6:6 nvml.ex_libpmemlog_TEST0_check_pmem_debug.fail
:6 100% 6:6 nvml.ex_libpmemobj_TEST0_check_pmem_debug.fail
:6 100% 6:6 nvml.ex_linkedlist_TEST0_check_pmem_debug.fail


2022-07-17 16:07:44 ./RUNTESTS -f pmem ex_libpmemblk
ex_libpmemblk/TEST0: SETUP (check/pmem/debug)
RUNTESTS: stopping: ex_libpmemblk/TEST0 failed, TEST=check FS=pmem BUILD=debug
2022-07-17 16:07:44 ./RUNTESTS -f pmem ex_libpmemlog
ex_libpmemlog/TEST0: SETUP (check/pmem/debug)
RUNTESTS: stopping: ex_libpmemlog/TEST0 failed, TEST=check FS=pmem BUILD=debug
2022-07-17 16:07:44 ./RUNTESTS -f pmem ex_libpmemobj
ex_libpmemobj/TEST0: SETUP (check/pmem/debug)
RUNTESTS: stopping: ex_libpmemobj/TEST0 failed, TEST=check FS=pmem BUILD=debug

...

2022-07-17 16:07:45 ./RUNTESTS -f pmem ex_linkedlist
ex_linkedlist/TEST0: SETUP (check/pmem/debug)
ex_linkedlist/TEST0 crashed (signal 6). err0.log below.
{ex_linkedlist.c:248 main} ex_linkedlist/TEST0: Error: pmemobj_create: /fs/pmem0//test_ex_linkedlist0????i⠏⠍⠙⠅ɗPMDKӜ⥺????D/testfile: Invalid argument
err0.log below.
ex_linkedlist/TEST0 err0.log {ex_linkedlist.c:248 main} ex_linkedlist/TEST0: Error: pmemobj_create: /fs/pmem0//test_ex_linkedlist0????i⠏⠍⠙⠅ɗPMDKӜ⥺????D/testfi
le: Invalid argument

out0.log below.
ex_linkedlist/TEST0 out0.log ex_linkedlist/TEST0: START: ex_linkedlist
ex_linkedlist/TEST0 out0.log ./ex_linkedlist /fs/pmem0//test_ex_linkedlist0????i⠏⠍⠙⠅ɗPMDKӜ⥺????D/testfile

pmem0.log below.
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:209 out_init] pid 21141: program: /lkp/benchmarks/nvml/src/test/ex_linkedlist/ex_linkedlist
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:211 out_init] libpmem version 1.1
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:215 out_init] src version: 1.11.0+git148.gfe27e1033
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:223 out_init] compiled with support for Valgrind pmemcheck
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:228 out_init] compiled with support for Valgrind helgrind
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:233 out_init] compiled with support for Valgrind memcheck
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:238 out_init] compiled with support for Valgrind drd
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:243 out_init] compiled with support for shutdown state
ex_linkedlist/TEST0 pmem0.log <libpmem>: <1> [out.c:248 out_init] compiled with libndctl 63+
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [mmap.c:39 util_mmap_init]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [libpmem.c:27 libpmem_init]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [pmem.c:827 pmem_init]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:502 pmem2_arch_init]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:425 pmem_cpuinfo_to_funcs]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:428 pmem_cpuinfo_to_funcs] clflush supported
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:480 pmem_cpuinfo_to_funcs] WC workaround = 1
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:303 use_avx_memcpy_memset] avx supported
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:311 use_avx_memcpy_memset] PMEM_AVX enabled
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:530 pmem2_arch_init] using clflush
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [init.c:537 pmem2_arch_init] using movnt AVX
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [auto_flush_linux.c:86 check_domain_in_region] region_path: /sys/bus/nd/devices/region0
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [pmem.c:851 pmem_init] Flushing CPU cache
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [pmem_posix.c:78 pmem_os_init]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [libpmem.c:40 libpmem_fini]
ex_linkedlist/TEST0 pmem0.log <libpmem>: <3> [mmap.c:73 util_mmap_fini]

Last 30 lines of pmemobj0.log below (whole file has 48 lines).
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [obj.c:1299 obj_get_nlanes]
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:3357 util_pool_create] setp 0x7ffdc07c6de8 path /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /
testfile poolsize 8388608 minsize 8388608 minpartsize 2097152 attr 0x7ffdc07c6d78 nlanes 0x7ffdc07c6de4 can_have_rep 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:3117 util_pool_create_uuids] setp 0x7ffdc07c6de8 path /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMD
KӜ⥺???? /testfile poolsize 8388608 minsize 8388608 minpartsize 2097152 pattr 0x7ffdc07c6d78 nlanes 0x7ffdc07c6de4 can_have_rep 1 remote 0
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:37 util_file_exists] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:2124 util_poolset_create_set] setp 0x7ffdc07c6de8 path /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPM
DKӜ⥺???? /testfile poolsize 8388608 minsize 8388608
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:115 util_file_get_type] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:37 util_file_exists] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:1703 util_poolset_single] path /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile filesize
8388608 create 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:115 util_file_get_type] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:37 util_file_exists] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set_badblocks.c:81 badblocks_check_poolset] set 0x221a810 create 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:4248 util_poolset_foreach_part_struct] set 0x221a810 callback 0x7f61e15c7930 arg 0x7ffdc07c6a9
0
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set_badblocks.c:34 badblocks_check_file_cb] part_file 0x7ffdc07c6a30 arg 0x7ffdc07c6a90
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:37 util_file_exists] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:2009 util_poolset_files_local] set 0x221a810 minpartsize 2097152 create 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:1781 util_part_open] part 0x22197a8 minsize 2097152 create 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:37 util_file_exists] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile"
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [file.c:417 util_file_create] path "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile" size 8388
608 minsize 2097152
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <1> [file.c:459 util_file_create] flock "/fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile": Invalid
argument
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <2> [set.c:1797 util_part_open] failed to create file: /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /test
file
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:630 util_poolset_close] set 0x221a810 del 1
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:2886 util_replica_close] set 0x221a810 repidx 0
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:484 util_unmap_part] part 0x22197a8
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:522 util_poolset_free] set 0x221a810
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <2> [obj.c:1363 pmemobj_createU] cannot create pool or pool set
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [libpmemobj.c:36 libpmemobj_fini]
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [obj.c:300 obj_fini]
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:140 util_remote_fini]
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [set.c:195 util_remote_unload]
ex_linkedlist/TEST0 pmemobj0.log <libpmemobj>: <3> [mmap.c:73 util_mmap_fini]

trace0.log below.
ex_linkedlist/TEST0 trace0.log {ex_linkedlist.c:235 main} ex_linkedlist/TEST0: START: ex_linkedlist
ex_linkedlist/TEST0 trace0.log ./ex_linkedlist /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /testfile
ex_linkedlist/TEST0 trace0.log {ex_linkedlist.c:248 main} ex_linkedlist/TEST0: Error: pmemobj_create: /fs/pmem0//test_ex_linkedlist0???? ⠏⠍⠙⠅ɗPMDKӜ⥺???? /test
file: Invalid argument

RUNTESTS: stopping: ex_linkedlist/TEST0 failed, TEST=check FS=pmem BUILD=debug


To reproduce:

git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file

# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.



--
0-DAY CI Kernel Test Service
https://01.org/lkp



Attachments:
(No filename) (10.56 kB)
config-5.19.0-rc6-00365-g7f68b5b24c3d (170.27 kB)
job-script (6.09 kB)
dmesg.xz (29.73 kB)
job.yaml (4.88 kB)
reproduce (2.48 kB)
nvml.xz (53.22 kB)
Download all attachments