INFO: task syz-executor.1:29848 blocked for more than 143 seconds.
Not tainted 6.9.0-rc4-next-20240416-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1 state:D stack:24184 pid:29848 tgid:29847 ppid:28563 flags:0x00004006
Call Trace:
context_switch kernel/sched/core.c:5408 [inline]
__schedule+0x17e8/0x4a50 kernel/sched/core.c:6745
__schedule_loop kernel/sched/core.c:6822 [inline]
schedule+0x14b/0x320 kernel/sched/core.c:6837
xlog_grant_head_wait+0x397/0x970 fs/xfs/xfs_log.c:307
xlog_grant_head_check+0x299/0x480
xfs_log_reserve+0x3d4/0xb80 fs/xfs/xfs_log.c:486
xfs_trans_reserve+0x239/0x6b0 fs/xfs/xfs_trans.c:195
xfs_trans_alloc+0x40e/0x830 fs/xfs/xfs_trans.c:284
xfs_trans_alloc_inode+0x1ac/0x5d0 fs/xfs/xfs_trans.c:1203
xfs_attr_set+0xa56/0x1680 fs/xfs/libxfs/xfs_attr.c:983
xfs_attr_change fs/xfs/xfs_xattr.c:117 [inline]
xfs_xattr_set+0x22b/0x3a0 fs/xfs/xfs_xattr.c:165
__vfs_setxattr+0x468/0x4a0 fs/xattr.c:200
__vfs_setxattr_noperm+0x12e/0x660 fs/xattr.c:234
vfs_setxattr+0x221/0x430 fs/xattr.c:321
do_setxattr fs/xattr.c:629 [inline]
setxattr+0x25d/0x2f0 fs/xattr.c:652
path_setxattr+0x1c0/0x2a0 fs/xattr.c:671
__do_sys_lsetxattr fs/xattr.c:694 [inline]
__se_sys_lsetxattr fs/xattr.c:690 [inline]
__x64_sys_lsetxattr+0xb8/0xd0 fs/xattr.c:690
do_syscall_x64 arch/x86/entry/common.c:52 [inline]
do_syscall_64+0xf5/0x240 arch/x86/entry/common.c:83
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f2e0e67dea9
RSP: 002b:00007f2e0f3fb0c8 EFLAGS: 00000246 ORIG_RAX: 00000000000000bd
RAX: ffffffffffffffda RBX: 00007f2e0e7abf80 RCX: 00007f2e0e67dea9
RDX: 0000000020000100 RSI: 0000000020000040 RDI: 0000000020000000
RBP: 00007f2e0e6ca4a4 R08: 0000000000000000 R09: 0000000000000000
R10: 000000000000fffe R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000000b R14: 00007f2e0e7abf80 R15: 00007fffb7e2a3a8
INFO: task syz-executor.1:29889 blocked for more than 143 seconds.
Not tainted 6.9.0-rc4-next-20240416-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1 state:D stack:26704 pid:29889 tgid:29847 ppid:28563 flags:0x00000006
Call Trace:
context_switch kernel/sched/core.c:5408 [inline]
__schedule+0x17e8/0x4a50 kernel/sched/core.c:6745
__schedule_loop kernel/sched/core.c:6822 [inline]
schedule+0x14b/0x320 kernel/sched/core.c:6837
xlog_grant_head_wait+0x397/0x970 fs/xfs/xfs_log.c:307
xlog_grant_head_check+0x299/0x480
xfs_log_reserve+0x3d4/0xb80 fs/xfs/xfs_log.c:486
xfs_trans_reserve+0x239/0x6b0 fs/xfs/xfs_trans.c:195
xfs_trans_alloc+0x40e/0x830 fs/xfs/xfs_trans.c:284
xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1320
xfs_create+0x7e5/0x1320 fs/xfs/xfs_inode.c:1062
xfs_generic_create+0x495/0xd70 fs/xfs/xfs_iops.c:199
lookup_open fs/namei.c:3497 [inline]
open_last_lookups fs/namei.c:3566 [inline]
path_openat+0x1425/0x3280 fs/namei.c:3796
do_filp_open+0x235/0x490 fs/namei.c:3826
do_sys_openat2+0x13e/0x1d0 fs/open.c:1405
do_sys_open fs/open.c:1420 [inline]
__do_sys_openat fs/open.c:1436 [inline]
__se_sys_openat fs/open.c:1431 [inline]
__x64_sys_openat+0x247/0x2a0 fs/open.c:1431
do_syscall_x64 arch/x86/entry/common.c:52 [inline]
do_syscall_64+0xf5/0x240 arch/x86/entry/common.c:83
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f2e0e67dea9
RSP: 002b:00007f2e0f3b90c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f2e0e7ac120 RCX: 00007f2e0e67dea9
RDX: 000000000000275a RSI: 00000000200001c0 RDI: ffffffffffffff9c
RBP: 00007f2e0e6ca4a4 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007f2e0e7ac120 R15: 00007fffb7e2a3a8
Showing all locks held in the system:
1 lock held by khungtaskd/30:
#0: ffffffff8e333b60 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:329 [inline]
#0: ffffffff8e333b60 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:841 [inline]
#0: ffffffff8e333b60 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6614
2 locks held by getty/4837:
#0: ffff88802f9410a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
#1: ffffc90002f162f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b5/0x1e10 drivers/tty/n_tty.c:2201
1 lock held by syz-executor.2/29832:
#0: ffffffff8e338f38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:323 [inline]
#0: ffffffff8e338f38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x451/0x830 kernel/rcu/tree_exp.h:939
3 locks held by syz-executor.1/29848:
#0: ffff88807ad30420 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:409
#1: ffff88805b083978 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#1: ffff88805b083978 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: vfs_setxattr+0x1e1/0x430 fs/xattr.c:320
#2: ffff88807ad30610 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_inode+0x1ac/0x5d0 fs/xfs/xfs_trans.c:1203
3 locks held by syz-executor.1/29889:
#0: ffff88807ad30420 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:409
#1: ffff88806d9cd878 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#1: ffff88806d9cd878 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: open_last_lookups fs/namei.c:3563 [inline]
#1: ffff88806d9cd878 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: path_openat+0x7d3/0x3280 fs/namei.c:3796
#2: ffff88807ad30610 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1320
3 locks held by syz-executor.0/30026:
#0: ffff88806bd9c420 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:409
#1: ffff888026af92b8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#1: ffff888026af92b8 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: vfs_setxattr+0x1e1/0x430 fs/xattr.c:320
#2: ffff88806bd9c610 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_inode+0x1ac/0x5d0 fs/xfs/xfs_trans.c:1203
3 locks held by syz-executor.0/30068:
#0: ffff88806bd9c420 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:409
#1: ffff888026aff778 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#1: ffff888026aff778 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: open_last_lookups fs/namei.c:3563 [inline]
#1: ffff888026aff778 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: path_openat+0x7d3/0x3280 fs/namei.c:3796
#2: ffff88806bd9c610 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1320
1 lock held by syz-executor.4/31214:
#0: ffffffff8e338f38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:323 [inline]
#0: ffffffff8e338f38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x451/0x830 kernel/rcu/tree_exp.h:939
2 locks held by syz-executor.0/31720:
#0: ffff88807e376810 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#0: ffff88807e376810 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release net/socket.c:658 [inline]
#0: ffff88807e376810 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: sock_close+0x90/0x240 net/socket.c:1421
#1: ffffffff8f5d5348 (rtnl_mutex){+.+.}-{3:3}, at: packet_flush_mclist net/packet/af_packet.c:3753 [inline]
#1: ffffffff8f5d5348 (rtnl_mutex){+.+.}-{3:3}, at: packet_release+0x47e/0xcc0 net/packet/af_packet.c:3151
3 locks held by syz-executor.0/31721:
#0: ffffffff8f5ba4c8 (br_ioctl_mutex){+.+.}-{3:3}, at: br_ioctl_call net/socket.c:1193 [inline]
#0: ffffffff8f5ba4c8 (br_ioctl_mutex){+.+.}-{3:3}, at: sock_ioctl+0x5c6/0x8e0 net/socket.c:1295
#1: ffffffff8f5d5348 (rtnl_mutex){+.+.}-{3:3}, at: br_ioctl_stub+0xa4/0xb00 net/bridge/br_ioctl.c:402
#2: ffffffff8e338e00 (rcu_state.barrier_mutex){+.+.}-{3:3}, at: rcu_barrier+0x4c/0x550 kernel/rcu/tree.c:4478
1 lock held by syz-executor.1/31738:
#0: ffff888048ec6e10 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:791 [inline]
#0: ffff888048ec6e10 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release net/socket.c:658 [inline]
#0: ffff888048ec6e10 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: sock_close+0x90/0x240 net/socket.c:1421
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 30 Comm: khungtaskd Not tainted 6.9.0-rc4-next-20240416-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x241/0x360 lib/dump_stack.c:114
nmi_cpu_backtrace+0x49c/0x4d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x198/0x320 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:160 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:223 [inline]
watchdog+0xfde/0x1020 kernel/hung_task.c:379
kthread+0x2f0/0x390 kernel/kthread.c:389
ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 61 Comm: kworker/u8:4 Not tainted 6.9.0-rc4-next-20240416-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
Workqueue: bat_events batadv_nc_worker
RIP: 0010:check_preemption_disabled+0xb/0x120 lib/smp_processor_id.c:13
Code: 8c eb 1c 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 41 57 41 56 41 54 53 48 83 ec 10 <65> 48 8b 04 25 28 00 00 00 48 89 44 24 08 65 8b 1d 7c 7b 7d 74 65
RSP: 0018:ffffc900015c7990 EFLAGS: 00000086
RAX: 0000000000000001 RBX: ffff888017fc1e00 RCX: 0000000000000001
RDX: 0000000000000000 RSI: ffffffff8bcab360 RDI: ffffffff8c1f8fa0
RBP: ffffc900015c7ab0 R08: ffff888061459603 R09: 1ffff1100c28b2c0
R10: dffffc0000000000 R11: ffffed100c28b2c1 R12: dffffc0000000000
R13: 1ffff920002b8f48 R14: ffffffff815a44e6 R15: 0000000000000201
FS: 0000000000000000(0000) GS:ffff8880b9500000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fc0c3579198 CR3: 000000000e132000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lockdep_hardirqs_off+0x75/0x110 kernel/locking/lockdep.c:4460
trace_hardirqs_off+0x12/0x40 kernel/trace/trace_preemptirq.c:87
__local_bh_enable_ip+0x106/0x200 kernel/softirq.c:364
spin_unlock_bh include/linux/spinlock.h:396 [inline]
batadv_nc_purge_paths+0x30f/0x3b0 net/batman-adv/network-coding.c:471
batadv_nc_worker+0x365/0x610 net/batman-adv/network-coding.c:722
process_one_work kernel/workqueue.c:3218 [inline]
process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3299
worker_thread+0x86d/0xd70 kernel/workqueue.c:3380
kthread+0x2f0/0x390 kernel/kthread.c:389
ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
vkms_vblank_simulate: vblank timer overrun