syzbot


INFO: task hung in fat_fallocate

Status: auto-closed as invalid on 2019/02/22 14:59
First crash: 2313d, last: 2313d
Similar bugs (1)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in fat_fallocate exfat 1 2413d 2412d 0/28 closed as dup on 2019/01/20 01:49

Sample crash report:
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:12182 blocked for more than 140 seconds.
__find_get_block_slow() failed. block=1, b_blocknr=8
      Not tainted 4.9.117-g8b21e85 #19
b_state=0x00000029, b_size=512
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
device loop0 blocksize: 4096
syz-executor0   D
__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
device loop0 blocksize: 4096
27368 12182  11219 0x00000004
b_state=0x00000029, b_size=512
 ffff8801cb8db000
device loop0 blocksize: 4096
 ffff8801c7ef4fc0 ffff8801c7ef4fc0__find_get_block_slow() failed. block=1, b_blocknr=8
 ffff8801bb824800b_state=0x00000029, b_size=512
device loop0 blocksize: 4096
 ffff8801db321c18 ffff88019ba37b88
__find_get_block_slow() failed. block=1, b_blocknr=8
 ffffffff839ebd0db_state=0x00000029, b_size=512
 ffffffff81235687device loop0 blocksize: 4096
 0000000000000000 ffff8801cb8db8c0
__find_get_block_slow() failed. block=1, b_blocknr=8
 0000000600000007b_state=0x00000029, b_size=512
 ffff8801db3224e8device loop0 blocksize: 4096
Call Trace:
__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
device loop0 blocksize: 4096
 [<ffffffff839ed30f>] schedule+0x7f/0x1b0 kernel/sched/core.c:3553
__find_get_block_slow() failed. block=1, b_blocknr=8
 [<ffffffff839f8948>] __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:526 [inline]
 [<ffffffff839f8948>] rwsem_down_write_failed+0x598/0x990 kernel/locking/rwsem-xadd.c:555
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
 [<ffffffff81ee8ec7>] call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:105
b_state=0x00000029, b_size=512
 [<ffffffff839f671c>] __down_write arch/x86/include/asm/rwsem.h:125 [inline]
 [<ffffffff839f671c>] down_write+0x5c/0xa0 kernel/locking/rwsem.c:54
device loop0 blocksize: 4096
__find_get_block_slow() failed. block=1, b_blocknr=8
 [<ffffffff818c872e>] inode_lock include/linux/fs.h:766 [inline]
 [<ffffffff818c872e>] fat_fallocate+0x10e/0x2d0 fs/fat/file.c:249
b_state=0x00000029, b_size=512
 [<ffffffff81568bb9>] vfs_fallocate+0x359/0x600 fs/open.c:329
device loop0 blocksize: 4096
 [<ffffffff8156bac3>] SYSC_fallocate fs/open.c:352 [inline]
 [<ffffffff8156bac3>] SyS_fallocate+0x53/0x90 fs/open.c:346
__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
 [<ffffffff81006316>] do_syscall_64+0x1a6/0x490 arch/x86/entry/common.c:282
device loop0 blocksize: 4096
 [<ffffffff839fcc13>] entry_SYSCALL_64_after_swapgs+0x5d/0xdb
__find_get_block_slow() failed. block=1, b_blocknr=8

Showing all locks held in the system:
b_state=0x00000029, b_size=512
device loop0 blocksize: 4096
2 locks held by khungtaskd/519:
 #0: 
__find_get_block_slow() failed. block=1, b_blocknr=8
 (b_state=0x00000029, b_size=512
rcu_read_lockdevice loop0 blocksize: 4096
){......}, at: [<ffffffff813667fc>] check_hung_uninterruptible_tasks kernel/hung_task.c:168 [inline]
){......}, at: [<ffffffff813667fc>] watchdog+0x11c/0xa20 kernel/hung_task.c:239
 #1: 
b_state=0x00000029, b_size=512
 (device loop0 blocksize: 4096
tasklist_lock){.+.+..}, at: [<ffffffff81426017>] debug_show_all_locks+0x79/0x218 kernel/locking/lockdep.c:4336
b_state=0x00000029, b_size=512
device loop0 blocksize: 4096
1 lock held by rsyslogd/3667:
 #0: 
