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-executor0:17570 blocked for more than 140 seconds. __find_get_block_slow() failed. block=1, b_blocknr=8 Not tainted 4.20.0-rc5+ #363 b_state=0x00000029, b_size=512 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. device loop0 blocksize: 4096 syz-executor0 D24648 17570 6047 0x00000004 __find_get_block_slow() failed. block=1, b_blocknr=8 Call Trace: b_state=0x00000029, b_size=512 context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 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 schedule+0xfe/0x460 kernel/sched/core.c:3516 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 __rwsem_down_write_failed_common+0xc9a/0x15e0 kernel/locking/rwsem-xadd.c:577 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 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 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 __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 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117 b_state=0x00000029, b_size=512 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0xa5/0x130 kernel/locking/rwsem.c:72 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 inode_lock include/linux/fs.h:757 [inline] do_last fs/namei.c:3321 [inline] path_openat+0x15c4/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 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 __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_sys_open+0x568/0x700 fs/open.c:1063 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 b_state=0x00000029, b_size=512 ksys_open include/linux/syscalls.h:1279 [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 device loop0 blocksize: 4096 __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 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:0x457569 __find_get_block_slow() failed. block=1, b_blocknr=8 Code: Bad RIP value. b_state=0x00000029, b_size=512 RSP: 002b:00007feb2bd2ac78 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 0000000000457569 b_state=0x00000029, b_size=512 RDX: 0000000000000000 RSI: 0000000000000044 RDI: 0000000020000a00 device loop0 blocksize: 4096 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 __find_get_block_slow() failed. block=1, b_blocknr=8 R10: 0000000000000000 R11: 0000000000000246 R12: 00007feb2bd2b6d4 b_state=0x00000029, b_size=512 R13: 00000000004bdbef R14: 00000000004cced0 R15: 00000000ffffffff device loop0 blocksize: 4096 Showing all locks held in the system: __find_get_block_slow() failed. block=1, b_blocknr=8 1 lock held by khungtaskd/1019: b_state=0x00000029, b_size=512 #0: 00000000f4f96ca6 (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4379 device loop0 blocksize: 4096 1 lock held by rsyslogd/5919: __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 000000005e5fa79d (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 b_state=0x00000029, b_size=512 2 locks held by getty/6009: device loop0 blocksize: 4096 #0: 00000000d78f951b (&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: 00000000dfb2cb21 (&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/6010: b_state=0x00000029, b_size=512 #0: 000000006a56538a (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 device loop0 blocksize: 4096 #1: 0000000054eea3d1 (&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/6011: b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #0: 000000003b9d299c (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 __find_get_block_slow() failed. block=1, b_blocknr=8 #1: 00000000af16686a (&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/6012: device loop0 blocksize: 4096 #0: 000000003201a720 (&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: 0000000027028521 (&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/6013: device loop0 blocksize: 4096 #0: 000000004d4df55d (&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: 00000000b94101f2 (&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/6014: device loop0 blocksize: 4096 #0: 00000000e141737a (&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: 00000000baee24b6 (&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/6015: device loop0 blocksize: 4096 #0: 000000000cf883b1 (&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: 00000000d862edfe (&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 6 locks held by syz-executor0/17562: __find_get_block_slow() failed. block=1, b_blocknr=8 1 lock held by syz-executor0/17570: b_state=0x00000029, b_size=512 #0: 00000000ac029705 (&sb->s_type->i_mutex_key#20){++++}, at: inode_lock include/linux/fs.h:757 [inline] #0: 00000000ac029705 (&sb->s_type->i_mutex_key#20){++++}, at: do_last fs/namei.c:3321 [inline] #0: 00000000ac029705 (&sb->s_type->i_mutex_key#20){++++}, at: path_openat+0x15c4/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 NMI backtrace for cpu 1 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 CPU: 1 PID: 1019 Comm: khungtaskd Not tainted 4.20.0-rc5+ #363 __find_get_block_slow() failed. block=1, b_blocknr=8 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 b_state=0x00000029, b_size=512 device loop0 blocksize: 4096 nmi_cpu_backtrace.cold.2+0x5c/0xa1 lib/nmi_backtrace.c:101 __find_get_block_slow() failed. block=1, b_blocknr=8 nmi_trigger_cpumask_backtrace+0x1e8/0x22a lib/nmi_backtrace.c:62 b_state=0x00000029, b_size=512 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline] watchdog+0xb51/0x1060 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 __find_get_block_slow() failed. block=1, b_blocknr=8 kthread+0x35a/0x440 kernel/kthread.c:246 b_state=0x00000029, b_size=512 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: 17562 Comm: syz-executor0 Not tainted 4.20.0-rc5+ #363 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:format_decode+0x6c/0xaf0 lib/vsprintf.c:2005 Code: 48 c7 45 80 a1 d7 26 89 48 c7 45 88 60 f3 d6 87 c7 00 f1 f1 f1 f1 c7 40 04 00 f2 f2 f2 65 48 8b 04 25 28 00 00 00 48 89 45 d0 <31> c0 48 89 7d 98 e8 e9 a7 a8 f9 48 8b 45 98 48 89 85 70 ff ff ff RSP: 0018:ffff8881d79a6b08 EFLAGS: 00000086 RAX: af2c515e9565d700 RBX: dffffc0000000000 RCX: ffffc90005de6000 RDX: 0000000000040000 RSI: ffff8881d79a6c28 RDI: ffffffff882bf4a1 RBP: ffff8881d79a6bb0 R08: ffff8881d1292380 R09: fffffbfff1616e74 R10: fffffbfff1616e74 R11: ffffffff8b0b73a0 R12: ffffffff882bf4a1 R13: ffff8881d79a6c28 R14: ffff8881d79a6b88 R15: ffff8881d79a6c68 FS: 00007feb2bd4c700(0000) GS:ffff8881dae00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000000000625208 CR3: 00000001c388a000 CR4: 00000000001426f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: vsnprintf+0x185/0x1b60 lib/vsprintf.c:2248 sprintf+0xb0/0xe0 lib/vsprintf.c:2498 print_time kernel/printk/printk.c:1228 [inline] print_prefix+0x26a/0x3f0 kernel/printk/printk.c:1251 msg_print_text+0xcc/0x1d0 kernel/printk/printk.c:1278 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.57+0x3a/0xff fs/buffer.c:1294 __getblk_slow fs/buffer.c:1039 [inline] __getblk_gfp+0x2b3/0xd50 fs/buffer.c:1320 __bread_gfp+0x2d/0x310 fs/buffer.c:1354 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_hash+0x12e/0x190 fs/namei.c:1546 filename_create+0x1e5/0x5b0 fs/namei.c:3636 user_path_create fs/namei.c:3693 [inline] do_mkdirat+0xda/0x310 fs/namei.c:3832 __do_sys_mkdirat fs/namei.c:3851 [inline] __se_sys_mkdirat fs/namei.c:3849 [inline] __x64_sys_mkdirat+0x76/0xb0 fs/namei.c:3849 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:00007feb2bd4bc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000102 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 RDX: 0000000100000000 RSI: 0000000020000480 RDI: 0000000000000005 RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007feb2bd4c6d4 R13: 00000000004c2b03 R14: 00000000004d45b0 R15: 00000000ffffffff