rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: (detected by 1, t=10502 jiffies, g=251541, q=101) rcu: All QSes seen, last rcu_preempt kthread activity 10503 (4295113495-4295102992), jiffies_till_next_fqs=1, root ->qsmask 0x0 rcu: rcu_preempt kthread starved for 10504 jiffies! g251541 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:28816 pid: 14 ppid: 2 flags:0x00004000 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x934/0x2710 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_timeout+0x14a/0x2a0 kernel/time/timer.c:1892 rcu_gp_fqs_loop kernel/rcu/tree.c:2004 [inline] rcu_gp_kthread+0xd1a/0x2300 kernel/rcu/tree.c:2177 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: 24266 Comm: syz-executor.1 Not tainted 5.13.0-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__lock_release kernel/locking/lockdep.c:5293 [inline] RIP: 0010:lock_release+0x1d6/0x720 kernel/locking/lockdep.c:5645 Code: 00 00 48 b8 00 00 00 00 00 fc ff df 4c 89 f2 48 c1 ea 03 0f b6 04 02 84 c0 74 08 3c 03 0f 8e bc 04 00 00 45 8b af e8 09 00 00 <45> 85 ed 0f 84 e0 02 00 00 48 8d 4c 24 50 44 89 ea 4c 89 e6 4c 89 RSP: 0018:ffffc90000007ae0 EFLAGS: 00000046 RAX: 0000000000000000 RBX: 0000000000000007 RCX: 0000000000000001 RDX: 1ffff1100c168bd5 RSI: 0000000000010001 RDI: 0000000000000000 RBP: 1ffff92000000f5e R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000001 R11: 0000000000000000 R12: ffffffff8b99a948 R13: 0000000000000002 R14: ffff888060b45ea8 R15: ffff888060b454c0 FS: 00007f23f6620700(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000001b2ce21000 CR3: 000000005c364000 CR4: 00000000001506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600 Call Trace: seqcount_lockdep_reader_access include/linux/seqlock.h:104 [inline] timekeeping_get_delta kernel/time/timekeeping.c:252 [inline] timekeeping_get_ns kernel/time/timekeeping.c:386 [inline] ktime_get+0x158/0x470 kernel/time/timekeeping.c:829 hrtimer_forward_now include/linux/hrtimer.h:510 [inline] perf_swevent_hrtimer+0x246/0x3f0 kernel/events/core.c:10545 __run_hrtimer kernel/time/hrtimer.c:1537 [inline] __hrtimer_run_queues+0x1c0/0xe40 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:ffffc900028576d0 EFLAGS: 00000206 RAX: 0000000000000003 RBX: 0000000000000000 RCX: 1ffffffff1752e4c RDX: 0000000000000001 RSI: ffffffff817b97b1 RDI: ffffffff81331571 RBP: ffffffff8ba97260 R08: 0000000000000001 R09: 0000000000000001 R10: ffffffff817b9779 R11: 0000000000000000 R12: 0000000000000185 R13: fffffbfff1752e4c R14: 0000000000000001 R15: ffff8880b9c52840 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:1450 [inline] alloc_vmap_area+0xbc6/0x1e30 mm/vmalloc.c:1491 __get_vm_area_node.constprop.0+0x128/0x380 mm/vmalloc.c:2371 __vmalloc_node_range+0x12e/0x960 mm/vmalloc.c:2937 __vmalloc_node mm/vmalloc.c:2996 [inline] __vmalloc+0x69/0x80 mm/vmalloc.c:3010 bpf_prog_alloc_no_stats+0x38/0x360 kernel/bpf/core.c:85 bpf_prog_alloc+0x28/0x1a0 kernel/bpf/core.c:119 bpf_prog_load+0x651/0x21f0 kernel/bpf/syscall.c:2221 __sys_bpf+0x65a/0x5390 kernel/bpf/syscall.c:4469 __do_sys_bpf kernel/bpf/syscall.c:4573 [inline] __se_sys_bpf kernel/bpf/syscall.c:4571 [inline] __x64_sys_bpf+0x75/0xb0 kernel/bpf/syscall.c:4571 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:0x4665d9 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:00007f23f6620188 EFLAGS: 00000246 ORIG_RAX: 0000000000000141 RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000048 RSI: 00000000200054c0 RDI: 0000000000000005 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007ffcb29e4e9f R14: 00007f23f6620300 R15: 0000000000022000 ================================ WARNING: inconsistent lock state 5.13.0-syzkaller #0 Not tainted -------------------------------- inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage. syz-executor.4/24260 [HC0[0]:SC1[1]:HE0:SE0] takes: ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: print_other_cpu_stall kernel/rcu/tree_stall.h:542 [inline] ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: check_cpu_stall kernel/rcu/tree_stall.h:708 [inline] ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_pending kernel/rcu/tree.c:3911 [inline] ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0xc9a/0x20c0 kernel/rcu/tree.c:2649 {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 __alloc_pages_bulk+0xe44/0x1870 mm/page_alloc.c:5323 alloc_pages_bulk_array_node include/linux/gfp.h:557 [inline] vm_area_alloc_pages mm/vmalloc.c:2775 [inline] __vmalloc_area_node mm/vmalloc.c:2845 [inline] __vmalloc_node_range+0x39d/0x960 mm/vmalloc.c:2947 alloc_thread_stack_node kernel/fork.c:245 [inline] dup_task_struct kernel/fork.c:875 [inline] copy_process+0x8db/0x74c0 kernel/fork.c:1952 kernel_clone+0xe7/0xab0 kernel/fork.c:2509 kernel_thread+0xb5/0xf0 kernel/fork.c:2561 call_usermodehelper_exec_work kernel/umh.c:174 [inline] call_usermodehelper_exec_work+0xcc/0x180 kernel/umh.c:160 process_one_work+0x98d/0x1630 kernel/workqueue.c:2276 worker_thread+0x658/0x11f0 kernel/workqueue.c:2422 kthread+0x3e5/0x4d0 kernel/kthread.c:319 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 irq event stamp: 9975801 hardirqs last enabled at (9975800): [] asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638 hardirqs last disabled at (9975801): [] sysvec_apic_timer_interrupt+0xb/0xc0 arch/x86/kernel/apic/apic.c:1100 softirqs last enabled at (4108592): [] invoke_softirq kernel/softirq.c:432 [inline] softirqs last enabled at (4108592): [] __irq_exit_rcu+0x16e/0x1c0 kernel/softirq.c:636 softirqs last disabled at (4108595): [] invoke_softirq kernel/softirq.c:432 [inline] softirqs last disabled at (4108595): [] __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 *** 5 locks held by syz-executor.4/24260: #0: ffffffff8ba97028 (vmap_purge_lock){+.+.}-{3:3}, at: _vm_unmap_aliases.part.0+0x36f/0x4f0 mm/vmalloc.c:2053 #1: ffffffff8ba97278 (free_vmap_area_lock){+.+.}-{2:2}, at: spin_lock include/linux/spinlock.h:354 [inline] #1: ffffffff8ba97278 (free_vmap_area_lock){+.+.}-{2:2}, at: __cond_resched_lock+0xa0/0xf0 kernel/sched/core.c:7821 #2: ffffffff8b97bac0 (rcu_read_lock){....}-{1:2}, at: ieee80211_iterate_active_interfaces_atomic+0x0/0x170 net/mac80211/util.c:1237 #3: ffffffff8c772f58 (hwsim_radio_lock){+.-.}-{2:2}, at: spin_lock include/linux/spinlock.h:354 [inline] #3: ffffffff8c772f58 (hwsim_radio_lock){+.-.}-{2:2}, at: mac80211_hwsim_tx_frame_no_nl.isra.0+0x68f/0x1330 drivers/net/wireless/mac80211_hwsim.c:1516 #4: ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: print_other_cpu_stall kernel/rcu/tree_stall.h:542 [inline] #4: ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: check_cpu_stall kernel/rcu/tree_stall.h:708 [inline] #4: ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_pending kernel/rcu/tree.c:3911 [inline] #4: ffffffff8b9846d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0xc9a/0x20c0 kernel/rcu/tree.c:2649 stack backtrace: CPU: 1 PID: 24260 Comm: syz-executor.4 Not tainted 5.13.0-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:79 [inline] dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:96 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:__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:ffffc90000dc0b90 EFLAGS: 00000246 RAX: 0000000000000000 RBX: ffff8880213bb260 RCX: 0000000000000100 RDX: 0000000000000004 RSI: 0000000000000001 RDI: 0000000000000000 RBP: dffffc0000000000 R08: 0000000000000004 R09: ffffffff852d4665 R10: ffffffff852d4723 R11: 0000000000000000 R12: ffff88805b06c780 R13: ffff88802c563490 R14: ffff88802c563260 R15: 0000000000000001 mac80211_hwsim_tx_frame_no_nl.isra.0+0x799/0x1330 drivers/net/wireless/mac80211_hwsim.c:1527 mac80211_hwsim_tx_frame+0x1ee/0x2a0 drivers/net/wireless/mac80211_hwsim.c:1784 mac80211_hwsim_beacon_tx+0x4b7/0x920 drivers/net/wireless/mac80211_hwsim.c:1838 __iterate_interfaces+0x1e5/0x520 net/mac80211/util.c:793 ieee80211_iterate_active_interfaces_atomic+0x8d/0x170 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/0xe40 kernel/time/hrtimer.c:1601 hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1618 __do_softirq+0x29b/0x9bd 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:arch_stack_walk+0x96/0xe0 arch/x86/kernel/stacktrace.c:26 Code: d3 84 c0 74 2a 48 8d bd 78 ff ff ff e8 23 8d 07 00 8b 85 78 ff ff ff 85 c0 74 14 48 8d bd 78 ff ff ff e8 0d 8a 07 00 48 85 c0 <48> 89 c6 75 cd 48 8b 45 d8 65 48 2b 04 25 28 00 00 00 75 2f 48 83 RSP: 0018:ffffc90002817200 EFLAGS: 00000246 RAX: 0000000000000000 RBX: ffffffff8163fc50 RCX: ffffc90002817128 RDX: 1ffff11004de7bd4 RSI: 0000000000000001 RDI: 0000000000000000 RBP: ffffc90002817288 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000001 R11: 0000000000000000 R12: ffffc900028172b8 R13: 0000000000000000 R14: ffff888026f3d4c0 R15: 0000000000000000 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:229 [inline] slab_free_hook mm/slub.c:1639 [inline] slab_free_freelist_hook+0xdf/0x240 mm/slub.c:1664 slab_free mm/slub.c:3224 [inline] kmem_cache_free+0x8e/0x5a0 mm/slub.c:3240 merge_or_add_vmap_area mm/vmalloc.c:1061 [inline] merge_or_add_vmap_area_augment mm/vmalloc.c:1111 [inline] __purge_vmap_area_lazy+0xaa7/0x1c50 mm/vmalloc.c:1645 _vm_unmap_aliases.part.0+0x3dd/0x4f0 mm/vmalloc.c:2055 _vm_unmap_aliases mm/vmalloc.c:2029 [inline] vm_unmap_aliases+0x47/0x50 mm/vmalloc.c:2078 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:851 [inline] bpf_int_jit_compile+0xe36/0x11e0 arch/x86/net/bpf_jit_comp.c:2313 bpf_prog_select_runtime+0x464/0x6a0 kernel/bpf/core.c:1892 bpf_prog_load+0xe90/0x21f0 kernel/bpf/syscall.c:2278 __sys_bpf+0x65a/0x5390 kernel/bpf/syscall.c:4469 __do_sys_bpf kernel/bpf/syscall.c:4573 [inline] __se_sys_bpf kernel/bpf/syscall.c:4571 [inline] __x64_sys_bpf+0x75/0xb0 kernel/bpf/syscall.c:4571 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:0x4665d9 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:00007f546208e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000141 RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000078 RSI: 0000000020000200 RDI: 0000000000000005 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007ffc4957274f R14: 00007f546208e300 R15: 0000000000022000 softirq: huh, entered softirq 8 HRTIMER ffffffff81655b00 with preempt_count 00000101, exited with 00000102?