INFO: task kworker/1:1H:120 blocked for more than 143 seconds.
Not tainted 6.1.21-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:1H state:D stack:24864 pid:120 ppid:2 flags:0x00004000
Workqueue: xfs-log/loop3 xlog_ioend_work
Call Trace:
context_switch kernel/sched/core.c:5238 [inline]
__schedule+0x132c/0x4330 kernel/sched/core.c:6551
schedule+0xbf/0x180 kernel/sched/core.c:6627
schedule_timeout+0xac/0x300 kernel/time/timer.c:1911
___down_common+0x336/0x5d0 kernel/locking/semaphore.c:225
__down_common+0x8c/0x360 kernel/locking/semaphore.c:246
down+0x80/0xb0 kernel/locking/semaphore.c:63
xfs_buf_lock+0x171/0x5b0 fs/xfs/xfs_buf.c:1120
xfs_buf_item_unpin+0x209/0x7b0 fs/xfs/xfs_buf_item.c:547
xfs_trans_committed_bulk+0x342/0x830 fs/xfs/xfs_trans.c:806
xlog_cil_committed+0x269/0xed0 fs/xfs/xfs_log_cil.c:795
xlog_cil_process_committed+0x155/0x1a0 fs/xfs/xfs_log_cil.c:823
xlog_state_shutdown_callbacks+0x2b6/0x3a0 fs/xfs/xfs_log.c:538
xlog_force_shutdown+0x328/0x380 fs/xfs/xfs_log.c:3821
xlog_ioend_work+0xa9/0x100 fs/xfs/xfs_log.c:1402
process_one_work+0x8aa/0x11f0 kernel/workqueue.c:2289
worker_thread+0xa5f/0x1210 kernel/workqueue.c:2436
kthread+0x268/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
INFO: task syz-executor.3:18967 blocked for more than 143 seconds.
Not tainted 6.1.21-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:21928 pid:18967 ppid:3681 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5238 [inline]
__schedule+0x132c/0x4330 kernel/sched/core.c:6551
schedule+0xbf/0x180 kernel/sched/core.c:6627
xlog_wait+0x166/0x1e0 fs/xfs/xfs_log_priv.h:617
xlog_wait_on_iclog+0x31c/0x560 fs/xfs/xfs_log.c:907
xfs_log_force_seq+0x1d6/0x440 fs/xfs/xfs_log.c:3393
__xfs_trans_commit+0xb70/0x1080 fs/xfs/xfs_trans.c:1014
xfs_sync_sb_buf+0x14b/0x1e0 fs/xfs/libxfs/xfs_sb.c:1108
xfs_ioc_setlabel fs/xfs/xfs_ioctl.c:1805 [inline]
xfs_file_ioctl+0x126b/0x1700 fs/xfs/xfs_ioctl.c:1903
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:870 [inline]
__se_sys_ioctl+0xf1/0x160 fs/ioctl.c:856
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x3d/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7fedd3e8c0f9
RSP: 002b:00007fedd4b4a168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fedd3fabf80 RCX: 00007fedd3e8c0f9
RDX: 0000000020000200 RSI: 0000000041009432 RDI: 0000000000000004
RBP: 00007fedd3ee7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffab94125f R14: 00007fedd4b4a300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8cf26870 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8cf27070 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by khungtaskd/28:
#0: ffffffff8cf266a0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by kworker/1:1H/120:
#0: ffff88801ec22138 ((wq_completion)xfs-log/loop3){+.+.}-{0:0}, at: process_one_work+0x77a/0x11f0
#1: ffffc900025b7d20 ((work_completion)(&iclog->ic_end_io_work)){+.+.}-{0:0}, at: process_one_work+0x7bd/0x11f0 kernel/workqueue.c:2264
2 locks held by getty/3314:
#0: ffff88814abe8098 (&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:2177
1 lock held by syz-executor.4/3688:
#0: ffffffff8cf2bc78 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:324 [inline]
#0: ffffffff8cf2bc78 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x479/0x8a0 kernel/rcu/tree_exp.h:948
2 locks held by kworker/1:5/3725:
#0: ffff888012464d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x77a/0x11f0
#1: ffffc900046efd20 ((work_completion)(&fw_work->work)){+.+.}-{0:0}, at: process_one_work+0x7bd/0x11f0 kernel/workqueue.c:2264
6 locks held by kworker/0:7/18783:
#0: ffff888012761938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x77a/0x11f0
#1: ffffc90003c1fd20 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7bd/0x11f0 kernel/workqueue.c:2264
#2: ffff888022449190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:836 [inline]
#2: ffff888022449190 (&dev->mutex){....}-{3:3}, at: hub_event+0x20e/0x57b0 drivers/usb/core/hub.c:5683
#3: ffff8881474744f8 (&port_dev->status_lock){+.+.}-{3:3}, at: usb_lock_port drivers/usb/core/hub.c:3105 [inline]
#3: ffff8881474744f8 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_port_connect drivers/usb/core/hub.c:5251 [inline]
#3: ffff8881474744f8 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_port_connect_change drivers/usb/core/hub.c:5499 [inline]
#3: ffff8881474744f8 (&port_dev->status_lock){+.+.}-{3:3}, at: port_event drivers/usb/core/hub.c:5655 [inline]
#3: ffff8881474744f8 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x2278/0x57b0 drivers/usb/core/hub.c:5737
#4: ffff888020da5468 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_port_connect drivers/usb/core/hub.c:5252 [inline]
#4: ffff888020da5468 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_port_connect_change drivers/usb/core/hub.c:5499 [inline]
#4: ffff888020da5468 (hcd->address0_mutex){+.+.}-{3:3}, at: port_event drivers/usb/core/hub.c:5655 [inline]
#4: ffff888020da5468 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x22a1/0x57b0 drivers/usb/core/hub.c:5737
#5: ffffffff8da27bf0 (ehci_cf_port_reset_rwsem){.+.+}-{3:3}, at: hub_port_reset+0x1f2/0x2180 drivers/usb/core/hub.c:2962
3 locks held by kworker/u4:27/929:
2 locks held by kworker/0:15/5718:
#0: ffff888012466538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x77a/0x11f0
#1: ffffc9000396fd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x7bd/0x11f0 kernel/workqueue.c:2264
1 lock held by syz-executor.3/18967:
#0: ffff8880849c8460 (sb_writers#18){.+.+}-{0:0}, at: mnt_want_write_file+0x5a/0x1f0 fs/namespace.c:437
1 lock held by syz-executor.3/19025:
#0: ffffffff8cf2bc78 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:292 [inline]
#0: ffffffff8cf2bc78 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x3b0/0x8a0 kernel/rcu/tree_exp.h:948
1 lock held by syz-executor.0/21399:
#0: ffffffff8cf2bb40 (rcu_state.barrier_mutex){+.+.}-{3:3}, at: rcu_barrier+0x48/0x5f0 kernel/rcu/tree.c:3953
1 lock held by syz-executor.1/21420:
#0: ffffffff8cf2bb40 (rcu_state.barrier_mutex){+.+.}-{3:3}, at: rcu_barrier+0x48/0x5f0 kernel/rcu/tree.c:3953
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.1.21-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
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+0x1b0/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+0xf18/0xf60 kernel/hung_task.c:377
kthread+0x268/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 929 Comm: kworker/u4:27 Not tainted 6.1.21-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
Workqueue: bat_events batadv_nc_worker
RIP: 0010:hlock_class kernel/locking/lockdep.c:228 [inline]
RIP: 0010:mark_lock+0xa2/0x340 kernel/locking/lockdep.c:4613
Code: 00 8b 1b 81 e3 ff 1f 00 00 48 89 d8 48 c1 e8 06 48 8d 3c c5 80 f1 26 90 be 08 00 00 00 e8 26 9f 75 00 48 0f a3 1d ee e7 bc 0e <73> 11 48 8d 04 5b 48 c1 e0 06 48 8d 98 80 50 f6 8f eb 23 48 c7 c0
RSP: 0018:ffffc9000a457958 EFLAGS: 00000057
RAX: 0000000000000001 RBX: 000000000000002a RCX: ffffffff816a098a
RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff9026f180
RBP: 0000000000000009 R08: dffffc0000000000 R09: fffffbfff204de31
R10: 0000000000000000 R11: dffffc0000000001 R12: ffff88808008a788
R13: dffffc0000000000 R14: 0000000000000200 R15: ffff88808008a7e0
FS: 0000000000000000(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000555555aa6708 CR3: 000000003b7e9000 CR4: 00000000003526e0
Call Trace:
mark_usage kernel/locking/lockdep.c:4556 [inline]
__lock_acquire+0xc6a/0x1f80 kernel/locking/lockdep.c:5010
lock_acquire+0x1f8/0x5a0 kernel/locking/lockdep.c:5669
rcu_lock_acquire+0x2a/0x30 include/linux/rcupdate.h:306
rcu_read_lock include/linux/rcupdate.h:747 [inline]
batadv_nc_purge_orig_hash net/batman-adv/network-coding.c:408 [inline]
batadv_nc_worker+0xc1/0x5b0 net/batman-adv/network-coding.c:719
process_one_work+0x8aa/0x11f0 kernel/workqueue.c:2289
worker_thread+0xa5f/0x1210 kernel/workqueue.c:2436
kthread+0x268/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306