INFO: rcu_sched detected stalls on CPUs/tasks: 0-...: (10502 ticks this GP) idle=522/140000000000001/0 softirq=36436/36444 fqs=14 (detected by 1, t=10503 jiffies, g=4427, c=4426, q=9) Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 17324 Comm: syz-executor.4 Not tainted 4.14.184-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff888093f5e1c0 task.stack: ffff88805c1f0000 RIP: 0010:__read_once_size include/linux/compiler.h:183 [inline] RIP: 0010:hlist_empty include/linux/list.h:671 [inline] RIP: 0010:perf_trace_lock_acquire+0x377/0x4b0 include/trace/events/lock.h:13 RSP: 0018:ffff8880aec079b8 EFLAGS: 00000046 RAX: dffffc0000000000 RBX: ffffe8ffffc2f1e8 RCX: dffffc0000000000 RDX: 1ffffd1ffff85e3d RSI: 1ffffffff0f00bac RDI: ffffffff87805d60 RBP: ffff8880aec07a78 R08: 0000000000000002 R09: 0000000000000000 R10: ffff88821fff7010 R11: 00000066f777cd2b R12: ffffffff87b6f000 R13: ffffffff87b84be0 R14: ffff8880aec07a50 R15: 0000000000000000 FS: 00007f4e8e178700(0000) GS:ffff8880aec00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000001b30f3e000 CR3: 000000008a3c4000 CR4: 00000000001426f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: trace_lock_acquire include/trace/events/lock.h:13 [inline] lock_acquire+0x2b8/0x3f0 kernel/locking/lockdep.c:3997 rcu_lock_acquire include/linux/rcupdate.h:242 [inline] rcu_read_lock include/linux/rcupdate.h:629 [inline] __perf_event_output kernel/events/core.c:6271 [inline] perf_event_output_forward+0x92/0x1f0 kernel/events/core.c:6291 __perf_event_overflow+0x113/0x310 kernel/events/core.c:7536 perf_swevent_hrtimer+0x220/0x350 kernel/events/core.c:8746 __run_hrtimer kernel/time/hrtimer.c:1223 [inline] __hrtimer_run_queues+0x24b/0xb90 kernel/time/hrtimer.c:1287 hrtimer_interrupt+0x1e6/0x5e0 kernel/time/hrtimer.c:1321 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1075 [inline] smp_apic_timer_interrupt+0x117/0x5f0 arch/x86/kernel/apic/apic.c:1100 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793 RIP: 0010:__read_once_size include/linux/compiler.h:183 [inline] RIP: 0010:atomic_read arch/x86/include/asm/atomic.h:27 [inline] RIP: 0010:rcu_dynticks_curr_cpu_in_eqs kernel/rcu/tree.c:362 [inline] RIP: 0010:rcu_is_watching+0x4f/0xb0 kernel/rcu/tree.c:1130 RSP: 0018:ffff88805c1f7520 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff10 RAX: dffffc0000000000 RBX: ffff8880aec23980 RCX: 1ffffffff0f00bac RDX: dffffc0000000000 RSI: ffffffff82fe6005 RDI: ffff8880aec2398c RBP: 0000000000000007 R08: 0000000000000038 R09: ffffea0000d076c0 R10: ffff8880a157bd00 R11: ffff8880341db9b7 R12: 0000000000000000 R13: 0000000000000038 R14: ffff88809a092200 R15: 000000000196b980 rcu_read_lock_sched_held+0x89/0x130 kernel/rcu/update.c:111 trace_writeback_mark_inode_dirty include/trace/events/writeback.h:114 [inline] __mark_inode_dirty+0xad5/0x1040 fs/fs-writeback.c:2134 mark_inode_dirty include/linux/fs.h:2020 [inline] generic_write_end+0x24a/0x350 fs/buffer.c:2229 ext4_da_write_end+0x48e/0x950 fs/ext4/inode.c:3200 generic_perform_write+0x268/0x420 mm/filemap.c:3058 __generic_file_write_iter+0x227/0x590 mm/filemap.c:3172 ext4_file_write_iter+0x279/0xd90 fs/ext4/file.c:270 call_write_iter include/linux/fs.h:1778 [inline] do_iter_readv_writev+0x3df/0x600 fs/read_write.c:675 do_iter_write fs/read_write.c:954 [inline] do_iter_write+0x152/0x550 fs/read_write.c:935 vfs_iter_write+0x70/0xa0 fs/read_write.c:967 iter_file_splice_write+0x52e/0xa10 fs/splice.c:749 do_splice_from fs/splice.c:851 [inline] direct_splice_actor+0x115/0x160 fs/splice.c:1018 splice_direct_to_actor+0x27e/0x730 fs/splice.c:973 do_splice_direct+0x164/0x210 fs/splice.c:1061 do_sendfile+0x469/0xaf0 fs/read_write.c:1441 SYSC_sendfile64 fs/read_write.c:1496 [inline] SyS_sendfile64+0x9b/0x110 fs/read_write.c:1488 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x45cb09 RSP: 002b:00007f4e8e177c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000028 RAX: ffffffffffffffda RBX: 00000000004fd540 RCX: 000000000045cb09 RDX: 00000000200001c0 RSI: 0000000000000006 RDI: 0000000000000006 RBP: 000000000078c040 R08: 0000000000000000 R09: 0000000000000000 R10: 00008080fffffffe R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000000008fe R14: 00000000004cbda8 R15: 00007f4e8e1786d4 Code: 00 48 8d 65 d8 5b 41 5c 41 5d 41 5e 41 5f 5d c3 48 b8 00 00 00 00 00 fc ff df 48 89 da 48 c1 ea 03 80 3c 02 00 0f 85 22 01 00 00 <48> 8b 85 70 ff ff ff 48 8b 00 48 85 c0 0f 85 c0 fd ff ff eb a2 rcu_sched kthread starved for 10474 jiffies! g4427 c4426 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=1 INFO: rcu_preempt self-detected stall on CPU rcu_sched R running task 0-...: (1 GPs behind) idle=522/140000000000001/0 softirq=36443/36444 fqs=12 29472 9 2 0x80000000 Call Trace: (t=10500 jiffies g=9770 c=9769 q=498) context_switch kernel/sched/core.c:2808 [inline] __schedule+0x8a6/0x1d70 kernel/sched/core.c:3384 rcu_preempt kthread starved for 10476 jiffies! g9770 c9769 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=1 rcu_preempt R running task 29904 8 2 0x80000000 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 Call Trace: schedule_timeout+0x4df/0xe50 kernel/time/timer.c:1746 context_switch kernel/sched/core.c:2808 [inline] __schedule+0x8a6/0x1d70 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 rcu_gp_kthread+0xb3d/0x1ce0 kernel/rcu/tree.c:2255 schedule_timeout+0x4df/0xe50 kernel/time/timer.c:1746 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 rcu_gp_kthread+0xb3d/0x1ce0 kernel/rcu/tree.c:2255 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 NMI backtrace for cpu 0 CPU: 0 PID: 17324 Comm: syz-executor.4 Not tainted 4.14.184-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+0x1b2/0x283 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x17f lib/nmi_backtrace.c:62 trigger_single_cpu_backtrace include/linux/nmi.h:158 [inline] rcu_dump_cpu_stacks+0x16d/0x1b8 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+0x490/0xdaa kernel/rcu/tree.c:2792 update_process_times+0x29/0x60 kernel/time/timer.c:1590 tick_sched_handle.isra.0+0x73/0x150 kernel/time/tick-sched.c:165 tick_sched_timer+0x41/0x120 kernel/time/tick-sched.c:1223 __run_hrtimer kernel/time/hrtimer.c:1223 [inline] __hrtimer_run_queues+0x24b/0xb90 kernel/time/hrtimer.c:1287 hrtimer_interrupt+0x1e6/0x5e0 kernel/time/hrtimer.c:1321 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1075 [inline] smp_apic_timer_interrupt+0x117/0x5f0 arch/x86/kernel/apic/apic.c:1100 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline] RIP: 0010:lock_release+0x41e/0x7f0 kernel/locking/lockdep.c:4020 RSP: 0018:ffff88805c1f7948 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff10 RAX: 1ffffffff0f62cd1 RBX: 1ffff1100b83ef2d RCX: 1ffff110127ebd47 RDX: dffffc0000000000 RSI: 0000000000000002 RDI: 0000000000000282 RBP: ffff888093f5e1c0 R08: 0000000000000001 R09: 0000000000000001 R10: ffff888093f5ea70 R11: ffff888093f5e1c0 R12: ffffffff816f0f80 R13: 0000000000000003 R14: ffff888093f5e1c0 R15: 0000000000000002 slab_pre_alloc_hook mm/slab.h:417 [inline] slab_alloc mm/slab.c:3376 [inline] __do_kmalloc mm/slab.c:3718 [inline] __kmalloc+0x56/0x400 mm/slab.c:3729 kmalloc_array include/linux/slab.h:607 [inline] kcalloc include/linux/slab.h:618 [inline] iter_file_splice_write+0x143/0xa10 fs/splice.c:692 do_splice_from fs/splice.c:851 [inline] direct_splice_actor+0x115/0x160 fs/splice.c:1018 splice_direct_to_actor+0x27e/0x730 fs/splice.c:973 do_splice_direct+0x164/0x210 fs/splice.c:1061 do_sendfile+0x469/0xaf0 fs/read_write.c:1441 SYSC_sendfile64 fs/read_write.c:1496 [inline] SyS_sendfile64+0x9b/0x110 fs/read_write.c:1488 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x45cb09 RSP: 002b:00007f4e8e177c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000028 RAX: ffffffffffffffda RBX: 00000000004fd540 RCX: 000000000045cb09 RDX: 00000000200001c0 RSI: 0000000000000006 RDI: 0000000000000006 RBP: 000000000078c040 R08: 0000000000000000 R09: 0000000000000000 R10: 00008080fffffffe R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000000008fe R14: 00000000004cbda8 R15: 00007f4e8e1786d4