INFO: task syz.2.460:8255 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.2.460       state:D stack:25096 pid:8255  tgid:8255  ppid:7857   task_flags:0x440040 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 xlog_grant_head_wait+0x453/0xa20
 xlog_grant_head_check+0x286/0x420
 xfs_log_reserve+0x2cc/0x780
 xfs_trans_alloc+0x29c/0x980
 xfs_free_eofblocks+0x1cb/0x4a0
 xfs_file_release+0x3e7/0x470
 __fput+0x44c/0xa70
 task_work_run+0x1d4/0x260
 exit_to_user_mode_loop+0xec/0x110
 do_syscall_64+0x2bd/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f891258ec29
RSP: 002b:00007ffd45515b78 EFLAGS: 00000246 ORIG_RAX: 00000000000001b4
RAX: 0000000000000000 RBX: 00007f89127d7da0 RCX: 00007f891258ec29
RDX: 0000000000000000 RSI: 000000000000001e RDI: 0000000000000003
RBP: 00007f89127d7da0 R08: 000000000000017c R09: 0000001145515e6f
R10: 00007f89127d7cb0 R11: 0000000000000246 R12: 000000000002afd3
R13: 00007ffd45515c70 R14: ffffffffffffffff R15: 00007ffd45515c90
 </TASK>
INFO: task syz.2.460:8256 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.2.460       state:D stack:24584 pid:8256  tgid:8255  ppid:7857   task_flags:0x440140 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 xlog_grant_head_wait+0x453/0xa20
 xlog_grant_head_check+0x286/0x420
 xfs_log_reserve+0x2cc/0x780
 xfs_trans_alloc+0x29c/0x980
 xfs_trans_alloc_inode+0x13c/0x4a0
 xfs_attr_set+0x7fa/0x1210
 xfs_xattr_set+0x14d/0x250
 __vfs_setxattr+0x43c/0x480
 __vfs_setxattr_noperm+0x12d/0x660
 vfs_setxattr+0x16b/0x2f0
 filename_setxattr+0x274/0x600
 path_setxattrat+0x364/0x3a0
 __x64_sys_lsetxattr+0xbf/0xe0
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f891258ec29
RSP: 002b:00007f89107f6038 EFLAGS: 00000246 ORIG_RAX: 00000000000000bd
RAX: ffffffffffffffda RBX: 00007f89127d5fa0 RCX: 00007f891258ec29
RDX: 00002000000000c0 RSI: 0000200000000080 RDI: 0000200000000300
RBP: 00007f8912611e41 R08: 0000000000000000 R09: 0000000000000000
R10: 000000000000fd3f R11: 0000000000000246 R12: 0000000000000000
R13: 00007f89127d6038 R14: 00007f89127d5fa0 R15: 00007ffd45515a18
 </TASK>

Showing all locks held in the system:
2 locks held by kworker/1:0/24:
 #0: ffff888129d52948 ((wq_completion)xfs-sync/loop2){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc900001c7bc0 ((work_completion)(&(&log->l_work)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
1 lock held by khungtaskd/34:
 #0: ffffffff8e13a0e0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180
3 locks held by kworker/1:4/976:
 #0: ffff88801a480d48 ((wq_completion)events){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc90006977bc0 (deferred_process_work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: switchdev_deferred_process_work+0xe/0x20
2 locks held by getty/5673:
 #0: ffff888104f490a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70
 #1: ffffc900026182f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x43e/0x1400
5 locks held by kworker/u8:4/5890:
 #0: ffff88801b2f7148 ((wq_completion)netns){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc900043cfbc0 (net_cleanup_work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffffffff8f52d350 (pernet_ops_rwsem){++++}-{4:4}, at: cleanup_net+0xf7/0x800
 #3: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: ops_undo_list+0x2a4/0x990
 #4: ffffffff8e13fb78 (rcu_state.exp_mutex){+.+.}-{4:4}, at: synchronize_rcu_expedited+0x2f6/0x730
4 locks held by kworker/u9:5/6365:
 #0: ffff88801abe0148 ((wq_completion)writeback){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc90002bbfbc0 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffff88811096e0e0 (&type->s_umount_key#56){++++}-{4:4}, at: super_trylock_shared+0x20/0xf0
 #3: ffff88811096e618 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc+0xd7/0x980
2 locks held by syz.2.460/8255:
 #0: ffff888122eceb30 (&sb->s_type->i_mutex_key#22){++++}-{4:4}, at: xfs_ilock_nowait+0xe7/0x530
 #1: ffff88811096e618 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc+0xd7/0x980
3 locks held by syz.2.460/8256:
 #0: ffff88811096e428 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write+0x41/0x90
 #1: ffff888122ece330 (&inode->i_sb->s_type->i_mutex_dir_key){++++}-{4:4}, at: vfs_setxattr+0x144/0x2f0
 #2: ffff88811096e618 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc+0xd7/0x980
