vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 INFO: task kworker/1:0:18 blocked for more than 140 seconds. 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: pdev(2) rhport(0) sockfd(3) Not tainted 4.14.218-syzkaller #0 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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: disconnect device 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: stop threads kworker/1:0 D 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: devid(0) speed(3) speed_str(high-speed) 28536 18 2 0x80000000 vhci_hcd: release socket vhci_hcd: connection closed 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 vhci_hcd: disconnect device Workqueue: usb_hub_wq hub_event vhci_hcd vhci_hcd.0: port 0 already used Call Trace: 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 context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3384 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3) vhci_hcd: release socket vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 vhci_hcd.0: port 0 already used vhci_hcd: connection closed vhci_hcd: disconnect device schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 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_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:691 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(3) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 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 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 vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) usb_kill_urb+0x7c/0x90 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 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: connection closed 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(3) speed_str(high-speed) 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: release socket 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 usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/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 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: release socket vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads hub_port_init+0xfdc/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4555 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 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: 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 process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3) vhci_hcd: release socket vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: connection closed process_scheduled_works syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2252 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: connection closed kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 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 ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 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: pdev(3) rhport(0) sockfd(3) INFO: task kworker/0:1:24 blocked for more than 140 seconds. vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 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 Not tainted 4.14.218-syzkaller #0 vhci_hcd: stop threads "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: release socket 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(3) speed_str(high-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: stop threads kworker/0:1 D vhci_hcd: release socket 27536 24 2 0x80000000 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: connection closed 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(3) speed_str(high-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: stop threads Call Trace: vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3384 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket vhci_hcd: connection closed vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3) vhci_hcd: stop threads vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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: release socket schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/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 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 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(3) speed_str(high-speed) 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 vhci_hcd: disconnect device 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: pdev(3) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_kill_urb+0x7c/0x90 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd: stop threads 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: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed 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 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 vhci_hcd.0: port 0 already used 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(3) speed_str(high-speed) vhci_hcd: disconnect device usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:151 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 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 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(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0xfdc/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4555 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 vhci_hcd.0: port 0 already used hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 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 process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 process_scheduled_works syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2252 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 vhci_hcd: disconnect device kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 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(4) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 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(5) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) INFO: task kworker/1:2:3522 blocked for more than 140 seconds. vhci_hcd: disconnect device Not tainted 4.14.218-syzkaller #0 vhci_hcd: connection closed 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 kworker/1:2 D 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 27704 3522 2 0x80000000 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(0) rhport(0) sockfd(3) vhci_hcd: stop threads vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used Call Trace: vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/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 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 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(3) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 vhci_hcd: disconnect device usb_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:691 vhci_hcd: stop threads vhci_hcd: connection closed 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(3) speed_str(high-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: 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_kill_urb+0x7c/0x90 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd: disconnect device 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: pdev(2) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 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: disconnect device 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: release socket vhci_hcd: disconnect device 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(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed vhci_hcd: stop threads vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:151 vhci_hcd: connection closed vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3) vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 hub_port_init+0xfdc/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4555 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 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 hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 vhci_hcd: disconnect device vhci_hcd: connection closed 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(3) speed_str(high-speed) 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 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 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 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: pdev(1) rhport(0) sockfd(3) vhci_hcd: release socket vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 worker_thread+0x5cc/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2250 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 kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 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(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket INFO: task kworker/0:2:3744 blocked for more than 140 seconds. 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: disconnect device Not tainted 4.14.218-syzkaller #0 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: pdev(5) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: release socket "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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: 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 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 kworker/0:2 D28152 3744 2 0x80000000 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: pdev(0) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: disconnect device 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: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads Call Trace: context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3384 vhci_hcd: release socket 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(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device vhci_hcd: stop threads 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(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 vhci_hcd: release socket vhci_hcd: connection closed usb_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:691 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: stop threads vhci_hcd: release socket 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(3) speed_str(high-speed) 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: pdev(4) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 usb_kill_urb+0x7c/0x90 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd: release socket usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 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: stop threads 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(3) speed_str(high-speed) vhci_hcd: release socket 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 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: 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: pdev(0) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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(3) speed_str(high-speed) vhci_hcd: stop threads usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:151 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: stop threads vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0xfdc/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4555 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: pdev(3) rhport(0) sockfd(3) vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 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 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(3) speed_str(high-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 process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 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 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(4) rhport(0) sockfd(3) process_scheduled_works syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2252 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 vhci_hcd.0: port 0 already used kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 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: 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: pdev(5) rhport(0) sockfd(3) ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device INFO: task kworker/1:1:7962 blocked for more than 140 seconds. 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 vhci_hcd.0: port 0 already used Not tainted 4.14.218-syzkaller #0 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3) "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 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 kworker/1:1 D vhci_hcd vhci_hcd.0: port 0 already used 28088 7962 2 0x80000000 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: stop threads Workqueue: usb_hub_wq hub_event vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used Call Trace: context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3384 schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 usb_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:691 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 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: release socket 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 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 vhci_hcd: release socket vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: stop threads vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: connection closed 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 vhci_hcd vhci_hcd.0: port 0 already used usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/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 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: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3) usb_get_descriptor+0xc0/0x160 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:652 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 vhci_hcd vhci_hcd.0: port 0 already used usb_get_device_descriptor+0x71/0xd0 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:924 vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0x629/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4647 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: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 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: stop threads vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 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: 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 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: 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: devid(0) speed(3) speed_str(high-speed) 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 vhci_hcd vhci_hcd.0: port 0 already used process_scheduled_works syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2252 vhci_hcd: disconnect device vhci_hcd: stop threads vhci_hcd vhci_hcd.0: port 0 already used 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(3) speed_str(high-speed) 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 kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 vhci_hcd: release socket vhci_hcd: connection closed vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 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 INFO: task kworker/1:4:8010 blocked for more than 140 seconds. vhci_hcd: release socket vhci_hcd vhci_hcd.0: pdev(4) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 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(5) rhport(0) sockfd(3) Not tainted 4.14.218-syzkaller #0 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: release socket "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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 vhci_hcd: stop threads vhci_hcd: connection closed vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3) kworker/1:4 D vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd vhci_hcd.0: port 0 already used 28568 8010 2 0x80000000 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: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads Workqueue: usb_hub_wq hub_event vhci_hcd: connection closed 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(3) speed_str(high-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: release socket Call Trace: vhci_hcd: connection closed context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/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 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 schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 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_kill_urb.part.0+0x125/0x190 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:691 vhci_hcd: stop threads 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(2) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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: 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: connection closed vhci_hcd: release socket 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 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/urb.c:686 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_start_wait_urb+0x209/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:62 vhci_hcd: connection closed 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 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 vhci_hcd.0: pdev(5) rhport(0) sockfd(3) vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: stop threads usb_internal_control_msg syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:151 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 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(3) speed_str(high-speed) 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: 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(1) rhport(0) sockfd(3) hub_port_init+0xfdc/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4555 vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4905 [inline] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] hub_event+0x18fd/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 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 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: release socket process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 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(0) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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: stop threads vhci_hcd vhci_hcd.0: port 0 already used 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(3) speed_str(high-speed) vhci_hcd: connection closed vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used process_scheduled_works syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2252 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: 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: stop threads kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 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 ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 vhci_hcd: disconnect device 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(3) speed_str(high-speed) Showing all locks held in the system: 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 5 locks held by kworker/1:0/18: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 5 locks held by kworker/0:1/24: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 1 lock held by khungtaskd/1531: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a syzkaller/managers/linux-4-14/kernel/kernel/locking/lockdep.c:4548 5 locks held by kworker/1:2/3522: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 5 locks held by kworker/0:2/3744: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 5 locks held by kworker/1:1/7962: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 5 locks held by kworker/1:4/8010: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock syzkaller/managers/linux-4-14/kernel/./include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x18e8/0x3d70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x2970 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/hub.c:4429 ============================================= 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(3) speed_str(high-speed) 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 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device 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 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: 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 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: pdev(1) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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: pdev(4) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) vhci_hcd: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket 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(3) speed_str(high-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: connection closed 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: disconnect device vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) 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 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: 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: pdev(3) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-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 vhci_hcd.0: port 0 already used NMI backtrace for cpu 0 vhci_hcd: disconnect device CPU: 0 PID: 1531 Comm: khungtaskd Not tainted 4.14.218-syzkaller #0 vhci_hcd: stop threads Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack syzkaller/managers/linux-4-14/kernel/lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 syzkaller/managers/linux-4-14/kernel/lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 syzkaller/managers/linux-4-14/kernel/lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 syzkaller/managers/linux-4-14/kernel/lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace syzkaller/managers/linux-4-14/kernel/./include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks syzkaller/managers/linux-4-14/kernel/kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 syzkaller/managers/linux-4-14/kernel/kernel/hung_task.c:274 kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 Sending NMI from CPU 0 to CPUs 1: vhci_hcd: release socket NMI backtrace for cpu 1 CPU: 1 PID: 7963 Comm: kworker/u4:1 Not tainted 4.14.218-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: usbip_event event_handler task: ffff8880b106a440 task.stack: ffff8880b3760000 RIP: 0010:update_vsyscall+0x73/0x340 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/vsyscall/vsyscall_gtod.c:37 RSP: 0018:ffff8880ba507ca8 EFLAGS: 00000002 RAX: 0000000000000005 RBX: ffffffff88f08be0 RCX: 0000000000000017 RDX: 0000000000000002 RSI: 0000000000000000 RDI: ffffffff88f08c04 RBP: ffffffff8beb6c00 R08: ffffffff8b9c8950 R09: 00000000000c403a R10: ffff8880b106ad40 R11: ffff8880b106a440 R12: 0000000000000000 R13: 000000002c12f357 R14: 0000000013516bcd R15: 000000000064eeb6 FS: 0000000000000000(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000004b1290 CR3: 0000000008e6a000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: timekeeping_update+0x223/0x3a0 syzkaller/managers/linux-4-14/kernel/kernel/time/timekeeping.c:656 update_wall_time+0x5b0/0xa20 syzkaller/managers/linux-4-14/kernel/kernel/time/timekeeping.c:2116 tick_do_update_jiffies64.part.0+0x172/0x270 syzkaller/managers/linux-4-14/kernel/kernel/time/tick-sched.c:100 tick_do_update_jiffies64 syzkaller/managers/linux-4-14/kernel/kernel/time/tick-sched.c:66 [inline] tick_sched_do_timer syzkaller/managers/linux-4-14/kernel/kernel/time/tick-sched.c:139 [inline] tick_sched_timer+0x1a0/0x200 syzkaller/managers/linux-4-14/kernel/kernel/time/tick-sched.c:1216 __run_hrtimer syzkaller/managers/linux-4-14/kernel/kernel/time/hrtimer.c:1223 [inline] __hrtimer_run_queues+0x30b/0xc80 syzkaller/managers/linux-4-14/kernel/kernel/time/hrtimer.c:1287 hrtimer_interrupt+0x1e6/0x5e0 syzkaller/managers/linux-4-14/kernel/kernel/time/hrtimer.c:1321 local_apic_timer_interrupt syzkaller/managers/linux-4-14/kernel/arch/x86/kernel/apic/apic.c:1075 [inline] smp_apic_timer_interrupt+0x117/0x5e0 syzkaller/managers/linux-4-14/kernel/arch/x86/kernel/apic/apic.c:1100 apic_timer_interrupt+0x93/0xa0 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:793 RIP: 0010:arch_local_irq_restore syzkaller/managers/linux-4-14/kernel/./arch/x86/include/asm/paravirt.h:779 [inline] RIP: 0010:console_trylock_spinning syzkaller/managers/linux-4-14/kernel/kernel/printk/printk.c:1685 [inline] RIP: 0010:vprintk_emit+0x549/0x620 syzkaller/managers/linux-4-14/kernel/kernel/printk/printk.c:1922 RSP: 0018:ffff8880b3767b78 EFLAGS: 00000297 ORIG_RAX: ffffffffffffff10 RAX: ffff8880b106a440 RBX: 1ffffffff11e1251 RCX: 1ffff1101620d5a2 RDX: 0000000000000000 RSI: ffff8880b106acf0 RDI: 0000000000000297 RBP: ffff8880b3767bb0 R08: ffffffff8b991910 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000018 R13: ffff8880b2d1c500 R14: 0000000000000297 R15: 0000000000000000 vprintk_func+0x58/0x160 syzkaller/managers/linux-4-14/kernel/kernel/printk/printk_safe.c:401 printk+0x9e/0xbc syzkaller/managers/linux-4-14/kernel/kernel/printk/printk.c:1996 vhci_shutdown_connection.cold+0xfb/0x840 syzkaller/managers/linux-4-14/kernel/drivers/usb/usbip/vhci_hcd.c:1048 event_handler+0x1c3/0x4a0 syzkaller/managers/linux-4-14/kernel/drivers/usb/usbip/usbip_event.c:92 process_one_work+0x793/0x14a0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2116 worker_thread+0x5cc/0xff0 syzkaller/managers/linux-4-14/kernel/kernel/workqueue.c:2250 kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 Code: ea 03 0f b6 14 02 48 89 f8 83 e0 07 83 c0 03 38 d0 7c 08 84 d2 0f 85 81 02 00 00 8b 05 2b 16 08 09 8b 53 24 83 05 8d 45 ff 09 01 <0f> ab d0 89 05 18 16 08 09 48 8d 7d 10 89 15 7e 45 ff 09 48 b8 vhci_hcd vhci_hcd.0: port 0 already used 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(3) speed_str(high-speed) 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: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device