INFO: rcu_preempt self-detected stall on CPU
1-...: (1 GPs behind) idle=ede/140000000000002/0 softirq=60740/60741 fqs=2
(t=10500 jiffies g=17275 c=17274 q=63)
rcu_preempt kthread starved for 10222 jiffies! g17275 c17274 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=0
rcu_preempt R running task 29184 8 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
schedule+0x92/0x1c0 kernel/sched/core.c:3428
schedule_timeout+0x43e/0xe10 kernel/time/timer.c:1746
rcu_gp_kthread+0xbf4/0x1ec0 kernel/rcu/tree.c:2255
kthread+0x319/0x430 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
NMI backtrace for cpu 1
CPU: 1 PID: 24695 Comm: syz-executor.4 Not tainted 4.14.166-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:17 [inline]
dump_stack+0x142/0x197 lib/dump_stack.c:58
nmi_cpu_backtrace.cold+0x57/0x94 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x141/0x189 lib/nmi_backtrace.c:62
arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
trigger_single_cpu_backtrace include/linux/nmi.h:158 [inline]
rcu_dump_cpu_stacks+0x186/0x1d2 kernel/rcu/tree.c:1396
print_cpu_stall kernel/rcu/tree.c:1542 [inline]
check_cpu_stall kernel/rcu/tree.c:1610 [inline]
__rcu_pending kernel/rcu/tree.c:3390 [inline]
rcu_pending kernel/rcu/tree.c:3452 [inline]
rcu_check_callbacks.cold+0x43d/0xd0a kernel/rcu/tree.c:2792
update_process_times+0x31/0x70 kernel/time/timer.c:1590
tick_sched_handle+0x85/0x160 kernel/time/tick-sched.c:161
tick_sched_timer+0x43/0x130 kernel/time/tick-sched.c:1219
__run_hrtimer kernel/time/hrtimer.c:1223 [inline]
__hrtimer_run_queues+0x270/0xbc0 kernel/time/hrtimer.c:1287
hrtimer_interrupt+0x1d8/0x5d0 kernel/time/hrtimer.c:1321
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1075 [inline]
smp_apic_timer_interrupt+0x11c/0x5e0 arch/x86/kernel/apic/apic.c:1100
apic_timer_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:792
RIP: 0010:__read_once_size include/linux/compiler.h:183 [inline]
RIP: 0010:list_empty include/linux/list.h:203 [inline]
RIP: 0010:sctp_packet_pack net/sctp/output.c:512 [inline]
RIP: 0010:sctp_packet_transmit+0x1658/0x3010 net/sctp/output.c:605
RSP: 0018:ffff8880aed07758 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: dffffc0000000000 RCX: ffff888077a38880
RDX: 1ffff1100f2a28ee RSI: ffffffff87f87220 RDI: 0000000000000286
RBP: ffff8880aed07890 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffff888097d10dc0
R13: ffff888089c562c0 R14: ffff888097d10df8 R15: ffff8880a52c5940
sctp_outq_flush+0xd13/0x31b0 net/sctp/outqueue.c:1187
sctp_outq_uncork+0x60/0x70 net/sctp/outqueue.c:761
sctp_cmd_interpreter net/sctp/sm_sideeffect.c:1787 [inline]
sctp_side_effects net/sctp/sm_sideeffect.c:1179 [inline]
sctp_do_sm+0x452/0x50d0 net/sctp/sm_sideeffect.c:1150
sctp_generate_heartbeat_event+0x1dd/0x400 net/sctp/sm_sideeffect.c:391
call_timer_fn+0x161/0x670 kernel/time/timer.c:1279
expire_timers kernel/time/timer.c:1318 [inline]
__run_timers kernel/time/timer.c:1636 [inline]
__run_timers kernel/time/timer.c:1604 [inline]
run_timer_softirq+0x5b7/0x1520 kernel/time/timer.c:1649
__do_softirq+0x244/0x9a0 kernel/softirq.c:288
invoke_softirq kernel/softirq.c:368 [inline]
irq_exit+0x160/0x1b0 kernel/softirq.c:409
exiting_irq arch/x86/include/asm/apic.h:648 [inline]
smp_apic_timer_interrupt+0x146/0x5e0 arch/x86/kernel/apic/apic.c:1102
apic_timer_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:792
RIP: 0010:proc_pident_instantiate+0x72/0x290 fs/proc/base.c:2449
RSP: 0018:ffff88821ac97748 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: ffffffff86d50420 RCX: 1ffff11012bd314c
RDX: 0000000000004149 RSI: ffffffff81aa0e30 RDI: ffff888095e98a60
RBP: ffff88821ac97770 R08: ffff888077a38000 R09: 0000000000000001
R10: 0000000000000000 R11: ffff888077a38000 R12: ffff888095e98a38
R13: ffff888048052420 R14: ffff8880655243c0 R15: ffff888048052420
proc_pident_lookup+0x17e/0x1f0 fs/proc/base.c:2498
proc_tgid_base_lookup+0x2a/0x30 fs/proc/base.c:3051
lookup_slow+0x226/0x440 fs/namei.c:1695
walk_component+0x698/0x1d00 fs/namei.c:1824
link_path_walk+0x81f/0x10a0 fs/namei.c:2153
path_openat+0x189/0x3f70 fs/namei.c:3565
do_filp_open+0x18e/0x250 fs/namei.c:3600
do_sys_open+0x2c5/0x430 fs/open.c:1084
SYSC_open fs/open.c:1102 [inline]
SyS_open+0x2d/0x40 fs/open.c:1097
do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x4150e1
RSP: 002b:00007f815596bc10 EFLAGS: 00000293 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f815596c6d4 RCX: 00000000004150e1
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00000000004c0099
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 00000000ffffffff
R13: 0000000000000b65 R14: 00000000004cc3d6 R15: 000000000075bf2c
INFO: rcu_sched detected stalls on CPUs/tasks:
1-...: (1 GPs behind) idle=ede/140000000000002/0 softirq=60740/60741 fqs=2
(detected by 0, t=10571 jiffies, g=12387, c=12386, q=3)
Sending NMI from CPU 0 to CPUs 1:
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.143 msecs
NMI backtrace for cpu 1
CPU: 1 PID: 24695 Comm: syz-executor.4 Not tainted 4.14.166-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff888077a38000 task.stack: ffff88821ac90000
RIP: 0010:separate_irq_context kernel/locking/lockdep.c:3117 [inline]
RIP: 0010:__lock_acquire+0xa9d/0x4620 kernel/locking/lockdep.c:3478
RSP: 0018:ffff8880aed07050 EFLAGS: 00000006
RAX: 000000000000000f RBX: 0000000000000012 RCX: ffff888077a38880
RDX: 1ffff1100ef4710f RSI: ffff888077a388f8 RDI: ffffffff895b4080
RBP: ffff8880aed07200 R08: 0000000000000000 R09: ffff888077a38918
R10: ffff888077a388f8 R11: ffff888077a38000 R12: 0000000000000000
R13: 0000000000000012 R14: ffff888077a388d0 R15: 22da3d843631b6de
FS: 00007f815596c700(0000) GS:ffff8880aed00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b2c425000 CR3: 00000002188e9000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_acquire+0x16f/0x430 kernel/locking/lockdep.c:3994
rcu_lock_acquire include/linux/rcupdate.h:242 [inline]
rcu_read_lock include/linux/rcupdate.h:629 [inline]
kill_fasync fs/fcntl.c:1010 [inline]
kill_fasync+0x73/0x3d0 fs/fcntl.c:1004
perf_event_wakeup+0x215/0x360 kernel/events/core.c:5558
perf_pending_event+0xb0/0xe0 kernel/events/core.c:5582
irq_work_run_list+0x105/0x190 kernel/irq_work.c:156
irq_work_run+0x52/0xb0 kernel/irq_work.c:171
smp_irq_work_interrupt+0xa8/0x4e0 arch/x86/kernel/irq_work.c:21
irq_work_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:823
RIP: 0010:find_stack lib/stackdepot.c:174 [inline]
RIP: 0010:depot_save_stack+0x106/0x410 lib/stackdepot.c:225
RSP: 0018:ffff8880aed07468 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff09
RAX: 00000000000ac5d6 RBX: 00000000c86ac5d6 RCX: 000000007031a84a
RDX: 0000000000000088 RSI: 0000000000000001 RDI: ffff8880aed074c0
RBP: ffff8880aed074b0 R08: 000000004a0f22e7 R09: 0000000000000003
R10: 0000000000000000 R11: ffff888077a38000 R12: ffff8880aed074c0
R13: ffff8880aed074d8 R14: 0000000000000011 R15: ffff888082cd0ef0
save_stack+0xa9/0xd0 mm/kasan/kasan.c:453
set_track mm/kasan/kasan.c:459 [inline]
kasan_kmalloc mm/kasan/kasan.c:551 [inline]
kasan_kmalloc+0xce/0xf0 mm/kasan/kasan.c:529
kmem_cache_alloc_node_trace+0x153/0x770 mm/slab.c:3661
__do_kmalloc_node mm/slab.c:3681 [inline]
__kmalloc_node_track_caller+0x3d/0x80 mm/slab.c:3696
__kmalloc_reserve.isra.0+0x40/0xe0 net/core/skbuff.c:137
__alloc_skb+0xcf/0x500 net/core/skbuff.c:205
alloc_skb include/linux/skbuff.h:980 [inline]
_sctp_make_chunk+0x51/0x270 net/sctp/sm_make_chunk.c:1388
sctp_make_control+0x35/0x150 net/sctp/sm_make_chunk.c:1429
sctp_make_heartbeat+0x88/0x250 net/sctp/sm_make_chunk.c:1148
sctp_sf_heartbeat.isra.0+0x26/0x180 net/sctp/sm_statefuns.c:971
sctp_sf_sendbeat_8_3+0x36f/0x520 net/sctp/sm_statefuns.c:1015
sctp_do_sm+0x108/0x50d0 net/sctp/sm_sideeffect.c:1147
sctp_generate_heartbeat_event+0x1dd/0x400 net/sctp/sm_sideeffect.c:391
call_timer_fn+0x161/0x670 kernel/time/timer.c:1279
expire_timers kernel/time/timer.c:1318 [inline]
__run_timers kernel/time/timer.c:1636 [inline]
__run_timers kernel/time/timer.c:1604 [inline]
run_timer_softirq+0x5b7/0x1520 kernel/time/timer.c:1649
__do_softirq+0x244/0x9a0 kernel/softirq.c:288
invoke_softirq kernel/softirq.c:368 [inline]
irq_exit+0x160/0x1b0 kernel/softirq.c:409
exiting_irq arch/x86/include/asm/apic.h:648 [inline]
smp_apic_timer_interrupt+0x146/0x5e0 arch/x86/kernel/apic/apic.c:1102
apic_timer_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:792
RIP: 0010:proc_pident_instantiate+0x72/0x290 fs/proc/base.c:2449
RSP: 0018:ffff88821ac97748 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: ffffffff86d50420 RCX: 1ffff11012bd314c
RDX: 0000000000004149 RSI: ffffffff81aa0e30 RDI: ffff888095e98a60
RBP: ffff88821ac97770 R08: ffff888077a38000 R09: 0000000000000001
R10: 0000000000000000 R11: ffff888077a38000 R12: ffff888095e98a38
R13: ffff888048052420 R14: ffff8880655243c0 R15: ffff888048052420
proc_pident_lookup+0x17e/0x1f0 fs/proc/base.c:2498
proc_tgid_base_lookup+0x2a/0x30 fs/proc/base.c:3051
lookup_slow+0x226/0x440 fs/namei.c:1695
walk_component+0x698/0x1d00 fs/namei.c:1824
link_path_walk+0x81f/0x10a0 fs/namei.c:2153
path_openat+0x189/0x3f70 fs/namei.c:3565
do_filp_open+0x18e/0x250 fs/namei.c:3600
do_sys_open+0x2c5/0x430 fs/open.c:1084
SYSC_open fs/open.c:1102 [inline]
SyS_open+0x2d/0x40 fs/open.c:1097
do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x4150e1
RSP: 002b:00007f815596bc10 EFLAGS: 00000293 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f815596c6d4 RCX: 00000000004150e1
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00000000004c0099
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 00000000ffffffff
R13: 0000000000000b65 R14: 00000000004cc3d6 R15: 000000000075bf2c
Code: 85 35 31 00 00 44 8b 25 f2 db 6e 08 45 85 e4 0f 85 e5 f6 ff ff e9 f5 a3 00 00 48 8b 8c 24 90 00 00 00 48 8d 04 80 4c 8d 74 c1 d8 <48> b8 00 00 00 00 00 fc ff df 49 8d 7e 21 48 89 fa 48 c1 ea 03
rcu_sched kthread starved for 10294 jiffies! g12387 c12386 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=0
rcu_sched R running task 29488 9 2 0x80000000
Call Trace:
context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
schedule+0x92/0x1c0 kernel/sched/core.c:3428
schedule_timeout+0x43e/0xe10 kernel/time/timer.c:1746
rcu_gp_kthread+0xbf4/0x1ec0 kernel/rcu/tree.c:2255
kthread+0x319/0x430 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404