b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 INFO: task syz-executor5:17590 blocked for more than 140 seconds. __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 Not tainted 4.20.0+ #9 device loop0 blocksize: 4096 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. __find_get_block_slow() failed. block=1, b_blocknr=8 syz-executor5 D24648 17590 8314 0x00000004 b_state=0x00000029, b_size=512 Call Trace: device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 context_switch kernel/sched/core.c:2831 [inline] __schedule+0x897/0x1e90 kernel/sched/core.c:3472 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 schedule+0xfe/0x350 kernel/sched/core.c:3516 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 wb_wait_for_completion+0x1e0/0x2d0 fs/fs-writeback.c:221 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 sync_inodes_sb+0x335/0x490 fs/fs-writeback.c:2417 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 sync_inodes_one_sb+0x57/0x70 fs/sync.c:74 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 iterate_supers+0x149/0x290 fs/super.c:633 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 ksys_sync+0xdf/0x1d0 fs/sync.c:113 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __ia32_sys_sync+0xe/0x20 fs/sync.c:124 __find_get_block_slow() failed. block=1, b_blocknr=8 do_syscall_64+0x1a3/0x800 arch/x86/entry/common.c:290 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 entry_SYSCALL_64_after_hwframe+0x49/0xbe device loop0 blocksize: 4096 RIP: 0033:0x457ec9 __find_get_block_slow() failed. block=1, b_blocknr=8 Code: Bad RIP value. b_state=0x00000029, b_size=512 RSP: 002b:00007f85ca917c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2 device loop0 blocksize: 4096 RAX: ffffffffffffffda RBX: 000000000073bf08 RCX: 0000000000457ec9 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 __find_get_block_slow() failed. block=1, b_blocknr=8 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f85ca9186d4 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 R13: 00000000004c4101 R14: 00000000004daff0 R15: 00000000ffffffff b_state=0x00000029, b_size=512 INFO: task syz-executor5:17601 blocked for more than 140 seconds. device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 Not tainted 4.20.0+ #9 b_state=0x00000029, b_size=512 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 syz-executor5 D25416 17601 8314 0x00000004 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 Call Trace: b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 context_switch kernel/sched/core.c:2831 [inline] __schedule+0x897/0x1e90 kernel/sched/core.c:3472 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 schedule+0xfe/0x350 kernel/sched/core.c:3516 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 wb_wait_for_completion+0x1e0/0x2d0 fs/fs-writeback.c:221 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 sync_inodes_sb+0x335/0x490 fs/fs-writeback.c:2417 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 sync_inodes_one_sb+0x57/0x70 fs/sync.c:74 device loop0 blocksize: 4096 iterate_supers+0x149/0x290 fs/super.c:633 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 ksys_sync+0xdf/0x1d0 fs/sync.c:113 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 __ia32_sys_sync+0xe/0x20 fs/sync.c:124 device loop0 blocksize: 4096 do_syscall_64+0x1a3/0x800 arch/x86/entry/common.c:290 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 entry_SYSCALL_64_after_hwframe+0x49/0xbe b_state=0x00000029, b_size=512 RIP: 0033:0x457ec9 device loop0 blocksize: 4096 Code: Bad RIP value. __find_get_block_slow() failed. block=1, b_blocknr=8 RSP: 002b:00007f85ca8f6c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 RAX: ffffffffffffffda RBX: 000000000073bfa8 RCX: 0000000000457ec9 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 b_state=0x00000029, b_size=512 RBP: 000000000073bfa0 R08: 0000000000000000 R09: 0000000000000000 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f85ca8f76d4 b_state=0x00000029, b_size=512 R13: 00000000004c4101 R14: 00000000004daff0 R15: 00000000ffffffff device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 Showing all locks held in the system: b_state=0x00000029, b_size=512 1 lock held by khungtaskd/1039: device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 000000004c2743f4 (rcu_read_lock){....}, at: debug_show_all_locks+0xc6/0x41d kernel/locking/lockdep.c:4389 b_state=0x00000029, b_size=512 1 lock held by rsyslogd/8115: device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 00000000c6f5183f (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1b3/0x1f0 fs/file.c:795 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 2 locks held by getty/8259: b_state=0x00000029, b_size=512 #0: 00000000209e2597 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000cc7c6d97 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 2 locks held by getty/8260: __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 0000000035ba714b (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 b_state=0x00000029, b_size=512 #1: 000000007e38a0ae (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 device loop0 blocksize: 4096 2 locks held by getty/8261: __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 0000000003a1eee5 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000bb248839 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 2 locks held by getty/8262: b_state=0x00000029, b_size=512 #0: 00000000e96d019e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 000000008b098c28 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/8263: device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 000000009f76da46 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000afa945ad (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/8264: device loop0 blocksize: 4096 #0: 000000002533c804 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 000000002a05694b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 2 locks held by getty/8265: b_state=0x00000029, b_size=512 #0: 0000000006cfdf4d (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 device loop0 blocksize: 4096 #1: 00000000b800a898 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0 drivers/tty/n_tty.c:2154 __find_get_block_slow() failed. block=1, b_blocknr=8 7 locks held by kworker/u4:6/9993: b_state=0x00000029, b_size=512 1 lock held by syz-executor5/17590: device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 00000000d67062f6 (&type->s_umount_key#63){++++}, at: iterate_supers+0xe2/0x290 fs/super.c:631 b_state=0x00000029, b_size=512 1 lock held by syz-executor5/17601: device loop0 blocksize: 4096 #0: 00000000d67062f6 (&type->s_umount_key#63){++++}, at: iterate_supers+0xe2/0x290 fs/super.c:631 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 ============================================= device loop0 blocksize: 4096 NMI backtrace for cpu 0 __find_get_block_slow() failed. block=1, b_blocknr=8 CPU: 0 PID: 1039 Comm: khungtaskd Not tainted 4.20.0+ #9 b_state=0x00000029, b_size=512 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: device loop0 blocksize: 4096 __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1db/0x2d0 lib/dump_stack.c:113 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 nmi_cpu_backtrace.cold+0x63/0xa4 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1be/0x236 lib/nmi_backtrace.c:62 __find_get_block_slow() failed. block=1, b_blocknr=8 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 b_state=0x00000029, b_size=512 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline] watchdog+0xbd2/0x10b0 kernel/hung_task.c:289 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 kthread+0x357/0x430 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 __find_get_block_slow() failed. block=1, b_blocknr=8 Sending NMI from CPU 0 to CPUs 1: b_state=0x00000029, b_size=512 NMI backtrace for cpu 1 CPU: 1 PID: 9993 Comm: kworker/u4:6 Not tainted 4.20.0+ #9 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: writeback wb_workfn (flush-7:0) RIP: 0010:number+0x81d/0xc80 lib/vsprintf.c:521 Code: ff e8 67 e7 92 f9 31 ff 44 89 f6 44 89 b5 24 ff ff ff e8 d6 e8 92 f9 45 85 f6 0f 88 42 03 00 00 4d 63 ee 4c 03 ad 28 ff ff ff <89> 9d 28 ff ff ff 4d 89 fc 48 8b 9d 30 ff ff ff e8 2e e7 92 f9 4c RSP: 0018:ffff88804d7d6318 EFLAGS: 00000086 RAX: 0000000000000000 RBX: 00000000fffffffd RCX: ffffffff87ef0dfa RDX: 0000000000000002 RSI: 0000000000000000 RDI: 0000000000000005 RBP: ffff88804d7d6438 R08: ffff88807fa94200 R09: ffffed1009afaccd R10: ffffed1009afaccc R11: ffff88804d7d6660 R12: 0000000000000002 R13: ffff88804d7d63b2 R14: 0000000000000002 R15: ffff88804d7d6663 FS: 0000000000000000(0000) GS:ffff8880ae700000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000024030f0 CR3: 00000000a416a000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: vsnprintf+0x2a9/0x1b10 lib/vsprintf.c:2462 sprintf+0xc0/0x100 lib/vsprintf.c:2598 print_time kernel/printk/printk.c:1239 [inline] print_prefix kernel/printk/printk.c:1251 [inline] msg_print_text+0x3f3/0x450 kernel/printk/printk.c:1262 console_unlock+0x43f/0x11e0 kernel/printk/printk.c:2383 vprintk_emit+0x370/0x960 kernel/printk/printk.c:1931 vprintk_default+0x28/0x30 kernel/printk/printk.c:1958 vprintk_func+0x7e/0x189 kernel/printk/printk_safe.c:398 printk+0xba/0xed kernel/printk/printk.c:1991 __find_get_block_slow fs/buffer.c:235 [inline] __find_get_block fs/buffer.c:1294 [inline] __find_get_block.cold+0x81/0xfb fs/buffer.c:1288 __getblk_slow fs/buffer.c:1039 [inline] __getblk_gfp+0x295/0xd20 fs/buffer.c:1320 __bread_gfp+0x2f/0x300 fs/buffer.c:1354 sb_bread include/linux/buffer_head.h:307 [inline] __fat_write_inode+0x33a/0xb70 fs/fat/inode.c:859 fat_write_inode+0x96/0x190 fs/fat/inode.c:908 write_inode fs/fs-writeback.c:1176 [inline] __writeback_single_inode+0xef1/0x1620 fs/fs-writeback.c:1375 writeback_sb_inodes+0x762/0x1260 fs/fs-writeback.c:1580 __writeback_inodes_wb+0x16d/0x3d0 fs/fs-writeback.c:1649 wb_writeback+0xa2d/0xf70 fs/fs-writeback.c:1758 wb_check_old_data_flush fs/fs-writeback.c:1860 [inline] wb_do_writeback fs/fs-writeback.c:1913 [inline] wb_workfn+0xf7f/0x16f0 fs/fs-writeback.c:1942 process_one_work+0xd0c/0x1ce0 kernel/workqueue.c:2153 worker_thread+0x143/0x14a0 kernel/workqueue.c:2296 kthread+0x357/0x430 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 2.133 msecs