Warning: Permanently added '10.128.0.254' (ED25519) to the list of known hosts. executing program [ 422.798903][ T3532] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 422.805479][ T3532] vhci_hcd vhci_hcd.0: devid(0) speed(1) speed_str(low-speed) [ 422.814683][ T3532] vhci_hcd vhci_hcd.0: Device attached [ 423.159129][ T1280] usb 9-1: new low-speed USB device number 2 using vhci_hcd [ 572.899052][ T27] INFO: task kworker/0:2:1280 blocked for more than 143 seconds. [ 572.906892][ T27] Not tainted 5.15.150-syzkaller #0 [ 572.912648][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 572.921337][ T27] task:kworker/0:2 state:D stack:25600 pid: 1280 ppid: 2 flags:0x00004000 [ 572.930556][ T27] Workqueue: usb_hub_wq hub_event [ 572.935685][ T27] Call Trace: [ 572.938995][ T27] [ 572.941919][ T27] __schedule+0x12c4/0x45b0 [ 572.946471][ T27] ? do_raw_spin_lock+0x14a/0x370 [ 572.951535][ T27] ? mark_lock+0x98/0x340 [ 572.955890][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 572.961911][ T27] ? __sched_text_start+0x8/0x8 [ 572.966760][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 572.971987][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 572.977186][ T27] ? lockdep_hardirqs_on+0x94/0x130 [ 572.982644][ T27] schedule+0x11b/0x1f0 [ 572.986797][ T27] usb_kill_urb+0x1c9/0x300 [ 572.991339][ T27] ? usb_unlink_urb+0xa0/0xa0 [ 572.996012][ T27] ? _raw_spin_lock_irq+0xdb/0x110 [ 573.001162][ T27] ? init_wait_entry+0xd0/0xd0 [ 573.005984][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.011197][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.016402][ T27] usb_start_wait_urb+0x1ac/0x510 [ 573.021485][ T27] ? usb_api_blocking_completion+0xa0/0xa0 [ 573.027296][ T27] usb_control_msg+0x2ad/0x4c0 [ 573.032080][ T27] ? usb_anchor_empty+0x40/0x40 [ 573.036926][ T27] ? kmem_cache_alloc_trace+0x143/0x290 [ 573.042560][ T27] ? hub_port_init+0x16d/0x27a0 [ 573.047407][ T27] hub_port_init+0xba4/0x27a0 [ 573.052129][ T27] ? _raw_spin_unlock+0x40/0x40 [ 573.056983][ T27] hub_event+0x28ed/0x54c0 [ 573.061470][ T27] ? led_work+0x700/0x700 [ 573.065802][ T27] ? read_lock_is_recursive+0x10/0x10 [ 573.071188][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.077168][ T27] ? rwsem_down_write_slowpath+0x1090/0x15c0 [ 573.083196][ T27] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.089108][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.094291][ T27] process_one_work+0x8a1/0x10c0 [ 573.099307][ T27] ? worker_detach_from_pool+0x260/0x260 [ 573.104941][ T27] ? _raw_spin_lock_irqsave+0x120/0x120 [ 573.110500][ T27] ? kthread_data+0x4e/0xc0 [ 573.114997][ T27] ? wq_worker_running+0x97/0x170 [ 573.120048][ T27] worker_thread+0xaca/0x1280 [ 573.124724][ T27] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.130649][ T27] kthread+0x3f6/0x4f0 [ 573.134753][ T27] ? rcu_lock_release+0x20/0x20 [ 573.139638][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.144226][ T27] ret_from_fork+0x1f/0x30 [ 573.148638][ T27] [ 573.151731][ T27] INFO: task syz-executor459:3532 blocked for more than 143 seconds. [ 573.159828][ T27] Not tainted 5.15.150-syzkaller #0 [ 573.165526][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.174192][ T27] task:syz-executor459 state:D stack:25088 pid: 3532 ppid: 3531 flags:0x00004006 [ 573.183422][ T27] Call Trace: [ 573.186679][ T27] [ 573.189718][ T27] __schedule+0x12c4/0x45b0 [ 573.194237][ T27] ? __sched_text_start+0x8/0x8 [ 573.199118][ T27] ? __mutex_trylock_common+0x8d/0x2e0 [ 573.204576][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.209786][ T27] schedule+0x11b/0x1f0 [ 573.213938][ T27] schedule_preempt_disabled+0xf/0x20 [ 573.219339][ T27] __mutex_lock_common+0xe34/0x25a0 [ 573.224538][ T27] ? usbdev_release+0x76/0x7c0 [ 573.229365][ T27] ? mutex_lock_io_nested+0x60/0x60 [ 573.234553][ T27] ? memset+0x1f/0x40 [ 573.238523][ T27] ? __fsnotify_update_child_dentry_flags+0x2a0/0x2a0 [ 573.245359][ T27] mutex_lock_nested+0x17/0x20 [ 573.250136][ T27] usbdev_release+0x76/0x7c0 [ 573.254711][ T27] ? ima_file_free+0xeb/0x3c0 [ 573.259464][ T27] ? usbdev_open+0x7a0/0x7a0 [ 573.264052][ T27] __fput+0x3bf/0x890 [ 573.268044][ T27] task_work_run+0x129/0x1a0 [ 573.272646][ T27] exit_to_user_mode_loop+0x106/0x130 [ 573.278040][ T27] exit_to_user_mode_prepare+0xb1/0x140 [ 573.283610][ T27] syscall_exit_to_user_mode+0x5d/0x250 [ 573.289177][ T27] do_syscall_64+0x49/0xb0 [ 573.293604][ T27] entry_SYSCALL_64_after_hwframe+0x61/0xcb [ 573.299523][ T27] RIP: 0033:0x7f2687fe50e0 [ 573.303931][ T27] RSP: 002b:00007ffefda24f18 EFLAGS: 00000202 ORIG_RAX: 0000000000000003 [ 573.312353][ T27] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f2687fe50e0 [ 573.320349][ T27] RDX: 0000000000000007 RSI: 00007ffefda24a50 RDI: 0000000000000003 [ 573.328303][ T27] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 573.336279][ T27] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000000f4240 [ 573.344280][ T27] R13: 00007ffefda251c8 R14: 0000000000000001 R15: 00007ffefda24f60 [ 573.352284][ T27] [ 573.355311][ T27] [ 573.355311][ T27] Showing all locks held in the system: [ 573.363054][ T27] 1 lock held by khungtaskd/27: [ 573.367891][ T27] #0: ffffffff8c91f720 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30 [ 573.377231][ T27] 5 locks held by kworker/0:2/1280: [ 573.382449][ T27] #0: ffff8881445a4938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 [ 573.393154][ T27] #1: ffffc90006057d20 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 [ 573.404477][ T27] #2: ffff88801ff75220 (&dev->mutex){....}-{3:3}, at: hub_event+0x208/0x54c0 [ 573.413382][ T27] #3: ffff8880200215c0 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x2238/0x54c0 [ 573.423335][ T27] #4: ffff888147678b68 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x2260/0x54c0 [ 573.433015][ T27] 2 locks held by getty/3260: [ 573.437677][ T27] #0: ffff88814abfe098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 [ 573.447528][ T27] #1: ffffc90002bab2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6af/0x1db0 [ 573.457657][ T27] 1 lock held by syz-executor459/3532: [ 573.463145][ T27] #0: ffff88801ff75220 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x76/0x7c0 [ 573.472326][ T27] [ 573.474645][ T27] ============================================= [ 573.474645][ T27] [ 573.483087][ T27] NMI backtrace for cpu 1 [ 573.487403][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.15.150-syzkaller #0 [ 573.495363][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/25/2024 [ 573.505406][ T27] Call Trace: [ 573.508662][ T27] [ 573.511571][ T27] dump_stack_lvl+0x1e3/0x2cb [ 573.516226][ T27] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.521840][ T27] ? panic+0x84d/0x84d [ 573.525893][ T27] ? nmi_cpu_backtrace+0x23b/0x4a0 [ 573.531048][ T27] nmi_cpu_backtrace+0x46a/0x4a0 [ 573.535968][ T27] ? __wake_up_klogd+0xd5/0x100 [ 573.540806][ T27] ? nmi_trigger_cpumask_backtrace+0x2a0/0x2a0 [ 573.546953][ T27] ? _printk+0xd1/0x111 [ 573.551087][ T27] ? panic+0x84d/0x84d [ 573.555134][ T27] ? __wake_up_klogd+0xcc/0x100 [ 573.559961][ T27] ? panic+0x84d/0x84d [ 573.564010][ T27] ? __rcu_read_unlock+0x92/0x100 [ 573.569058][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.575127][ T27] nmi_trigger_cpumask_backtrace+0x181/0x2a0 [ 573.581087][ T27] watchdog+0xe72/0xeb0 [ 573.585262][ T27] kthread+0x3f6/0x4f0 [ 573.589305][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.594300][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.598862][ T27] ret_from_fork+0x1f/0x30 [ 573.603256][ T27] [ 573.606392][ T27] Sending NMI from CPU 1 to CPUs 0: [ 573.611663][ C0] NMI backtrace for cpu 0 skipped: idling at acpi_idle_do_entry+0x10f/0x340 [ 573.619242][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 573.628282][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.150-syzkaller #0 [ 573.636230][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/25/2024 [ 573.646254][ T27] Call Trace: [ 573.649507][ T27] [ 573.652411][ T27] dump_stack_lvl+0x1e3/0x2cb [ 573.657066][ T27] ? io_uring_drop_tctx_refs+0x19d/0x19d [ 573.662673][ T27] ? panic+0x84d/0x84d [ 573.666719][ T27] panic+0x318/0x84d [ 573.670586][ T27] ? schedule_preempt_disabled+0x20/0x20 [ 573.676203][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.682345][ T27] ? fb_is_primary_device+0xcc/0xcc [ 573.687519][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.693561][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.699689][ T27] ? nmi_trigger_cpumask_backtrace+0x281/0x2a0 [ 573.705822][ T27] ? nmi_trigger_cpumask_backtrace+0x286/0x2a0 [ 573.711983][ T27] watchdog+0xeb0/0xeb0 [ 573.716121][ T27] kthread+0x3f6/0x4f0 [ 573.720167][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.725167][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.729729][ T27] ret_from_fork+0x1f/0x30 [ 573.734125][ T27] [ 573.737381][ T27] Kernel Offset: disabled [ 573.741692][ T27] Rebooting in 86400 seconds..