syzbot


INFO: task hung in blkdev_put

Status: upstream: reported C repro on 2023/06/23 01:15
Bug presence: origin:upstream
[Documentation on labels]
Reported-by: syzbot+d41c7fb1ab4f65a17ab8@syzkaller.appspotmail.com
First crash: 358d, last: 81d
Fix bisection: failed (error log, bisect log)
  
Bug presence (1)
Date Name Commit Repro Result
2023/06/24 upstream (ToT) a92b7d26c743 C [report] INFO: task hung in blkdev_put
Similar bugs (14)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in blkdev_put (3) fs 1 1510d 1510d 0/27 auto-closed as invalid on 2020/06/25 13:28
android-49 INFO: task hung in blkdev_put (2) 3 1673d 1692d 0/3 auto-closed as invalid on 2020/03/14 12:22
linux-4.19 INFO: task hung in blkdev_put C error 31 657d 1422d 0/1 upstream: reported C repro on 2020/07/23 21:33
upstream INFO: task hung in blkdev_put udf 320 1952d 2378d 0/27 closed as dup on 2018/11/11 08:29
linux-4.14 INFO: task hung in blkdev_put 2 1735d 1885d 0/1 auto-closed as invalid on 2020/01/12 01:56
linux-4.14 INFO: task hung in blkdev_put (3) C error 16 606d 1384d 0/1 upstream: reported C repro on 2020/08/30 21:52
upstream INFO: task hung in blkdev_put (4) block C done 486 94d 1350d 0/27 upstream: reported C repro on 2020/10/03 13:09
android-49 INFO: task hung in blkdev_put 220 1871d 1888d 0/3 auto-closed as invalid on 2019/10/25 08:47
linux-4.14 INFO: task hung in blkdev_put (2) 2 1539d 1577d 0/1 auto-closed as invalid on 2020/07/26 14:38
android-414 INFO: task hung in blkdev_put 119 1657d 1890d 0/1 auto-closed as invalid on 2020/03/30 04:06
android-44 INFO: task hung in blkdev_put 26 1957d 1888d 0/2 auto-closed as invalid on 2019/08/03 02:42
android-44 INFO: task hung in blkdev_put (2) 3 1669d 1746d 0/2 auto-closed as invalid on 2020/03/18 19:27
linux-6.1 INFO: task hung in blkdev_put origin:upstream C 125 19h11m 416d 0/3 upstream: reported C repro on 2023/04/25 09:01
upstream INFO: task hung in blkdev_put (2) fs 2 1664d 1710d 0/27 auto-closed as invalid on 2020/02/22 04:07

Sample crash report:
INFO: task syz-executor197:3986 blocked for more than 143 seconds.
      Not tainted 5.15.152-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor197 state:D stack:    0 pid: 3986 ppid:  3985 flags:0x00000005
Call trace:
 __switch_to+0x308/0x5e8 arch/arm64/kernel/process.c:518
 context_switch kernel/sched/core.c:5030 [inline]
 __schedule+0xf10/0x1e48 kernel/sched/core.c:6376
 schedule+0x11c/0x1c8 kernel/sched/core.c:6459
 schedule_preempt_disabled+0x18/0x2c kernel/sched/core.c:6518
 __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
 tracehook_notify_resume include/linux/tracehook.h:189 [inline]
 do_notify_resume+0x262c/0x32b8 arch/arm64/kernel/signal.c:946
 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:609
 el0t_64_sync_handler+0x84/0xe4 arch/arm64/kernel/entry-common.c:626
 el0t_64_sync+0x1a0/0x1a4 arch/arm64/kernel/entry.S:584
INFO: task syz-executor197:3987 blocked for more than 143 seconds.
      Not tainted 5.15.152-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor197 state:D stack:    0 pid: 3987 ppid:  3985 flags:0x0000000d
