INFO: task syz-executor727:9571 blocked for more than 143 seconds.
Not tainted 5.5.0-rc2-next-20191220-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor727 D24840 9571 9570 0x00004000
Call Trace:
context_switch kernel/sched/core.c:3385 [inline]
__schedule+0x934/0x1f90 kernel/sched/core.c:4081
schedule+0xdc/0x2b0 kernel/sched/core.c:4155
io_schedule+0x1c/0x70 kernel/sched/core.c:5799
wait_on_page_bit_common mm/filemap.c:1175 [inline]
wait_on_page_bit+0x27c/0xa60 mm/filemap.c:1224
wait_on_page_writeback+0x1b2/0x4f0 mm/page-writeback.c:2822
__filemap_fdatawait_range+0x145/0x340 mm/filemap.c:526
file_write_and_wait_range+0x1ac/0x210 mm/filemap.c:786
__generic_file_fsync+0x79/0x200 fs/libfs.c:1070
fat_file_fsync+0x78/0x210 fs/fat/file.c:190
vfs_fsync_range+0x141/0x230 fs/sync.c:197
generic_write_sync include/linux/fs.h:2851 [inline]
generic_file_write_iter+0x4ea/0x68e mm/filemap.c:3474
call_write_iter include/linux/fs.h:1901 [inline]
do_iter_readv_writev+0x5f8/0x8f0 fs/read_write.c:693
do_iter_write fs/read_write.c:970 [inline]
do_iter_write+0x184/0x610 fs/read_write.c:951
vfs_iter_write+0x77/0xb0 fs/read_write.c:983
iter_file_splice_write+0x717/0xc10 fs/splice.c:760
do_splice_from fs/splice.c:863 [inline]
direct_splice_actor+0x123/0x190 fs/splice.c:1037
splice_direct_to_actor+0x3b4/0xa30 fs/splice.c:992
do_splice_direct+0x1da/0x2a0 fs/splice.c:1080
do_sendfile+0x597/0xd00 fs/read_write.c:1464
__do_sys_sendfile64 fs/read_write.c:1525 [inline]
__se_sys_sendfile64 fs/read_write.c:1511 [inline]
__x64_sys_sendfile64+0x1dd/0x220 fs/read_write.c:1511
do_syscall_64+0xfa/0x790 arch/x86/entry/common.c:294
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x445929
Code: Bad RIP value.
RSP: 002b:00007fffe0bfce58 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000445929
RDX: 0000000000000000 RSI: 0000000000000004 RDI: 0000000000000004
RBP: 00007fffe0bfce90 R08: 0000000000000003 R09: 0000000000000003
R10: 00008080fffffffe R11: 0000000000000246 R12: 00007fffe0bfcf40
R13: 0000000000000003 R14: 0000000000000004 R15: 0000000000000000
Showing all locks held in the system:
1 lock held by khungtaskd/1113:
#0: ffffffff899af980 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x279 kernel/locking/lockdep.c:5334
3 locks held by rs:main Q:Reg/9453:
#0: ffff8880ae837518 (&rq->lock){-.-.}, at: newidle_balance+0xa28/0xe80 kernel/sched/fair.c:10178
#1: ffffffff899af980 (rcu_read_lock){....}, at: __update_idle_core+0x45/0x3f0 kernel/sched/fair.c:5729
#2: ffff8880a19e9508 (&sb->s_type->i_mutex_key#11){+.+.}, at: inode_lock include/linux/fs.h:791 [inline]
#2: ffff8880a19e9508 (&sb->s_type->i_mutex_key#11){+.+.}, at: ext4_buffered_write_iter+0xba/0x460 fs/ext4/file.c:246
1 lock held by rsyslogd/9455:
#0: ffff8880a1f860e0 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:803
2 locks held by getty/9545:
#0: ffff88808d1ce090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005b4b2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9546:
#0: ffff88809c3f6090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005b7b2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9547:
#0: ffff88809940a090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005bcb2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9548:
#0: ffff8880993e3090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005bab2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9549:
#0: ffff888094113090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005bbb2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9550:
#0: ffff888095b46090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90005b9b2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
2 locks held by getty/9551:
#0: ffff88821529a090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340
#1: ffffc90004f272e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x220/0x1bf0 drivers/tty/n_tty.c:2156
1 lock held by syz-executor727/9571:
#0: ffff88809b166428 (sb_writers#8){.+.+}, at: file_start_write include/linux/fs.h:2880 [inline]
#0: ffff88809b166428 (sb_writers#8){.+.+}, at: do_sendfile+0x9b9/0xd00 fs/read_write.c:1463
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 1113 Comm: khungtaskd Not tainted 5.5.0-rc2-next-20191220-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x197/0x210 lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x70/0xb2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x23b/0x28b lib/nmi_backtrace.c:62
arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:249 [inline]
watchdog+0xdf1/0x14e0 kernel/hung_task.c:333
kthread+0x361/0x430 kernel/kthread.c:255
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.5.0-rc2-next-20191220-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__read_once_size include/linux/compiler.h:232 [inline]
RIP: 0010:arch_atomic_read arch/x86/include/asm/atomic.h:31 [inline]
RIP: 0010:atomic_read include/asm-generic/atomic-instrumented.h:41 [inline]
RIP: 0010:rcu_dynticks_curr_cpu_in_eqs+0x69/0xb0 kernel/rcu/tree.c:302
Code: 89 be 04 00 00 00 4c 8d a3 d8 00 00 00 4c 89 e7 e8 5c 0d 51 00 4c 89 e2 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 0f b6 14 02 <4c> 89 e0 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 17 8b 83 d8 00 00
RSP: 0018:ffffc90000007e98 EFLAGS: 00000802
RAX: dffffc0000000000 RBX: ffff8880ae8382c0 RCX: ffffffff81620624
RDX: 0000000000000000 RSI: 0000000000000004 RDI: ffff8880ae838398
RBP: ffffc90000007eb0 R08: 1ffff11015d07073 R09: ffffed1015d07074
R10: ffffed1015d07073 R11: ffff8880ae83839b R12: ffff8880ae838398
R13: ffffffff89576160 R14: ffff8880ae800000 R15: 0000000000000000
FS: 0000000000000000(0000) GS:ffff8880ae800000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000000243a000 CR3: 000000008ff28000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
rcu_is_watching+0x10/0x30 kernel/rcu/tree.c:925
rcu_read_lock_held_common+0xb4/0x130 kernel/rcu/update.c:104
rcu_read_lock_sched_held+0x5b/0xd0 kernel/rcu/update.c:119
trace_softirq_raise include/trace/events/irq.h:156 [inline]
__raise_softirq_irqoff kernel/softirq.c:451 [inline]
raise_softirq_irqoff+0x1a7/0x1f0 kernel/softirq.c:425
scheduler_ipi+0x4c7/0x640 kernel/sched/core.c:2346
smp_reschedule_interrupt+0x78/0x4c0 arch/x86/kernel/smp.c:244
reschedule_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:853
RIP: 0010:native_safe_halt+0xe/0x10 arch/x86/include/asm/irqflags.h:61
Code: 78 e4 e3 f9 eb 8a cc cc cc cc cc cc e9 07 00 00 00 0f 00 2d b4 1b 59 00 f4 c3 66 90 e9 07 00 00 00 0f 00 2d a4 1b 59 00 fb f4 cc 55 48 89 e5 41 57 41 56 41 55 41 54 53 e8 2e 88 93 f9 e8 79
RSP: 0018:ffffffff89807ce8 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff02
RAX: 1ffffffff13275ce RBX: ffffffff8987a440 RCX: 0000000000000000
RDX: dffffc0000000000 RSI: 0000000000000006 RDI: ffffffff8987acdc
RBP: ffffffff89807d18 R08: ffffffff8987a440 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: dffffc0000000000
R13: ffffffff8a816ac0 R14: 0000000000000000 R15: 0000000000000000
arch_cpu_idle+0xa/0x10 arch/x86/kernel/process.c:686
default_idle_call+0x84/0xb0 kernel/sched/idle.c:94
cpuidle_idle_call kernel/sched/idle.c:154 [inline]
do_idle+0x3c8/0x6e0 kernel/sched/idle.c:269
cpu_startup_entry+0x1b/0x20 kernel/sched/idle.c:361
rest_init+0x23b/0x371 init/main.c:452
arch_call_rest_init+0xe/0x1b
start_kernel+0x904/0x943 init/main.c:786
x86_64_start_reservations+0x29/0x2b arch/x86/kernel/head64.c:490
x86_64_start_kernel+0x77/0x7b arch/x86/kernel/head64.c:471
secondary_startup_64+0xa4/0xb0 arch/x86/kernel/head_64.S:242