1 lock held by syz-executor/8600:
 #0: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: tun_chr_close+0x3e/0x1c0
1 lock held by syz.1.573/8895:
 #0: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: tun_chr_close+0x3e/0x1c0
3 locks held by kworker/u10:9/11246:
 #0: ffff88801a489148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc90002ddfbc0 ((linkwatch_work).work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0xe/0x60
2 locks held by kworker/u9:12/11439:
1 lock held by syz.9.1208/11549:
 #0: ffffffff8f53a208 (rtnl_mutex){+.+.}-{4:4}, at: wext_ioctl_dispatch+0xa2/0x410

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

NMI backtrace for cpu 1
CPU: 1 UID: 0 PID: 34 Comm: khungtaskd Not tainted syzkaller #0 PREEMPT(full) 
Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
Call Trace:
 <TASK>
 dump_stack_lvl+0x189/0x250
 nmi_cpu_backtrace+0x39e/0x3d0
 nmi_trigger_cpumask_backtrace+0x17a/0x300
 watchdog+0xf93/0xfe0
 kthread+0x711/0x8a0
 ret_from_fork+0x439/0x7d0
 ret_from_fork_asm+0x1a/0x30
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 11552 Comm: syz.7.1207 Not tainted syzkaller #0 PREEMPT(full) 
Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
RIP: 0010:lockdep_hardirqs_on+0x63/0x150
Code: 00 75 51 65 8b 05 7d b7 26 07 85 c0 75 7b 65 8b 05 3a b4 26 07 85 c0 75 70 83 3d 57 ca 31 0e 00 75 32 48 c7 04 24 00 00 00 00 <9c> 8f 04 24 f7 04 24 00 02 00 00 75 6e 83 3d 39 ca 31 0e 00 75 14
RSP: 0018:ffffc9000470f4b0 EFLAGS: 00000046
RAX: 0000000000000000 RBX: ffff88803aab3980 RCX: ae5def7b2e20dd00
RDX: 0000000000000000 RSI: ffffffff8dba996e RDI: ffffffff8b7a6234
RBP: 0000000000000000 R08: ffffffff8fa3a837 R09: 1ffffffff1f47506
R10: dffffc0000000000 R11: fffffbfff1f47507 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
FS:  00007f0629a276c0(0000) GS:ffff8880b8613000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000000000 CR3: 0000000123b80000 CR4: 00000000000006f0
Call Trace:
 <TASK>
 irqentry_exit+0x74/0x90
 exc_page_fault+0x9f/0xf0
 asm_exc_page_fault+0x26/0x30
RIP: 0010:strncpy_from_user+0x259/0x290
Code: e0 48 83 c4 10 5b 41 5c 41 5d 41 5e 41 5f 5d e9 3d 0e 7e 06 cc e8 a7 7f c0 fc 45 31 e4 eb df f3 0f 1e fa e8 99 7f c0 fc eb bc <f3> 0f 1e fa e8 8e 7f c0 fc 4c 8b 74 24 08 4d 89 f5 4d 29 e5 49 89
RSP: 0018:ffffc9000470f5c0 EFLAGS: 00010246
RAX: ffffffff84ff2c37 RBX: 0000000000000000 RCX: ffff88803aab3980
RDX: 0000000000000002 RSI: 0000000000000200 RDI: 0000000000000007
RBP: fffffffffffffff8 R08: ffff88804b0316ff R09: 1ffff110096062df
R10: dffffc0000000000 R11: ffffed10096062e0 R12: 0000000000000000
R13: dffffc0000000000 R14: 0000000000000200 R15: 0000000000000000
 strncpy_from_user_nofault+0x72/0x150
 bpf_bprintf_prepare+0xbbc/0x13d0
 bpf_trace_printk+0xdb/0x190
 bpf_prog_7c77c7e0f6645ad8+0x3e/0x44
 bpf_trace_run2+0x284/0x4b0
 __traceiter_kfree+0x2e/0x50
 kfree+0x3a0/0x440
 ___sys_recvmsg+0x1c4/0x510
 do_recvmmsg+0x307/0x770
 __x64_sys_recvmmsg+0x190/0x240
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f0628b8ec29
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f0629a27038 EFLAGS: 00000246 ORIG_RAX: 000000000000012b
RAX: ffffffffffffffda RBX: 00007f0628dd6090 RCX: 00007f0628b8ec29
RDX: 0000000000010106 RSI: 00002000000000c0 RDI: 0000000000000003
RBP: 00007f0628c11e41 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000002 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f0628dd6128 R14: 00007f0628dd6090 R15: 00007ffe9c0e63e8
 </TASK>
