INFO: task jbd2/sda1-8:3307 blocked for more than 140 seconds. Not tainted 4.19.0-rc4-next-20180921+ #77 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. jbd2/sda1-8 D17496 3307 2 0x80000000 Call Trace: context_switch kernel/sched/core.c:2830 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3479 schedule+0xfe/0x460 kernel/sched/core.c:3523 jbd2_journal_commit_transaction+0xd38/0x89da fs/jbd2/commit.c:435 kjournald2+0x26d/0xb30 fs/jbd2/journal.c:229 kthread+0x35a/0x440 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: task syz-executor0:21338 blocked for more than 140 seconds. Not tainted 4.19.0-rc4-next-20180921+ #77 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D21856 21338 9977 0x00000004 Call Trace: context_switch kernel/sched/core.c:2830 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3479 schedule+0xfe/0x460 kernel/sched/core.c:3523 __rwsem_down_write_failed_common+0xbbc/0x15e0 kernel/locking/rwsem-xadd.c:577 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0xa5/0x130 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:745 [inline] do_truncate+0x1b0/0x2d0 fs/open.c:61 handle_truncate fs/namei.c:3008 [inline] do_last fs/namei.c:3424 [inline] path_openat+0x375c/0x5160 fs/namei.c:3534 do_filp_open+0x255/0x380 fs/namei.c:3564 do_sys_open+0x568/0x700 fs/open.c:1063 __do_sys_openat fs/open.c:1090 [inline] __se_sys_openat fs/open.c:1084 [inline] __x64_sys_openat+0x9d/0x100 fs/open.c:1084 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457679 Code: Bad RIP value. RSP: 002b:00007f8d147c5c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 00007f8d147c66d4 RCX: 0000000000457679 RDX: 000000000000275a RSI: 0000000020000080 RDI: ffffffffffffff9c RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000004d3fc0 R14: 00000000004c2b9e R15: 0000000000000000 INFO: task syz-executor0:21393 blocked for more than 140 seconds. Not tainted 4.19.0-rc4-next-20180921+ #77 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D22552 21393 9977 0x00000004 Call Trace: context_switch kernel/sched/core.c:2830 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3479 schedule+0xfe/0x460 kernel/sched/core.c:3523 __rwsem_down_write_failed_common+0xbbc/0x15e0 kernel/locking/rwsem-xadd.c:577 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0xa5/0x130 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:745 [inline] do_truncate+0x1b0/0x2d0 fs/open.c:61 handle_truncate fs/namei.c:3008 [inline] do_last fs/namei.c:3424 [inline] path_openat+0x375c/0x5160 fs/namei.c:3534 do_filp_open+0x255/0x380 fs/namei.c:3564 do_sys_open+0x568/0x700 fs/open.c:1063 ksys_open include/linux/syscalls.h:1292 [inline] __do_sys_creat fs/open.c:1121 [inline] __se_sys_creat fs/open.c:1119 [inline] __x64_sys_creat+0x61/0x80 fs/open.c:1119 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457679 Code: Bad RIP value. RSP: 002b:00007f8d14783c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 00007f8d147846d4 RCX: 0000000000457679 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00000000200000c0 RBP: 000000000072c040 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000004cc688 R14: 00000000004bdcdc R15: 0000000000000002 INFO: task syz-executor0:21394 blocked for more than 140 seconds. Not tainted 4.19.0-rc4-next-20180921+ #77 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D23432 21394 9977 0x00000004 Call Trace: context_switch kernel/sched/core.c:2830 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3479 schedule+0xfe/0x460 kernel/sched/core.c:3523 __rwsem_down_write_failed_common+0xbbc/0x15e0 kernel/locking/rwsem-xadd.c:577 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0xa5/0x130 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:745 [inline] ext4_fallocate+0x917/0x22e0 fs/ext4/extents.c:4957 vfs_fallocate+0x4b4/0x940 fs/open.c:308 ksys_fallocate+0x56/0x90 fs/open.c:331 __do_sys_fallocate fs/open.c:339 [inline] __se_sys_fallocate fs/open.c:337 [inline] __x64_sys_fallocate+0x97/0xf0 fs/open.c:337 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457679 Code: Bad RIP value. RSP: 002b:00007f8d14762c78 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 00007f8d147636d4 RCX: 0000000000457679 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000004 RBP: 000000000072c0e0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000010000 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000004cc868 R14: 00000000004bddb5 R15: 0000000000000003 INFO: task syz-executor0:21395 blocked for more than 140 seconds. Not tainted 4.19.0-rc4-next-20180921+ #77 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D25456 21395 9977 0x00000004 Call Trace: context_switch kernel/sched/core.c:2830 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3479 schedule+0xfe/0x460 kernel/sched/core.c:3523 __rwsem_down_write_failed_common+0xbbc/0x15e0 kernel/locking/rwsem-xadd.c:577 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0xa5/0x130 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:745 [inline] ext4_fallocate+0x917/0x22e0 fs/ext4/extents.c:4957 vfs_fallocate+0x4b4/0x940 fs/open.c:308 ksys_fallocate+0x56/0x90 fs/open.c:331 __do_sys_fallocate fs/open.c:339 [inline] __se_sys_fallocate fs/open.c:337 [inline] __x64_sys_fallocate+0x97/0xf0 fs/open.c:337 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457679 Code: Bad RIP value. RSP: 002b:00007f8d14741c78 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 00007f8d147426d4 RCX: 0000000000457679 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 000000000072c180 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000010001 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000004cc868 R14: 00000000004bddb5 R15: 0000000000000004 Showing all locks held in the system: 4 locks held by kworker/u4:0/7: #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: __write_once_size include/linux/compiler.h:215 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 000000004cdd89f0 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0xb43/0x1b80 kernel/workqueue.c:2124 #1: 00000000c291343e ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0xb9a/0x1b80 kernel/workqueue.c:2128 #2: 00000000c126cc51 (&fc->fs_type->s_umount_key#30){++++}, at: trylock_super+0x22/0x110 fs/super.c:411 #3: 0000000090120c6c (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x9a/0x1a0 mm/page-writeback.c:2340 1 lock held by khungtaskd/982: #0: 000000002f93fe4e (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4435 3 locks held by rs:main Q:Reg/5447: #0: 00000000724da91a (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 #1: 00000000df7caef1 (sb_writers#5){.+.+}, at: file_start_write include/linux/fs.h:2784 [inline] #1: 00000000df7caef1 (sb_writers#5){.+.+}, at: vfs_write+0x42a/0x560 fs/read_write.c:548 #2: 000000001374c919 (&sb->s_type->i_mutex_key#12){+.+.}, at: inode_trylock include/linux/fs.h:770 [inline] #2: 000000001374c919 (&sb->s_type->i_mutex_key#12){+.+.}, at: ext4_file_write_iter+0x2a1/0x1420 fs/ext4/file.c:232 1 lock held by rsyslogd/5449: #0: 000000005fec2675 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 2 locks held by getty/5539: #0: 000000004cf5d0cd (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000004ac1acec (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5540: #0: 000000009f61a56f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 0000000011db9b90 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5541: #0: 000000002caae233 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000d4c4a436 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5542: #0: 000000009f100afe (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000bac5264c (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5543: #0: 000000006ec7cd29 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000da2cd7e5 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5544: #0: 00000000a890fcbf (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000005ca7ff43 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5545: #0: 00000000449a8cb6 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000615266f9 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by syz-executor2/8998: #0: 000000002f63ebf8 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000084ce3c2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 1 lock held by syz-executor0/10631: #0: 000000000d5e47ad (sb_internal){.+.+}, at: sb_start_intwrite include/linux/fs.h:1630 [inline] #0: 000000000d5e47ad (sb_internal){.+.+}, at: ext4_evict_inode+0x68b/0x1ad0 fs/ext4/inode.c:250 2 locks held by syz-executor0/21338: #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: sb_start_write include/linux/fs.h:1583 [inline] #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 00000000d1bee10d (&sb->s_type->i_mutex_key#12){+.+.}, at: inode_lock include/linux/fs.h:745 [inline] #1: 00000000d1bee10d (&sb->s_type->i_mutex_key#12){+.+.}, at: do_truncate+0x1b0/0x2d0 fs/open.c:61 6 locks held by syz-executor0/21346: 2 locks held by syz-executor0/21393: #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: sb_start_write include/linux/fs.h:1583 [inline] #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 000000000daffbee (&sb->s_type->i_mutex_key#12){+.+.}, at: inode_lock include/linux/fs.h:745 [inline] #1: 000000000daffbee (&sb->s_type->i_mutex_key#12){+.+.}, at: do_truncate+0x1b0/0x2d0 fs/open.c:61 2 locks held by syz-executor0/21394: #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: file_start_write include/linux/fs.h:2784 [inline] #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: vfs_fallocate+0x72a/0x940 fs/open.c:307 #1: 000000000daffbee (&sb->s_type->i_mutex_key#12){+.+.}, at: inode_lock include/linux/fs.h:745 [inline] #1: 000000000daffbee (&sb->s_type->i_mutex_key#12){+.+.}, at: ext4_fallocate+0x917/0x22e0 fs/ext4/extents.c:4957 2 locks held by syz-executor0/21395: #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: file_start_write include/linux/fs.h:2784 [inline] #0: 00000000df7caef1 (sb_writers#5){.+.+}, at: vfs_fallocate+0x72a/0x940 fs/open.c:307 #1: 00000000d1bee10d (&sb->s_type->i_mutex_key#12){+.+.}, at: inode_lock include/linux/fs.h:745 [inline] #1: 00000000d1bee10d (&sb->s_type->i_mutex_key#12){+.+.}, at: ext4_fallocate+0x917/0x22e0 fs/ext4/extents.c:4957 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 982 Comm: khungtaskd Not tainted 4.19.0-rc4-next-20180921+ #77 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+0x1d3/0x2c4 lib/dump_stack.c:113 nmi_cpu_backtrace.cold.4+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1c2/0x22c 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:144 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:204 [inline] watchdog+0xb39/0x1050 kernel/hung_task.c:265 kthread+0x35a/0x440 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 0 to CPUs 1: INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.259 msecs NMI backtrace for cpu 1 CPU: 1 PID: 21346 Comm: syz-executor0 Not tainted 4.19.0-rc4-next-20180921+ #77 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:ext4_find_extent+0x80/0x9b0 fs/ext4/extents.c:866 Code: 0f 85 f3 07 00 00 48 8b 45 a8 48 83 7d a0 00 44 0f bf a0 16 fe ff ff 44 89 e3 66 44 89 65 d0 0f 84 7a 06 00 00 e8 b0 29 6c ff <48> 8b 55 a0 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 80 3c 02 00 RSP: 0018:ffff880193b4f150 EFLAGS: 00000246 RAX: 0000000000040000 RBX: 0000000000000000 RCX: ffffc9000b692000 RDX: 0000000000040000 RSI: ffffffff82112780 RDI: ffff880185d6b646 RBP: ffff880193b4f1b0 R08: ffff8801bfd26280 R09: ffffed003b585b57 R10: ffffed003b585b57 R11: ffff8801dac2dabb R12: 0000000000000000 R13: 00000000ffd46700 R14: ffff880185d6b640 R15: ffff880193b4f3e0 FS: 00007f8d147a5700(0000) GS:ffff8801dad00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001c3e4b000 CR4: 00000000001406e0 Call Trace: get_ext_path fs/ext4/move_extent.c:31 [inline] mext_check_coverage.constprop.13+0x2b0/0x510 fs/ext4/move_extent.c:98 move_extent_per_page fs/ext4/move_extent.c:323 [inline] ext4_move_extents+0x2784/0x3c20 fs/ext4/move_extent.c:669 ext4_ioctl+0x314f/0x4210 fs/ext4/ioctl.c:799 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:501 [inline] do_vfs_ioctl+0x1de/0x1720 fs/ioctl.c:685 ksys_ioctl+0xa9/0xd0 fs/ioctl.c:702 __do_sys_ioctl fs/ioctl.c:709 [inline] __se_sys_ioctl fs/ioctl.c:707 [inline] __x64_sys_ioctl+0x73/0xb0 fs/ioctl.c:707 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457679 Code: 1d b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 eb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007f8d147a4c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007f8d147a56d4 RCX: 0000000000457679 RDX: 0000000020000040 RSI: 00000000c028660f RDI: 0000000000000003 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 00000000004cf3d0 R14: 00000000004bf70f R15: 0000000000000001