vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) vhci_hcd: connection closed vhci_hcd: stop threads vhci_hcd: release socket vhci_hcd: disconnect device INFO: task kworker/1:3:4713 blocked for more than 140 seconds. Not tainted 4.19.164-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/1:3 D25784 4713 2 0x80000000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 usb_kill_urb.part.0+0x197/0x220 drivers/usb/core/urb.c:697 usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:692 usb_start_wait_urb+0x252/0x4c0 drivers/usb/core/message.c:63 usb_internal_control_msg drivers/usb/core/message.c:101 [inline] usb_control_msg+0x31c/0x4a0 drivers/usb/core/message.c:152 hub_port_init+0x12d9/0x2fa0 drivers/usb/core/hub.c:4654 hub_port_connect drivers/usb/core/hub.c:5020 [inline] hub_port_connect_change drivers/usb/core/hub.c:5203 [inline] port_event drivers/usb/core/hub.c:5311 [inline] hub_event+0x1cf8/0x43f0 drivers/usb/core/hub.c:5391 process_one_work+0x864/0x1570 kernel/workqueue.c:2155 worker_thread+0x64c/0x1130 kernel/workqueue.c:2298 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Showing all locks held in the system: 1 lock held by khungtaskd/1565: #0: 00000000f3333b5d (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440 5 locks held by kworker/1:3/4713: #0: 00000000cb4e1ff3 ((wq_completion)"usb_hub_wq"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 00000000ce2e1588 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 000000009ab83cf3 (&dev->mutex){....}, at: device_lock include/linux/device.h:1173 [inline] #2: 000000009ab83cf3 (&dev->mutex){....}, at: hub_event+0x11b/0x43f0 drivers/usb/core/hub.c:5337 #3: 000000006034fe67 (&port_dev->status_lock){+.+.}, at: usb_lock_port drivers/usb/core/hub.c:2977 [inline] #3: 000000006034fe67 (&port_dev->status_lock){+.+.}, at: hub_port_connect drivers/usb/core/hub.c:5019 [inline] #3: 000000006034fe67 (&port_dev->status_lock){+.+.}, at: hub_port_connect_change drivers/usb/core/hub.c:5203 [inline] #3: 000000006034fe67 (&port_dev->status_lock){+.+.}, at: port_event drivers/usb/core/hub.c:5311 [inline] #3: 000000006034fe67 (&port_dev->status_lock){+.+.}, at: hub_event+0x1ce3/0x43f0 drivers/usb/core/hub.c:5391 #4: 000000000c575faa (hcd->address0_mutex){+.+.}, at: hub_port_init+0x1b6/0x2fa0 drivers/usb/core/hub.c:4528 1 lock held by in:imklog/7816: #0: 000000009cee40b7 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 vhci_hcd vhci_hcd.0: port 1 already used 7 locks held by syz-executor.0/15552: #0: 000000002b982594 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1824 [inline] #0: 000000002b982594 (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455 #1: 00000000f3333b5d (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline] #1: 00000000f3333b5d (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857 #2: 000000002a46ebf8 (&sig->wait_chldexit){....}, at: __wake_up_common_lock+0xb0/0x170 kernel/sched/wait.c:120 #3: 000000004070012b (&(&sig->stats_lock)->seqcount){....}, at: exit_notify kernel/exit.c:745 [inline] #3: 000000004070012b (&(&sig->stats_lock)->seqcount){....}, at: do_exit+0x1597/0x2be0 kernel/exit.c:910 vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(3) #4: 000000006e0ad000 (&obj_hash[i].lock){-.-.}, at: debug_object_active_state lib/debugobjects.c:725 [inline] #4: 000000006e0ad000 (&obj_hash[i].lock){-.-.}, at: debug_object_active_state+0x104/0x330 lib/debugobjects.c:713 vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) #5: 00000000d163b6b3 (pool_lock){-.-.}, at: alloc_object lib/debugobjects.c:174 [inline] #5: 00000000d163b6b3 (pool_lock){-.-.}, at: __debug_object_init+0x145/0x9b0 lib/debugobjects.c:387 vhci_hcd: connection closed vhci_hcd: stop threads #6: 00000000d163b6b3 (pool_lock){-.-.}, at: alloc_object lib/debugobjects.c:174 [inline] #6: 00000000d163b6b3 (pool_lock){-.-.}, at: __debug_object_init+0x145/0x9b0 lib/debugobjects.c:387 vhci_hcd: release socket vhci_hcd: disconnect device ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1565 Comm: khungtaskd Not tainted 4.19.164-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2fe lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1eb lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x991/0xe60 kernel/hung_task.c:287 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 9790 Comm: kworker/u4:3 Not tainted 4.19.164-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: bat_events batadv_nc_worker RIP: 0010:lock_acquire+0x149/0x3c0 kernel/locking/lockdep.c:3907 Code: 65 8b 05 da e1 b4 7e 83 f8 07 0f 87 e2 01 00 00 89 c0 48 0f a3 05 6f 13 da 09 0f 82 95 01 00 00 4c 8b 4c 24 08 44 89 ea 6a 00 <48> 89 ef 6a 00 45 89 f8 44 89 f1 44 89 e6 ff 74 24 60 ff 74 24 18 RSP: 0018:ffff88808d467c50 EFLAGS: 00000086 RAX: 0000000000000000 RBX: ffff888097ee61c0 RCX: 0000000000000001 RDX: 0000000000000000 RSI: 0000000000000002 RDI: ffff888097ee6a44 RBP: ffffffff89f85c60 R08: 0000000000000000 R09: 0000000000000286 R10: 0000000000000004 R11: 0000000000000000 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000002 R15: 0000000000000000 FS: 0000000000000000(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f7f85ee4000 CR3: 00000000a14f5000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: rcu_lock_acquire include/linux/rcupdate.h:242 [inline] rcu_read_lock include/linux/rcupdate.h:627 [inline] batadv_nc_purge_orig_hash net/batman-adv/network-coding.c:419 [inline] batadv_nc_worker+0x12d/0xd50 net/batman-adv/network-coding.c:730 process_one_work+0x864/0x1570 kernel/workqueue.c:2155 worker_thread+0x64c/0x1130 kernel/workqueue.c:2298 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415