INFO: task kworker/1:3:4051 blocked for more than 144 seconds.
Not tainted 6.1.0-rc3-syzkaller-00058-gdd65a243a915 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:3 state:D stack:22128 pid:4051 ppid:2 flags:0x00004000
Workqueue: events request_firmware_work_func
Call Trace:
context_switch kernel/sched/core.c:5191 [inline]
__schedule+0x979/0x2770 kernel/sched/core.c:6503
schedule+0xda/0x1b0 kernel/sched/core.c:6579
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6638
__mutex_lock_common kernel/locking/mutex.c:679 [inline]
__mutex_lock+0xa44/0x1350 kernel/locking/mutex.c:747
device_lock include/linux/device.h:835 [inline]
ath9k_hif_usb_firmware_fail drivers/net/wireless/ath/ath9k/hif_usb.c:1135 [inline]
ath9k_hif_usb_firmware_cb+0x3a9/0x530 drivers/net/wireless/ath/ath9k/hif_usb.c:1268
request_firmware_work_func+0x12c/0x230 drivers/base/firmware_loader/main.c:1107
process_one_work+0x9bf/0x1710 kernel/workqueue.c:2289
worker_thread+0x665/0x1080 kernel/workqueue.c:2436
kthread+0x2ea/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/11:
#0: ffffffff87a95f50 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
5 locks held by kworker/1:1/24:
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
#0: ffff888109c14938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x86d/0x1710 kernel/workqueue.c:2260
#1: ffffc900001a7da8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a1/0x1710 kernel/workqueue.c:2264
#2: ffff88810f8ec190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#2: ffff88810f8ec190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1bc/0x4810 drivers/usb/core/hub.c:5737
#3: ffff8881186c0190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#3: ffff8881186c0190 (&dev->mutex){....}-{3:3}, at: __device_attach+0x76/0x530 drivers/base/dd.c:983
#4: ffff8881186c3118 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#4: ffff8881186c3118 (&dev->mutex){....}-{3:3}, at: __device_attach+0x76/0x530 drivers/base/dd.c:983
1 lock held by khungtaskd/26:
#0: ffffffff87a96aa0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6494
2 locks held by kworker/u4:2/33:
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
#0: ffff888100069138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x86d/0x1710 kernel/workqueue.c:2260
#1: ffffc90000447da8 ((work_completion)(&sub_info->work)){+.+.}-{0:0}, at: process_one_work+0x8a1/0x1710 kernel/workqueue.c:2264
3 locks held by kworker/0:2/71:
2 locks held by getty/1223:
#0:
ffff888110eea098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:244
#1: ffffc900000452f0 (
&ldata->atomic_read_lock){+.+.}-{3:3}
, at: n_tty_read+0xef0/0x13e0 drivers/tty/n_tty.c:2177
3 locks held by kworker/1:3/4051:
#0:
ffff888100064d38
((wq_completion)events
){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
){+.+.}-{0:0}, at: process_one_work+0x86d/0x1710 kernel/workqueue.c:2260
#1: ffffc900017c7da8 ((work_completion)(&fw_work->work)
){+.+.}-{0:0}
, at: process_one_work+0x8a1/0x1710 kernel/workqueue.c:2264
#2: ffff88810f9ac190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#2: ffff88810f9ac190 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_fail drivers/net/wireless/ath/ath9k/hif_usb.c:1135 [inline]
#2: ffff88810f9ac190 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_cb+0x3a9/0x530 drivers/net/wireless/ath/ath9k/hif_usb.c:1268
5 locks held by kworker/1:5/4103:
6 locks held by kworker/1:6/4192:
5 locks held by kworker/1:8/4257:
3 locks held by kworker/0:8/4917:
3 locks held by udevd/7948:
#0: ffff88811a711c88 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:236 [inline]
#0: ffff88811a711c88 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x189/0x7a0 fs/kernfs/file.c:276
#1: ffff888109284a00 (kn->active#24){++++}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:237 [inline]
#1: ffff888109284a00 (kn->active#24){++++}-{0:0}, at: kernfs_fop_read_iter+0x1ac/0x7a0 fs/kernfs/file.c:276
#2: ffff8881178f5190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff8881178f5190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:874
3 locks held by udevd/7964:
#0: ffff88811ce57488 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:236 [inline]
#0: ffff88811ce57488 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x189/0x7a0 fs/kernfs/file.c:276
#1: ffff888138e7dda0 (kn->active#24){++++}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:237 [inline]
#1: ffff888138e7dda0 (kn->active#24){++++}-{0:0}, at: kernfs_fop_read_iter+0x1ac/0x7a0 fs/kernfs/file.c:276
#2: ffff8881186c0190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff8881186c0190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:874
3 locks held by udevd/7965:
#0: ffff88810fef7088 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:236 [inline]
#0: ffff88810fef7088 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x189/0x7a0 fs/kernfs/file.c:276
#1: ffff8881100fc660 (kn->active#24){++++}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:237 [inline]
#1: ffff8881100fc660 (kn->active#24){++++}-{0:0}, at: kernfs_fop_read_iter+0x1ac/0x7a0 fs/kernfs/file.c:276
#2: ffff88813a5c8190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff88813a5c8190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:874
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 26 Comm: khungtaskd Not tainted 6.1.0-rc3-syzkaller-00058-gdd65a243a915 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
nmi_cpu_backtrace.cold+0x24/0x18a lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x32f/0x3c0 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+0xc71/0xfc0 kernel/hung_task.c:377
kthread+0x2ea/0x3a0 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: 24 Comm: kworker/1:1 Not tainted 6.1.0-rc3-syzkaller-00058-gdd65a243a915 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022
Workqueue: usb_hub_wq hub_event
RIP: 0010:format_decode+0x340/0xad0 lib/vsprintf.c:2594
Code: f9 12 0f 86 70 01 00 00 e8 4d c4 81 fb be 01 00 00 00 31 ff e8 d1 c0 81 fb e8 3c c4 81 fb 89 d8 bf 6c 00 00 00 31 db 83 c8 20 <89> c6 88 44 24 10 e8 b5 c0 81 fb 0f b6 44 24 10 4c 89 24 24 3c 6c
RSP: 0018:ffffc900001a66d0 EFLAGS: 00000202
RAX: 0000000000000075 RBX: 0000000000000000 RCX: ffffc9000c97c000
RDX: 0000000000040000 RSI: ffffffff85c51bd4 RDI: 000000000000006c
RBP: ffffc900001a67e8 R08: 0000000000000001 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000000 R12: ffffffff86488083
R13: ffffffff86488082 R14: 1ffff92000034cdd R15: 0000000000000001
FS: 0000000000000000(0000) GS:ffff8881f6900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fb065b10300 CR3: 00000001366e4000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
vsnprintf+0x155/0x14f0 lib/vsprintf.c:2752
snprintf+0xbb/0xf0 lib/vsprintf.c:2935
print_caller kernel/printk/printk.c:1283 [inline]
info_print_prefix+0x11c/0x340 kernel/printk/printk.c:1302
record_print_text+0x14d/0x3e0 kernel/printk/printk.c:1349
console_emit_next_record.constprop.0+0x6bf/0x840 kernel/printk/printk.c:2714
console_flush_all kernel/printk/printk.c:2793 [inline]
console_unlock+0x3be/0x600 kernel/printk/printk.c:2860
vprintk_emit+0x1b9/0x5f0 kernel/printk/printk.c:2268
vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
_printk+0xba/0xed kernel/printk/printk.c:2289
rc_map_get.cold+0x74/0x8e drivers/media/rc/rc-main.c:129
rc_prepare_rx_device drivers/media/rc/rc-main.c:1795 [inline]
rc_register_device+0x1107/0x16b0 drivers/media/rc/rc-main.c:1927
rc_core_dvb_usb_remote_init drivers/media/usb/dvb-usb/dvb-usb-remote.c:289 [inline]
dvb_usb_remote_init+0x784/0x1600 drivers/media/usb/dvb-usb/dvb-usb-remote.c:337
dvb_usb_init drivers/media/usb/dvb-usb/dvb-usb-init.c:188 [inline]
dvb_usb_device_init.cold+0xa76/0x14c0 drivers/media/usb/dvb-usb/dvb-usb-init.c:308
dw2102_probe+0x188/0x240 drivers/media/usb/dvb-usb/dw2102.c:2561
usb_probe_interface+0x30b/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:560 [inline]
really_probe+0x249/0xb90 drivers/base/dd.c:639
__driver_probe_device+0x1df/0x4d0 drivers/base/dd.c:778
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:808
__device_attach_driver+0x1d0/0x2e0 drivers/base/dd.c:936
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:1008
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbd5/0x1e90 drivers/base/core.c:3517
usb_set_configuration+0x1019/0x1900 drivers/usb/core/message.c:2170
usb_generic_driver_probe+0xba/0x100 drivers/usb/core/generic.c:238
usb_probe_device+0xd4/0x2c0 drivers/usb/core/driver.c:293
call_driver_probe drivers/base/dd.c:560 [inline]
really_probe+0x249/0xb90 drivers/base/dd.c:639
__driver_probe_device+0x1df/0x4d0 drivers/base/dd.c:778
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:808
__device_attach_driver+0x1d0/0x2e0 drivers/base/dd.c:936
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:1008
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbd5/0x1e90 drivers/base/core.c:3517
usb_new_device.cold+0x685/0x10ad drivers/usb/core/hub.c:2573
hub_port_connect drivers/usb/core/hub.c:5405 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5549 [inline]
port_event drivers/usb/core/hub.c:5709 [inline]
hub_event+0x2d58/0x4810 drivers/usb/core/hub.c:5791
process_one_work+0x9bf/0x1710 kernel/workqueue.c:2289
process_scheduled_works kernel/workqueue.c:2352 [inline]
worker_thread+0x854/0x1080 kernel/workqueue.c:2438
kthread+0x2ea/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306