INFO: task hung in usb_get_descriptor

32 views

Skip to first unread message

syzbot

unread,

Oct 3, 2020, 8:49:23 AM10/3/20

to syzkaller...@googlegroups.com

Hello,

syzbot found the following issue on:

HEAD commit: b09c3451 Linux 4.19.149
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=171c2f23900000
kernel config: https://syzkaller.appspot.com/x/.config?x=d7c6dfb55644e8fd
dashboard link: https://syzkaller.appspot.com/bug?extid=7f70f05581ec61b352d3
compiler: gcc (GCC) 10.1.0-syz 20200507
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=17737c93900000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=126f55bd900000

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+7f70f0...@syzkaller.appspotmail.com

vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
INFO: task kworker/1:2:2886 blocked for more than 140 seconds.
vhci_hcd vhci_hcd.0: port 0 already used
Not tainted 4.19.149-syzkaller #0
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kworker/1:2 D27920 2886 2 0x80000000
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
Workqueue: usb_hub_wq hub_event
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
Call Trace:
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x8e5/0x22e0 kernel/sched/core.c:3517
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_start_wait_urb+0x24f/0x2b0 drivers/usb/core/message.c:63
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_internal_control_msg drivers/usb/core/message.c:101 [inline]
usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
usb_get_descriptor+0xc5/0x1b0 drivers/usb/core/message.c:654
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_get_device_descriptor+0x81/0xf0 drivers/usb/core/message.c:926
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
hub_port_init+0xb32/0x2ea0 drivers/usb/core/hub.c:4749
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
hub_port_connect drivers/usb/core/hub.c:5020 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
port_event drivers/usb/core/hub.c:5311 [inline]
hub_event+0x1981/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
process_one_work+0x796/0x14e0 kernel/workqueue.c:2155
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
worker_thread+0x64c/0x1130 kernel/workqueue.c:2298
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kthread+0x33f/0x460 kernel/kthread.c:259
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
INFO: task kworker/0:3:6454 blocked for more than 140 seconds.
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
Not tainted 4.19.149-syzkaller #0
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
kworker/0:3 D27680 6454 2 0x80000000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x8e5/0x22e0 kernel/sched/core.c:3517
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
usb_start_wait_urb+0x24f/0x2b0 drivers/usb/core/message.c:63
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_internal_control_msg drivers/usb/core/message.c:101 [inline]
usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
hub_port_init+0x8b3/0x2ea0 drivers/usb/core/hub.c:4654
vhci_hcd: disconnect device
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
hub_port_connect drivers/usb/core/hub.c:5020 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
port_event drivers/usb/core/hub.c:5311 [inline]
hub_event+0x1981/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
process_one_work+0x796/0x14e0 kernel/workqueue.c:2155
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
process_scheduled_works kernel/workqueue.c:2214 [inline]
worker_thread+0x82b/0x1130 kernel/workqueue.c:2300
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kthread+0x33f/0x460 kernel/kthread.c:259
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
vhci_hcd: disconnect device
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
INFO: task kworker/0:1:6490 blocked for more than 140 seconds.
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
Not tainted 4.19.149-syzkaller #0
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
kworker/0:1 D27344 6490 2 0x80000000
vhci_hcd vhci_hcd.0: port 0 already used
Workqueue: usb_hub_wq hub_event
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
Call Trace:
vhci_hcd: release socket
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x8e5/0x22e0 kernel/sched/core.c:3517
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
usb_start_wait_urb+0x24f/0x2b0 drivers/usb/core/message.c:63
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: disconnect device
usb_internal_control_msg drivers/usb/core/message.c:101 [inline]
usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
hub_port_init+0x8b3/0x2ea0 drivers/usb/core/hub.c:4654
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
hub_port_connect drivers/usb/core/hub.c:5020 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
port_event drivers/usb/core/hub.c:5311 [inline]
hub_event+0x1981/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
process_one_work+0x796/0x14e0 kernel/workqueue.c:2155
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
worker_thread+0x64c/0x1130 kernel/workqueue.c:2298
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: release socket
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kthread+0x33f/0x460 kernel/kthread.c:259
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
INFO: task kworker/1:0:6498 blocked for more than 140 seconds.
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
Not tainted 4.19.149-syzkaller #0
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kworker/1:0 D28040 6498 2 0x80000000
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
Workqueue: usb_hub_wq hub_event
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
Call Trace:
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x8e5/0x22e0 kernel/sched/core.c:3517
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
usb_start_wait_urb+0x24f/0x2b0 drivers/usb/core/message.c:63
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
usb_internal_control_msg drivers/usb/core/message.c:101 [inline]
usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
hub_port_init+0x8b3/0x2ea0 drivers/usb/core/hub.c:4654
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
hub_port_connect drivers/usb/core/hub.c:5020 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
port_event drivers/usb/core/hub.c:5311 [inline]
hub_event+0x1981/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
process_one_work+0x796/0x14e0 kernel/workqueue.c:2155
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
worker_thread+0x64c/0x1130 kernel/workqueue.c:2298
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
kthread+0x33f/0x460 kernel/kthread.c:259
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
INFO: task kworker/1:4:6536 blocked for more than 140 seconds.
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
Not tainted 4.19.149-syzkaller #0
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
kworker/1:4 D27688 6536 2 0x80000000
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
Workqueue: usb_hub_wq hub_event
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
Call Trace:
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x8e5/0x22e0 kernel/sched/core.c:3517
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
usb_start_wait_urb+0x24f/0x2b0 drivers/usb/core/message.c:63
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: release socket
vhci_hcd: disconnect device
usb_internal_control_msg drivers/usb/core/message.c:101 [inline]
usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: connection closed
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
usb_get_descriptor+0xc5/0x1b0 drivers/usb/core/message.c:654
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
usb_get_device_descriptor+0x81/0xf0 drivers/usb/core/message.c:926
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: stop threads
hub_port_init+0xb32/0x2ea0 drivers/usb/core/hub.c:4749
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
hub_port_connect drivers/usb/core/hub.c:5020 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
port_event drivers/usb/core/hub.c:5311 [inline]
hub_event+0x1981/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
process_one_work+0x796/0x14e0 kernel/workqueue.c:2155
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
worker_thread+0x64c/0x1130 kernel/workqueue.c:2298
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
kthread+0x33f/0x460 kernel/kthread.c:259
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN

