syzbot


INFO: task hung in path_openat

Status: auto-closed as invalid on 2021/07/23 23:26
Reported-by: syzbot+66e4d3ab0db07dc9e616@syzkaller.appspotmail.com
First crash: 1120d, last: 1120d
Similar bugs (17)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 INFO: task hung in path_openat 2 1679d 1712d 0/1 auto-closed as invalid on 2020/01/11 07:40
upstream INFO: task hung in path_openat (4) fuse 1 1450d 1450d 0/26 auto-closed as invalid on 2020/07/28 10:23
upstream INFO: task hung in path_openat (3) fs 4 1610d 1726d 0/26 auto-closed as invalid on 2020/02/19 20:16
linux-6.1 INFO: task hung in path_openat (2) 1 110d 110d 0/3 auto-obsoleted due to no activity on 2024/04/08 11:39
upstream INFO: task hung in path_openat (7) fs 377 3h53m 560d 0/26 upstream: reported on 2022/10/06 10:29
linux-5.15 INFO: task hung in path_openat (2) 1 4d22h 4d22h 0/3 upstream: reported on 2024/04/14 03:45
linux-4.19 INFO: task hung in path_openat (2) 1 879d 879d 0/1 auto-closed as invalid on 2022/03/21 04:47
android-49 INFO: task hung in path_openat 64 1850d 1831d 0/3 auto-closed as invalid on 2019/09/22 08:41
upstream INFO: task hung in path_openat (5) fs 23 1091d 1252d 0/26 auto-closed as invalid on 2021/07/22 20:44
linux-4.19 INFO: task hung in path_openat (3) f2fs jfs 20 457d 616d 0/1 upstream: reported on 2022/08/11 13:14
upstream INFO: task hung in path_openat (6) fs 13 826d 976d 0/26 closed as invalid on 2022/02/07 19:19
android-414 INFO: task hung in path_openat 42 1754d 1833d 0/1 auto-closed as invalid on 2019/10/28 21:04
linux-6.1 INFO: task hung in path_openat 3 278d 380d 0/3 auto-obsoleted due to no activity on 2023/10/23 12:08
linux-6.1 INFO: task hung in path_openat (3) 6 3d18h 4d13h 0/3 upstream: reported on 2024/04/14 13:03
upstream INFO: task hung in path_openat exfat 246 1918d 2208d 0/26 closed as dup on 2018/09/08 15:37
linux-5.15 INFO: task hung in path_openat C error 3 261d 373d 0/3 auto-obsoleted due to no activity on 2023/11/09 20:56
upstream INFO: task hung in path_openat (2) fs 1 1821d 1821d 0/26 closed as invalid on 2019/05/08 13:05

Sample crash report:
Buffer I/O error on dev loop2, logical block 706676115, async page read
attempt to access beyond end of device
loop2: rw=0, want=3431094354, limit=272
Buffer I/O error on dev loop2, logical block 1715547176, async page read
INFO: task syz-executor.2:28796 blocked for more than 140 seconds.
      Not tainted 4.14.227-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.2  D29424 28796  27914 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3384
 schedule+0x8d/0x1b0 kernel/sched/core.c:3428
 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:588 [inline]
 rwsem_down_write_failed+0x343/0x6d0 kernel/locking/rwsem-xadd.c:617
 call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:105
 __down_write arch/x86/include/asm/rwsem.h:126 [inline]
 down_write+0x4f/0x90 kernel/locking/rwsem.c:56
 inode_lock include/linux/fs.h:719 [inline]
 do_last fs/namei.c:3331 [inline]
 path_openat+0xde2/0x2970 fs/namei.c:3569
 do_filp_open+0x179/0x3c0 fs/namei.c:3603
 do_sys_open+0x296/0x410 fs/open.c:1081
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x466459
RSP: 002b:00007fb25f74d188 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 000000000056c200 RCX: 0000000000466459
RDX: 0000000000000000 RSI: 0000000000141042 RDI: 0000000020000140
RBP: 00000000004bf9fb R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c200
R13: 00007ffc9db9fcbf R14: 00007fb25f74d300 R15: 0000000000022000

Showing all locks held in the system:
2 locks held by kworker/u4:2/32:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
1 lock held by khungtaskd/1531:
 #0:  (tasklist_lock){.+.+}, at: [<ffffffff86ff3ca7>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548
