Warning: Permanently added '10.128.0.176' (ED25519) to the list of known hosts. executing program [ 411.038078][ T3529] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 411.044740][ T3529] vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) [ 411.053600][ T3529] vhci_hcd vhci_hcd.0: Device attached [ 411.405131][ T21] usb 9-1: new high-speed USB device number 2 using vhci_hcd [ 572.915102][ T26] INFO: task kworker/1:0:21 blocked for more than 143 seconds. [ 572.922789][ T26] Not tainted 5.15.123-syzkaller #0 [ 572.928807][ T26] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 572.937550][ T26] task:kworker/1:0 state:D stack:24760 pid: 21 ppid: 2 flags:0x00004000 [ 572.947072][ T26] Workqueue: usb_hub_wq hub_event [ 572.952409][ T26] Call Trace: [ 572.955848][ T26] [ 572.958969][ T26] __schedule+0x12c4/0x4590 [ 572.963570][ T26] ? do_raw_spin_lock+0x14a/0x370 [ 572.968689][ T26] ? mark_lock+0x98/0x340 [ 572.973045][ T26] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 572.979523][ T26] ? __sched_text_start+0x8/0x8 [ 572.984439][ T26] ? do_raw_spin_unlock+0x137/0x8b0 [ 572.989712][ T26] ? _raw_spin_unlock_irq+0x1f/0x40 [ 572.994981][ T26] ? lockdep_hardirqs_on+0x94/0x130 [ 573.000366][ T26] schedule+0x11b/0x1f0 [ 573.004745][ T26] usb_kill_urb+0x1c9/0x300 [ 573.009849][ T26] ? usb_unlink_urb+0xa0/0xa0 [ 573.014654][ T26] ? _raw_spin_lock_irq+0xdb/0x110 [ 573.019920][ T26] ? init_wait_entry+0xd0/0xd0 [ 573.024716][ T26] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.030093][ T26] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.035341][ T26] usb_start_wait_urb+0x1ac/0x510 [ 573.040387][ T26] ? usb_api_blocking_completion+0xa0/0xa0 [ 573.046269][ T26] usb_control_msg+0x2ad/0x4c0 [ 573.051293][ T26] ? usb_anchor_empty+0x40/0x40 [ 573.056291][ T26] ? kmem_cache_alloc_trace+0x143/0x290 [ 573.061918][ T26] ? hub_port_init+0x99c/0x23f0 [ 573.066942][ T26] hub_port_init+0xa05/0x23f0 [ 573.071681][ T26] hub_event+0x29ec/0x56d0 [ 573.076358][ T26] ? led_work+0x700/0x700 [ 573.080815][ T26] ? read_lock_is_recursive+0x10/0x10 [ 573.086243][ T26] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.092358][ T26] ? debug_mutex_wake_waiter+0xa0/0x320 [ 573.097964][ T26] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.103886][ T26] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.109219][ T26] process_one_work+0x8a1/0x10c0 [ 573.114288][ T26] ? worker_detach_from_pool+0x260/0x260 [ 573.119988][ T26] ? _raw_spin_lock_irqsave+0x120/0x120 [ 573.125599][ T26] ? kthread_data+0x4e/0xc0 [ 573.130112][ T26] ? wq_worker_running+0x97/0x170 [ 573.135281][ T26] worker_thread+0xaca/0x1280 [ 573.140212][ T26] kthread+0x3f6/0x4f0 [ 573.144308][ T26] ? rcu_lock_release+0x20/0x20 [ 573.149242][ T26] ? kthread_blkcg+0xd0/0xd0 [ 573.153854][ T26] ret_from_fork+0x1f/0x30 [ 573.158395][ T26] [ 573.161521][ T26] INFO: task syz-executor933:3529 blocked for more than 143 seconds. [ 573.169652][ T26] Not tainted 5.15.123-syzkaller #0 [ 573.175422][ T26] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.184185][ T26] task:syz-executor933 state:D stack:25088 pid: 3529 ppid: 3528 flags:0x00004006 [ 573.193546][ T26] Call Trace: [ 573.197339][ T26] [ 573.200332][ T26] __schedule+0x12c4/0x4590 [ 573.204873][ T26] ? __sched_text_start+0x8/0x8 [ 573.209814][ T26] ? __mutex_trylock_common+0x8d/0x2e0 [ 573.215394][ T26] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.220777][ T26] schedule+0x11b/0x1f0 [ 573.224996][ T26] schedule_preempt_disabled+0xf/0x20 [ 573.230412][ T26] __mutex_lock_common+0xe34/0x25a0 [ 573.235697][ T26] ? usbdev_release+0x76/0x7c0 [ 573.240521][ T26] ? mutex_lock_io_nested+0x60/0x60 [ 573.245785][ T26] ? memset+0x1f/0x40 [ 573.249843][ T26] ? __fsnotify_update_child_dentry_flags+0x2a0/0x2a0 [ 573.256710][ T26] mutex_lock_nested+0x17/0x20 [ 573.261497][ T26] usbdev_release+0x76/0x7c0 [ 573.266141][ T26] ? ima_file_free+0xeb/0x3c0 [ 573.270928][ T26] ? usbdev_open+0x7a0/0x7a0 [ 573.275597][ T26] __fput+0x3bf/0x890 [ 573.279676][ T26] task_work_run+0x129/0x1a0 [ 573.284272][ T26] exit_to_user_mode_loop+0x106/0x130 [ 573.289719][ T26] exit_to_user_mode_prepare+0xb1/0x140 [ 573.295305][ T26] syscall_exit_to_user_mode+0x5d/0x250 [ 573.300856][ T26] do_syscall_64+0x49/0xb0 [ 573.305329][ T26] entry_SYSCALL_64_after_hwframe+0x61/0xcb [ 573.311289][ T26] RIP: 0033:0x7f1524dab0e0 [ 573.315752][ T26] RSP: 002b:00007ffd426777e8 EFLAGS: 00000202 ORIG_RAX: 0000000000000003 [ 573.324186][ T26] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f1524dab0e0 [ 573.332201][ T26] RDX: 0000000000000007 RSI: 00007ffd42677320 RDI: 0000000000000003 [ 573.340214][ T26] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 573.348251][ T26] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000000f4240 [ 573.356282][ T26] R13: 00007ffd42677a98 R14: 0000000000000001 R15: 00007ffd42677830 [ 573.364492][ T26] [ 573.367826][ T26] [ 573.367826][ T26] Showing all locks held in the system: [ 573.375693][ T26] 5 locks held by kworker/1:0/21: [ 573.380747][ T26] #0: ffff888016d0b138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 [ 573.391620][ T26] #1: ffffc90000db7d20 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 [ 573.403043][ T26] #2: ffff88801ed34220 (&dev->mutex){....}-{3:3}, at: hub_event+0x207/0x56d0 [ 573.412081][ T26] #3: ffff88801ee005c0 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x2325/0x56d0 [ 573.422187][ T26] #4: ffff88801ec05568 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x235a/0x56d0 [ 573.431964][ T26] 1 lock held by khungtaskd/26: [ 573.436863][ T26] #0: ffffffff8c91e920 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30 [ 573.446401][ T26] 1 lock held by klogd/2950: [ 573.451000][ T26] #0: ffff8880b9b396d8 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x26/0x140 [ 573.461063][ T26] 2 locks held by getty/3258: [ 573.465865][ T26] #0: ffff888024a30098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 [ 573.475769][ T26] #1: ffffc900020a32e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6af/0x1da0 [ 573.486043][ T26] 1 lock held by syz-executor933/3529: [ 573.491517][ T26] #0: ffff88801ed34220 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x76/0x7c0 [ 573.500837][ T26] [ 573.503266][ T26] ============================================= [ 573.503266][ T26] [ 573.511881][ T26] NMI backtrace for cpu 0 [ 573.516225][ T26] CPU: 0 PID: 26 Comm: khungtaskd Not tainted 5.15.123-syzkaller #0 [ 573.524203][ T26] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023 [ 573.534301][ T26] Call Trace: [ 573.537691][ T26] [ 573.540644][ T26] dump_stack_lvl+0x1e3/0x2cb [ 573.545448][ T26] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.551198][ T26] ? panic+0x84d/0x84d [ 573.555275][ T26] ? nmi_cpu_backtrace+0x23b/0x4a0 [ 573.560557][ T26] nmi_cpu_backtrace+0x46a/0x4a0 [ 573.565514][ T26] ? __wake_up_klogd+0xd5/0x100 [ 573.570506][ T26] ? nmi_trigger_cpumask_backtrace+0x2a0/0x2a0 [ 573.576680][ T26] ? _printk+0xd1/0x111 [ 573.580835][ T26] ? panic+0x84d/0x84d [ 573.584895][ T26] ? __wake_up_klogd+0xcc/0x100 [ 573.589758][ T26] ? panic+0x84d/0x84d [ 573.593836][ T26] ? __rcu_read_unlock+0x92/0x100 [ 573.598904][ T26] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.605056][ T26] nmi_trigger_cpumask_backtrace+0x181/0x2a0 [ 573.611037][ T26] watchdog+0xe72/0xeb0 [ 573.615224][ T26] kthread+0x3f6/0x4f0 [ 573.619402][ T26] ? hungtask_pm_notify+0x50/0x50 [ 573.624440][ T26] ? kthread_blkcg+0xd0/0xd0 [ 573.629036][ T26] ret_from_fork+0x1f/0x30 [ 573.633462][ T26] [ 573.636731][ T26] Sending NMI from CPU 0 to CPUs 1: [ 573.641972][ C1] NMI backtrace for cpu 1 skipped: idling at acpi_idle_do_entry+0x10f/0x340 [ 573.645406][ T26] Kernel panic - not syncing: hung_task: blocked tasks [ 573.658642][ T26] CPU: 1 PID: 26 Comm: khungtaskd Not tainted 5.15.123-syzkaller #0 [ 573.666638][ T26] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023 [ 573.676681][ T26] Call Trace: [ 573.680063][ T26] [ 573.682984][ T26] dump_stack_lvl+0x1e3/0x2cb [ 573.687662][ T26] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.693376][ T26] ? panic+0x84d/0x84d [ 573.697616][ T26] panic+0x318/0x84d [ 573.701512][ T26] ? schedule_preempt_disabled+0x20/0x20 [ 573.707134][ T26] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.713292][ T26] ? fb_is_primary_device+0xcc/0xcc [ 573.718753][ T26] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.724839][ T26] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.730987][ T26] ? nmi_trigger_cpumask_backtrace+0x281/0x2a0 [ 573.737144][ T26] ? nmi_trigger_cpumask_backtrace+0x286/0x2a0 [ 573.743314][ T26] watchdog+0xeb0/0xeb0 [ 573.747474][ T26] kthread+0x3f6/0x4f0 [ 573.751626][ T26] ? hungtask_pm_notify+0x50/0x50 [ 573.756732][ T26] ? kthread_blkcg+0xd0/0xd0 [ 573.761312][ T26] ret_from_fork+0x1f/0x30 [ 573.765728][ T26] [ 573.768980][ T26] Kernel Offset: disabled [ 573.773307][ T26] Rebooting in 86400 seconds..