INFO: task kworker/0:1:12 blocked for more than 143 seconds.
Not tainted 5.19.0-rc7-syzkaller-00199-g8288c99fc263 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:1 state:D
stack:22464 pid: 12 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:5146 [inline]
__schedule+0x93f/0x2630 kernel/sched/core.c:6458
schedule+0xd2/0x1f0 kernel/sched/core.c:6530
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1911
do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common+0x378/0x530 kernel/sched/completion.c:106
__flush_workqueue+0x3ed/0x13a0 kernel/workqueue.c:2861
ath6kl_usb_flush_all drivers/net/wireless/ath/ath6kl/usb.c:481 [inline]
hif_detach_htc drivers/net/wireless/ath/ath6kl/usb.c:861 [inline]
ath6kl_usb_power_off+0xdc/0x140 drivers/net/wireless/ath/ath6kl/usb.c:1060
ath6kl_hif_power_off drivers/net/wireless/ath/ath6kl/hif-ops.h:143 [inline]
ath6kl_core_init drivers/net/wireless/ath/ath6kl/core.c:257 [inline]
ath6kl_core_init+0x236/0x11c0 drivers/net/wireless/ath/ath6kl/core.c:66
ath6kl_usb_probe+0xc11/0x1200 drivers/net/wireless/ath/ath6kl/usb.c:1160
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:555 [inline]
really_probe+0x23e/0xb90 drivers/base/dd.c:634
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:764
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:794
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:917
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:989
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbda/0x1ea0 drivers/base/core.c:3428
usb_set_configuration+0x101e/0x1900 drivers/usb/core/message.c:2170
usb_generic_driver_probe+0xba/0x100 drivers/usb/core/generic.c:238
usb_probe_device+0xd9/0x2c0 drivers/usb/core/driver.c:293
call_driver_probe drivers/base/dd.c:555 [inline]
really_probe+0x23e/0xb90 drivers/base/dd.c:634
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:764
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:794
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:917
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:989
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbda/0x1ea0 drivers/base/core.c:3428
usb_new_device.cold+0x641/0x1091 drivers/usb/core/hub.c:2573
hub_port_connect drivers/usb/core/hub.c:5353 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5497 [inline]
port_event drivers/usb/core/hub.c:5653 [inline]
hub_event+0x25d5/0x4690 drivers/usb/core/hub.c:5735
process_one_work+0x996/0x1610 kernel/workqueue.c:2289
worker_thread+0x665/0x1080 kernel/workqueue.c:2436
kthread+0x2ef/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
INFO: task kworker/1:1:24 blocked for more than 144 seconds.
Not tainted 5.19.0-rc7-syzkaller-00199-g8288c99fc263 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:1 state:D
stack:22104 pid: 24 ppid: 2 flags:0x00004000
Workqueue: events request_firmware_work_func
Call Trace:
context_switch kernel/sched/core.c:5146 [inline]
__schedule+0x93f/0x2630 kernel/sched/core.c:6458
schedule+0xd2/0x1f0 kernel/sched/core.c:6530
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6589
__mutex_lock_common kernel/locking/mutex.c:679 [inline]
__mutex_lock+0xa70/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+0x996/0x1610 kernel/workqueue.c:2289
worker_thread+0x665/0x1080 kernel/workqueue.c:2436
kthread+0x2ef/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Showing all locks held in the system:
5 locks held by kworker/0:1/12:
#0:
ffff888109b4ed38
((wq_completion)usb_hub_wq
){+.+.}-{0:0}
, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
, at: set_work_data kernel/workqueue.c:636 [inline]
, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1:
ffffc900000cfda8
(
(work_completion)(&hub->events)
){+.+.}-{0:0}
, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
#2:
ffff88810f2a8190
(
&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: hub_event+0x1c1/0x4690 drivers/usb/core/hub.c:5681
#3:
ffff888116a9d190
(
&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: __device_attach+0x76/0x530 drivers/base/dd.c:964
#4:
ffff888111df7118
(&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: __device_attach+0x76/0x530 drivers/base/dd.c:964
3 locks held by kworker/1:1/24:
#0:
ffff888100064d38
(
(wq_completion)events
){+.+.}-{0:0}
, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
, at: set_work_data kernel/workqueue.c:636 [inline]
, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1:
ffffc900001a7da8
(
(work_completion)(&fw_work->work)
){+.+.}-{0:0}
, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
#2:
ffff88810f2a8190
(
&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: ath9k_hif_usb_firmware_fail drivers/net/wireless/ath/ath9k/hif_usb.c:1135 [inline]
, at: ath9k_hif_usb_firmware_cb+0x3a9/0x530 drivers/net/wireless/ath/ath9k/hif_usb.c:1268
1 lock held by khungtaskd/26:
#0:
ffffffff87a95140
(rcu_read_lock
){....}-{1:2}
, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6491
6 locks held by kworker/0:3/1140:
6 locks held by syslogd/1162:
#0:
ffff8881f6937b58
(&rq->__lock
){-.-.}-{2:2}
, at: raw_spin_rq_lock_nested+0x1e/0x30 kernel/sched/core.c:544
#1:
ffff8881110ad1e8
(
rlock-AF_UNIX
){+.+.}-{2:2}
, at: __skb_try_recv_datagram+0x13a/0x4e0 net/core/datagram.c:262
#2:
ffffffff87a95140
(
rcu_read_lock
){....}-{1:2}
, at: constant_test_bit arch/x86/include/asm/bitops.h:207 [inline]
, at: test_bit include/asm-generic/bitops/instrumented-non-atomic.h:135 [inline]
, at: task_spread_page include/linux/sched.h:1782 [inline]
, at: cpuset_do_page_mem_spread include/linux/cpuset.h:125 [inline]
, at: filemap_alloc_folio mm/filemap.c:986 [inline]
, at: __filemap_get_folio+0xb2/0x10c0 mm/filemap.c:1992
#3:
ffffffff87a95140
(
rcu_read_lock
){....}-{1:2}
, at: page_pgdat include/linux/mm.h:1484 [inline]
, at: __mod_lruvec_page_state+0x6f/0x3e0 mm/memcontrol.c:761
#4:
ffffffff8b9938c8
(
&obj_hash[i].lock
){-.-.}-{2:2}
, at: debug_object_activate+0x12e/0x3e0 lib/debugobjects.c:658
#5:
ffffffff8ba1cde8
(
&obj_hash[i].lock
){-.-.}-{2:2}
, at: debug_object_activate+0x12e/0x3e0 lib/debugobjects.c:658
2 locks held by getty/1239:
#0:
ffff88810020c098
(
&tty->ldisc_sem
){++++}-{0:0}
, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:244
#1:
ffffc900000432e8
(
&ldata->atomic_read_lock
){+.+.}-{3:3}
, at: n_tty_read+0xe50/0x13c0 drivers/tty/n_tty.c:2124
3 locks held by udevd/3984:
#0:
ffff888110065888
(
&of->mutex
){+.+.}-{3:3}
, at: kernfs_file_read_iter fs/kernfs/file.c:197 [inline]
, at: kernfs_fop_read_iter+0x189/0x6e0 fs/kernfs/file.c:236
#1:
ffff888111ca3830
(
kn->active
#48
){++++}-{0:0}
, at: kernfs_file_read_iter fs/kernfs/file.c:198 [inline]
, at: kernfs_fop_read_iter+0x1ac/0x6e0 fs/kernfs/file.c:236
#2: ffff888116a9d190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff888116a9d190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:873
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 26 Comm: khungtaskd Not tainted 5.19.0-rc7-syzkaller-00199-g8288c99fc263 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/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+0x47/0x144 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x1e6/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
watchdog+0xc1d/0xf50 kernel/hung_task.c:369
kthread+0x2ef/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:
cdc_wdm 6-1:1.0: nonzero urb status received: -71
NMI backtrace for cpu 1
CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.19.0-rc7-syzkaller-00199-g8288c99fc263 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022
RIP: 0010:io_serial_out+0x8b/0xa0 drivers/tty/serial/8250/8250_port.c:467
Code: 48 8d 7d 40 44 89 e1 48 b8 00 00 00 00 00 fc ff df 48 89 fa d3 e3 48 c1 ea 03 80 3c 02 00 75 18 66 03 5d 40 44 89 e8 89 da ee <5b> 5d 41 5c 41 5d c3 e8 49 63 20 ff eb a4 e8 72 63 20 ff eb e1 41
RSP: 0018:ffffc900001783b8 EFLAGS: 00000002
RAX: 000000000000005b RBX: 00000000000003f8 RCX: 0000000000000000
RDX: 00000000000003f8 RSI: ffffffff8259bab1 RDI: ffffffff8ba8ed40
RBP: ffffffff8ba8ed00 R08: 0000000000000001 R09: 000000000000001f
R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000000
R13: 000000000000005b R14: ffffffff8259ba50 R15: 0000000000000000
FS: 0000000000000000(0000) GS:ffff8881f6900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007ffc23299fa8 CR3: 0000000110b1d000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
serial_out drivers/tty/serial/8250/8250.h:123 [inline]
serial8250_console_fifo_write drivers/tty/serial/8250/8250_port.c:3365 [inline]
serial8250_console_write+0xcca/0xfe0 drivers/tty/serial/8250/8250_port.c:3440
call_console_driver kernel/printk/printk.c:1945 [inline]
console_emit_next_record.constprop.0+0x3de/0x840 kernel/printk/printk.c:2732
console_flush_all kernel/printk/printk.c:2794 [inline]
console_unlock+0x37a/0x5a0 kernel/printk/printk.c:2861
vprintk_emit+0x1b9/0x5f0 kernel/printk/printk.c:2271
dev_vprintk_emit+0x36e/0x3b2 drivers/base/core.c:4627
dev_printk_emit+0xba/0xf1 drivers/base/core.c:4638
__dev_printk+0xcf/0xf5 drivers/base/core.c:4650
_dev_err+0xd7/0x109 drivers/base/core.c:4693
wdm_int_callback.cold+0xc2/0x104 drivers/usb/class/cdc-wdm.c:269
__usb_hcd_giveback_urb+0x2b0/0x5c0 drivers/usb/core/hcd.c:1670
usb_hcd_giveback_urb+0x380/0x430 drivers/usb/core/hcd.c:1753
dummy_timer+0x11f9/0x32b0 drivers/usb/gadget/udc/dummy_hcd.c:1988
call_timer_fn+0x1a5/0x6b0 kernel/time/timer.c:1474
expire_timers kernel/time/timer.c:1519 [inline]
__run_timers.part.0+0x679/0xa80 kernel/time/timer.c:1790
__run_timers kernel/time/timer.c:1768 [inline]
run_timer_softirq+0xb3/0x1d0 kernel/time/timer.c:1803
__do_softirq+0x288/0x9a5 kernel/softirq.c:571
invoke_softirq kernel/softirq.c:445 [inline]
__irq_exit_rcu+0x113/0x170 kernel/softirq.c:650
irq_exit_rcu+0x5/0x20 kernel/softirq.c:662
sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1106
asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:649
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:29 [inline]
RIP: 0010:arch_local_save_flags arch/x86/include/asm/irqflags.h:70 [inline]
RIP: 0010:arch_irqs_disabled arch/x86/include/asm/irqflags.h:130 [inline]
RIP: 0010:acpi_safe_halt drivers/acpi/processor_idle.c:112 [inline]
RIP: 0010:acpi_idle_do_entry+0x1c9/0x240 drivers/acpi/processor_idle.c:554
Code: 89 de e8 fa f3 54 fb 84 db 75 98 e8 f1 f7 54 fb e8 ac 3c 5b fb 66 90 e8 e5 f7 54 fb 0f 00 2d ae a0 7b 00 e8 d9 f7 54 fb fb f4 <9c> 5b 81 e3 00 02 00 00 fa 31 ff 48 89 de e8 24 f4 54 fb 48 85 db
RSP: 0018:ffffc9000010fd20 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff8881002cd580 RSI: ffffffff85f03117 RDI: 0000000000000000
RBP: ffff888108f2d064 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001
R13: ffff888108f2d000 R14: ffff888108f2d064 R15: ffff88810ad95804
acpi_idle_enter+0x369/0x510 drivers/acpi/processor_idle.c:691
cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237
cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351
call_cpuidle kernel/sched/idle.c:155 [inline]
cpuidle_idle_call kernel/sched/idle.c:236 [inline]
do_idle+0x3e8/0x590 kernel/sched/idle.c:303
cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:400
start_secondary+0x21d/0x2b0 arch/x86/kernel/smpboot.c:266
secondary_startup_64_no_verify+0xce/0xdb