rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 0-...!: (1 ticks this GP) idle=93d/1/0x4000000000000000 softirq=76583/76583 fqs=0
(detected by 1, t=10502 jiffies, g=123269, q=339)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 26 Comm: kauditd Not tainted 5.16.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__lock_acquire+0x2d5/0x54a0 kernel/locking/lockdep.c:4964
Code: 0f 85 6b 39 00 00 49 8d 44 24 18 49 89 5c 24 10 48 89 c2 48 89 44 24 48 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 80 3c 02 00 <0f> 85 02 3b 00 00 48 8b 44 24 20 49 8d b5 44 0a 00 00 48 ba 00 00
RSP: 0018:ffffc90000007c00 EFLAGS: 00000046
RAX: dffffc0000000000 RBX: ffff8880b9c2a418 RCX: 000000000000005c
RDX: 1ffff11002320894 RSI: 0000000000000004 RDI: ffff888011904498
RBP: 0000000000000000 R08: 1ffff11002320890 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: ffff888011904488
R13: ffff888011903a00 R14: 0000000000000000 R15: 0000000000000001
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f6c72ffa3a4 CR3: 000000006bb45000 CR4: 0000000000350ef0
Call Trace:
lock_acquire kernel/locking/lockdep.c:5637 [inline]
lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
__raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
_raw_spin_lock_irq+0x32/0x50 kernel/locking/spinlock.c:170
__run_hrtimer kernel/time/hrtimer.c:1689 [inline]
__hrtimer_run_queues+0x243/0xe50 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x31c/0x790 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1086 [inline]
__sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1103
sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1097
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:preempt_count arch/x86/include/asm/preempt.h:27 [inline]
RIP: 0010:check_kcov_mode kernel/kcov.c:166 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x60 kernel/kcov.c:200
Code: 48 89 ef 5d e9 d1 22 46 00 5d be 03 00 00 00 e9 56 1b 63 02 66 0f 1f 44 00 00 48 8b be b0 01 00 00 e8 b4 ff ff ff 31 c0 c3 90 <65> 8b 05 39 d5 8a 7e 89 c1 48 8b 34 24 81 e1 00 01 00 00 65 48 8b
RSP: 0018:ffffc90000e1faf8 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff888011903a00 RSI: ffffffff815ed74c RDI: 0000000000000003
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8ff72a07
R10: ffffffff815ed742 R11: 0000000000000000 R12: ffffffff84d408d0
R13: 0000000000000200 R14: ffffc90000e1fb58 R15: dffffc0000000000
console_unlock+0x6c2/0xb70 kernel/printk/printk.c:2716
vprintk_emit+0x198/0x4f0 kernel/printk/printk.c:2245
vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
_printk+0xba/0xed kernel/printk/printk.c:2266
kauditd_printk_skb kernel/audit.c:538 [inline]
kauditd_hold_skb.cold+0x41/0x50 kernel/audit.c:571
kauditd_send_queue+0x19d/0x210 kernel/audit.c:734
kauditd_thread+0x762/0xba0 kernel/audit.c:860
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
rcu: rcu_preempt kthread timer wakeup didn't happen for 10501 jiffies! g123269 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402
rcu: Possible timer handling issue on cpu=0 timer-softirq=59050
rcu: rcu_preempt kthread starved for 10502 jiffies! g123269 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402 ->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:I stack:28688 pid: 14 ppid: 2 flags:0x00004000
Call Trace:
context_switch kernel/sched/core.c:4972 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6253
schedule+0xd2/0x260 kernel/sched/core.c:6326
schedule_timeout+0x14a/0x2a0 kernel/time/timer.c:1881
rcu_gp_fqs_loop+0x186/0x810 kernel/rcu/tree.c:1955
rcu_gp_kthread+0x1de/0x320 kernel/rcu/tree.c:2128
kthread+0x405/0x4f0 kernel/kthread.c:327
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: 26 Comm: kauditd Not tainted 5.16.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:rcu_read_lock_sched_held+0x4a/0x70 kernel/rcu/update.c:125
Code: e8 1b 9d 00 00 84 c0 74 38 be ff ff ff ff 48 c7 c7 e0 3b b8 8b e8 a6 8d e1 07 85 c0 75 d3 65 8b 05 0b ed 9f 7e a9 ff ff ff 7f <75> c5 9c 41 5c 49 c1 ec 09 49 83 f4 01 41 83 e4 01 44 89 e0 41 5c
RSP: 0018:ffffc90000007e30 EFLAGS: 00000002
RAX: 0000000000010002 RBX: ffff888034815340 RCX: 0000000000000001
RDX: 0000000000000000 RSI: 0000000000010002 RDI: 0000000000000000
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000001
R10: ffffffff8167051f R11: 0000000000000000 R12: 0000000000000001
R13: ffff8880b9c2a500 R14: ffff8880b9c2a400 R15: ffffffff875eb030
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f6c72ffa3a4 CR3: 000000006bb45000 CR4: 0000000000350ef0
Call Trace:
trace_hrtimer_expire_entry include/trace/events/timer.h:232 [inline]
__run_hrtimer kernel/time/hrtimer.c:1682 [inline]
__hrtimer_run_queues+0x9b0/0xe50 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x31c/0x790 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1086 [inline]
__sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1103
sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1097
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:preempt_count arch/x86/include/asm/preempt.h:27 [inline]
RIP: 0010:check_kcov_mode kernel/kcov.c:166 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x60 kernel/kcov.c:200
Code: 48 89 ef 5d e9 d1 22 46 00 5d be 03 00 00 00 e9 56 1b 63 02 66 0f 1f 44 00 00 48 8b be b0 01 00 00 e8 b4 ff ff ff 31 c0 c3 90 <65> 8b 05 39 d5 8a 7e 89 c1 48 8b 34 24 81 e1 00 01 00 00 65 48 8b
RSP: 0018:ffffc90000e1faf8 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff888011903a00 RSI: ffffffff815ed74c RDI: 0000000000000003
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8ff72a07
R10: ffffffff815ed742 R11: 0000000000000000 R12: ffffffff84d408d0
R13: 0000000000000200 R14: ffffc90000e1fb58 R15: dffffc0000000000
console_unlock+0x6c2/0xb70 kernel/printk/printk.c:2716
vprintk_emit+0x198/0x4f0 kernel/printk/printk.c:2245
vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
_printk+0xba/0xed kernel/printk/printk.c:2266
kauditd_printk_skb kernel/audit.c:538 [inline]
kauditd_hold_skb.cold+0x41/0x50 kernel/audit.c:571
kauditd_send_queue+0x19d/0x210 kernel/audit.c:734
kauditd_thread+0x762/0xba0 kernel/audit.c:860
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
watchdog: BUG: soft lockup - CPU#1 stuck for 225s! [syz-executor.3:2178]
Modules linked in:
irq event stamp: 49060
hardirqs last enabled at (49059): [] asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
hardirqs last disabled at (49060): [] sysvec_apic_timer_interrupt+0xb/0xc0 arch/x86/kernel/apic/apic.c:1097
softirqs last enabled at (1030): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last enabled at (1030): [] __irq_exit_rcu+0x123/0x180 kernel/softirq.c:636
softirqs last disabled at (997): [] invoke_softirq kernel/softirq.c:432 [inline]
softirqs last disabled at (997): [] __irq_exit_rcu+0x123/0x180 kernel/softirq.c:636
CPU: 1 PID: 2178 Comm: syz-executor.3 Not tainted 5.16.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:csd_lock_wait kernel/smp.c:440 [inline]
RIP: 0010:smp_call_function_many_cond+0x452/0xc20 kernel/smp.c:969
Code: 0b 00 85 ed 74 4d 48 b8 00 00 00 00 00 fc ff df 4d 89 f4 4c 89 f5 49 c1 ec 03 83 e5 07 49 01 c4 83 c5 03 e8 80 75 0b 00 f3 90 <41> 0f b6 04 24 40 38 c5 7c 08 84 c0 0f 85 33 06 00 00 8b 43 08 31
RSP: 0018:ffffc9000434f760 EFLAGS: 00000246
RAX: 0000000000040000 RBX: ffff8880b9c41d40 RCX: ffffc90014def000
RDX: 0000000000040000 RSI: ffffffff816c2540 RDI: 0000000000000003
RBP: 0000000000000003 R08: 0000000000000000 R09: 0000000000000001
R10: ffffffff816c2566 R11: 0000000000000000 R12: ffffed10173883a9
R13: 0000000000000000 R14: ffff8880b9c41d48 R15: 0000000000000001
FS: 00007f5982c41700(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000561bc6287780 CR3: 000000008c0cc000 CR4: 0000000000350ee0
Call Trace:
on_each_cpu_cond_mask+0x56/0xa0 kernel/smp.c:1135
invalidate_bdev+0x91/0xd0 block/bdev.c:87
btrfs_get_bdev_and_sb+0xd3/0x260 fs/btrfs/volumes.c:518
btrfs_open_one_device fs/btrfs/volumes.c:624 [inline]
open_fs_devices+0x615/0xdc0 fs/btrfs/volumes.c:1218
btrfs_open_devices+0x11b/0x150 fs/btrfs/volumes.c:1274
btrfs_mount_root+0x536/0xc10 fs/btrfs/super.c:1698
legacy_get_tree+0x105/0x220 fs/fs_context.c:610
vfs_get_tree+0x89/0x2f0 fs/super.c:1500
fc_mount fs/namespace.c:994 [inline]
vfs_kern_mount.part.0+0xd3/0x170 fs/namespace.c:1024
vfs_kern_mount+0x3c/0x60 fs/namespace.c:1011
btrfs_mount+0x234/0xa60 fs/btrfs/super.c:1786
legacy_get_tree+0x105/0x220 fs/fs_context.c:610
vfs_get_tree+0x89/0x2f0 fs/super.c:1500
do_new_mount fs/namespace.c:2988 [inline]
path_mount+0x1320/0x1fa0 fs/namespace.c:3318
do_mount fs/namespace.c:3331 [inline]
__do_sys_mount fs/namespace.c:3539 [inline]
__se_sys_mount fs/namespace.c:3516 [inline]
__x64_sys_mount+0x27f/0x300 fs/namespace.c:3516
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:0x7f59856cd01a
Code: 48 c7 c2 bc ff ff ff f7 d8 64 89 02 b8 ff ff ff ff eb d2 e8 b8 04 00 00 0f 1f 84 00 00 00 00 00 49 89 ca b8 a5 00 00 00 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:00007f5982c40fa8 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 0000000020000200 RCX: 00007f59856cd01a
RDX: 0000000020000000 RSI: 0000000020000100 RDI: 00007f5982c41000
RBP: 00007f5982c41040 R08: 00007f5982c41040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000206 R12: 0000000020000000
R13: 0000000020000100 R14: 00007f5982c41000 R15: 0000000020001c40
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 26 Comm: kauditd Not tainted 5.16.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:lockdep_recursion_finish kernel/locking/lockdep.c:438 [inline]
RIP: 0010:lock_is_held_type+0xe4/0x140 kernel/locking/lockdep.c:5681
Code: f6 47 22 03 0f 95 c0 45 31 ed 44 39 f0 41 0f 94 c5 48 c7 c7 e0 0f ac 89 e8 a9 0d 00 00 b8 ff ff ff ff 65 0f c1 05 0c 69 be 76 <83> f8 01 75 29 9c 58 f6 c4 02 75 3d 48 f7 04 24 00 02 00 00 74 01
RSP: 0018:ffffc90000007cf0 EFLAGS: 00000057
RAX: 0000000000000001 RBX: 0000000000000001 RCX: 0000000000000001
RDX: 0000000000000000 RSI: 0000000000010003 RDI: 0000000000000000
RBP: ffffffff8bb83be0 R08: 0000000000000000 R09: ffffffff8d912ad7
R10: fffffbfff1b2255a R11: 0000000000000000 R12: ffff888011903a00
R13: 0000000000000000 R14: 00000000ffffffff R15: ffff888011904460
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f6c72ffa3a4 CR3: 000000006bb45000 CR4: 0000000000350ef0
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_acquire include/trace/events/lock.h:13 [inline]
lock_acquire+0x442/0x510 kernel/locking/lockdep.c:5608
__raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
_raw_spin_lock_irq+0x32/0x50 kernel/locking/spinlock.c:170
__run_hrtimer kernel/time/hrtimer.c:1689 [inline]
__hrtimer_run_queues+0x243/0xe50 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x31c/0x790 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1086 [inline]
__sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1103
sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1097
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:preempt_count arch/x86/include/asm/preempt.h:27 [inline]
RIP: 0010:check_kcov_mode kernel/kcov.c:166 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x60 kernel/kcov.c:200
Code: 48 89 ef 5d e9 d1 22 46 00 5d be 03 00 00 00 e9 56 1b 63 02 66 0f 1f 44 00 00 48 8b be b0 01 00 00 e8 b4 ff ff ff 31 c0 c3 90 <65> 8b 05 39 d5 8a 7e 89 c1 48 8b 34 24 81 e1 00 01 00 00 65 48 8b
RSP: 0018:ffffc90000e1faf8 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff888011903a00 RSI: ffffffff815ed74c RDI: 0000000000000003
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8ff72a07
R10: ffffffff815ed742 R11: 0000000000000000 R12: ffffffff84d408d0
R13: 0000000000000200 R14: ffffc90000e1fb58 R15: dffffc0000000000
console_unlock+0x6c2/0xb70 kernel/printk/printk.c:2716
vprintk_emit+0x198/0x4f0 kernel/printk/printk.c:2245
vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
_printk+0xba/0xed kernel/printk/printk.c:2266
kauditd_printk_skb kernel/audit.c:538 [inline]
kauditd_hold_skb.cold+0x41/0x50 kernel/audit.c:571
kauditd_send_queue+0x19d/0x210 kernel/audit.c:734
kauditd_thread+0x762/0xba0 kernel/audit.c:860
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
----------------
Code disassembly (best guess):
0: 0f 85 6b 39 00 00 jne 0x3971
6: 49 8d 44 24 18 lea 0x18(%r12),%rax
b: 49 89 5c 24 10 mov %rbx,0x10(%r12)
10: 48 89 c2 mov %rax,%rdx
13: 48 89 44 24 48 mov %rax,0x48(%rsp)
18: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax
1f: fc ff df
22: 48 c1 ea 03 shr $0x3,%rdx
26: 80 3c 02 00 cmpb $0x0,(%rdx,%rax,1)
* 2a: 0f 85 02 3b 00 00 jne 0x3b32 <-- trapping instruction
30: 48 8b 44 24 20 mov 0x20(%rsp),%rax
35: 49 8d b5 44 0a 00 00 lea 0xa44(%r13),%rsi
3c: 48 rex.W
3d: ba .byte 0xba