syzbot


INFO: task hung in do_read_cache_page

Status: upstream: reported C repro on 2023/04/16 18:09
Bug presence: origin:upstream
[Documentation on labels]
Reported-by: syzbot+f7e37037530e954a8467@syzkaller.appspotmail.com
First crash: 410d, last: 332d
Fix bisection: failed (error log, bisect log)
  
Bug presence (1)
Date Name Commit Repro Result
2023/05/22 upstream (ToT) 44c026a73be8 C [report] INFO: task hung in blkdev_put
Similar bugs (8)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 INFO: task hung in do_read_cache_page (2) C error 26 488d 1206d 0/1 upstream: reported C repro on 2021/02/09 08:22
upstream INFO: task hung in do_read_cache_page block 10 2152d 2255d 0/26 auto-closed as invalid on 2019/02/22 10:09
linux-4.14 INFO: task hung in do_read_cache_page 2 684d 720d 0/1 auto-obsoleted due to no activity on 2022/11/13 17:53
upstream INFO: task hung in do_read_cache_page (3) mm fs C done inconclusive 88 688d 1585d 0/26 upstream: reported C repro on 2020/01/27 06:32
android-49 INFO: task hung in do_read_cache_page 1 2196d 2196d 0/3 auto-closed as invalid on 2019/02/22 13:59
upstream INFO: task hung in do_read_cache_page (2) block 1 1722d 1722d 0/26 auto-closed as invalid on 2019/11/11 08:43
linux-4.19 INFO: task hung in do_read_cache_page C done 2 1264d 1324d 1/1 fixed on 2021/01/13 11:08
upstream INFO: task can't die in wait_on_page_bit_common fs mm C done 5 1018d 1371d 0/26 upstream: reported C repro on 2020/08/28 22:28

Sample crash report:
INFO: task udevd:4002 blocked for more than 143 seconds.
      Not tainted 5.15.112-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:udevd           state:D stack:    0 pid: 4002 ppid:  3585 flags:0x00000004
Call trace:
 __switch_to+0x308/0x5e8 arch/arm64/kernel/process.c:518
 context_switch kernel/sched/core.c:5026 [inline]
 __schedule+0xf10/0x1e38 kernel/sched/core.c:6372
 schedule+0x11c/0x1c8 kernel/sched/core.c:6455
 io_schedule+0x8c/0x194 kernel/sched/core.c:8472
 wait_on_page_bit_common+0x6fc/0xc14 mm/filemap.c:1356
 wait_on_page_bit mm/filemap.c:1417 [inline]
 wait_on_page_locked include/linux/pagemap.h:688 [inline]
 wait_on_page_read mm/filemap.c:3428 [inline]
 do_read_cache_page+0x760/0x950 mm/filemap.c:3471
 read_cache_page+0x68/0x84 mm/filemap.c:3565
 read_mapping_page include/linux/pagemap.h:515 [inline]
 read_part_sector+0xe8/0x4d8 block/partitions/core.c:727
 adfspart_check_ICS+0xd4/0x5d0 block/partitions/acorn.c:360
 check_partition block/partitions/core.c:148 [inline]
 blk_add_partitions block/partitions/core.c:612 [inline]
 bdev_disk_changed+0x774/0x1370 block/partitions/core.c:698
 blkdev_get_whole+0x2a0/0x344 block/bdev.c:682
 blkdev_get_by_dev+0x238/0x89c block/bdev.c:824
 blkdev_open+0x10c/0x274 block/fops.c:463
 do_dentry_open+0x780/0xed8 fs/open.c:826
 vfs_open+0x7c/0x90 fs/open.c:956
 do_open fs/namei.c:3538 [inline]
 path_openat+0x1f28/0x26f0 fs/namei.c:3672
 do_filp_open+0x1a8/0x3b4 fs/namei.c:3699
 do_sys_openat2+0x128/0x3d8 fs/open.c:1211
 do_sys_open fs/open.c:1227 [inline]
 __do_sys_openat fs/open.c:1243 [inline]
 __se_sys_openat fs/open.c:1238 [inline]
 __arm64_sys_openat+0x1f0/0x240 fs/open.c:1238
 __invoke_syscall arch/arm64/kernel/syscall.c:38 [inline]
 invoke_syscall+0x98/0x2b8 arch/arm64/kernel/syscall.c:52
 el0_svc_common+0x138/0x258 arch/arm64/kernel/syscall.c:142
 do_el0_svc+0x58/0x14c arch/arm64/kernel/syscall.c:181
 el0_svc+0x7c/0x1f0 arch/arm64/kernel/entry-common.c:596
 el0t_64_sync_handler+0x84/0xe4 arch/arm64/kernel/entry-common.c:614
 el0t_64_sync+0x1a0/0x1a4 arch/arm64/kernel/entry.S:584
