rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
(detected by 0, t=10502 jiffies, g=212905, q=68)
rcu: All QSes seen, last rcu_preempt kthread activity 10502 (4295071268-4295060766), jiffies_till_next_fqs=1, root ->qsmask 0x0
rcu: rcu_preempt kthread starved for 10502 jiffies! g212905 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1
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 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 15615 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
RIP: 0010:__lock_is_held kernel/locking/lockdep.c:5368 [inline]
RIP: 0010:lock_is_held_type+0x9f/0x140 kernel/locking/lockdep.c:5668
Code: 05 56 25 d4 76 85 c0 7f 12 e9 88 00 00 00 83 c3 01 41 3b 9c 24 e8 09 00 00 7d 7b 48 63 c3 48 89 ee 48 8d 04 80 4d 8d 7c c5 00 <4c> 89 ff e8 99 fe ff ff 85 c0 74 d8 41 83 fe ff 41 bd 01 00 00 00
RSP: 0018:ffffc90000dc0d58 EFLAGS: 00000097
RAX: 0000000000000005 RBX: 0000000000000001 RCX: 0000000000000001
RDX: 0000000000000000 RSI: ffffffff8b97c1c0 RDI: ffff888012995eb0
RBP: ffffffff8b97c1c0 R08: 0000000000000000 R09: ffffffff8d6c9157
R10: fffffbfff1ad922a R11: 0000000000000000 R12: ffff8880129954c0
R13: ffff888012995eb0 R14: 00000000ffffffff R15: ffff888012995ed8
FS: 00007efd7db41700(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000000004 CR3: 000000008685d000 CR4: 00000000001506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_is_held include/linux/lockdep.h:283 [inline]
rcu_read_lock_sched_held+0x3a/0x70 kernel/rcu/update.c:125
trace_lock_release include/trace/events/lock.h:58 [inline]
lock_release+0x522/0x720 kernel/locking/lockdep.c:5636
seqcount_lockdep_reader_access include/linux/seqlock.h:104 [inline]
ktime_get+0x8d/0x470 kernel/time/timekeeping.c:827
clockevents_program_event+0x141/0x370 kernel/time/clockevents.c:326
tick_program_event+0xac/0x140 kernel/time/tick-oneshot.c:44
hrtimer_interrupt+0x414/0xa00 kernel/time/hrtimer.c:1676
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:trylock_clear_pending kernel/locking/qspinlock_paravirt.h:121 [inline]
RIP: 0010:pv_wait_head_or_lock kernel/locking/qspinlock_paravirt.h:435 [inline]
RIP: 0010:__pv_queued_spin_lock_slowpath+0x3c4/0xb40 kernel/locking/qspinlock.c:508
Code: 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 85 91 05 00 00 0f b6 45 00 84
RSP: 0018:ffffc900172befe8 EFLAGS: 00000202
RAX: 0000000000000003 RBX: 0000000000000000 RCX: 1ffff110050a6c70
RDX: 0000000000000001 RSI: ffffffff817bd271 RDI: ffffffff81332591
RBP: ffff888028536380 R08: 0000000000000001 R09: 0000000000000001
R10: ffffffff817bd239 R11: 0000000000000000 R12: 0000000000006520
R13: ffffed10050a6c70 R14: 0000000000000001 R15: ffff8880b9d527c0
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]
ext4_lock_group+0x1e5/0x240 fs/ext4/ext4.h:3456
ext4_mb_find_by_goal+0x2ca/0xd60 fs/ext4/mballoc.c:2215
ext4_mb_regular_allocator+0x237/0x3870 fs/ext4/mballoc.c:2636
ext4_mb_new_blocks+0x24d4/0x5230 fs/ext4/mballoc.c:5515
ext4_ext_map_blocks+0x1fa3/0x6070 fs/ext4/extents.c:4245
ext4_map_blocks+0x653/0x17d0 fs/ext4/inode.c:638
ext4_alloc_file_blocks.isra.0+0x2c1/0xae0 fs/ext4/extents.c:4432
ext4_fallocate+0x45e/0x3ff0 fs/ext4/extents.c:4712
vfs_fallocate+0x48d/0xd80 fs/open.c:311
ioctl_preallocate+0x18e/0x200 fs/ioctl.c:497
file_ioctl fs/ioctl.c:537 [inline]
do_vfs_ioctl+0x1144/0x15d0 fs/ioctl.c:1048
__do_sys_ioctl fs/ioctl.c:1067 [inline]
__se_sys_ioctl fs/ioctl.c:1055 [inline]
__x64_sys_ioctl+0x108/0x200 fs/ioctl.c:1055
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:0x4665f9
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:00007efd7db41188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665f9
RDX: 0000000020000040 RSI: 000000004030582a RDI: 0000000000000005
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80
R13: 00007ffcc21007af R14: 00007efd7db41300 R15: 0000000000022000
================================
WARNING: inconsistent lock state
5.14.0-rc5-syzkaller #0 Not tainted
--------------------------------
inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage.
syz-executor.5/15611 [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
allocate_slab+0x1b0/0x4b0 mm/slub.c:1863
new_slab mm/slub.c:1891 [inline]
new_slab_objects mm/slub.c:2637 [inline]
___slab_alloc+0x473/0x7b0 mm/slub.c:2800
__slab_alloc.constprop.0+0xa7/0xf0 mm/slub.c:2840
slab_alloc_node mm/slub.c:2922 [inline]
slab_alloc mm/slub.c:2964 [inline]
kmem_cache_alloc+0x3e1/0x4a0 mm/slub.c:2969
vm_area_alloc+0x1c/0x110 kernel/fork.c:349
__bprm_mm_init fs/exec.c:252 [inline]
bprm_mm_init fs/exec.c:376 [inline]
alloc_bprm+0x33e/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: 9388259
hardirqs last enabled at (9388258): [] asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
hardirqs last disabled at (9388259): [] sysvec_apic_timer_interrupt+0xb/0xc0 arch/x86/kernel/apic/apic.c:1100
softirqs last enabled at (8246796): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last enabled at (8246796): [] __irq_exit_rcu+0x16e/0x1c0 kernel/softirq.c:636
softirqs last disabled at (8246799): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last disabled at (8246799): [] __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 ***
7 locks held by syz-executor.5/15611:
#0: ffff888028d6c460 (sb_writers#5){.+.+}-{0:0}, at: ioctl_preallocate+0x18e/0x200 fs/ioctl.c:497
#1: ffff88806a7dc058 (&sb->s_type->i_mutex_key#10){++++}-{3:3}, at: inode_lock include/linux/fs.h:774 [inline]
#1: ffff88806a7dc058 (&sb->s_type->i_mutex_key#10){++++}-{3:3}, at: ext4_fallocate+0x332/0x3ff0 fs/ext4/extents.c:4690
#2: ffff88806a7dbe48 (&ei->i_data_sem){++++}-{3:3}, at: ext4_map_blocks+0x5e1/0x17d0 fs/ext4/inode.c:631
#3: ffff888028536398 (&bgl->locks[i].lock){+.+.}-{2:2}, at: spin_trylock include/linux/spinlock.h:364 [inline]
#3: ffff888028536398 (&bgl->locks[i].lock){+.+.}-{2:2}, at: ext4_lock_group+0x71/0x240 fs/ext4/ext4.h:3443
#4: ffffffff8b97c280 (rcu_read_lock){....}-{1:2}, at: ieee80211_iterate_active_interfaces_atomic+0x0/0x180 net/mac80211/util.c:1237
#5: ffffffff8c77d7f8 (hwsim_radio_lock){+.-.}-{2:2}, at: spin_lock include/linux/spinlock.h:354 [inline]
#5: ffffffff8c77d7f8 (hwsim_radio_lock){+.-.}-{2:2}, at: mac80211_hwsim_tx_frame_no_nl.isra.0+0x68f/0x1330 drivers/net/wireless/mac80211_hwsim.c:1516
#6: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: print_other_cpu_stall kernel/rcu/tree_stall.h:543 [inline]
#6: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: check_cpu_stall kernel/rcu/tree_stall.h:709 [inline]
#6: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_pending kernel/rcu/tree.c:3922 [inline]
#6: ffffffff8b9850d8 (rcu_node_0){?.-.}-{2:2}, at: rcu_sched_clock_irq+0xc9a/0x20c0 kernel/rcu/tree.c:2641
stack backtrace:
CPU: 0 PID: 15611 Comm: syz-executor.5 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 8d 6c 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:ffffc90000007ba0 EFLAGS: 00000202
RAX: 0000000000000000 RBX: ffff888085e93260 RCX: 0000000000000100
RDX: 0000000000000004 RSI: ffffffff85333d23 RDI: ffff888085e96f0c
RBP: dffffc0000000000 R08: 0000000000000006 R09: 0000000000000000
R10: ffffffff85333d59 R11: 0000000000000000 R12: ffff888083db0c80
R13: ffff88806bfdb490 R14: ffff88806bfdb260 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_pc+0x50/0x60 kernel/kcov.c:203
Code: 35 8b 82 34 15 00 00 85 c0 74 2b 8b 82 10 15 00 00 83 f8 02 75 20 48 8b 8a 18 15 00 00 8b 92 14 15 00 00 48 8b 01 48 83 c0 01 <48> 39 c2 76 07 48 89 34 c1 48 89 01 c3 0f 1f 00 41 55 41 54 49 89
RSP: 0018:ffffc9001726f318 EFLAGS: 00000206
RAX: 00000000000366e1 RBX: 0000000000001860 RCX: ffffc900145d0000
RDX: 0000000000040000 RSI: ffffffff8213ca76 RDI: 0000000000000003
RBP: 0000000000000000 R08: 0000000000000000 R09: ffff888028d6e627
R10: ffffffff8213ca6d R11: 0000000000000000 R12: 0000000000002000
R13: ffff88802e16b000 R14: 0000000000000000 R15: ffff88801137bc6c
ext4_set_bits+0xa6/0x120 fs/ext4/mballoc.c:1694
ext4_mb_mark_diskspace_used+0x5d4/0x1230 fs/ext4/mballoc.c:3776
ext4_mb_new_blocks+0xd30/0x5230 fs/ext4/mballoc.c:5533
ext4_ext_map_blocks+0x1fa3/0x6070 fs/ext4/extents.c:4245
ext4_map_blocks+0x653/0x17d0 fs/ext4/inode.c:638
ext4_alloc_file_blocks.isra.0+0x2c1/0xae0 fs/ext4/extents.c:4432
ext4_fallocate+0x45e/0x3ff0 fs/ext4/extents.c:4712
vfs_fallocate+0x48d/0xd80 fs/open.c:311
ioctl_preallocate+0x18e/0x200 fs/ioctl.c:497
file_ioctl fs/ioctl.c:537 [inline]
do_vfs_ioctl+0x1144/0x15d0 fs/ioctl.c:1048
__do_sys_ioctl fs/ioctl.c:1067 [inline]
__se_sys_ioctl fs/ioctl.c:1055 [inline]
__x64_sys_ioctl+0x108/0x200 fs/ioctl.c:1055
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:0x4665f9
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:00007f5da2080188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665f9
RDX: 0000000020000040 RSI: 000000004030582a RDI: 0000000000000005
RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80
R13: 00007ffe75701e8f R14: 00007f5da2080300 R15: 0000000000022000
----------------
Code disassembly (best guess):
0: 05 56 25 d4 76 add $0x76d42556,%eax
5: 85 c0 test %eax,%eax
7: 7f 12 jg 0x1b
9: e9 88 00 00 00 jmpq 0x96
e: 83 c3 01 add $0x1,%ebx
11: 41 3b 9c 24 e8 09 00 cmp 0x9e8(%r12),%ebx
18: 00
19: 7d 7b jge 0x96
1b: 48 63 c3 movslq %ebx,%rax
1e: 48 89 ee mov %rbp,%rsi
21: 48 8d 04 80 lea (%rax,%rax,4),%rax
25: 4d 8d 7c c5 00 lea 0x0(%r13,%rax,8),%r15
* 2a: 4c 89 ff mov %r15,%rdi <-- trapping instruction
2d: e8 99 fe ff ff callq 0xfffffecb
32: 85 c0 test %eax,%eax
34: 74 d8 je 0xe
36: 41 83 fe ff cmp $0xffffffff,%r14d
3a: 41 bd 01 00 00 00 mov $0x1,%r13d