syzbot


INFO: task hung in vfs_fileattr_set

Status: auto-obsoleted due to no activity on 2023/08/26 02:12
Subsystems: xfs
[Documentation on labels]
First crash: 812d, last: 779d
Similar bugs (2)
Kernel Title Rank 🛈 Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in vfs_fileattr_set (2) jfs 1 3 429d 444d 0/29 auto-obsoleted due to no activity on 2024/08/10 03:35
upstream INFO: task hung in vfs_fileattr_set (3) lsm kernfs jfs 1 3 276d 313d 0/29 auto-obsoleted due to no activity on 2025/01/10 13:53

Sample crash report:
INFO: task syz-executor.1:6033 blocked for more than 143 seconds.
      Not tainted 6.4.0-rc3-syzkaller-00291-g4e893b5aa4ac #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1  state:D stack:24488 pid:6033  ppid:5030   flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5343 [inline]
 __schedule+0x187b/0x4900 kernel/sched/core.c:6669
 schedule+0xc3/0x180 kernel/sched/core.c:6745
 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6804
 rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
 __down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
 inode_lock include/linux/fs.h:775 [inline]
 vfs_fileattr_set+0x139/0xd40 fs/ioctl.c:681
 ioctl_setflags fs/ioctl.c:728 [inline]
 do_vfs_ioctl+0x1e47/0x2b10 fs/ioctl.c:839
 __do_sys_ioctl fs/ioctl.c:868 [inline]
 __se_sys_ioctl+0x81/0x160 fs/ioctl.c:856
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f146248c169
RSP: 002b:00007f146325e168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f14625abf80 RCX: 00007f146248c169
RDX: 0000000020000300 RSI: 0000000040086602 RDI: 0000000000000005
RBP: 00007f14624e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffd69a4babf R14: 00007f146325e300 R15: 0000000000022000
 </TASK>
INFO: task syz-executor.1:6112 blocked for more than 144 seconds.
      Not tainted 6.4.0-rc3-syzkaller-00291-g4e893b5aa4ac #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1  state:D stack:26240 pid:6112  ppid:5030   flags:0x00004004
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5343 [inline]
 __schedule+0x187b/0x4900 kernel/sched/core.c:6669
 schedule+0xc3/0x180 kernel/sched/core.c:6745
 xlog_grant_head_wait+0x387/0x910 fs/xfs/xfs_log.c:307
 xlog_grant_head_check+0x299/0x480
 xfs_log_reserve+0x3c4/0xb10 fs/xfs/xfs_log.c:486
 xfs_trans_reserve+0x239/0x6a0 fs/xfs/xfs_trans.c:194
 xfs_trans_alloc+0x423/0x810 fs/xfs/xfs_trans.c:283
 xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1246
 xfs_create+0x6c9/0x1240 fs/xfs/xfs_inode.c:1002
 xfs_generic_create+0x491/0xd70 fs/xfs/xfs_iops.c:199
 lookup_open fs/namei.c:3492 [inline]
 open_last_lookups fs/namei.c:3560 [inline]
 path_openat+0x13df/0x3170 fs/namei.c:3788
 do_filp_open+0x234/0x490 fs/namei.c:3818
 do_sys_openat2+0x13f/0x500 fs/open.c:1356
 do_sys_open fs/open.c:1372 [inline]
 __do_sys_open fs/open.c:1380 [inline]
 __se_sys_open fs/open.c:1376 [inline]
 __x64_sys_open+0x225/0x270 fs/open.c:1376
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f146248c169
RSP: 002b:00007f146323d168 EFLAGS: 00000246
 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f14625ac050 RCX: 00007f146248c169
RDX: 0000000000000000 RSI: 0000000000060142 RDI: 0000000020000000
RBP: 00007f14624e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffd69a4babf R14: 00007f146323d300 R15: 0000000000022000
 </TASK>

Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
 #0: ffffffff8cf276f0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:518
1 lock held by rcu_tasks_trace/14:
 #0: ffffffff8cf27ab0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:518
1 lock held by khungtaskd/28:
 #0: ffffffff8cf27520 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by kworker/0:2/900:
 #0: ffff888012472538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2378
 #1: ffffc9000534fd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2380