Showing all locks held in the system:
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
1 lock held by khungtaskd/1094:
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#0: 0000000039c6a7e6 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x291 kernel/locking/lockdep.c:4440
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
5 locks held by kworker/u4:3/2317:
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
5 locks held by kworker/1:2/2886:
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
#0: 00000000ab3365e7 ((wq_completion)"usb_hub_wq"){+.+.}, at: process_one_work+0x692/0x14e0 kernel/workqueue.c:2126
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#1: 0000000077f5dcab ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x6c8/0x14e0 kernel/workqueue.c:2130
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
#2: 00000000a89e54c4 (&dev->mutex){....}, at: device_lock include/linux/device.h:1173 [inline]
#2: 00000000a89e54c4 (&dev->mutex){....}, at: hub_event+0x10f/0x3fc0 drivers/usb/core/hub.c:5337
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#3: 00000000bf04ff50 (&port_dev->status_lock){+.+.}, at: usb_lock_port drivers/usb/core/hub.c:2977 [inline]
#3: 00000000bf04ff50 (&port_dev->status_lock){+.+.}, at: hub_port_connect drivers/usb/core/hub.c:5019 [inline]
#3: 00000000bf04ff50 (&port_dev->status_lock){+.+.}, at: hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
#3: 00000000bf04ff50 (&port_dev->status_lock){+.+.}, at: port_event drivers/usb/core/hub.c:5311 [inline]
#3: 00000000bf04ff50 (&port_dev->status_lock){+.+.}, at: hub_event+0x196c/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
#4: 000000007013f6c4 (hcd->address0_mutex){+.+.}, at: hub_port_init+0x1b5/0x2ea0 drivers/usb/core/hub.c:4528
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: connection closed
1 lock held by systemd-journal/3723:
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
1 lock held by in:imklog/6175:
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: stop threads
5 locks held by kworker/0:3/6454:
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
#0: 00000000ab3365e7 ((wq_completion)"usb_hub_wq"){+.+.}, at: process_one_work+0x692/0x14e0 kernel/workqueue.c:2126
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
#1: 0000000038f8d8d8 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x6c8/0x14e0 kernel/workqueue.c:2130
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
#2: 00000000ecd3fc92 (&dev->mutex){....}, at: device_lock include/linux/device.h:1173 [inline]
#2: 00000000ecd3fc92 (&dev->mutex){....}, at: hub_event+0x10f/0x3fc0 drivers/usb/core/hub.c:5337
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
#3: 0000000091e8ac83 (&port_dev->status_lock){+.+.}, at: usb_lock_port drivers/usb/core/hub.c:2977 [inline]
#3: 0000000091e8ac83 (&port_dev->status_lock){+.+.}, at: hub_port_connect drivers/usb/core/hub.c:5019 [inline]
#3: 0000000091e8ac83 (&port_dev->status_lock){+.+.}, at: hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
#3: 0000000091e8ac83 (&port_dev->status_lock){+.+.}, at: port_event drivers/usb/core/hub.c:5311 [inline]
#3: 0000000091e8ac83 (&port_dev->status_lock){+.+.}, at: hub_event+0x196c/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#4: 000000005e93afff (hcd->address0_mutex){+.+.}, at: hub_port_init+0x1b5/0x2ea0 drivers/usb/core/hub.c:4528
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
5 locks held by kworker/0:1/6490:
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#0: 00000000ab3365e7 ((wq_completion)"usb_hub_wq"){+.+.}, at: process_one_work+0x692/0x14e0 kernel/workqueue.c:2126
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#1: 000000000bea8aba ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x6c8/0x14e0 kernel/workqueue.c:2130
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd vhci_hcd.0: port 0 already used
#2: 00000000fd81c642 (&dev->mutex){....}, at: device_lock include/linux/device.h:1173 [inline]
#2: 00000000fd81c642 (&dev->mutex){....}, at: hub_event+0x10f/0x3fc0 drivers/usb/core/hub.c:5337
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
#3: 00000000d8504121 (&port_dev->status_lock){+.+.}, at: usb_lock_port drivers/usb/core/hub.c:2977 [inline]
#3: 00000000d8504121 (&port_dev->status_lock){+.+.}, at: hub_port_connect drivers/usb/core/hub.c:5019 [inline]
#3: 00000000d8504121 (&port_dev->status_lock){+.+.}, at: hub_port_connect_change drivers/usb/core/hub.c:5203 [inline]
#3: 00000000d8504121 (&port_dev->status_lock){+.+.}, at: port_event drivers/usb/core/hub.c:5311 [inline]
#3: 00000000d8504121 (&port_dev->status_lock){+.+.}, at: hub_event+0x196c/0x3fc0 drivers/usb/core/hub.c:5391
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: connection closed
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
#4: 00000000708615af (hcd->address0_mutex){+.+.}, at: hub_port_init+0x1b5/0x2ea0 drivers/usb/core/hub.c:4528
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd vhci_hcd.0: port 0 already used
5 locks held by kworker/1:0/6498:
vhci_hcd: release socket
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#0: 00000000ab3365e7 ((wq_completion)"usb_hub_wq"){+.+.}, at: process_one_work+0x692/0x14e0 kernel/workqueue.c:2126
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed)
vhci_hcd: disconnect device
#1: 00000000c25d9655 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x6c8/0x14e0 kernel/workqueue.c:2130
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: Failed attach request for unsupported USB speed: UNKNOWN
#2: 00