Call trace:
 __switch_to+0x308/0x5e8 arch/arm64/kernel/process.c:518
 context_switch kernel/sched/core.c:5030 [inline]
 __schedule+0xf10/0x1e48 kernel/sched/core.c:6376
 schedule+0x11c/0x1c8 kernel/sched/core.c:6459
 schedule_preempt_disabled+0x18/0x2c kernel/sched/core.c:6518
 __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
 tracehook_notify_resume include/linux/tracehook.h:189 [inline]
 do_notify_resume+0x262c/0x32b8 arch/arm64/kernel/signal.c:946
 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:609
 el0t_64_sync_handler+0x84/0xe4 arch/arm64/kernel/entry-common.c:626
 el0t_64_sync+0x1a0/0x1a4 arch/arm64/kernel/entry.S:584
INFO: task udevd:3989 blocked for more than 143 seconds.
      Not tainted 5.15.152-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:udevd           state:D stack:    0 pid: 3989 ppid:  3585 flags:0x00000004
Call trace:
 __switch_to+0x308/0x5e8 arch/arm64/kernel/process.c:518
 context_switch kernel/sched/core.c:5030 [inline]
 __schedule+0xf10/0x1e48 kernel/sched/core.c:6376
 schedule+0x11c/0x1c8 kernel/sched/core.c:6459
 io_schedule+0x8c/0x194 kernel/sched/core.c:8484
 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:3437 [inline]
 do_read_cache_page+0x760/0x950 mm/filemap.c:3480
 read_cache_page+0x68/0x84 mm/filemap.c:3574
 read_mapping_page include/linux/pagemap.h:515 [inline]
 read_part_sector+0xe8/0x4d8 block/partitions/core.c:729
 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:614 [inline]
 bdev_disk_changed+0x83c/0x1358 block/partitions/core.c:700
 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:3608 [inline]
 path_openat+0x1f28/0x26f0 fs/namei.c:3742
 do_filp_open+0x1a8/0x3b4 fs/namei.c:3769
 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:608
 el0t_64_sync_handler+0x84/0xe4 arch/arm64/kernel/entry-common.c:626
 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: ffff800014ae14a0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0xc/0x44 include/linux/rcupdate.h:268
1 lock held by klogd/3574:
 #0: ffff0001b4806918 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested kernel/sched/core.c:475 [inline]
 #0: ffff0001b4806918 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock kernel/sched/sched.h:1326 [inline]
 #0: ffff0001b4806918 (&rq->__lock){-.-.}-{2:2}, at: rq_lock kernel/sched/sched.h:1621 [inline]
 #0: ffff0001b4806918 (&rq->__lock){-.-.}-{2:2}, at: __schedule+0x328/0x1e48 kernel/sched/core.c:6290
2 locks held by getty/3722:
 #0: ffff0000d2d61098 (&tty->ldisc_sem){++++}-{0:0}, at: ldsem_down_read+0x40/0x50 drivers/tty/tty_ldsem.c:340
 #1: ffff80001a29b2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x414/0x1204 drivers/tty/n_tty.c:2158
1 lock held by syz-executor197/3986:
 #0: ffff0000cc08d918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xe0/0x6b0 block/bdev.c:912
1 lock held by syz-executor197/3987:
 #0: ffff0000cc08d918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0xe0/0x6b0 block/bdev.c:912
1 lock held by udevd/3989:
 #0: ffff0000cc08d918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0x12c/0x89c block/bdev.c:817

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


Crashes (4):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/03/25 07:18 linux-5.15.y b95c01af2113 0ea90952 .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in blkdev_put
2023/06/23 01:15 linux-5.15.y f67653019430 79782afc .config console log report syz C [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in blkdev_put
2023/10/07 02:29 linux-5.15.y 1edcec18cfb7 ea12a918 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: task hung in blkdev_put
2023/07/01 07:20 linux-5.15.y 4af60700a60c af3053d2 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 INFO: task hung in blkdev_put
* Struck through repros no longer work on HEAD.