INFO: task syz-executor516:4345 blocked for more than 143 seconds.
      Not tainted 5.15.112-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor516 state:D stack:    0 pid: 4345 ppid:  3998 flags:0x0000000d
Call trace:
 __switch_to+0x308/0x5e8 arch/arm64/kernel/process.c:518
 context_switch kernel/sched/core.c:5026 [inline]
 __schedule+0xf10/0x1e38 kernel/sched/core.c:6372
 schedule+0x11c/0x1c8 kernel/sched/core.c:6455
 schedule_preempt_disabled+0x18/0x2c kernel/sched/core.c:6514
 __mutex_lock_common+0xba0/0x2154 kernel/locking/mutex.c:669
 __mutex_lock kernel/locking/mutex.c:729 [inline]
 mutex_lock_nested+0xa4/0xf8 kernel/locking/mutex.c:743
 blkdev_put+0xe0/0x6b0 block/bdev.c:912
 blkdev_close+0x74/0xb0 block/fops.c:475
 __fput+0x30c/0x7f0 fs/file_table.c:280
 ____fput+0x20/0x30 fs/file_table.c:308
 task_work_run+0x130/0x1e4 kernel/task_work.c:164
 get_signal+0x1450/0x1550 kernel/signal.c:2661
 do_signal arch/arm64/kernel/signal.c:890 [inline]
 do_notify_resume+0x3d0/0x32b8 arch/arm64/kernel/signal.c:943
 prepare_exit_to_user_mode arch/arm64/kernel/entry-common.c:133 [inline]
 exit_to_user_mode arch/arm64/kernel/entry-common.c:138 [inline]
 el0_svc+0xfc/0x1f0 arch/arm64/kernel/entry-common.c:597
 el0t_64_sync_handler+0x84/0xe4 arch/arm64/kernel/entry-common.c:614
 el0t_64_sync+0x1a0/0x1a4 arch/arm64/kernel/entry.S:584

Showing all locks held in the system:
1 lock held by khungtaskd/27:
 #0: ffff800014aa19e0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0xc/0x44 include/linux/rcupdate.h:268
2 locks held by getty/3725:
 #0: ffff0000d3913098 (&tty->ldisc_sem){++++}-{0:0}, at: ldsem_down_read+0x40/0x50 drivers/tty/tty_ldsem.c:340
 #1: ffff80001a27b2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x414/0x1200 drivers/tty/n_tty.c:2147
1 lock held by udevd/4002:
 #0: ffff0000cc143118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0x12c/0x89c block/bdev.c:817
1 lock held by syz-executor516/4345:
 #0: ffff0000cc143118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xe0/0x6b0 block/bdev.c:912

=============================================


Crashes (9):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/05/21 22:28 linux-5.15.y 9d6bde853685 4bce1a3e .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in do_read_cache_page
2023/07/03 02:12 linux-5.15.y 4af60700a60c bfc47836 .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/06/18 08:12 linux-5.15.y 471e639e59d1 f3921d4d .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/06/08 17:58 linux-5.15.y d7af3e5ba454 058b3a5a .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in do_read_cache_page
2023/07/03 03:27 linux-5.15.y 4af60700a60c bfc47836 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/06/19 00:41 linux-5.15.y 471e639e59d1 f3921d4d .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/05/15 15:54 linux-5.15.y b0ece631f84a c4d362e7 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/04/16 18:09 linux-5.15.y 4fdad925aa1a ec410564 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in do_read_cache_page
2023/04/23 16:16 linux-5.15.y 3299fb36854f 2b32bd34 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in do_read_cache_page
* Struck through repros no longer work on HEAD.