__find_get_block_slow() failed. block=1, b_blocknr=8
 (b_state=0x00000029, b_size=512
&f->f_pos_lockdevice loop0 blocksize: 4096
){+.+.+.}, at: [<ffffffff815d859c>] __fdget_pos+0xac/0xd0 fs/file.c:781
2 locks held by getty/3763:
b_state=0x00000029, b_size=512
 #0: 
device loop0 blocksize: 4096
 (&tty->ldisc_sem){++++++}__find_get_block_slow() failed. block=1, b_blocknr=8
, at: [<ffffffff839fadb2>] ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:367
 #1: 
device loop0 blocksize: 4096
 (&ldata->atomic_read_lock){+.+.+.}__find_get_block_slow() failed. block=1, b_blocknr=8
, at: [<ffffffff821207f2>] n_tty_read+0x202/0x16e0 drivers/tty/n_tty.c:2142
device loop0 blocksize: 4096
2 locks held by syz-executor0/12182:
 #0: 
__find_get_block_slow() failed. block=1, b_blocknr=8
 (b_state=0x00000029, b_size=512
sb_writersdevice loop0 blocksize: 4096
#14){.+.+.+}, at: [<ffffffff81568b5b>] sb_start_write include/linux/fs.h:1573 [inline]
#14){.+.+.+}, at: [<ffffffff81568b5b>] vfs_fallocate+0x2fb/0x600 fs/open.c:328
 #1: 
b_state=0x00000029, b_size=512
 (device loop0 blocksize: 4096
&sb->s_type->i_mutex_key#20){++++++}__find_get_block_slow() failed. block=1, b_blocknr=8
, at: [<ffffffff818c872e>] inode_lock include/linux/fs.h:766 [inline]
, at: [<ffffffff818c872e>] fat_fallocate+0x10e/0x2d0 fs/fat/file.c:249
2 locks held by syz-executor0/12185:
device loop0 blocksize: 4096
 #0:  (sb_writers
__find_get_block_slow() failed. block=1, b_blocknr=8
#14b_state=0x00000029, b_size=512
){.+.+.+}device loop0 blocksize: 4096
, at: [<ffffffff815e0e3f>] sb_start_write include/linux/fs.h:1573 [inline]
, at: [<ffffffff815e0e3f>] mnt_want_write+0x3f/0xb0 fs/namespace.c:391
 #1: 
b_state=0x00000029, b_size=512
 (device loop0 blocksize: 4096
&sb->s_type->i_mutex_key#20){++++++}__find_get_block_slow() failed. block=1, b_blocknr=8
, at: [<ffffffff8156abe8>] inode_lock include/linux/fs.h:766 [inline]
, at: [<ffffffff8156abe8>] do_truncate2+0x128/0x1f0 fs/open.c:61
1 lock held by init/12267:
device loop0 blocksize: 4096
 #0:  (tty_mutex
__find_get_block_slow() failed. block=1, b_blocknr=8
){+.+.+.}b_state=0x00000029, b_size=512
, at: [<ffffffff8211abfc>] tty_open_by_driver drivers/tty/tty_io.c:2047 [inline]
, at: [<ffffffff8211abfc>] tty_open+0x46c/0xe20 drivers/tty/tty_io.c:2125
1 lock held by init/12268:
 #0: 
__find_get_block_slow() failed. block=1, b_blocknr=8
 (b_state=0x00000029, b_size=512
tty_mutexdevice loop0 blocksize: 4096
){+.+.+.}, at: [<ffffffff8211abfc>] tty_open_by_driver drivers/tty/tty_io.c:2047 [inline]
){+.+.+.}, at: [<ffffffff8211abfc>] tty_open+0x46c/0xe20 drivers/tty/tty_io.c:2125
1 lock held by init/12270:
b_state=0x00000029, b_size=512
 #0: 
device loop0 blocksize: 4096
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open_by_driver drivers/tty/tty_io.c:2047 [inline]
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open+0x46c/0xe20 drivers/tty/tty_io.c:2125
1 lock held by init/12271:
b_state=0x00000029, b_size=512
 #0: 
