kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 INFO: task syz-executor4:31137 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor4 D24560 31137 6028 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 wb_wait_for_completion+0x1f9/0x2d0 fs/fs-writeback.c:221 sync_inodes_sb+0x33e/0x480 fs/fs-writeback.c:2417 sync_inodes_one_sb+0x59/0x70 fs/sync.c:74 iterate_supers+0x149/0x290 fs/super.c:724 ksys_sync+0xec/0x1e0 fs/sync.c:113 __ia32_sys_sync+0xe/0x20 fs/sync.c:124 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: Bad RIP value. RSP: 002b:00007f8e8e269c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2 RAX: ffffffffffffffda RBX: 000000000072bfa8 RCX: 0000000000457569 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f8e8e26a6d4 R13: 00000000004c3156 R14: 00000000004d8190 R15: 00000000ffffffff INFO: task syz-executor4:31189 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor4 D24560 31189 6028 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 wb_wait_for_completion+0x1f9/0x2d0 fs/fs-writeback.c:221 sync_inodes_sb+0x33e/0x480 fs/fs-writeback.c:2417 sync_inodes_one_sb+0x59/0x70 fs/sync.c:74 iterate_supers+0x149/0x290 fs/super.c:724 ksys_sync+0xec/0x1e0 fs/sync.c:113 kworker/u4:5(3036): getblk(): executed=9 bh_count=0 bh_state=0 __ia32_sys_sync+0xe/0x20 fs/sync.c:124 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: Bad RIP value. RSP: 002b:00007f8e8e248c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2 RAX: ffffffffffffffda RBX: 000000000072c048 RCX: 0000000000457569 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 RBP: 000000000072c040 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f8e8e2496d4 R13: 00000000004c3156 R14: 00000000004d8190 R15: 00000000ffffffff Showing all locks held in the system: 1 lock held by khungtaskd/1009: #0: 00000000b42bfb49 (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4379 4 locks held by kworker/u4:5/3036: 3 locks held by rs:main Q:Reg/5795: #0: 00000000a6c92c0b (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 #1: 000000003d54207e (sb_writers#3){.+.+}, at: file_start_write include/linux/fs.h:2828 [inline] #1: 000000003d54207e (sb_writers#3){.+.+}, at: vfs_write+0x42a/0x560 fs/read_write.c:548 #2: 000000004a061cc0 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x9a/0x1a0 mm/page-writeback.c:2328 1 lock held by rsyslogd/5797: #0: 00000000b536d09a (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 2 locks held by getty/5887: #0: 000000005dffa97f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000845232e2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5888: #0: 00000000eed46495 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000e0a0c98a (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5889: #0: 000000005521e4ed (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000db6cfb24 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5890: #0: 0000000031f7ccd2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000004f4f7814 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5891: #0: 0000000017f6e3f2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000f3386946 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5892: #0: 0000000051b7e6c2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000bf4dd0dc (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/5893: #0: 000000009d0beb1d (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000e3306453 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 1 lock held by syz-executor4/31137: #0: 000000003fc81b88 (&fc->fs_type->s_umount_key#57){++++}, at: iterate_supers+0xe2/0x290 fs/super.c:722 1 lock held by syz-executor4/31189: #0: 000000003fc81b88 (&fc->fs_type->s_umount_key#57){++++}, at: iterate_supers+0xe2/0x290 fs/super.c:722 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1009 Comm: khungtaskd Not tainted 4.20.0-rc1-next-20181109+ #110 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+0x244/0x39d lib/dump_stack.c:113 nmi_cpu_backtrace.cold.2+0x5c/0xa1 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1e8/0x22a 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:205 [inline] watchdog+0xb4c/0x1060 kernel/hung_task.c:289 kthread+0x35a/0x440 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 2.210 msecs NMI backtrace for cpu 0 CPU: 0 PID: 3036 Comm: kworker/u4:5 Not tainted 4.20.0-rc1-next-20181109+ #110 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: writeback wb_workfn (flush-7:0) RIP: 0010:__sanitizer_cov_trace_pc+0x8/0x50 kernel/kcov.c:97 Code: d0 72 1b 49 83 c1 01 4a 89 7c 10 e0 4a 89 74 10 e8 4a 89 54 10 f0 4a 89 4c d8 20 4c 89 08 5d c3 66 90 55 48 89 e5 48 8b 75 08 <65> 48 8b 04 25 40 ee 01 00 65 8b 15 08 45 82 7e 81 e2 00 01 1f 00 RSP: 0018:ffff8801ca4ed880 EFLAGS: 00000293 RAX: ffff8801ca4a4540 RBX: 0000000000000001 RCX: ffffffff8392065a RDX: 0000000000000000 RSI: ffffffff83920668 RDI: 0000000000000005 RBP: ffff8801ca4ed880 R08: ffff8801ca4a4540 R09: ffffed003b5c5b67 R10: ffffed003b5c5b67 R11: ffff8801dae2db3b R12: 0000000000000000 R13: ffffffff8860fe20 R14: ffffffff8860fde0 R15: ffff8801ca4edbc8 FS: 0000000000000000(0000) GS:ffff8801dae00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001c3337000 CR4: 00000000001426f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: check_preemption_disabled+0x48/0x280 lib/smp_processor_id.c:51 debug_smp_processor_id+0x1c/0x20 lib/smp_processor_id.c:56 rcu_lockdep_current_cpu_online+0xc9/0x210 kernel/rcu/tree.c:980 rcu_read_lock_held+0x90/0xc0 kernel/rcu/update.c:279 xa_head include/linux/xarray.h:832 [inline] xas_start+0x2f7/0x740 lib/xarray.c:182 xas_load+0x21/0x1e0 lib/xarray.c:227 find_get_entry+0x3ca/0x1120 mm/filemap.c:1415 pagecache_get_page+0x12f/0xf00 mm/filemap.c:1518 find_get_page_flags include/linux/pagemap.h:278 [inline] __find_get_block_slow fs/buffer.c:205 [inline] __find_get_block+0x635/0xf10 fs/buffer.c:1325 __getblk_slow fs/buffer.c:1058 [inline] __getblk_gfp+0x3d3/0x1030 fs/buffer.c:1351 __bread_gfp+0x2d/0x310 fs/buffer.c:1385 sb_bread include/linux/buffer_head.h:307 [inline] __fat_write_inode+0x347/0xb60 fs/fat/inode.c:860 fat_write_inode+0x97/0x180 fs/fat/inode.c:909 write_inode fs/fs-writeback.c:1176 [inline] __writeback_single_inode+0xf4a/0x1650 fs/fs-writeback.c:1375 writeback_sb_inodes+0x71f/0x1210 fs/fs-writeback.c:1580 __writeback_inodes_wb+0x1b9/0x340 fs/fs-writeback.c:1649 wb_writeback+0xa5d/0xfa0 fs/fs-writeback.c:1758 wb_check_start_all fs/fs-writeback.c:1882 [inline] wb_do_writeback fs/fs-writeback.c:1908 [inline] wb_workfn+0xedf/0x1780 fs/fs-writeback.c:1942 process_one_work+0xc8b/0x1c40 kernel/workqueue.c:2153 worker_thread+0x17f/0x1390 kernel/workqueue.c:2296 kthread+0x35a/0x440 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352