INFO: task syz.3.123:4132 blocked for more than 143 seconds.
Not tainted 6.1.110-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.123 state:D stack:22600 pid:4132 ppid:3637 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5241 [inline]
__schedule+0x143f/0x4570 kernel/sched/core.c:6558
schedule+0xbf/0x180 kernel/sched/core.c:6634
xlog_grant_head_wait+0x3b6/0xa00 fs/xfs/xfs_log.c:307
xlog_grant_head_check+0x295/0x480
xfs_log_reserve+0x3e1/0xc30 fs/xfs/xfs_log.c:486
xfs_trans_reserve+0x239/0x6a0 fs/xfs/xfs_trans.c:194
xfs_trans_alloc+0x41e/0x890 fs/xfs/xfs_trans.c:283
xfs_trans_alloc_inode+0x129/0x450 fs/xfs/xfs_trans.c:1191
xfs_attr_set+0xa4e/0x1660 fs/xfs/libxfs/xfs_attr.c:1024
xfs_attr_change fs/xfs/xfs_xattr.c:106 [inline]
xfs_xattr_set+0x227/0x3a0 fs/xfs/xfs_xattr.c:151
__vfs_setxattr+0x3e7/0x420 fs/xattr.c:182
__vfs_setxattr_noperm+0x12a/0x5e0 fs/xattr.c:216
vfs_setxattr+0x21d/0x420 fs/xattr.c:309
do_setxattr fs/xattr.c:594 [inline]
setxattr+0x250/0x2b0 fs/xattr.c:617
path_setxattr+0x1bc/0x2a0 fs/xattr.c:636
__do_sys_setxattr fs/xattr.c:652 [inline]
__se_sys_setxattr fs/xattr.c:648 [inline]
__x64_sys_setxattr+0xb7/0xd0 fs/xattr.c:648
do_syscall_x64 arch/x86/entry/common.c:51 [inline]
do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:81
entry_SYSCALL_64_after_hwframe+0x68/0xd2
RIP: 0033:0x7f6a6c17def9
RSP: 002b:00007f6a6cefc038 EFLAGS: 00000246 ORIG_RAX: 00000000000000bc
RAX: ffffffffffffffda RBX: 00007f6a6c335f80 RCX: 00007f6a6c17def9
RDX: 0000000020000100 RSI: 0000000020000340 RDI: 0000000020000040
RBP: 00007f6a6c1f0b76 R08: 0000000000000000 R09: 0000000000000000
R10: 000000000000fc21 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f6a6c335f80 R15: 00007ffc233cd198
INFO: task syz.3.123:4188 blocked for more than 144 seconds.
Not tainted 6.1.110-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.123 state:D stack:27024 pid:4188 ppid:3637 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5241 [inline]
__schedule+0x143f/0x4570 kernel/sched/core.c:6558
schedule+0xbf/0x180 kernel/sched/core.c:6634
xlog_grant_head_wait+0x3b6/0xa00 fs/xfs/xfs_log.c:307
xlog_grant_head_check+0x295/0x480
xfs_log_reserve+0x3e1/0xc30 fs/xfs/xfs_log.c:486
xfs_trans_reserve+0x239/0x6a0 fs/xfs/xfs_trans.c:194
xfs_trans_alloc+0x41e/0x890 fs/xfs/xfs_trans.c:283
xfs_trans_alloc_icreate+0xc5/0x2b0 fs/xfs/xfs_trans.c:1246
xfs_create+0x749/0x1360 fs/xfs/xfs_inode.c:1002
xfs_generic_create+0x48d/0xd70 fs/xfs/xfs_iops.c:199
vfs_mkdir+0x3b6/0x590 fs/namei.c:4108
do_mkdirat+0x225/0x360 fs/namei.c:4133
__do_sys_mkdirat fs/namei.c:4148 [inline]
__se_sys_mkdirat fs/namei.c:4146 [inline]
__x64_sys_mkdirat+0x85/0x90 fs/namei.c:4146
do_syscall_x64 arch/x86/entry/common.c:51 [inline]
do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:81
entry_SYSCALL_64_after_hwframe+0x68/0xd2
RIP: 0033:0x7f6a6c17def9
RSP: 002b:00007f6a6cedb038 EFLAGS: 00000246 ORIG_RAX: 0000000000000102
RAX: ffffffffffffffda RBX: 00007f6a6c336058 RCX: 00007f6a6c17def9
RDX: 0000000000000000 RSI: 0000000020000140 RDI: ffffffffffffff9c
RBP: 00007f6a6c1f0b76 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f6a6c336058 R15: 00007ffc233cd198
Showing all locks held in the system:
4 locks held by kworker/u4:1/11:
#0: ffff888017e1e938 ((wq_completion)netns){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#1: ffffc90000107d20 (net_cleanup_work){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#2: ffffffff8e4ed390 (pernet_ops_rwsem){++++}-{3:3}, at: cleanup_net+0xf1/0xb60 net/core/net_namespace.c:566
#3: ffffffff8e4f96e8 (rtnl_mutex){+.+.}-{3:3}, at: ip6gre_exit_batch_net+0xc0/0x460 net/ipv6/ip6_gre.c:1666
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8d32b1d0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xe30 kernel/rcu/tasks.h:517
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8d32b9d0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xe30 kernel/rcu/tasks.h:517
1 lock held by khungtaskd/28:
#0: ffffffff8d32b000 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:350 [inline]
#0: ffffffff8d32b000 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:791 [inline]
#0: ffffffff8d32b000 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x51/0x290 kernel/locking/lockdep.c:6494
1 lock held by dhcpcd/3305:
#0: ffffffff8e4f96e8 (rtnl_mutex){+.+.}-{3:3}, at: devinet_ioctl+0x2a5/0x1b20 net/ipv4/devinet.c:1070
2 locks held by getty/3393:
#0: ffff88802e0ef098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc900031262f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6a7/0x1db0 drivers/tty/n_tty.c:2198
4 locks held by syz-executor/3636:
#0: ffff88807e0e90b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close net/bluetooth/hci_core.c:508 [inline]
#0: ffff88807e0e90b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_unregister_dev+0x1ff/0x500 net/bluetooth/hci_core.c:2710
#1: ffff88807e0e8078 (&hdev->lock){+.+.}-{3:3}, at: hci_dev_close_sync+0x48d/0x1020 net/bluetooth/hci_sync.c:5053
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1800 [inline]
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_conn_hash_flush+0xb8/0x2a0 net/bluetooth/hci_conn.c:2446
#3: ffffffff8d3305f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:291 [inline]
#3: ffffffff8d3305f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x4f0/0x930 kernel/rcu/tree_exp.h:962
3 locks held by syz-executor/3650:
#0: ffff8880792810b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close net/bluetooth/hci_core.c:508 [inline]
#0: ffff8880792810b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_unregister_dev+0x1ff/0x500 net/bluetooth/hci_core.c:2710
#1: ffff888079280078 (&hdev->lock){+.+.}-{3:3}, at: hci_dev_close_sync+0x48d/0x1020 net/bluetooth/hci_sync.c:5053
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1800 [inline]
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_conn_hash_flush+0xb8/0x2a0 net/bluetooth/hci_conn.c:2446
2 locks held by kworker/1:3/3680:
#0: ffff888017c72138 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#1: ffffc90003f5fd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
2 locks held by kworker/1:9/3789:
#0: ffff888017c70938 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#1: ffffc9000453fd20 (free_ipc_work){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
3 locks held by kworker/u4:7/3973:
#0: ffff888017c79138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#1: ffffc90004757d20 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0x7a9/0x11d0 kernel/workqueue.c:2267
#2: ffffffff8e4f96e8 (rtnl_mutex){+.+.}-{3:3}, at: linkwatch_event+0xa/0x50 net/core/link_watch.c:263
2 locks held by kworker/u4:8/4091:
3 locks held by syz.3.123/4132:
#0: ffff888026e64460 (sb_writers#12){.+.+}-{0:0}, at: mnt_want_write+0x3b/0x80 fs/namespace.c:393
#1: ffff88805828d878 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: inode_lock include/linux/fs.h:758 [inline]
#1: ffff88805828d878 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{3:3}, at: vfs_setxattr+0x1dd/0x420 fs/xattr.c:308
#2: ffff888026e64650 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc_inode+0x129/0x450 fs/xfs/xfs_trans.c:1191
3 locks held by syz.3.123/4188:
#0: ffff888026e64460 (sb_writers#12){.+.+}-{0:0}, at: mnt_want_write+0x3b/0x80 fs/namespace.c:393
#1: ffff888058338338 (&inode->i_sb->s_type->i_mutex_dir_key/1){+.+.}-{3:3}, at: inode_lock_nested include/linux/fs.h:793 [inline]
#1: ffff888058338338 (&inode->i_sb->s_type->i_mutex_dir_key/1){+.+.}-{3:3}, at: filename_create+0x25c/0x530 fs/namei.c:3878
#2: ffff888026e64650 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc_icreate+0xc5/0x2b0 fs/xfs/xfs_trans.c:1246
3 locks held by syz-executor/4150:
#0: ffff888076d710b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close net/bluetooth/hci_core.c:508 [inline]
#0: ffff888076d710b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_unregister_dev+0x1ff/0x500 net/bluetooth/hci_core.c:2710
#1: ffff888076d70078 (&hdev->lock){+.+.}-{3:3}, at: hci_dev_close_sync+0x48d/0x1020 net/bluetooth/hci_sync.c:5053
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1800 [inline]
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_conn_hash_flush+0xb8/0x2a0 net/bluetooth/hci_conn.c:2446
3 locks held by syz-executor/4363:
#0: ffff8880672710b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close net/bluetooth/hci_core.c:508 [inline]
#0: ffff8880672710b8 (&hdev->req_lock){+.+.}-{3:3}, at: hci_unregister_dev+0x1ff/0x500 net/bluetooth/hci_core.c:2710
#1: ffff888067270078 (&hdev->lock){+.+.}-{3:3}, at: hci_dev_close_sync+0x48d/0x1020 net/bluetooth/hci_sync.c:5053
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1800 [inline]
#2: ffffffff8e650ac8 (hci_cb_list_lock){+.+.}-{3:3}, at: hci_conn_hash_flush+0xb8/0x2a0 net/bluetooth/hci_conn.c:2446
2 locks held by syz-executor/5286:
#0: ffffffff8e4f96e8 (rtnl_mutex){+.+.}-{3:3}, at: rtnl_lock net/core/rtnetlink.c:74 [inline]
#0: ffffffff8e4f96e8 (rtnl_mutex){+.+.}-{3:3}, at: rtnetlink_rcv_msg+0x7c1/0xff0 net/core/rtnetlink.c:6118
#1: ffffffff8d3305f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:323 [inline]
#1: ffffffff8d3305f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x360/0x930 kernel/rcu/tree_exp.h:962
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.1.110-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/06/2024
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e3/0x2cb lib/dump_stack.c:106
nmi_cpu_backtrace+0x4e1/0x560 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x1ae/0x3f0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:220 [inline]
watchdog+0xf88/0xfd0 kernel/hung_task.c:377
kthread+0x28d/0x320 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 3073 Comm: syslogd Not tainted 6.1.110-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/06/2024
RIP: 0010:aa_file_perm+0x251/0xf60 security/apparmor/file.c:622
Code: 90 fd 4d 85 f6 0f 84 9b 0b 00 00 e8 a9 1b 90 fd 49 83 c7 48 4c 89 f8 48 c1 e8 03 49 bc 00 00 00 00 00 fc ff df 42 0f b6 04 20 <84> c0 0f 85 ef 0b 00 00 45 8b 3f 48 8b 44 24 18 48 8d 58 40 48 89
RSP: 0018:ffffc9000313faa0 EFLAGS: 00000a02
RAX: 0000000000000000 RBX: 0000000000000001 RCX: ffff88807e8ebb80
RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000000
RBP: ffffc9000313fc38 R08: ffffffff83fa9375 R09: fffffbfff223b845
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: 1ffff92000627f60 R14: ffff888017e1dab0 R15: ffff88802dd5dc88
FS: 00007ffb19acc380(0000) GS:ffff8880b8f00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055753938f950 CR3: 000000002ee04000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
common_file_perm+0x173/0x1d0 security/apparmor/lsm.c:495
security_file_permission+0x65/0xa0 security/security.c:1534
rw_verify_area fs/read_write.c:374 [inline]
vfs_read+0x236/0xbf0 fs/read_write.c:461
ksys_read+0x19c/0x2c0 fs/read_write.c:613
do_syscall_x64 arch/x86/entry/common.c:51 [inline]
do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:81
entry_SYSCALL_64_after_hwframe+0x68/0xd2
RIP: 0033:0x7ffb19c20b6a
Code: 00 3d 00 00 41 00 75 0d 50 48 8d 3d 2d 08 0a 00 e8 ea 7d 01 00 31 c0 e9 07 ff ff ff 64 8b 04 25 18 00 00 00 85 c0 75 1b 0f 05 <48> 3d 00 f0 ff ff 76 6c 48 8b 15 8f a2 0d 00 f7 d8 64 89 02 48 83
RSP: 002b:00007fff52e86528 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007ffb19c20b6a
RDX: 00000000000000ff RSI: 0000564724aa2950 RDI: 0000000000000000
RBP: 0000564724aa2910 R08: 0000000000000001 R09: 0000000000000000
R10: 00007ffb19dbf3a3 R11: 0000000000000246 R12: 0000564724aa2996
R13: 0000564724aa2950 R14: 0000000000000000 R15: 00007ffb19dfda80