2 locks held by getty/4751:
 #0: ffff88802d1ba098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
 #1: ffffc900015a02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6ab/0x1db0 drivers/tty/n_tty.c:2176
1 lock held by syz-executor.0/5025:
 #0: ffffffff8cf2cbf8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:293 [inline]
 #0: ffffffff8cf2cbf8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x3a3/0x890 kernel/rcu/tree_exp.h:992
1 lock held by syz-executor.4/5035:
2 locks held by kworker/1:5/5086:
2 locks held by syz-executor.1/6033:
 #0: ffff888140048460 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write_file+0x5e/0x1f0 fs/namespace.c:438
 #1: ffff888074de0af8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:775 [inline]
 #1: ffff888074de0af8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: vfs_fileattr_set+0x139/0xd40 fs/ioctl.c:681
3 locks held by syz-executor.1/6112:
 #0: ffff888140048460 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:394
 #1: ffff888074de0af8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:775 [inline]
 #1: ffff888074de0af8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: open_last_lookups fs/namei.c:3557 [inline]
 #1: ffff888074de0af8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: path_openat+0x7ba/0x3170 fs/namei.c:3788
 #2: ffff888140048650 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1246
1 lock held by syz-executor.5/8911:
 #0: ffffffff8cf2cbf8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:325 [inline]
 #0: ffffffff8cf2cbf8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x46c/0x890 kernel/rcu/tree_exp.h:992
4 locks held by syz-executor.1/8949:

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

NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.4.0-rc3-syzkaller-00291-g4e893b5aa4ac #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/25/2023
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1e7/0x2d0 lib/dump_stack.c:106
 nmi_cpu_backtrace+0x498/0x4d0 lib/nmi_backtrace.c:113
 nmi_trigger_cpumask_backtrace+0x187/0x300 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
 watchdog+0xec2/0xf00 kernel/hung_task.c:379
 kthread+0x2b8/0x350 kernel/kthread.c:379
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
 </TASK>
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 5187 Comm: kworker/u4:8 Not tainted 6.4.0-rc3-syzkaller-00291-g4e893b5aa4ac #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/25/2023
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:check_preemption_disabled+0x48/0x110 lib/smp_processor_id.c:55
Code: 54 75 65 8b 05 81 6f 54 75 a9 ff ff ff 7f 74 22 65 48 8b 04 25 28 00 00 00 48 3b 44 24 08 0f 85 c7 00 00 00 89 d8 48 83 c4 10 <5b> 41 5c 41 5e 41 5f c3 48 c7 04 24 00 00 00 00 9c 8f 04 24 f7 04
RSP: 0000:ffffc9000537faf8 EFLAGS: 00000082
RAX: 0000000000000001 RBX: 0000000000000001 RCX: ffffffff816b38a0
RDX: 0000000000000000 RSI: ffffffff8aea9b00 RDI: ffffffff8b3844c0
RBP: ffffc9000537fc50 R08: dffffc0000000000 R09: fffffbfff1cab8e6
R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffff92000a6ff70
R13: ffffffff815b2f51 R14: ffffc9000537fbd0 R15: dffffc0000000000
FS:  0000000000000000(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f1b1146e000 CR3: 000000000cd30000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <TASK>
 lockdep_recursion_inc kernel/locking/lockdep.c:462 [inline]
 lock_release+0x187/0x9d0 kernel/locking/lockdep.c:5710
 process_one_work+0x969/0x10e0 kernel/workqueue.c:2411
 worker_thread+0xa63/0x1210 kernel/workqueue.c:2552
 kthread+0x2b8/0x350 kernel/kthread.c:379
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
 </TASK>

Crashes (2):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/05/28 02:06 upstream 4e893b5aa4ac cf184559 .config console log report info [disk image] [vmlinux] [kernel image] ci2-upstream-fs INFO: task hung in vfs_fileattr_set
2023/04/25 23:08 upstream 173ea743bf7a 65320f8e .config console log report info [disk image] [vmlinux] [kernel image] ci2-upstream-fs INFO: task hung in vfs_fileattr_set
* Struck through repros no longer work on HEAD.