b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 syz-executor0(13286): getblk(): executed=9 bh_count=0 bh_state=0 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 INFO: task syz-executor0:13324 blocked for more than 140 seconds. device loop0 blocksize: 4096 Not tainted 4.19.0-next-20181102+ #104 __find_get_block_slow() failed. block=1, b_blocknr=8 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. b_state=0x00000029, b_size=512 syz-executor0 D24800 13324 5704 0x00000004 device loop0 blocksize: 4096 Call Trace: __find_get_block_slow() failed. block=1, b_blocknr=8 context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 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 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 schedule+0xfe/0x460 kernel/sched/core.c:3516 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 d_wait_lookup fs/dcache.c:2408 [inline] d_alloc_parallel+0x1478/0x1f40 fs/dcache.c:2490 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 lookup_open+0x560/0x1b90 fs/namei.c:3147 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 do_last fs/namei.c:3324 [inline] path_openat+0x2464/0x5150 fs/namei.c:3534 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 __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 do_filp_open+0x255/0x380 fs/namei.c:3564 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 do_sys_open+0x568/0x700 fs/open.c:1063 __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 __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 __find_get_block_slow() failed. block=1, b_blocknr=8 do_syscall_64+0x1b9/0x820 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 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 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 RIP: 0033:0x457569 device loop0 blocksize: 4096 Code: Bad RIP value. __find_get_block_slow() failed. block=1, b_blocknr=8 RSP: 002b:00007fea6ae22c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 b_state=0x00000029, b_size=512 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 device loop0 blocksize: 4096 RDX: 0000000000000002 RSI: 0000000020000080 RDI: 0000000000000005 __find_get_block_slow() failed. block=1, b_blocknr=8 RBP: 000000000072c040 R08: 0000000000000000 R09: 0000000000000000 b_state=0x00000029, b_size=512 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fea6ae236d4 device loop0 blocksize: 4096 R13: 00000000004c2d6f R14: 00000000004d4630 R15: 00000000ffffffff __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/1009: device loop0 blocksize: 4096 #0: 0000000045455c11 (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4379 __find_get_block_slow() failed. block=1, b_blocknr=8 1 lock held by rsyslogd/5576: b_state=0x00000029, b_size=512 2 locks held by getty/5666: device loop0 blocksize: 4096 #0: 0000000095d2aaf3 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000d997accf (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/5667: #0: 00000000e795a766 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 device loop0 blocksize: 4096 #1: 00000000cc630069 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 __find_get_block_slow() failed. block=1, b_blocknr=8 2 locks held by getty/5668: b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 #0: 00000000fa511246 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000bdb532fc (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/5669: device loop0 blocksize: 4096 #0: 00000000fbd1e6ab (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000b989fbf5 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/5670: device loop0 blocksize: 4096 #0: 00000000753b7f4f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000c8431eab (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 b_state=0x00000029, b_size=512 2 locks held by getty/5671: device loop0 blocksize: 4096 #0: 00000000c9b7fd9e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000805aba38 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 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/5672: b_state=0x00000029, b_size=512 #0: 00000000ba245a3a (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 device loop0 blocksize: 4096 #1: 0000000043895282 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 __find_get_block_slow() failed. block=1, b_blocknr=8 7 locks held by syz-executor0/13286: b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 2 locks held by syz-executor0/13324: b_state=0x00000029, b_size=512 #0: 00000000f36721d1 (sb_writers#18){.+.+}, at: sb_start_write include/linux/fs.h:1604 [inline] #0: 00000000f36721d1 (sb_writers#18){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 device loop0 blocksize: 4096 #1: 000000007feb92f4 (&sb->s_type->i_mutex_key#25){++++}, at: inode_lock_shared include/linux/fs.h:774 [inline] #1: 000000007feb92f4 (&sb->s_type->i_mutex_key#25){++++}, at: do_last fs/namei.c:3323 [inline] #1: 000000007feb92f4 (&sb->s_type->i_mutex_key#25){++++}, at: path_openat+0x2444/0x5150 fs/namei.c:3534 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 ============================================= NMI backtrace for cpu 1 __find_get_block_slow() failed. block=1, b_blocknr=8 CPU: 1 PID: 1009 Comm: khungtaskd Not tainted 4.19.0-next-20181102+ #104 b_state=0x00000029, b_size=512 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 device loop0 blocksize: 4096 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 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 kthread+0x35a/0x440 kernel/kthread.c:246 device loop0 blocksize: 4096 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: __find_get_block_slow() failed. block=1, b_blocknr=8 NMI backtrace for cpu 0 CPU: 0 PID: 13286 Comm: syz-executor0 Not tainted 4.19.0-next-20181102+ #104 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__read_once_size include/linux/compiler.h:182 [inline] RIP: 0010:check_kcov_mode kernel/kcov.c:69 [inline] RIP: 0010:write_comp_data+0x22/0x70 kernel/kcov.c:122 Code: 90 90 90 90 90 90 90 90 55 48 89 e5 65 4c 8b 04 25 40 ee 01 00 65 8b 05 bc 85 82 7e a9 00 01 1f 00 75 51 41 8b 80 d8 12 00 00 <83> f8 03 75 45 49 8b 80 e0 12 00 00 45 8b 80 dc 12 00 00 4c 8b 08 RSP: 0018:ffff88017f7465a8 EFLAGS: 00000046 RAX: 0000000000000002 RBX: 0000000000000007 RCX: ffffffff87cc6840 RDX: 0000000000000009 RSI: 0000000000000006 RDI: 0000000000000001 RBP: ffff88017f7465a8 R08: ffff880180ffe140 R09: ffffed002fee8cf3 R10: ffffed002fee8cf3 R11: 0000000000000003 R12: ffffffff88d649a0 R13: 0000000000000009 R14: 0000000000000001 R15: 0000000000000008 FS: 00007fea6ae65700(0000) GS:ffff8801dae00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001ccb0e000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __sanitizer_cov_trace_switch+0x53/0x90 kernel/kcov.c:224 vsnprintf+0x1c0/0x1b60 lib/vsprintf.c:2252 snprintf+0xae/0xe0 lib/vsprintf.c:2429 print_time kernel/printk/printk.c:1226 [inline] print_prefix+0x38e/0x3f0 kernel/printk/printk.c:1251 msg_print_text+0x83/0x1d0 kernel/printk/printk.c:1274 console_unlock+0x4e6/0x1190 kernel/printk/printk.c:2388 vprintk_emit+0x391/0x990 kernel/printk/printk.c:1922 vprintk_default+0x28/0x30 kernel/printk/printk.c:1964 vprintk_func+0x7e/0x181 kernel/printk/printk_safe.c:398 printk+0xa7/0xcf kernel/printk/printk.c:1997 __find_get_block_slow fs/buffer.c:231 [inline] __find_get_block.cold.58+0x3a/0xff 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__get_entry+0x5a6/0xa40 fs/fat/dir.c:101 fat_get_entry fs/fat/dir.c:129 [inline] fat_search_long+0x33b/0x1570 fs/fat/dir.c:479 vfat_find+0x16d/0x1a0 fs/fat/namei_vfat.c:697 vfat_lookup+0x107/0x640 fs/fat/namei_vfat.c:711 lookup_open+0x72e/0x1b90 fs/namei.c:3213 do_last fs/namei.c:3324 [inline] path_openat+0x2464/0x5150 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:0x457569 Code: fd b3 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 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007fea6ae64c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000080 RDI: 0000000000000005 RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fea6ae656d4 R13: 00000000004c2d6f R14: 00000000004d4630 R15: 00000000ffffffff