Date:   Tue, 19 Jul 2022 23:38:57 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     Kuniyuki Iwashima <kuniyu@...zon.com>
Cc:     0day robot <lkp@...el.com>, LKML <linux-kernel@...r.kernel.org>,
        linux-fsdevel@...r.kernel.org, lkp@...ts.01.org,
        Jeff Layton <jlayton@...nel.org>,
        Chuck Lever <chuck.lever@...cle.com>,
        Alexander Viro <viro@...iv.linux.org.uk>,
        Kuniyuki Iwashima <kuniyu@...zon.com>,
        Kuniyuki Iwashima <kuni1840@...il.com>
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/20220716013140.61445-1-kuniyu@amazon.com

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 <oliver.sang@...el.com>

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



View attachment "config-5.19.0-rc6-00365-g7f68b5b24c3d" of type "text/plain" (167783 bytes)

View attachment "job-script" of type "text/plain" (6076 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (30444 bytes)

View attachment "job.yaml" of type "text/plain" (4854 bytes)

View attachment "reproduce" of type "text/plain" (2494 bytes)

Download attachment "nvml.xz" of type "application/x-xz" (54500 bytes)

Powered by blists - more mailing lists