2 locks held by kworker/u4:4/13455:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by kworker/u4:6/6578:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by kworker/u4:7/6784:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by kworker/u4:9/7032:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by kworker/u4:10/7156:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by kworker/u4:14/4432:
 #0:  ("events_unbound"){+.+.}, at: [<ffffffff81363810>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
 #1:  ((&sub_info->work)){+.+.}, at: [<ffffffff81363846>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
2 locks held by syz-executor.2/28796:
 #0:  (sb_writers#23){.+.+}, at: [<ffffffff818da0fa>] sb_start_write include/linux/fs.h:1549 [inline]
 #0:  (sb_writers#23){.+.+}, at: [<ffffffff818da0fa>] mnt_want_write+0x3a/0xb0 fs/namespace.c:386
 #1:  (&type->i_mutex_dir_key#14){++++}, at: [<ffffffff8189ced2>] inode_lock include/linux/fs.h:719 [inline]
 #1:  (&type->i_mutex_dir_key#14){++++}, at: [<ffffffff8189ced2>] do_last fs/namei.c:3331 [inline]
 #1:  (&type->i_mutex_dir_key#14){++++}, at: [<ffffffff8189ced2>] path_openat+0xde2/0x2970 fs/namei.c:3569

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

NMI backtrace for cpu 1
CPU: 1 PID: 1531 Comm: khungtaskd Not tainted 4.14.227-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x1b2/0x281 lib/dump_stack.c:58
 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
 watchdog+0x5b9/0xb40 kernel/hung_task.c:274
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4618 Comm: systemd-journal Not tainted 4.14.227-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff8880a17c46c0 task.stack: ffff8880a17c8000
RIP: 0010:trace_lock_release include/trace/events/lock.h:58 [inline]
RIP: 0010:lock_release+0x5a6/0x870 kernel/locking/lockdep.c:4016
RSP: 0018:ffff8880a17cfaf0 EFLAGS: 00000002
RAX: 0000000000000000 RBX: 1ffff110142f9f61 RCX: 0000000000000001
RDX: 0000000000000001 RSI: 0000000000000002 RDI: ffff8880a17c4f44
RBP: ffffffff88e126c8 R08: ffffffff8b9a9d70 R09: 00000000000e0063
R10: 0000000000000000 R11: ffff8880a17c46c0 R12: ffffffff8189af32
R13: ffff8880b2a230a8 R14: 0000000000000000 R15: dffffc0000000000
FS:  00007f95144d58c0(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f9511361010 CR3: 00000000a1017000 CR4: 00000000001426f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 seqcount_lockdep_reader_access include/linux/seqlock.h:82 [inline]
 read_seqcount_begin include/linux/seqlock.h:164 [inline]
 read_seqbegin include/linux/seqlock.h:441 [inline]
 path_init+0x605/0x1a20 fs/namei.c:2216
 path_parentat+0x22/0x120 fs/namei.c:2394
 filename_parentat+0x176/0x520 fs/namei.c:2420
 filename_create+0x8a/0x3f0 fs/namei.c:3657
 user_path_create fs/namei.c:3732 [inline]
 SYSC_mkdirat fs/namei.c:3864 [inline]
 SyS_mkdirat+0x95/0x270 fs/namei.c:3856
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7f9513790687
RSP: 002b:00007ffd4877e558 EFLAGS: 00000293 ORIG_RAX: 0000000000000053
RAX: ffffffffffffffda RBX: 00007ffd48781470 RCX: 00007f9513790687
RDX: 00007f9514201a00 RSI: 00000000000001ed RDI: 000055c4773668a0
RBP: 00007ffd4877e590 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000069 R11: 0000000000000293 R12: 0000000000000000
R13: 0000000000000000 R14: 00007ffd48781470 R15: 00007ffd4877ea80
Code: 85 a1 02 00 00 8b 05 6a ff b7 0a 85 c0 0f 85 19 fe ff ff e9 64 b1 bd 05 65 ff 05 e6 24 c0 7e 48 8b 05 b7 5c b1 08 e8 da 4e 04 00 <85> c0 74 0d 80 3d 98 0c b1 08 00 0f 84 47 01 00 00 65 ff 0d c2 

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2021/03/25 23:26 linux-4.14.y 670d6552eda8 6a383ecf .config console log report info ci2-linux-4-14 INFO: task hung in path_openat
* Struck through repros no longer work on HEAD.