[paulmckrcu:dev] [srcu] 26cb612c43: BUG:using__this_cpu_read()in_preemptible

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 




Hello,

kernel test robot noticed "BUG:using__this_cpu_read()in_preemptible" on:

commit: 26cb612c431de5093ae6a3a67ecaa0363f5b8829 ("srcu: Add srcu_read_lock_lite() and srcu_read_unlock_lite()")
https://github.com/paulmckrcu/linux dev

in testcase: rcutorture
version: 
with following parameters:

	runtime: 300s
	test: cpuhotplug
	torture_type: srcud



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

(please refer to attached dmesg/kmsg for entire log/backtrace)


in our tests, this issue doesn't always happen, but with a not small rate.

daf812f27d6bbe4c 26cb612c431de5093ae6a3a67ec
---------------- ---------------------------
       fail:runs  %reproduction    fail:runs
           |             |             |
           :50          66%          33:50    dmesg.BUG:using__this_cpu_read()in_preemptible



If you fix the issue in a separate patch/commit (i.e. not just a new version of
the same patch/commit), kindly add following tags
| Reported-by: kernel test robot <oliver.sang@xxxxxxxxx>
| Closes: https://lore.kernel.org/oe-lkp/202409231124.358fed11-lkp@xxxxxxxxx


[  169.560380][   T76] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/1:2/76
[ 169.561229][ T76] caller is try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[  169.561657][   T76] CPU: 0 UID: 0 PID: 76 Comm: kworker/1:2 Not tainted 6.11.0-rc1-00125-g26cb612c431d #1
[  169.562369][   T76] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[  169.563120][   T76] Workqueue: rcu_gp process_srcu
[  169.563518][   T76] Call Trace:
[  169.563789][   T76]  <TASK>
[ 169.564031][ T76] dump_stack_lvl (lib/dump_stack.c:122) 
[ 169.564418][ T76] check_preemption_disabled (lib/smp_processor_id.c:52) 
[ 169.564842][ T76] ? try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[ 169.565219][ T76] ? process_one_work (kernel/workqueue.c:3206) 
[ 169.565592][ T76] ? srcu_advance_state (kernel/rcu/srcutree.c:1784) 
[ 169.565994][ T76] ? process_srcu (kernel/rcu/srcutree.c:1893) 
[ 169.566373][ T76] ? process_one_work (kernel/workqueue.c:3236) 
[ 169.566790][ T76] ? __pfx_process_one_work (kernel/workqueue.c:3133) 
[ 169.567199][ T76] ? __list_add (include/linux/list.h:83 include/linux/list.h:150) 
[ 169.567559][ T76] ? process_scheduled_works (kernel/workqueue.c:3312) 
[ 169.567990][ T76] ? worker_thread (include/linux/list.h:373 kernel/workqueue.c:948 kernel/workqueue.c:3391) 
[ 169.568361][ T76] ? __kthread_parkme (arch/x86/include/asm/current.h:49 kernel/kthread.c:293) 
[ 169.568761][ T76] ? __pfx_worker_thread (kernel/workqueue.c:3339) 
[ 169.569156][ T76] ? kthread (kernel/kthread.c:389) 
[ 169.569474][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.569848][ T76] ? ret_from_fork (arch/x86/kernel/process.c:153) 
[ 169.570212][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.570563][ T76] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:257) 
[  169.570954][   T76]  </TASK>
[  169.652036][   T76] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/1:2/76
[ 169.652785][ T76] caller is try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[  169.653204][   T76] CPU: 0 UID: 0 PID: 76 Comm: kworker/1:2 Not tainted 6.11.0-rc1-00125-g26cb612c431d #1
[  169.653945][   T76] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[  169.654710][   T76] Workqueue: rcu_gp process_srcu
[  169.655095][   T76] Call Trace:
[  169.655357][   T76]  <TASK>
[ 169.655591][ T76] dump_stack_lvl (lib/dump_stack.c:122) 
[ 169.655958][ T76] check_preemption_disabled (lib/smp_processor_id.c:52) 
[ 169.656392][ T76] ? try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[ 169.656771][ T76] ? process_one_work (kernel/workqueue.c:3206) 
[ 169.657162][ T76] ? srcu_advance_state (kernel/rcu/srcutree.c:1765) 
[ 169.657559][ T76] ? process_srcu (kernel/rcu/srcutree.c:1893) 
[ 169.657909][ T76] ? process_one_work (kernel/workqueue.c:3236) 
[ 169.658263][ T76] ? __pfx_process_one_work (kernel/workqueue.c:3133) 
[ 169.658623][ T76] ? __list_add (include/linux/list.h:83 include/linux/list.h:150) 
[ 169.658911][ T76] ? process_scheduled_works (kernel/workqueue.c:3312) 
[ 169.659254][ T76] ? worker_thread (include/linux/list.h:373 kernel/workqueue.c:948 kernel/workqueue.c:3391) 
[ 169.659554][ T76] ? __kthread_parkme (arch/x86/include/asm/current.h:49 kernel/kthread.c:293) 
[ 169.659885][ T76] ? __pfx_worker_thread (kernel/workqueue.c:3339) 
[ 169.660211][ T76] ? kthread (kernel/kthread.c:389) 
[ 169.660480][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.660773][ T76] ? ret_from_fork (arch/x86/kernel/process.c:153) 
[ 169.661069][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.661363][ T76] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:257) 
[  169.661693][   T76]  </TASK>
[  169.662140][   T76] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/1:2/76
[ 169.662810][ T76] caller is try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[  169.663222][   T76] CPU: 0 UID: 0 PID: 76 Comm: kworker/1:2 Not tainted 6.11.0-rc1-00125-g26cb612c431d #1
[  169.663934][   T76] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[  169.664696][   T76] Workqueue: rcu_gp process_srcu
[  169.665091][   T76] Call Trace:
[  169.665353][   T76]  <TASK>
[ 169.665586][ T76] dump_stack_lvl (lib/dump_stack.c:122) 
[ 169.665959][ T76] check_preemption_disabled (lib/smp_processor_id.c:52) 
[ 169.666369][ T76] ? try_check_zero (kernel/rcu/srcutree.c:485 kernel/rcu/srcutree.c:1149) 
[ 169.666727][ T76] ? preempt_count_sub (kernel/sched/core.c:5685) 
[ 169.667127][ T76] ? process_one_work (kernel/workqueue.c:3206) 
[ 169.667519][ T76] ? srcu_advance_state (kernel/rcu/srcutree.c:1784) 
[ 169.667938][ T76] ? process_srcu (kernel/rcu/srcutree.c:1893) 
[ 169.668310][ T76] ? process_one_work (kernel/workqueue.c:3236) 
[ 169.668719][ T76] ? __pfx_process_one_work (kernel/workqueue.c:3133) 
[ 169.669150][ T76] ? __list_add (include/linux/list.h:83 include/linux/list.h:150) 
[ 169.669517][ T76] ? process_scheduled_works (kernel/workqueue.c:3312) 
[ 169.669954][ T76] ? worker_thread (include/linux/list.h:373 kernel/workqueue.c:948 kernel/workqueue.c:3391) 
[ 169.670303][ T76] ? __kthread_parkme (arch/x86/include/asm/current.h:49 kernel/kthread.c:293) 
[ 169.670692][ T76] ? __pfx_worker_thread (kernel/workqueue.c:3339) 
[ 169.671077][ T76] ? kthread (kernel/kthread.c:389) 
[ 169.671412][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.671761][ T76] ? ret_from_fork (arch/x86/kernel/process.c:153) 
[ 169.672114][ T76] ? __pfx_kthread (kernel/kthread.c:342) 
[ 169.672463][ T76] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:257) 
[  169.672861][   T76]  </TASK>
[  169.690595][   T75] smpboot: CPU 1 is now offline



The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20240923/202409231124.358fed11-lkp@xxxxxxxxx



-- 
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki





[Index of Archives]     [Linux Samsung SoC]     [Linux Rockchip SoC]     [Linux Actions SoC]     [Linux for Synopsys ARC Processors]     [Linux NFS]     [Linux NILFS]     [Linux USB Devel]     [Video for Linux]     [Linux Audio Users]     [Yosemite News]     [Linux Kernel]     [Linux SCSI]


  Powered by Linux