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 INFO: task kworker/1:2:2796 blocked for more than 140 seconds. vhci_hcd vhci_hcd.0: port 0 already used Not tainted 4.14.198-syzkaller #0 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 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. vhci_hcd vhci_hcd.0: port 0 already used kworker/1:2 D27176 2796 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: 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: release socket 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 Call Trace: vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device 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: 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: 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(0) rhport(0) sockfd(3) schedule+0x8d/0x1b0 kernel/sched/core.c:3428 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: connection closed 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 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 vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 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(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: release socket 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 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: 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: disconnect device 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) usb_internal_control_msg drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151 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: 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(2) speed_str(full-speed) vhci_hcd: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0xfb1/0x28b0 drivers/usb/core/hub.c:4555 vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) 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 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: connection closed vhci_hcd: stop threads vhci_hcd: connection closed vhci_hcd: release socket vhci_hcd: disconnect device 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(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 vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd: release socket vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used process_one_work+0x793/0x14a0 kernel/workqueue.c:2116 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: release socket vhci_hcd: disconnect device worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250 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: 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(2) speed_str(full-speed) vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) kthread+0x30d/0x420 kernel/kthread.c:232 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: release socket 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 arch/x86/entry/entry_64.S:404 vhci_hcd: stop threads vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed INFO: task kworker/0:2:3347 blocked for more than 140 seconds. vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(1) rhport(0) sockfd(3) Not tainted 4.14.198-syzkaller #0 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 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 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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 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 kworker/0:2 D vhci_hcd: disconnect device 28240 3347 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: stop threads Workqueue: usb_hub_wq hub_event vhci_hcd: connection closed 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(2) speed_str(full-speed) vhci_hcd vhci_hcd.0: port 0 already used Call Trace: 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: port 0 already used vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) 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: connection closed vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used schedule+0x8d/0x1b0 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 vhci_hcd: stop threads vhci_hcd: connection closed usb_kill_urb.part.0+0x125/0x190 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: 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: pdev(5) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) 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(2) rhport(0) sockfd(3) vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 vhci_hcd: connection closed vhci_hcd: release socket vhci_hcd: disconnect device 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: devid(0) speed(2) speed_str(full-speed) 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: 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 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: 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: 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(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: connection closed vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0xfb1/0x28b0 drivers/usb/core/hub.c:4555 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 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 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 vhci_hcd.0: pdev(4) rhport(0) sockfd(3) 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: devid(0) speed(2) speed_str(full-speed) 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: 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 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116 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: 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: 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(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: release socket process_scheduled_works kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 kernel/workqueue.c:2252 vhci_hcd: connection closed 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: 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(2) speed_str(full-speed) kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/1:1:6368 blocked for more than 140 seconds. vhci_hcd: disconnect device 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(3) 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 vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed Not tainted 4.14.198-syzkaller #0 vhci_hcd: disconnect device "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 kworker/1:1 D vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads 28632 6368 2 0x80000000 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: pdev(4) 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 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 Call Trace: vhci_hcd: disconnect device vhci_hcd: stop threads vhci_hcd vhci_hcd.0: pdev(5) rhport(0) sockfd(3) vhci_hcd: release socket vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 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: pdev(2) 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 vhci_hcd.0: pdev(1) 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: connection closed vhci_hcd: release socket 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: connection closed vhci_hcd: stop threads vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) vhci_hcd: release socket vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) schedule+0x8d/0x1b0 kernel/sched/core.c:3428 vhci_hcd: disconnect device 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(2) speed_str(full-speed) 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: 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: connection closed 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: 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_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 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 usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 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: 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(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: stop threads 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 vhci_hcd.0: pdev(2) rhport(0) sockfd(3) 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: 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: connection closed vhci_hcd: disconnect device vhci_hcd: stop threads vhci_hcd: connection closed vhci_hcd: release socket vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0xfb1/0x28b0 drivers/usb/core/hub.c:4555 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(1) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) 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 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: disconnect device vhci_hcd vhci_hcd.0: pdev(0) 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: stop threads 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: release socket 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 vhci_hcd: connection closed 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 INFO: task kworker/0:0:6380 blocked for more than 140 seconds. 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: devid(0) speed(2) speed_str(full-speed) Not tainted 4.14.198-syzkaller #0 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 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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) kworker/0:0 D27528 6380 2 0x80000000 vhci_hcd: connection closed 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 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: 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(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) Call Trace: vhci_hcd: release socket vhci_hcd: disconnect device 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: stop threads schedule+0x8d/0x1b0 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 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: connection closed 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: 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: 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: release socket usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 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: pdev(3) 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: pdev(0) rhport(0) sockfd(3) vhci_hcd: connection closed 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 vhci_hcd.0: port 0 already used vhci_hcd: connection closed usb_internal_control_msg drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151 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: 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 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 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: connection closed 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: 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 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: 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(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: disconnect device 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: release socket 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(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: stop threads process_scheduled_works kernel/workqueue.c:2176 [inline] worker_thread+0x7d3/0xff0 kernel/workqueue.c:2252 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: release socket vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3) kthread+0x30d/0x420 kernel/kthread.c:232 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 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: stop threads ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 vhci_hcd: release socket vhci_hcd: disconnect device INFO: task kworker/0:3:6425 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: 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: stop threads Not tainted 4.14.198-syzkaller #0 vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device vhci_hcd: stop threads kworker/0:3 D28176 6425 2 0x80000000 vhci_hcd: release socket vhci_hcd: connection closed 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 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 vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads vhci_hcd: connection closed vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used 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(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: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used Call Trace: vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: stop threads context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 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: 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: 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: 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(2) speed_str(full-speed) schedule+0x8d/0x1b0 kernel/sched/core.c:3428 vhci_hcd: stop threads vhci_hcd: connection closed usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691 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(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: stop threads vhci_hcd: release socket usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device usb_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 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(2) speed_str(full-speed) 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: disconnect device 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: 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: pdev(2) rhport(0) sockfd(3) 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 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: 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: connection closed vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652 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 drivers/usb/core/message.c:924 vhci_hcd: stop threads vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: port 0 already used hub_port_init+0x625/0x28b0 drivers/usb/core/hub.c:4647 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: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 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: 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: 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: devid(0) speed(2) speed_str(full-speed) vhci_hcd: disconnect device 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 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116 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: connection closed 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 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250 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: pdev(0) 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: disconnect device kthread+0x30d/0x420 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: connection closed 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(2) speed_str(full-speed) vhci_hcd: release socket 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:3:6457 blocked for more than 140 seconds. 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: disconnect device vhci_hcd: stop threads Not tainted 4.14.198-syzkaller #0 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: pdev(2) rhport(0) sockfd(3) "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 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: stop threads kworker/1:3 D28512 6457 2 0x80000000 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(1) 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 Workqueue: usb_hub_wq hub_event 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: stop threads Call Trace: vhci_hcd: release socket vhci_hcd: disconnect device vhci_hcd: stop threads context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 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 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(2) speed_str(full-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 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 vhci_hcd: disconnect device vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed vhci_hcd: stop threads usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691 vhci_hcd: release socket vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) vhci_hcd: disconnect device 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(2) speed_str(full-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed vhci_hcd: release socket usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 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_start_wait_urb+0x206/0x260 drivers/usb/core/message.c:62 vhci_hcd: disconnect device 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: 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: 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 vhci_hcd.0: port 0 already used 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(2) speed_str(full-speed) vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: connection closed vhci_hcd: release socket usb_internal_control_msg drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151 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: connection closed vhci_hcd: disconnect device vhci_hcd: stop threads hub_port_init+0xfb1/0x28b0 drivers/usb/core/hub.c:4555 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) 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 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(2) speed_str(full-speed) vhci_hcd: release socket vhci_hcd: disconnect device 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 vhci_hcd: connection closed 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: pdev(0) rhport(0) sockfd(3) 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 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: 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: stop threads vhci_hcd: connection closed 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: 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: stop threads 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: 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: devid(0) speed(2) speed_str(full-speed) ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 vhci_hcd: release socket 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) Showing all locks held in the system: vhci_hcd: stop threads vhci_hcd: release socket vhci_hcd: disconnect device vhci_hcd: connection closed vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd vhci_hcd.0: pdev(3) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) 1 lock held by khungtaskd/1068: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 5 locks held by kworker/1:2/2796: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 5 locks held by kworker/0:2/3347: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 5 locks held by kworker/1:1/6368: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 5 locks held by kworker/0:0/6380: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 1 lock held by syz-executor079/6390: #0: (tasklist_lock){.+.+}, at: [] release_task+0x14d/0x1380 kernel/exit.c:198 5 locks held by kworker/0:3/6425: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 5 locks held by kworker/1:3/6457: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1081 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0xfc/0x39a0 drivers/usb/core/hub.c:5220 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2934 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4904 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5088 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5194 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x1bb0/0x39a0 drivers/usb/core/hub.c:5274 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_init+0x15b/0x28b0 drivers/usb/core/hub.c:4429 ============================================= 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: release socket vhci_hcd vhci_hcd.0: port 0 already used vhci_hcd: disconnect device vhci_hcd: stop threads vhci_hcd: connection closed 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(2) speed_str(full-speed) 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: release socket 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: 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 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(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: disconnect device NMI backtrace for cpu 1 vhci_hcd vhci_hcd.0: port 0 already used CPU: 1 PID: 1068 Comm: khungtaskd Not tainted 4.14.198-syzkaller #0 vhci_hcd: stop threads 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 vhci_hcd: release socket vhci_hcd: disconnect device nmi_trigger_cpumask_backtrace+0x13a/0x17f lib/nmi_backtrace.c:62 vhci_hcd: stop threads 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 vhci_hcd: release socket 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: 6369 Comm: kworker/u4:1 Not tainted 4.14.198-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: usbip_event event_handler task: ffff888097a88400 task.stack: ffff8880a9488000 RIP: 0010:__lock_acquire+0x225/0x3f20 kernel/locking/lockdep.c:3396 RSP: 0018:ffff8880a948f8a8 EFLAGS: 00000006 RAX: ffffffff8a0c52f0 RBX: 0000000000000000 RCX: 0000000000000000 RDX: 1ffffffff0faf8c5 RSI: 0000000000000000 RDI: ffffffff87d7c628 RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000000001 R10: 0000000000000001 R11: ffff888097a88400 R12: ffffffff87d7c620 R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff8a5a8c00 FS: 0000000000000000(0000) GS:ffff8880aea00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000004b5040 CR3: 0000000088061000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 console_lock_spinning_enable kernel/printk/printk.c:1588 [inline] console_unlock+0x36f/0xf20 kernel/printk/printk.c:2394 vprintk_emit+0x224/0x620 kernel/printk/printk.c:1923 vprintk_func+0x58/0x152 kernel/printk/printk_safe.c:401 printk+0x9e/0xbc kernel/printk/printk.c:1996 vhci_shutdown_connection.cold+0xfb/0x7f3 drivers/usb/usbip/vhci_hcd.c:1046 event_handler+0x18a/0x420 drivers/usb/usbip/usbip_event.c:92 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 Code: 4b 8d 7c f4 08 48 89 fa 48 c1 ea 03 80 3c 02 00 0f 85 5e 2a 00 00 4b 8b 44 f4 08 48 85 c0 0f 84 31 ff ff ff f0 ff 80 38 01 00 00 <49> 8d b3 80 08 00 00 48 ba 00 00 00 00 00 fc ff df 48 89 f1 48 vhci_hcd vhci_hcd.0: pdev(2) rhport(0) sockfd(3) vhci_hcd: connection closed vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) vhci_hcd vhci_hcd.0: port 0 already used