INFO: task kworker/0:4:4102 blocked for more than 143 seconds.
Not tainted 5.16.0-rc6-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:4 state:D stack:22448 pid: 4102 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4972 [inline]
__schedule+0x931/0x2320 kernel/sched/core.c:6253
schedule+0xd2/0x260 kernel/sched/core.c:6326
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6385
__mutex_lock_common kernel/locking/mutex.c:680 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:740
unregister_netdev+0xe/0x20 net/core/dev.c:11138
usbnet_disconnect+0x139/0x270 drivers/net/usb/usbnet.c:1623
usb_unbind_interface+0x1d8/0x8e0 drivers/usb/core/driver.c:458
__device_release_driver+0x5d7/0x700 drivers/base/dd.c:1205
device_release_driver_internal drivers/base/dd.c:1236 [inline]
device_release_driver+0x26/0x40 drivers/base/dd.c:1259
bus_remove_device+0x2eb/0x5a0 drivers/base/bus.c:529
device_del+0x502/0xd60 drivers/base/core.c:3581
usb_disable_device+0x35b/0x7b0 drivers/usb/core/message.c:1419
usb_disconnect.cold+0x27a/0x78e drivers/usb/core/hub.c:2228
hub_port_connect drivers/usb/core/hub.c:5202 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5502 [inline]
port_event drivers/usb/core/hub.c:5660 [inline]
hub_event+0x1e39/0x44d0 drivers/usb/core/hub.c:5742
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
kthread+0x40b/0x500 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
Showing all locks held in the system:
1 lock held by khungtaskd/25:
#0:
ffffffff87891780
(
rcu_read_lock){....}-{1:2}
, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6458
6 locks held by kworker/1:2/705:
4 locks held by dhcpcd/1205:
2 locks held by getty/1227:
#0:
ffff88810e3c0098
(&tty->ldisc_sem
){++++}-{0:0}
, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:252
#1:
ffffc900000432e8 (&ldata->atomic_read_lock){+.+.}-{3:3}
, at: n_tty_read+0xcf0/0x1230 drivers/tty/n_tty.c:2113
6 locks held by kworker/1:4/4093:
6 locks held by kworker/0:4/4102:
#0: ffff888103981d38
((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:1198 [inline]
, at: set_work_data kernel/workqueue.c:635 [inline]
, at: set_work_pool_and_clear_pending kernel/workqueue.c:662 [inline]
, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2269
#1:
ffffc900020c7db0
(
(work_completion)(&hub->events)
){+.+.}-{0:0}
, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2273
#2:
ffff88810d14f220
(&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:760 [inline]
, at: hub_event+0x1c5/0x44d0 drivers/usb/core/hub.c:5688
#3:
ffff888113cb0220
(&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:760 [inline]
, at: usb_disconnect.cold+0x43/0x78e drivers/usb/core/hub.c:2219
#4: ffff888115a351a8
(&dev->mutex
){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1032 [inline]
){....}-{3:3}, at: device_release_driver_internal drivers/base/dd.c:1233 [inline]
){....}-{3:3}, at: device_release_driver+0x1c/0x40 drivers/base/dd.c:1259
#5: ffffffff8886aea8
(
rtnl_mutex){+.+.}-{3:3}
, at: unregister_netdev+0xe/0x20 net/core/dev.c:11138
3 locks held by kworker/0:8/7044:
#0:
ffff88810da42538
((wq_completion)ipv6_addrconf
){+.+.}-{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:1198 [inline]
){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:635 [inline]
){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:662 [inline]
){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2269
#1: ffffc90009d0fdb0
((addr_chk_work).work){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2273
#2: ffffffff8886aea8
(rtnl_mutex){+.+.}-{3:3}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4595
3 locks held by udevd/18856:
#0: ffff88810da28088 (
&of->mutex){+.+.}-{3:3}
, at: kernfs_file_read_iter fs/kernfs/file.c:203 [inline]
, at: kernfs_fop_read_iter+0x185/0x5f0 fs/kernfs/file.c:242
#1: ffff88810d1b21d8 (kn->active#51
){++++}-{0:0}
, at: kernfs_file_read_iter fs/kernfs/file.c:204 [inline]
, at: kernfs_fop_read_iter+0x1a8/0x5f0 fs/kernfs/file.c:242
#2: ffff88810c0f1220 (&dev->mutex){....}-{3:3}
, at: device_lock_interruptible include/linux/device.h:765 [inline]
, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:873
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 25 Comm: khungtaskd Not tainted 5.16.0-rc6-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
<TASK>
__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+0x1b3/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:210 [inline]
watchdog+0xc1d/0xf50 kernel/hung_task.c:295
kthread+0x40b/0x500 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 1205 Comm: dhcpcd Not tainted 5.16.0-rc6-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:native_apic_mem_write+0x8/0x10 arch/x86/include/asm/apic.h:110
Code: c7 80 62 9a 89 e8 78 03 62 00 eb b0 66 0f 1f 44 00 00 be 01 00 00 00 e9 76 40 1d 00 cc cc cc cc cc cc 89 ff 89 b7 00 c0 5f ff <c3> 0f 1f 80 00 00 00 00 48 b8 00 00 00 00 00 fc ff df 53 89 fb 48
RSP: 0018:ffffc90000007eb8 EFLAGS: 00000046
RAX: dffffc0000000000 RBX: ffffffff87330a80 RCX: 0000000000000020
RDX: 1ffffffff0e66152 RSI: 0000000000050094 RDI: 0000000000000380
RBP: ffff8881f6827240 R08: 000000000000003f R09: 0000000000000000
R10: ffffffff81368d27 R11: 0000000000000000 R12: 0000000000050094
R13: 0000000000000020 R14: 0000000000000000 R15: ffff8881f682a1c0
FS: 00007f3595afa740(0000) GS:ffff8881f6800000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000555556d85b38 CR3: 00000001146ab000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
<IRQ>
apic_write arch/x86/include/asm/apic.h:394 [inline]
lapic_next_event+0x4d/0x80 arch/x86/kernel/apic/apic.c:469
clockevents_program_event+0x254/0x370 kernel/time/clockevents.c:334
tick_program_event+0xac/0x140 kernel/time/tick-oneshot.c:44
hrtimer_interrupt+0x36e/0x790 kernel/time/hrtimer.c:1824
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1086 [inline]
__sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1103
sysvec_apic_timer_interrupt+0x89/0xc0 arch/x86/kernel/apic/apic.c:1097
</IRQ>
<TASK>
asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:preempt_count arch/x86/include/asm/preempt.h:27 [inline]
RIP: 0010:check_kcov_mode kernel/kcov.c:166 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x60 kernel/kcov.c:200
Code: 48 89 ef 5d e9 91 5b 2e 00 5d be 03 00 00 00 e9 a6 b1 c0 00 66 0f 1f 44 00 00 48 8b be b0 01 00 00 e8 b4 ff ff ff 31 c0 c3 90 <65> 8b 05 39 e0 be 7e 89 c1 48 8b 34 24 81 e1 00 01 00 00 65 48 8b
RSP: 0018:ffffc90000f8f2d8 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff88811458d400 RSI: ffffffff812ba591 RDI: 0000000000000003
RBP: ffffc90000f8f318 R08: 0000000000000000 R09: ffffffff8a7b688f
R10: ffffffff812ba587 R11: 0000000000000000 R12: 0000000000000037
R13: ffff8881065e8000 R14: 0000000000000200 R15: ffffc90000f8f438
console_trylock_spinning kernel/printk/printk.c:1885 [inline]
vprintk_emit+0x377/0x4f0 kernel/printk/printk.c:2244
dev_vprintk_emit+0x36e/0x3b2 drivers/base/core.c:4594
dev_printk_emit+0xba/0xf1 drivers/base/core.c:4605
__netdev_printk+0x1c6/0x27a net/core/dev.c:11447
netdev_err+0xd7/0x109 net/core/dev.c:11499
asix_set_sw_mii drivers/net/usb/asix_common.c:301 [inline]
asix_set_sw_mii drivers/net/usb/asix_common.c:295 [inline]
asix_check_host_enable.cold+0x23/0x63 drivers/net/usb/asix_common.c:72
asix_mdio_read+0x90/0x220 drivers/net/usb/asix_common.c:497
asix_phy_reset+0x104/0x170 drivers/net/usb/asix_devices.c:215
ax88178_reset+0x3f5/0x1310 drivers/net/usb/asix_devices.c:977
usbnet_open+0xc8/0x5d0 drivers/net/usb/usbnet.c:894
__dev_open+0x2bc/0x4d0 net/core/dev.c:1490
__dev_change_flags+0x583/0x750 net/core/dev.c:8796
dev_change_flags+0x93/0x170 net/core/dev.c:8867
devinet_ioctl+0x15d1/0x1ca0 net/ipv4/devinet.c:1144
inet_ioctl+0x1e6/0x320 net/ipv4/af_inet.c:969
sock_do_ioctl+0xcc/0x230 net/socket.c:1118
sock_ioctl+0x2f1/0x640 net/socket.c:1235
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:874 [inline]
__se_sys_ioctl fs/ioctl.c:860 [inline]
__x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f3595be80e7
Code: 3c 1c e8 1c ff ff ff 85 c0 79 87 49 c7 c4 ff ff ff ff 5b 5d 4c 89 e0 41 5c c3 66 0f 1f 84 00 00 00 00 00 b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 61 9d 0c 00 f7 d8 64 89 01 48
RSP: 002b:00007fff90d2f2a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f3595afa6c8 RCX: 00007f3595be80e7
RDX: 00007fff90d3f498 RSI: 0000000000008914 RDI: 0000000000000005
RBP: 00007fff90d4f648 R08: 00007fff90d3f458 R09: 00007fff90d3f408
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff90d3f498 R14: 0000000000000028 R15: 0000000000008914
</TASK>
----------------
Code disassembly (best guess):
0: c7 80 62 9a 89 e8 78 movl $0x620378,-0x1776659e(%rax)
7: 03 62 00
a: eb b0 jmp 0xffffffbc
c: 66 0f 1f 44 00 00 nopw 0x0(%rax,%rax,1)
12: be 01 00 00 00 mov $0x1,%esi
17: e9 76 40 1d 00 jmpq 0x1d4092
1c: cc int3
1d: cc int3
1e: cc int3
1f: cc int3
20: cc int3
21: cc int3
22: 89 ff mov %edi,%edi
24: 89 b7 00 c0 5f ff mov %esi,-0xa04000(%rdi)
* 2a: c3 retq <-- trapping instruction
2b: 0f 1f 80 00 00 00 00 nopl 0x0(%rax)
32: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax
39: fc ff df
3c: 53 push %rbx
3d: 89 fb mov %edi,%ebx
3f: 48 rex.W