rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
(detected by 1, t=10502 jiffies, g=437777, q=28)
rcu: All QSes seen, last rcu_preempt kthread activity 10501 (4295201362-4295190861), jiffies_till_next_fqs=1, root ->qsmask 0x0
rcu: rcu_preempt kthread starved for 10502 jiffies! g437777 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0
rcu: Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
rcu: RCU grace-period kthread stack dump:
task:rcu_preempt state:R running task stack:28880 pid: 14 ppid: 2 flags:0x00004000
Call Trace:
context_switch kernel/sched/core.c:4681 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5938
schedule+0xd3/0x270 kernel/sched/core.c:6017
schedule_timeout+0x14a/0x2a0 kernel/time/timer.c:1881
rcu_gp_fqs_loop kernel/rcu/tree.c:1996 [inline]
rcu_gp_kthread+0xd34/0x1980 kernel/rcu/tree.c:2169
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
rcu: Stack dump where RCU GP kthread last ran:
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 3319 Comm: syz-executor.4 Not tainted 5.14.0-rc5-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__lock_acquire+0x1ec/0x54a0 kernel/locking/lockdep.c:4925
Code: f6 4c 8d 24 c5 00 00 00 00 74 4a 4a 8d 4c 21 d8 48 be 00 00 00 00 00 fc ff df 48 8d 79 20 49 89 f8 49 c1 e8 03 41 0f b6 34 30 <40> 84 f6 74 0a 40 80 fe 03 0f 8e 94 3b 00 00 0f b7 71 20 81 e6 ff
RSP: 0018:ffffc90000007890 EFLAGS: 00000802
RAX: 0000000000000005 RBX: ffffffff8b97c280 RCX: ffff888016764270
RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff888016764290
RBP: 0000000000000000 R08: 1ffff11002cec852 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000028
R13: ffff888016763880 R14: 0000000000000002 R15: 0000000000000001
FS: 00007f3f7b411700(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000000000 CR3: 0000000092785000 CR4: 00000000001506f0
DR0: fffffffffffffffe DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
Call Trace:
lock_acquire kernel/locking/lockdep.c:5625 [inline]
lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5590
rcu_lock_acquire include/linux/rcupdate.h:267 [inline]
rcu_read_lock include/linux/rcupdate.h:687 [inline]
__perf_event_output kernel/events/core.c:7459 [inline]
perf_event_output_forward+0xa5/0x280 kernel/events/core.c:7481
__perf_event_overflow+0x13c/0x3d0 kernel/events/core.c:9153
perf_swevent_hrtimer+0x37c/0x3f0 kernel/events/core.c:10540
__run_hrtimer kernel/time/hrtimer.c:1537 [inline]
__hrtimer_run_queues+0x1c0/0xe50 kernel/time/hrtimer.c:1601
hrtimer_interrupt+0x330/0xa00 kernel/time/hrtimer.c:1663
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1089 [inline]
__sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1106
sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1100
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:pv_wait_head_or_lock kernel/locking/qspinlock_paravirt.h:434 [inline]
RIP: 0010:__pv_queued_spin_lock_slowpath+0x3ba/0xb40 kernel/locking/qspinlock.c:508
Code: eb c6 45 01 01 41 bc 00 80 00 00 48 c1 e9 03 83 e3 07 41 be 01 00 00 00 48 b8 00 00 00 00 00 fc ff df 4c 8d 2c 01 eb 0c f3 90 <41> 83 ec 01 0f 84 72 04 00 00 41 0f b6 45 00 38 d8 7f 08 84 c0 0f
RSP: 0018:ffffc9000212f538 EFLAGS: 00000206
RAX: 0000000000000003 RBX: 0000000000000000 RCX: 1ffffffff1752e98
RDX: 0000000000000001 RSI: ffffffff817bd271 RDI: ffffffff81332591
RBP: ffffffff8ba974c0 R08: 0000000000000001 R09: 0000000000000001
R10: ffffffff817bd239 R11: 0000000000000000 R12: 000000000000320f
R13: fffffbfff1752e98 R14: 0000000000000001 R15: ffff8880b9c527c0
pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:585 [inline]
queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline]
queued_spin_lock include/asm-generic/qspinlock.h:85 [inline]
do_raw_spin_lock+0x200/0x2b0 kernel/locking/spinlock_debug.c:113
spin_lock include/linux/spinlock.h:354 [inline]
preload_this_cpu_lock mm/vmalloc.c:1466 [inline]
alloc_vmap_area+0x1dd/0x1e30 mm/vmalloc.c:1507
__get_vm_area_node.constprop.0+0x128/0x380 mm/vmalloc.c:2389
__vmalloc_node_range+0x12e/0x960 mm/vmalloc.c:2956
module_alloc+0x73/0x90 arch/x86/kernel/module.c:75
bpf_jit_binary_alloc+0xa5/0x180 kernel/bpf/core.c:874
bpf_int_jit_compile+0x450/0x11e0 arch/x86/net/bpf_jit_comp.c:2320
bpf_prog_select_runtime+0x464/0x6a0 kernel/bpf/core.c:1914
bpf_prog_load+0xe8b/0x21f0 kernel/bpf/syscall.c:2311
__sys_bpf+0x665/0x4c10 kernel/bpf/syscall.c:4593
__do_sys_bpf kernel/bpf/syscall.c:4697 [inline]
__se_sys_bpf kernel/bpf/syscall.c:4695 [inline]
__x64_sys_bpf+0x75/0xb0 kernel/bpf/syscall.c:4695
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f3f7b411188 EFLAGS: 00000246 ORIG_RAX: 0000000000000141
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665e9
RDX: 000000000000003f RSI: 0000000020000100 RDI: 0000000000000005
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80
R13: 00007ffea85987bf R14: 00007f3f7b411300 R15: 0000000000022000
================================
WARNING: inconsistent lock state
5.14.0-rc5-syzkaller #0 Not tainted
--------------------------------
inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage.
syz-executor.1/3316 [HC0[0]:SC1[1]:HE0:SE0] takes:
ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: print_other_cpu_stall kernel/rcu/tree_stall.h:543 [inline]
ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: check_cpu_stall kernel/rcu/tree_stall.h:709 [inline]
ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_pending kernel/rcu/tree.c:3922 [inline]
ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0xc9a/0x20c0 kernel/rcu/tree.c:2641
{IN-HARDIRQ-W} state was registered at:
lock_acquire kernel/locking/lockdep.c:5625 [inline]
lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5590
__raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
_raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:159
rcu_report_exp_cpu_mult+0x1c/0x280 kernel/rcu/tree_exp.h:237
flush_smp_call_function_queue+0x34b/0x640 kernel/smp.c:663
__sysvec_call_function_single+0x95/0x3d0 arch/x86/kernel/smp.c:248
sysvec_call_function_single+0x8e/0xc0 arch/x86/kernel/smp.c:243
asm_sysvec_call_function_single+0x12/0x20 arch/x86/include/asm/idtentry.h:646
lock_acquire+0x1ef/0x510 kernel/locking/lockdep.c:5593
down_write_killable+0x95/0x170 kernel/locking/rwsem.c:1417
mmap_write_lock_killable include/linux/mmap_lock.h:87 [inline]
__bprm_mm_init fs/exec.c:257 [inline]
bprm_mm_init fs/exec.c:376 [inline]
alloc_bprm+0x3be/0x8f0 fs/exec.c:1521
kernel_execve+0x55/0x460 fs/exec.c:1941
call_usermodehelper_exec_async+0x2e3/0x580 kernel/umh.c:112
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
irq event stamp: 10201085
hardirqs last enabled at (10201084): [] asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
hardirqs last disabled at (10201085): [] sysvec_apic_timer_interrupt+0xb/0xc0 arch/x86/kernel/apic/apic.c:1100
softirqs last enabled at (7787730): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last enabled at (7787730): [] __irq_exit_rcu+0x16e/0x1c0 kernel/softirq.c:636
softirqs last disabled at (7787733): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last disabled at (7787733): [] __irq_exit_rcu+0x16e/0x1c0 kernel/softirq.c:636
other info that might help us debug this:
Possible unsafe locking scenario:
CPU0
----
lock(rcu_node_0);
lock(rcu_node_0);
*** DEADLOCK ***
6 locks held by syz-executor.1/3316:
#0: ffffffff8ba97288 (vmap_purge_lock){+.+.}-{3:3}, at: _vm_unmap_aliases.part.0+0x382/0x500 mm/vmalloc.c:2071
#1: ffffffff8ba974d8 (free_vmap_area_lock){+.+.}-{2:2}, at: spin_lock include/linux/spinlock.h:354 [inline]
#1: ffffffff8ba974d8 (free_vmap_area_lock){+.+.}-{2:2}, at: __cond_resched_lock+0xa0/0xf0 kernel/sched/core.c:7802
#2: ffffffff8b97c280 (rcu_read_lock){....}-{1:2}, at: is_bpf_text_address+0x0/0x170 kernel/bpf/core.c:693
#3: ffffffff8b97c280 (rcu_read_lock){....}-{1:2}, at: ieee80211_iterate_active_interfaces_atomic+0x0/0x180 net/mac80211/util.c:1237
#4: ffffffff8c77d8b8 (hwsim_radio_lock){+.-.}-{2:2}, at: spin_lock include/linux/spinlock.h:354 [inline]
#4: ffffffff8c77d8b8 (hwsim_radio_lock){+.-.}-{2:2}, at: mac80211_hwsim_tx_frame_no_nl.isra.0+0x68f/0x1330 drivers/net/wireless/mac80211_hwsim.c:1516
#5: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: print_other_cpu_stall kernel/rcu/tree_stall.h:543 [inline]
#5: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: check_cpu_stall kernel/rcu/tree_stall.h:709 [inline]
#5: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_pending kernel/rcu/tree.c:3922 [inline]
#5: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0xc9a/0x20c0 kernel/rcu/tree.c:2641
stack backtrace:
CPU: 1 PID: 3316 Comm: syz-executor.1 Not tainted 5.14.0-rc5-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:105
print_usage_bug kernel/locking/lockdep.c:203 [inline]
valid_state kernel/locking/lockdep.c:3933 [inline]
mark_lock_irq kernel/locking/lockdep.c:4136 [inline]
mark_lock.cold+0x61/0x8e kernel/locking/lockdep.c:4593
mark_held_locks+0x9f/0xe0 kernel/locking/lockdep.c:4194
__trace_hardirqs_on_caller kernel/locking/lockdep.c:4212 [inline]
lockdep_hardirqs_on_prepare kernel/locking/lockdep.c:4280 [inline]
lockdep_hardirqs_on_prepare+0x135/0x400 kernel/locking/lockdep.c:4232
trace_hardirqs_on+0x5b/0x1c0 kernel/trace/trace_preemptirq.c:49
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:mac80211_hwsim_tx_frame_no_nl.isra.0+0x77b/0x1330 drivers/net/wireless/mac80211_hwsim.c:1527
Code: 00 00 00 c6 84 24 98 00 00 00 00 74 bb e8 0d 6b 42 fc 48 8d bb ac 3c 00 00 48 89 f8 48 89 fa 48 c1 e8 03 83 e2 07 0f b6 04 28 <38> d0 7f 08 84 c0 0f 85 36 09 00 00 44 0f b6 bb ac 3c 00 00 31 ff
RSP: 0018:ffffc90000dc0ba0 EFLAGS: 00000202
RAX: 0000000000000000 RBX: ffff8880196db260 RCX: 0000000000000100
RDX: 0000000000000004 RSI: ffffffff85333ea3 RDI: ffff8880196def0c
RBP: dffffc0000000000 R08: 0000000000000002 R09: 0000000000000000
R10: ffffffff85333ed9 R11: 0000000000000000 R12: ffff88809596a780
R13: ffff888062dd3490 R14: ffff888062dd3260 R15: 0000000000000000
mac80211_hwsim_tx_frame+0x1ee/0x2a0 drivers/net/wireless/mac80211_hwsim.c:1784
mac80211_hwsim_beacon_tx+0x49b/0x930 drivers/net/wireless/mac80211_hwsim.c:1838
__iterate_interfaces+0x1e5/0x520 net/mac80211/util.c:793
ieee80211_iterate_active_interfaces_atomic+0x70/0x180 net/mac80211/util.c:829
mac80211_hwsim_beacon+0xd5/0x1a0 drivers/net/wireless/mac80211_hwsim.c:1861
__run_hrtimer kernel/time/hrtimer.c:1537 [inline]
__hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1601
hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1618
__do_softirq+0x29b/0x9c2 kernel/softirq.c:558
invoke_softirq kernel/softirq.c:432 [inline]
__irq_exit_rcu+0x16e/0x1c0 kernel/softirq.c:636
irq_exit_rcu+0x5/0x20 kernel/softirq.c:648
sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1100
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:__sanitizer_cov_trace_const_cmp1+0x1/0x80 kernel/kcov.c:269
Code: fe 72 1f 48 83 c2 01 4c 89 44 38 e8 48 c7 44 38 e0 06 00 00 00 48 89 4c 38 f0 4e 89 54 c8 20 48 89 10 c3 66 0f 1f 44 00 00 53 <41> 89 fb 41 89 f1 bf 03 00 00 00 65 48 8b 0c 25 00 f0 01 00 48 89
RSP: 0018:ffffc9000238f150 EFLAGS: 00000246
RAX: 0000000000000001 RBX: 0000000000000001 RCX: 1804ae9b40081cab
RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000000
RBP: 00000000004665e9 R08: 0000000000000000 R09: ffffffff8fcf28e7
R10: fffffbfff1f9e51c R11: 0000000000086088 R12: ffffc9000238f280
R13: 0000000000000000 R14: ffff888082b0d4c0 R15: 0000000000000000
rcu_read_lock include/linux/rcupdate.h:688 [inline]
is_bpf_text_address+0x46/0x170 kernel/bpf/core.c:706
kernel_text_address kernel/extable.c:151 [inline]
kernel_text_address+0xbd/0xf0 kernel/extable.c:120
__kernel_text_address+0x9/0x30 kernel/extable.c:105
unwind_get_return_address arch/x86/kernel/unwind_orc.c:318 [inline]
unwind_get_return_address+0x51/0x90 arch/x86/kernel/unwind_orc.c:313
arch_stack_walk+0x93/0xe0 arch/x86/kernel/stacktrace.c:26
stack_trace_save+0x8c/0xc0 kernel/stacktrace.c:121
kasan_save_stack+0x1b/0x40 mm/kasan/common.c:38
kasan_set_track+0x1c/0x30 mm/kasan/common.c:46
kasan_set_free_info+0x20/0x30 mm/kasan/generic.c:360
____kasan_slab_free mm/kasan/common.c:366 [inline]
____kasan_slab_free mm/kasan/common.c:328 [inline]
__kasan_slab_free+0xfb/0x130 mm/kasan/common.c:374
kasan_slab_free include/linux/kasan.h:230 [inline]
slab_free_hook mm/slub.c:1625 [inline]
slab_free_freelist_hook+0xdf/0x240 mm/slub.c:1650
slab_free mm/slub.c:3210 [inline]
kmem_cache_free+0x8a/0x5b0 mm/slub.c:3226
merge_or_add_vmap_area mm/vmalloc.c:1077 [inline]
merge_or_add_vmap_area_augment mm/vmalloc.c:1127 [inline]
__purge_vmap_area_lazy+0xaa7/0x1c50 mm/vmalloc.c:1663
_vm_unmap_aliases.part.0+0x3f0/0x500 mm/vmalloc.c:2073
_vm_unmap_aliases mm/vmalloc.c:2047 [inline]
vm_unmap_aliases+0x47/0x50 mm/vmalloc.c:2096
change_page_attr_set_clr+0x241/0x500 arch/x86/mm/pat/set_memory.c:1740
change_page_attr_clear arch/x86/mm/pat/set_memory.c:1797 [inline]
set_memory_ro+0x78/0xa0 arch/x86/mm/pat/set_memory.c:1943
bpf_jit_binary_lock_ro include/linux/filter.h:892 [inline]
bpf_int_jit_compile+0xe36/0x11e0 arch/x86/net/bpf_jit_comp.c:2338
bpf_prog_select_runtime+0x464/0x6a0 kernel/bpf/core.c:1914
bpf_prog_load+0xe8b/0x21f0 kernel/bpf/syscall.c:2311
__sys_bpf+0x665/0x4c10 kernel/bpf/syscall.c:4593
__do_sys_bpf kernel/bpf/syscall.c:4697 [inline]
__se_sys_bpf kernel/bpf/syscall.c:4695 [inline]
__x64_sys_bpf+0x75/0xb0 kernel/bpf/syscall.c:4695
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x4665e9
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f4a8b760188 EFLAGS: 00000246 ORIG_RAX: 0000000000000141
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004665e9
RDX: 0000000000000048 RSI: 0000000020000200 RDI: 0000000000000005
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c038
R13: 00007ffe08cfe01f R14: 00007f4a8b760300 R15: 0000000000022000
softirq: huh, entered softirq 8 HRTIMER ffffffff816576d0 with preempt_count 00000101, exited with 00000102?
----------------
Code disassembly (best guess):
0: f6 4c 8d 24 c5 testb $0xc5,0x24(%rbp,%rcx,4)
5: 00 00 add %al,(%rax)
7: 00 00 add %al,(%rax)
9: 74 4a je 0x55
b: 4a 8d 4c 21 d8 lea -0x28(%rcx,%r12,1),%rcx
10: 48 be 00 00 00 00 00 movabs $0xdffffc0000000000,%rsi
17: fc ff df
1a: 48 8d 79 20 lea 0x20(%rcx),%rdi
1e: 49 89 f8 mov %rdi,%r8
21: 49 c1 e8 03 shr $0x3,%r8
25: 41 0f b6 34 30 movzbl (%r8,%rsi,1),%esi
2a: 40 84 f6 test %sil,%sil <-- trapping instruction
2d: 74 0a je 0x39
2f: 40 80 fe 03 cmp $0x3,%sil
33: 0f 8e 94 3b 00 00 jle 0x3bcd
39: 0f b7 71 20 movzwl 0x20(%rcx),%esi
3d: 81 .byte 0x81
3e: e6 ff out %al,$0xff