device loop0 blocksize: 4096
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open_by_driver drivers/tty/tty_io.c:2047 [inline]
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open+0x46c/0xe20 drivers/tty/tty_io.c:2125
1 lock held by init/12272:
b_state=0x00000029, b_size=512
 #0: 
device loop0 blocksize: 4096
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open_by_driver drivers/tty/tty_io.c:2047 [inline]
 (tty_mutex){+.+.+.}, at: [<ffffffff8211abfc>] tty_open+0x46c/0xe20 drivers/tty/tty_io.c:2125

b_state=0x00000029, b_size=512
=============================================

device loop0 blocksize: 4096
NMI backtrace for cpu 1
CPU: 1 PID: 519 Comm: khungtaskd Not tainted 4.9.117-g8b21e85 #19
__find_get_block_slow() failed. block=1, b_blocknr=8
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
b_state=0x00000029, b_size=512
 ffff8801d8427d08
device loop0 blocksize: 4096
 ffffffff81eb4be9 0000000000000000 0000000000000001__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
 0000000000000001
device loop0 blocksize: 4096
 0000000000000001 ffffffff810b9bd0 ffff8801d8427d40__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
 ffffffff81ebfee7
device loop0 blocksize: 4096
 0000000000000001 0000000000000000 0000000000000003__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
Call Trace:
device loop0 blocksize: 4096
 [<ffffffff81eb4be9>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81eb4be9>] dump_stack+0xc1/0x128 lib/dump_stack.c:51
__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
 [<ffffffff81ebfee7>] nmi_cpu_backtrace.cold.2+0x48/0x87 lib/nmi_backtrace.c:99
device loop0 blocksize: 4096
__find_get_block_slow() failed. block=1, b_blocknr=8
 [<ffffffff81ebfe7a>] nmi_trigger_cpumask_backtrace+0x12a/0x14f lib/nmi_backtrace.c:60
b_state=0x00000029, b_size=512
 [<ffffffff810b9cd4>] arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:37
device loop0 blocksize: 4096
 [<ffffffff81366d94>] trigger_all_cpu_backtrace include/linux/nmi.h:58 [inline]
 [<ffffffff81366d94>] check_hung_task kernel/hung_task.c:125 [inline]
 [<ffffffff81366d94>] check_hung_uninterruptible_tasks kernel/hung_task.c:182 [inline]
 [<ffffffff81366d94>] watchdog+0x6b4/0xa20 kernel/hung_task.c:239
__find_get_block_slow() failed. block=1, b_blocknr=8
b_state=0x00000029, b_size=512
 [<ffffffff8119d0ed>] kthread+0x26d/0x300 kernel/kthread.c:211
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
 [<ffffffff839fcddc>] ret_from_fork+0x5c/0x70 arch/x86/entry/entry_64.S:373
b_state=0x00000029, b_size=512
Sending NMI from CPU 1 to CPUs 0:
device loop0 blocksize: 4096
NMI backtrace for cpu 0
CPU: 0 PID: 1617 Comm: kworker/u4:3 Not tainted 4.9.117-g8b21e85 #19
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: writeback wb_workfnc (flush-7:0)c
task: ffff8801cf87b000 task.stack: ffff8801cf920000
RIP: 0010:[<ffffffff812301c8>] c [<ffffffff812301c8>] __lock_is_held+0x8/0xf0 kernel/locking/lockdep.c:3590
RSP: 0018:ffff8801cf927418  EFLAGS: 00000046
RAX: 0000000000000007 RBX: 0000000000000246 RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffffffff81f1c62b RDI: ffffffff846defa0
RBP: ffff8801cf927428 R08: ffff8801cf87b960 R09: 0000000000000001
R10: ffff8801cf87b000 R11: 1ffff10039f0f727 R12: ffff8801cf87b000
R13: ffffffff846defa0 R14: 0000000000000000 R15: ffff8801cbf8b748
FS:  0000000000000000(0000) GS:ffff8801db200000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000000176ab10 CR3: 00000001d77fd000 CR4: 00000000001606f0
DR0: 0000000020000000 DR1: 0000000020000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600
Stack:
 0000000000000000c ffff8801cbf8b748c ffff8801cf927450c ffffffff81230a94c
 ffffea00071e3ac0c ffff8801cbe4ac30c dffffc0000000000c ffff8801cf927460c
 ffffffff8127c284c ffff8801cf9274c8c ffffffff814391bbc ffffffff81438e70c
