Warning: Permanently added '10.128.0.13' (ED25519) to the list of known hosts. executing program [ 406.671357][ T3529] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 406.678401][ T3529] vhci_hcd vhci_hcd.0: devid(0) speed(3) speed_str(high-speed) [ 406.687247][ T3529] vhci_hcd vhci_hcd.0: Device attached [ 407.034746][ T7] usb 9-1: new high-speed USB device number 2 using vhci_hcd [ 573.074806][ T27] INFO: task kworker/0:0:7 blocked for more than 143 seconds. [ 573.074845][ T27] Not tainted 5.15.153-syzkaller #0 [ 573.074856][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.074864][ T27] task:kworker/0:0 state:D stack:24824 pid: 7 ppid: 2 flags:0x00004000 [ 573.107030][ T27] Workqueue: usb_hub_wq hub_event [ 573.112148][ T27] Call Trace: [ 573.115585][ T27] [ 573.118644][ T27] __schedule+0x12c4/0x45b0 [ 573.123257][ T27] ? do_raw_spin_lock+0x14a/0x370 [ 573.128586][ T27] ? mark_lock+0x98/0x340 [ 573.132952][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.139028][ T27] ? __sched_text_start+0x8/0x8 [ 573.143902][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.149182][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.154626][ T27] ? lockdep_hardirqs_on+0x94/0x130 [ 573.159903][ T27] schedule+0x11b/0x1f0 [ 573.164246][ T27] usb_kill_urb+0x1c9/0x300 [ 573.169002][ T27] ? usb_unlink_urb+0xa0/0xa0 [ 573.173702][ T27] ? _raw_spin_lock_irq+0xdb/0x110 [ 573.178892][ T27] ? init_wait_entry+0xd0/0xd0 [ 573.183772][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.189252][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.194486][ T27] usb_start_wait_urb+0x1ac/0x510 [ 573.199627][ T27] ? usb_api_blocking_completion+0xa0/0xa0 [ 573.205563][ T27] usb_control_msg+0x2ad/0x4c0 [ 573.210444][ T27] ? usb_anchor_empty+0x40/0x40 [ 573.215485][ T27] ? kmem_cache_alloc_trace+0x143/0x290 [ 573.221140][ T27] ? hub_port_init+0x16d/0x27a0 [ 573.226626][ T27] hub_port_init+0xba4/0x27a0 [ 573.231422][ T27] ? _raw_spin_unlock+0x40/0x40 [ 573.236342][ T27] hub_event+0x28ed/0x54c0 [ 573.240886][ T27] ? led_work+0x700/0x700 [ 573.245523][ T27] ? read_lock_is_recursive+0x10/0x10 [ 573.251095][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.257324][ T27] ? rwsem_down_write_slowpath+0xc90/0x15c0 [ 573.263245][ T27] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.269307][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.274812][ T27] process_one_work+0x8a1/0x10c0 [ 573.280049][ T27] ? worker_detach_from_pool+0x260/0x260 [ 573.285738][ T27] ? _raw_spin_lock_irqsave+0x120/0x120 [ 573.291496][ T27] ? kthread_data+0x4e/0xc0 [ 573.296141][ T27] ? wq_worker_running+0x97/0x170 [ 573.301183][ T27] worker_thread+0xaca/0x1280 [ 573.306091][ T27] kthread+0x3f6/0x4f0 [ 573.310348][ T27] ? rcu_lock_release+0x20/0x20 [ 573.315297][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.319892][ T27] ret_from_fork+0x1f/0x30 [ 573.324824][ T27] [ 573.327993][ T27] INFO: task syz-executor308:3529 blocked for more than 143 seconds. [ 573.336556][ T27] Not tainted 5.15.153-syzkaller #0 [ 573.342333][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.351095][ T27] task:syz-executor308 state:D stack:25072 pid: 3529 ppid: 3528 flags:0x00004006 [ 573.360386][ T27] Call Trace: [ 573.363666][ T27] [ 573.366651][ T27] __schedule+0x12c4/0x45b0 [ 573.371205][ T27] ? __sched_text_start+0x8/0x8 [ 573.376118][ T27] ? __mutex_trylock_common+0x8d/0x2e0 [ 573.381592][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.386862][ T27] schedule+0x11b/0x1f0 [ 573.391027][ T27] schedule_preempt_disabled+0xf/0x20 [ 573.396580][ T27] __mutex_lock_common+0xe34/0x25a0 [ 573.401835][ T27] ? usbdev_release+0x76/0x7c0 [ 573.406751][ T27] ? mutex_lock_io_nested+0x60/0x60 [ 573.412248][ T27] ? memset+0x1f/0x40 [ 573.416367][ T27] ? __fsnotify_update_child_dentry_flags+0x2a0/0x2a0 [ 573.423192][ T27] mutex_lock_nested+0x17/0x20 [ 573.428585][ T27] usbdev_release+0x76/0x7c0 [ 573.433203][ T27] ? ima_file_free+0xeb/0x3c0 [ 573.438199][ T27] ? usbdev_open+0x7a0/0x7a0 [ 573.442835][ T27] __fput+0x3bf/0x890 [ 573.447011][ T27] task_work_run+0x129/0x1a0 [ 573.451618][ T27] exit_to_user_mode_loop+0x106/0x130 [ 573.457093][ T27] exit_to_user_mode_prepare+0xb1/0x140 [ 573.462651][ T27] syscall_exit_to_user_mode+0x5d/0x250 [ 573.468281][ T27] do_syscall_64+0x49/0xb0 [ 573.472900][ T27] entry_SYSCALL_64_after_hwframe+0x61/0xcb [ 573.478926][ T27] RIP: 0033:0x7f435cb920e0 [ 573.483442][ T27] RSP: 002b:00007ffe59200d28 EFLAGS: 00000202 ORIG_RAX: 0000000000000003 [ 573.491942][ T27] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f435cb920e0 [ 573.500140][ T27] RDX: 0000000000000007 RSI: 00007ffe59200860 RDI: 0000000000000003 [ 573.508171][ T27] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 573.516268][ T27] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000000f4240 [ 573.524236][ T27] R13: 00007ffe59200fd8 R14: 0000000000000001 R15: 00007ffe59200d70 [ 573.532285][ T27] [ 573.535435][ T27] [ 573.535435][ T27] Showing all locks held in the system: [ 573.543615][ T27] 5 locks held by kworker/0:0/7: [ 573.548612][ T27] #0: ffff8881425c5d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 [ 573.559409][ T27] #1: ffffc90000cc7d20 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 [ 573.570684][ T27] #2: ffff888147ce7220 (&dev->mutex){....}-{3:3}, at: hub_event+0x208/0x54c0 [ 573.579774][ T27] #3: ffff888147ceb5c0 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x2238/0x54c0 [ 573.589787][ T27] #4: ffff888147c60c68 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x2260/0x54c0 [ 573.599510][ T27] 1 lock held by khungtaskd/27: [ 573.604378][ T27] #0: ffffffff8c91f720 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30 [ 573.613789][ T27] 1 lock held by klogd/2951: [ 573.618509][ T27] #0: ffff8880b9b3a318 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x26/0x140 [ 573.628836][ T27] 2 locks held by getty/3257: [ 573.633600][ T27] #0: ffff88802495d098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 [ 573.643574][ T27] #1: ffffc90002bab2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6af/0x1db0 [ 573.653921][ T27] 1 lock held by syz-executor308/3529: [ 573.659498][ T27] #0: ffff888147ce7220 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x76/0x7c0 [ 573.668835][ T27] [ 573.671337][ T27] ============================================= [ 573.671337][ T27] [ 573.680049][ T27] NMI backtrace for cpu 0 [ 573.684648][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.153-syzkaller #0 [ 573.692613][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 573.703013][ T27] Call Trace: [ 573.706278][ T27] [ 573.709195][ T27] dump_stack_lvl+0x1e3/0x2cb [ 573.713861][ T27] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.719473][ T27] ? panic+0x84d/0x84d [ 573.723721][ T27] ? nmi_cpu_backtrace+0x23b/0x4a0 [ 573.728942][ T27] nmi_cpu_backtrace+0x46a/0x4a0 [ 573.733963][ T27] ? __wake_up_klogd+0xd5/0x100 [ 573.738806][ T27] ? nmi_trigger_cpumask_backtrace+0x2a0/0x2a0 [ 573.745034][ T27] ? _printk+0xd1/0x111 [ 573.749263][ T27] ? panic+0x84d/0x84d [ 573.753446][ T27] ? __wake_up_klogd+0xcc/0x100 [ 573.758751][ T27] ? panic+0x84d/0x84d [ 573.762885][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.769202][ T27] nmi_trigger_cpumask_backtrace+0x181/0x2a0 [ 573.775340][ T27] watchdog+0xe72/0xeb0 [ 573.779613][ T27] kthread+0x3f6/0x4f0 [ 573.783661][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.789202][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.793769][ T27] ret_from_fork+0x1f/0x30 [ 573.798172][ T27] [ 573.801294][ T27] Sending NMI from CPU 0 to CPUs 1: [ 573.806630][ C1] NMI backtrace for cpu 1 skipped: idling at acpi_idle_do_entry+0x10f/0x340 [ 573.807690][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 573.822336][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.153-syzkaller #0 [ 573.830476][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 573.840793][ T27] Call Trace: [ 573.844240][ T27] [ 573.847496][ T27] dump_stack_lvl+0x1e3/0x2cb [ 573.852184][ T27] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.857805][ T27] ? panic+0x84d/0x84d [ 573.862030][ T27] panic+0x318/0x84d [ 573.865902][ T27] ? schedule_preempt_disabled+0x20/0x20 [ 573.871542][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.877678][ T27] ? fb_is_primary_device+0xcc/0xcc [ 573.882952][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.889012][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.895332][ T27] ? nmi_trigger_cpumask_backtrace+0x281/0x2a0 [ 573.901464][ T27] ? nmi_trigger_cpumask_backtrace+0x286/0x2a0 [ 573.907683][ T27] watchdog+0xeb0/0xeb0 [ 573.911908][ T27] kthread+0x3f6/0x4f0 [ 573.916040][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.921040][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.925604][ T27] ret_from_fork+0x1f/0x30 [ 573.930014][ T27] [ 573.933461][ T27] Kernel Offset: disabled [ 573.937877][ T27] Rebooting in 86400 seconds..