linux-kernel - [linus:master] [rcutorture] a5c095e0e9: WARNING:suspicious_RCU

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives

Hash Suite: Windows password security audit tool. GUI, reports in PDF.

[<prev] [next>] [thread-next>] [day] [month] [year] [list]

Message-ID: <202212032149.66b0c23b-oliver.sang@intel.com>
Date:   Sat, 3 Dec 2022 22:47:47 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     "Paul E. McKenney" <paulmck@...nel.org>
CC:     <oe-lkp@...ts.linux.dev>, <lkp@...el.com>,
        <linux-kernel@...r.kernel.org>
Subject: [linus:master] [rcutorture]  a5c095e0e9: WARNING:suspicious_RCU_usage


Greeting,

FYI, we noticed WARNING:suspicious_RCU_usage due to commit (built with gcc-11):

commit: a5c095e0e9b6fedcffd0907c84f77751128e2a34 ("rcutorture: Abstract read-lock-held checks")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master

in testcase: rcutorture
version: 
with following parameters:

	runtime: 300s
	test: default
	torture_type: busted_srcud

test-description: rcutorture is rcutorture kernel module load/unload test.
test-url: https://www.kernel.org/doc/Documentation/RCU/torture.txt


on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G

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>
| Link: https://lore.kernel.org/oe-lkp/202212032149.66b0c23b-oliver.sang@intel.com


[  154.593443][  T500] WARNING: suspicious RCU usage
[  154.594126][  T500] 5.13.0-rc1-00008-ga5c095e0e9b6 #1 Not tainted
[  154.594990][  T500] -----------------------------
[  154.595665][  T500] kernel/rcu/rcutorture.c:1568 suspicious rcu_dereference_check() usage!
[  154.596944][  T500]
[  154.596944][  T500] other info that might help us debug this:
[  154.596944][  T500]
[  154.598385][  T500]
[  154.598385][  T500] rcu_scheduler_active = 2, debug_locks = 1
[  154.599595][  T500] no locks held by rcu_torture_rea/500.
[  154.601317][  T500]
[  154.601317][  T500] stack backtrace:
[  154.602154][  T500] CPU: 1 PID: 500 Comm: rcu_torture_rea Not tainted 5.13.0-rc1-00008-ga5c095e0e9b6 #1
[  154.603441][  T500] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.0-debian-1.16.0-4 04/01/2014
[  154.604909][  T500] Call Trace:
[ 154.605402][ T500] ? dump_stack (??:?) 
[ 154.606122][ T500] ? lockdep_rcu_suspicious (??:?) 
[ 154.606892][ T500] ? rcu_torture_one_read (rcutorture.c:?) rcutorture
[ 154.607813][ T500] ? rcutorture_loop_extend (rcutorture.c:?) rcutorture
[ 154.608764][ T500] ? __mod_timer (timer.c:?) 
[ 154.609578][ T500] ? do_init_timer (timer.c:?) 
[ 154.610282][ T500] ? rcu_torture_reader (rcutorture.c:?) rcutorture
[ 154.611202][ T500] ? rcu_torture_read_exit_child (rcutorture.c:?) rcutorture
[ 154.612204][ T500] ? __kasan_check_read (??:?) 
[ 154.612974][ T500] ? rcu_torture_reader (rcutorture.c:?) rcutorture
[ 154.613950][ T500] ? __kasan_check_read (??:?) 
[ 154.614673][ T500] ? test_bit (main.c:?) 
[ 154.615332][ T500] ? __kthread_parkme (kthread.c:?) 
[ 154.616059][ T500] ? kthread (kthread.c:?) 
[ 154.616640][ T500] ? rcu_torture_read_exit_child (rcutorture.c:?) rcutorture
[ 154.617642][ T500] ? kzalloc (resource.c:?) 
[ 154.618361][ T500] ? ret_from_fork (??:?) 
[  154.627467][  T483] busted_srcud-torture: Creating torture_shuffle task
[  154.629419][  T502] busted_srcud-torture: rcu_torture_stats task started
[  154.640374][  T483] busted_srcud-torture: Creating torture_stutter task
[  154.644728][  T504] busted_srcud-torture: torture_shuffle task started
[  154.645963][  T483] busted_srcud-torture: rcu_torture_fwd_prog_init: Disabled, unsupported by RCU flavor under test
[  154.647399][  T483] busted_srcud-torture: Creating rcu_torture_read_exit task
[  154.649698][  T505] busted_srcud-torture: torture_stutter task started
[ 154.660318][ T483] initcall rcu_torture_init+0x0/0x2b83 [rcutorture] returned 0 after 472073 usecs 
[  154.679808][  T507] busted_srcud-torture: rcu_torture_read_exit: Start of test
[  160.204160][  T507] busted_srcud-torture: rcu_torture_read_exit: End of episode
[  173.852307][  T507] busted_srcud-torture: rcu_torture_read_exit: Start of episode


To reproduce:

        # build kernel
	cd linux
	cp config-5.13.0-rc1-00008-ga5c095e0e9b6 .config
	make HOSTCC=gcc-11 CC=gcc-11 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
	make HOSTCC=gcc-11 CC=gcc-11 ARCH=x86_64 INSTALL_MOD_PATH=<mod-install-dir> modules_install
	cd <mod-install-dir>
	find lib/ | cpio -o -H newc --quiet | gzip > modules.cgz


        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        bin/lkp qemu -k <bzImage> -m modules.cgz job-script # job-script is attached in this email

        # 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.13.0-rc1-00008-ga5c095e0e9b6" of type "text/plain" (120097 bytes)

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

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

View attachment "rcutorture" of type "text/plain" (10772 bytes)