IPVS: length: 68 != 24 IPVS: length: 68 != 24 INFO: task jbd2/sda1-8:3078 blocked for more than 140 seconds. Not tainted 4.19.0-rc6+ #139 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. jbd2/sda1-8 D18264 3078 2 0x80000000 Call Trace: context_switch kernel/sched/core.c:2825 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3473 schedule+0xfe/0x460 kernel/sched/core.c:3517 jbd2_journal_commit_transaction+0xd42/0x89f8 fs/jbd2/commit.c:435 kjournald2+0x26d/0xb30 fs/jbd2/journal.c:229 kthread+0x35a/0x420 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:413 INFO: task syz-executor5:7046 blocked for more than 140 seconds. Not tainted 4.19.0-rc6+ #139 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor5 D23160 7046 5527 0x00000004 Call Trace: context_switch kernel/sched/core.c:2825 [inline] __schedule+0x86c/0x1ed0 kernel/sched/core.c:3473 schedule+0xfe/0x460 kernel/sched/core.c:3517 __rwsem_down_write_failed_common+0xbb9/0x1670 kernel/locking/rwsem-xadd.c:566 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:595 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 ext4_map_blocks+0x88f/0x1b50 fs/ext4/inode.c:629 mpage_map_one_extent fs/ext4/inode.c:2450 [inline] mpage_map_and_submit_extent fs/ext4/inode.c:2503 [inline] ext4_writepages+0x2622/0x4110 fs/ext4/inode.c:2854 do_writepages+0x9a/0x1a0 mm/page-writeback.c:2340 __filemap_fdatawrite_range+0x364/0x4a0 mm/filemap.c:445 __filemap_fdatawrite mm/filemap.c:453 [inline] filemap_flush+0x23/0x30 mm/filemap.c:478 ext4_alloc_da_blocks+0x310/0x4c0 fs/ext4/inode.c:3245 ext4_release_file+0x275/0x440 fs/ext4/file.c:88 __fput+0x385/0xa30 fs/file_table.c:278 ____fput+0x15/0x20 fs/file_table.c:309 task_work_run+0x1e8/0x2a0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x318/0x380 arch/x86/entry/common.c:166 prepare_exit_to_usermode arch/x86/entry/common.c:197 [inline] syscall_return_slowpath arch/x86/entry/common.c:268 [inline] do_syscall_64+0x6be/0x820 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x410ff1 Code: 7a 01 48 63 ff 89 54 24 10 4c 89 54 24 08 e8 76 a5 ff ff 48 85 c0 49 89 c7 49 89 44 24 58 8b 54 24 10 4c 8b 54 24 08 0f 84 f2 <00> 00 00 48 63 ca 4c 89 f6 48 89 c7 48 89 ca 48 89 4c 24 10 4c 89 RSP: 002b:00007ffc9a595bd0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000410ff1 RDX: 0000000000000000 RSI: 0000000000730dd8 RDI: 0000000000000004 RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 R10: 00007ffc9a595b00 R11: 0000000000000293 R12: 0000000000000000 R13: 0000000000000001 R14: 0000000000000002 R15: 0000000000000005 Showing all locks held in the system: 4 locks held by kworker/u4:3/629: #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: __write_once_size include/linux/compiler.h:215 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0xb43/0x1b90 kernel/workqueue.c:2124 #1: 00000000cc4fca42 ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0xb9a/0x1b90 kernel/workqueue.c:2128 #2: 0000000037563291 (&type->s_umount_key#30){++++}, at: trylock_super+0x22/0x110 fs/super.c:412 #3: 00000000fbfc97c4 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x9a/0x1a0 mm/page-writeback.c:2340 1 lock held by khungtaskd/982: #0: 00000000bbcb56db (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4435 4 locks held by kworker/u4:4/2754: #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: __write_once_size include/linux/compiler.h:215 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 0000000090680966 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0xb43/0x1b90 kernel/workqueue.c:2124 #1: 0000000033316696 ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0xb9a/0x1b90 kernel/workqueue.c:2128 #2: 0000000037563291 (&type->s_umount_key#30){++++}, at: trylock_super+0x22/0x110 fs/super.c:412 #3: 00000000fbfc97c4 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x9a/0x1a0 mm/page-writeback.c:2340 3 locks held by rs:main Q:Reg/5251: #0: 0000000039c7b046 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 #1: 0000000004f9aafa (sb_writers#3){.+.+}, at: file_start_write include/linux/fs.h:2761 [inline] #1: 0000000004f9aafa (sb_writers#3){.+.+}, at: vfs_write+0x42a/0x560 fs/read_write.c:548 #2: 0000000008eb6a44 (&sb->s_type->i_mutex_key#10){+.+.}, at: inode_trylock include/linux/fs.h:758 [inline] #2: 0000000008eb6a44 (&sb->s_type->i_mutex_key#10){+.+.}, at: ext4_file_write_iter+0x2a1/0x1420 fs/ext4/file.c:232 1 lock held by rsyslogd/5254: #0: 000000004dca7cc6 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 2 locks held by getty/5344: #0: 00000000d31319fa (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000008a9b2deb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5345: #0: 0000000047eb3a63 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000009147cf9b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5346: #0: 000000009a91caa8 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000a0afa0de (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5347: #0: 00000000e96d6ab9 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000fb7ebd5e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5348: #0: 000000004ddd1274 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000009cbf9904 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5349: #0: 00000000596560b7 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 0000000083b9b74f (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/5350: #0: 0000000045de9c35 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000008aae51b3 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 3 locks held by syz-executor5/7046: #0: 00000000fbfc97c4 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x9a/0x1a0 mm/page-writeback.c:2340 #1: 00000000838aef04 (jbd2_handle){++++}, at: start_this_handle+0x581/0x1250 fs/jbd2/transaction.c:383 #2: 00000000a2d31862 (&ei->i_data_sem){++++}, at: ext4_map_blocks+0x88f/0x1b50 fs/ext4/inode.c:629 6 locks held by syz-executor5/7063: ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 982 Comm: khungtaskd Not tainted 4.19.0-rc6+ #139 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+0x1c4/0x2b4 lib/dump_stack.c:113 nmi_cpu_backtrace.cold.3+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1b3/0x1ed 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+0xb3e/0x1050 kernel/hung_task.c:265 kthread+0x35a/0x420 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:413 Sending NMI from CPU 0 to CPUs 1: INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.335 msecs NMI backtrace for cpu 1 CPU: 1 PID: 7063 Comm: syz-executor5 Not tainted 4.19.0-rc6+ #139 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:mext_check_coverage.constprop.13+0x18f/0x510 fs/ext4/move_extent.c:98 Code: 00 00 00 00 fc ff df 48 c1 ea 03 80 3c 02 00 0f 85 e3 02 00 00 4c 89 fa 48 89 5d 98 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 <0f> b6 04 02 84 c0 74 08 3c 03 0f 8e cf 02 00 00 41 c7 07 00 00 00 RSP: 0018:ffff8801cd5a71c0 EFLAGS: 00000a02 RAX: dffffc0000000000 RBX: ffff8801cc52e780 RCX: ffffc9000c0ef000 RDX: 1ffff10039ab4e7c RSI: ffffffff821e6b7b RDI: ffff8801cc52e790 RBP: ffff8801cd5a7270 R08: ffff8801c6532200 R09: 1ffffffff1273965 R10: ffffed003b5c4732 R11: ffff8801dae23993 R12: ffff8801cc52e780 R13: 0000000095017bb4 R14: ffff8801c51d0530 R15: ffff8801cd5a73e0 FS: 00007f0482bbd700(0000) GS:ffff8801daf00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001c10bc000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: move_extent_per_page fs/ext4/move_extent.c:323 [inline] ext4_move_extents+0x2784/0x3c20 fs/ext4/move_extent.c:669 ext4_ioctl+0x3154/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:0x457519 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:00007f0482bbcc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457519 RDX: 0000000020000300 RSI: 00000000c028660f RDI: 0000000000000007 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f0482bbd6d4 R13: 00000000004bf57c R14: 00000000004cf400 R15: 00000000ffffffff