Call Trace:
 [<ffffffff81230a94>] lock_is_held+0xb4/0x140 kernel/locking/lockdep.c:3794
 [<ffffffff8127c284>] rcu_read_lock_held+0xa4/0xc0 kernel/rcu/update.c:297
 [<ffffffff814391bb>] radix_tree_deref_slot include/linux/radix-tree.h:199 [inline]
 [<ffffffff814391bb>] find_get_entry+0x34b/0x540 mm/filemap.c:1095
 [<ffffffff8143a2eb>] pagecache_get_page+0x4b/0x720 mm/filemap.c:1201
 [<ffffffff81624392>] find_get_page_flags include/linux/pagemap.h:264 [inline]
 [<ffffffff81624392>] __find_get_block_slow+0xc2/0x330 fs/buffer.c:212
 [<ffffffff8162493e>] __find_get_block+0x23e/0x4c0 fs/buffer.c:1360
 [<ffffffff81625749>] __getblk_slow fs/buffer.c:1101 [inline]
 [<ffffffff81625749>] __getblk_gfp+0x189/0x710 fs/buffer.c:1386
 [<ffffffff816290ed>] __bread_gfp+0x2d/0x270 fs/buffer.c:1420
 [<ffffffff818cc62b>] sb_bread include/linux/buffer_head.h:300 [inline]
 [<ffffffff818cc62b>] __fat_write_inode+0x2ab/0x980 fs/fat/inode.c:852
 [<ffffffff818d08e9>] fat_write_inode+0x79/0x170 fs/fat/inode.c:901
 [<ffffffff8160273d>] write_inode fs/fs-writeback.c:1180 [inline]
 [<ffffffff8160273d>] __writeback_single_inode+0x86d/0x1020 fs/fs-writeback.c:1379
 [<ffffffff81603a3c>] writeback_sb_inodes+0x4ac/0xe70 fs/fs-writeback.c:1584
 [<ffffffff816044fb>] __writeback_inodes_wb+0xfb/0x1e0 fs/fs-writeback.c:1653
 [<ffffffff81604c82>] wb_writeback+0x512/0xbd0 fs/fs-writeback.c:1762
 [<ffffffff8160e5b0>] wb_check_old_data_flush fs/fs-writeback.c:1877 [inline]
 [<ffffffff8160e5b0>] wb_do_writeback fs/fs-writeback.c:1901 [inline]
 [<ffffffff8160e5b0>] wb_workfn+0x850/0xdb0 fs/fs-writeback.c:1930
 [<ffffffff8118d181>] process_one_work+0x7e1/0x1500 kernel/workqueue.c:2092
 [<ffffffff8118df76>] worker_thread+0xd6/0x10a0 kernel/workqueue.c:2226
 [<ffffffff8119d0ed>] kthread+0x26d/0x300 kernel/kthread.c:211
 [<ffffffff839fcddc>] ret_from_fork+0x5c/0x70 arch/x86/entry/entry_64.S:373
Code: c48 c89 cf7 c48 c89 c75 cd0 ce8 c57 cbd c30 c00 c48 c8b c75 cd0 ce9 c26 cfc cff cff c0f c1f c40 c00 c66 c2e c0f c1f c84 c00 c00 c00 c00 c00 c55 c48 c89 ce5 c41 c57 c41 c56 c<49> c89 cfe c41 c55 c41 c54 c53 c65 c48 c8b c1c c25 cc0 c7d c01 c00 c48 c8d c83 cc0 c
__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
__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

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2018/08/06 16:56 https://android.googlesource.com/kernel/common android-4.9 8b21e85d919c 1beb8136 .config console log report ci-android-49-kasan-gce-root
* Struck through repros no longer work on HEAD.