---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.
syzbot can test patches for this issue, for details see:
https://goo.gl/tpsmEJ#testing-patches

syzbot

unread,

Oct 3, 2020, 1:33:23 PM10/3/20

to syzkaller...@googlegroups.com

Hello,

syzbot found the following issue on:

HEAD commit: cbfa1702 Linux 4.14.198
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=172e267d900000
kernel config: https://syzkaller.appspot.com/x/.config?x=3990958d85b55e59
dashboard link: https://syzkaller.appspot.com/bug?extid=b914983de17f6ba4c7b4

compiler: gcc (GCC) 10.1.0-syz 20200507

Unfortunately, I don't have any reproducer for this issue yet.

IMPORTANT: if you fix the issue, please add the following tag to the commit:

Reported-by: syzbot+b91498...@syzkaller.appspotmail.com

netlink: 20 bytes leftover after parsing attributes in process `syz-executor.5'.
INFO: task kworker/1:1:23 blocked for more than 140 seconds.
Not tainted 4.14.198-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

kworker/1:1 D27160 23 2 0x80000000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3384
schedule+0x8d/0x1b0 kernel/sched/core.c:3428
usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686
usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62
usb_internal_control_msg drivers/usb/core/message.c:100 [inline]
usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151
usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652
usb_get_device_descriptor+0x71/0xd0 drivers/usb/core/message.c:924
hub_port_init+0x625/0x28b0 drivers/usb/core/hub.c:4647
hub_port_connect drivers/usb/core/hub.c:4905 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
port_event drivers/usb/core/hub.c:5194 [inline]
hub_event+0x1bc5/0x39a0 drivers/usb/core/hub.c:5274
process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/0:1:24 blocked for more than 140 seconds.
Not tainted 4.14.198-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

kworker/0:1 D26960 24 2 0x80000000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3384
schedule+0x8d/0x1b0 kernel/sched/core.c:3428
usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686
usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62
usb_internal_control_msg drivers/usb/core/message.c:100 [inline]
usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151
hub_port_init+0xfb1/0x28b0 drivers/usb/core/hub.c:4555
hub_port_connect drivers/usb/core/hub.c:4905 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
port_event drivers/usb/core/hub.c:5194 [inline]
hub_event+0x1bc5/0x39a0 drivers/usb/core/hub.c:5274
process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
process_scheduled_works kernel/workqueue.c:2176 [inline]
worker_thread+0x7d3/0xff0 kernel/workqueue.c:2252
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/1:2:3654 blocked for more than 140 seconds.
Not tainted 4.14.198-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

kworker/1:2 D26392 3654 2 0x80000000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3384
schedule+0x8d/0x1b0 kernel/sched/core.c:3428
usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691
usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686
usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62
usb_internal_control_msg drivers/usb/core/message.c:100 [inline]
usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151
usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652
usb_get_device_descriptor+0x71/0xd0 drivers/usb/core/message.c:924
hub_port_init+0x625/0x28b0 drivers/usb/core/hub.c:4647
hub_port_connect drivers/usb/core/hub.c:4905 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
port_event drivers/usb/core/hub.c:5194 [inline]
hub_event+0x1bc5/0x39a0 drivers/usb/core/hub.c:5274
process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/1:3:6077 blocked for more than 140 seconds.
Not tainted 4.14.198-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

kworker/1:3 D27224 6077 2 0x80000000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3384
schedule+0x8d/0x1b0 kernel/sched/core.c:3428
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486
__mutex_lock_common kernel/locking/mutex.c:833 [inline]
__mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893
hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429
hub_port_connect drivers/usb/core/hub.c:4905 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
port_event drivers/usb/core/hub.c:5194 [inline]
hub_event+0x1bc5/0x39a0 drivers/usb/core/hub.c:5274
process_one_work+0x793/0x14a0 kernel/workqueue.c:2116
worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: task kworker/1:4:7580 blocked for more than 140 seconds.
Not tainted 4.14.198-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

kworker/1:4 D27240 7580 2 0x80000000

Workqueue: usb_hub_wq hub_event
Call Trace:

Showing all locks held in the system:

5 locks held by kworker/1:1/23:
#0: ("usb_hub_wq"){+.+.}, at: [<ffffffff813ba640>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
#1: ((&hub->events)){+.+.}, at: [<ffffffff813ba676>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] device_lock include/linux/device.h:1081 [inline]
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] usb_lock_port drivers/usb/core/hub.c:2934 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect drivers/usb/core/hub.c:4904 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] port_event drivers/usb/core/hub.c:5194 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274
#4: (hcd->address0_mutex){+.+.}, at: [<ffffffff842a4b1b>] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429
5 locks held by kworker/0:1/24:
#0: ("usb_hub_wq"){+.+.}, at: [<ffffffff813ba640>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
#1: ((&hub->events)){+.+.}, at: [<ffffffff813ba676>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] device_lock include/linux/device.h:1081 [inline]
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] usb_lock_port drivers/usb/core/hub.c:2934 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect drivers/usb/core/hub.c:4904 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] port_event drivers/usb/core/hub.c:5194 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274
#4: (hcd->address0_mutex){+.+.}, at: [<ffffffff842a4b1b>] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429
1 lock held by khungtaskd/1068:
#0: (tasklist_lock){.+.+}, at: [<ffffffff814777f4>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548
5 locks held by kworker/1:2/3654:
#0: ("usb_hub_wq"){+.+.}, at: [<ffffffff813ba640>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
#1: ((&hub->events)){+.+.}, at: [<ffffffff813ba676>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] device_lock include/linux/device.h:1081 [inline]
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] usb_lock_port drivers/usb/core/hub.c:2934 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect drivers/usb/core/hub.c:4904 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] port_event drivers/usb/core/hub.c:5194 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274
#4: (hcd->address0_mutex){+.+.}, at: [<ffffffff842a4b1b>] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429
5 locks held by kworker/1:3/6077:
#0: ("usb_hub_wq"){+.+.}, at: [<ffffffff813ba640>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
#1: ((&hub->events)){+.+.}, at: [<ffffffff813ba676>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] device_lock include/linux/device.h:1081 [inline]
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] usb_lock_port drivers/usb/core/hub.c:2934 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect drivers/usb/core/hub.c:4904 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] port_event drivers/usb/core/hub.c:5194 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274
#4: (hcd->address0_mutex){+.+.}, at: [<ffffffff842a4b1b>] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429
5 locks held by kworker/1:4/7580:
#0: ("usb_hub_wq"){+.+.}, at: [<ffffffff813ba640>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087
#1: ((&hub->events)){+.+.}, at: [<ffffffff813ba676>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] device_lock include/linux/device.h:1081 [inline]
#2: (&dev->mutex){....}, at: [<ffffffff842ae59c>] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] usb_lock_port drivers/usb/core/hub.c:2934 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect drivers/usb/core/hub.c:4904 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] port_event drivers/usb/core/hub.c:5194 [inline]
#3: (&port_dev->status_lock){+.+.}, at: [<ffffffff842b0050>] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274
#4: (hcd->address0_mutex){+.+.}, at: [<ffffffff842a4b1b>] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429

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

NMI backtrace for cpu 1
CPU: 1 PID: 1068 Comm: khungtaskd Not tainted 4.14.198-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:17 [inline]
dump_stack+0x1b2/0x283 lib/dump_stack.c:58
nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x13a/0x17f lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
watchdog+0x5b9/0xb40 kernel/hung_task.c:274
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 6042 Comm: rs:main Q:Reg Not tainted 4.14.198-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff8880a05b2540 task.stack: ffff888088740000
RIP: 0033:0x7f0e39d9e182
RSP: 002b:00007f0e3735cc70 EFLAGS: 00000246
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f0e39d9e17f
RDX: 000000000000090b RSI: 0000000000000080 RDI: 0000000000000001
RBP: 0000555d9b777288 R08: 0000555d9b777000 R09: 0000000000000485
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f0e3735ccd0
R13: 0000000000000000 R14: 0000555d9a67b290 R15: 0000000000000000
FS: 00007f0e3735d700(0000) GS:ffff8880aea00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007ff2f198a000 CR3: 00000000a7f5e000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400

syzbot

unread,

Oct 14, 2020, 10:59:18 PM10/14/20

to syzkaller...@googlegroups.com

syzbot has found a reproducer for the following issue on:

HEAD commit: cbfa1702 Linux 4.14.198
git tree: linux-4.14.y

console output: https://syzkaller.appspot.com/x/log.txt?x=1703c678500000

kernel config: https://syzkaller.appspot.com/x/.config?x=3990958d85b55e59
dashboard link: https://syzkaller.appspot.com/bug?extid=b914983de17f6ba4c7b4
compiler: gcc (GCC) 10.1.0-syz 20200507

syz repro: https://syzkaller.appspot.com/x/repro.syz?x=12e33a07900000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=129c8b10500000

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+b91498...@syzkaller.appspotmail.com

vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads

INFO: task kworker/0:1:24 blocked for more than 140 seconds.

vhci_hcd: release socket
Not tainted 4.14.198-syzkaller #0

vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3)

vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

kworker/0:1 D
vhci_hcd: release socket
28072 24 2 0x80000000

vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

Workqueue: usb_hub_wq hub_event
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd: release socket

Call Trace:

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used

context_switch kernel/sched/core.c:2808 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3384

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads

vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd: release socket

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used

schedule+0x8d/0x1b0 kernel/sched/core.c:3428

vhci_hcd vhci_hcd.0: port 0 already used

usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device

vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used

usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686

vhci_hcd vhci_hcd.0: port 0 already used

usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62

vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd: stop threads
vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used

usb_internal_control_msg drivers/usb/core/message.c:100 [inline]
usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652

vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

usb_get_device_descriptor+0x71/0xd0 drivers/usb/core/message.c:924

vhci_hcd: release socket
vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3)

hub_port_init+0x625/0x28b0 drivers/usb/core/hub.c:4647
vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd: connection closed
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: release socket

vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

process_one_work+0x793/0x14a0 kernel/workqueue.c:2116

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd: connection closed
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

process_scheduled_works kernel/workqueue.c:2176 [inline]
worker_thread+0x7d3/0xff0 kernel/workqueue.c:2252

vhci_hcd: stop threads
vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used

kthread+0x30d/0x420 kernel/kthread.c:232

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3)

vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads

vhci_hcd: connection closed
vhci_hcd vhci_hcd.0: port 0 already used

ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404

vhci_hcd vhci_hcd.0: port 0 already used

INFO: task kworker/1:2:2714 blocked for more than 140 seconds.

vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3)
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: connection closed

vhci_hcd: release socket
vhci_hcd vhci_hcd.0: port 0 already used

Not tainted 4.14.198-syzkaller #0

vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd: connection closed

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads

kworker/1:2 D
vhci_hcd: release socket
27792 2714 2 0x80000000
vhci_hcd: disconnect device
vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3)

vhci_hcd vhci_hcd.0: port 0 already used

vhci_hcd vhci_hcd.0: devid(0) speed(5) speed_str(super-speed)

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
Workqueue: usb_hub_wq hub_event

vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd vhci_hcd.0: port 0 already used
vhci_hcd: stop threads

vhci_hcd: release socket
Call Trace: