Warning: Permanently added '10.128.0.90' (ED25519) to the list of known hosts. executing program [ 404.747683][ T3530] vhci_hcd vhci_hcd.0: pdev(0) rhport(0) sockfd(4) [ 404.754541][ T3530] vhci_hcd vhci_hcd.0: devid(0) speed(2) speed_str(full-speed) [ 404.763693][ T3530] vhci_hcd vhci_hcd.0: Device attached [ 405.037488][ T1069] vhci_hcd: vhci_device speed not set [ 405.107290][ T1069] usb 9-1: new full-speed USB device number 2 using vhci_hcd [ 573.157354][ T27] INFO: task kworker/1:2:1069 blocked for more than 143 seconds. [ 573.165210][ T27] Not tainted 5.15.158-syzkaller #0 [ 573.171091][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.179796][ T27] task:kworker/1:2 state:D stack:24256 pid: 1069 ppid: 2 flags:0x00004000 [ 573.189138][ T27] Workqueue: usb_hub_wq hub_event [ 573.194482][ T27] Call Trace: [ 573.197787][ T27] [ 573.200724][ T27] __schedule+0x12c4/0x45b0 [ 573.205312][ T27] ? do_raw_spin_lock+0x14a/0x370 [ 573.210371][ T27] ? mark_lock+0x98/0x340 [ 573.214709][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.220760][ T27] ? release_firmware_map_entry+0x190/0x190 [ 573.226762][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.231985][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.237310][ T27] ? lockdep_hardirqs_on+0x94/0x130 [ 573.242564][ T27] schedule+0x11b/0x1f0 [ 573.246706][ T27] usb_kill_urb+0x1c9/0x300 [ 573.251319][ T27] ? usb_unlink_urb+0xa0/0xa0 [ 573.256020][ T27] ? _raw_spin_lock_irq+0xdb/0x110 [ 573.261294][ T27] ? init_wait_entry+0xd0/0xd0 [ 573.266147][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.271365][ T27] ? _raw_spin_unlock_irq+0x1f/0x40 [ 573.276586][ T27] usb_start_wait_urb+0x1ac/0x510 [ 573.281664][ T27] ? usb_api_blocking_completion+0xa0/0xa0 [ 573.287503][ T27] usb_control_msg+0x2ad/0x4c0 [ 573.292348][ T27] ? usb_anchor_empty+0x40/0x40 [ 573.297320][ T27] ? kmem_cache_alloc_trace+0x143/0x290 [ 573.303093][ T27] ? hub_port_init+0x16d/0x27a0 [ 573.307988][ T27] hub_port_init+0xba4/0x27a0 [ 573.312680][ T27] ? _raw_spin_unlock+0x40/0x40 [ 573.317584][ T27] hub_event+0x28ed/0x54c0 [ 573.322031][ T27] ? led_work+0x700/0x700 [ 573.326372][ T27] ? read_lock_is_recursive+0x10/0x10 [ 573.331872][ T27] ? lockdep_hardirqs_on_prepare+0x438/0x7a0 [ 573.338064][ T27] ? down_read_killable_nested+0x1c0/0x350 [ 573.344760][ T27] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.350747][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.355974][ T27] process_one_work+0x8a1/0x10c0 [ 573.361199][ T27] ? worker_detach_from_pool+0x260/0x260 [ 573.366839][ T27] ? _raw_spin_lock_irqsave+0x120/0x120 [ 573.372506][ T27] ? kthread_data+0x4e/0xc0 [ 573.377018][ T27] ? wq_worker_running+0x97/0x170 [ 573.382084][ T27] worker_thread+0xaca/0x1280 [ 573.386773][ T27] kthread+0x3f6/0x4f0 [ 573.390912][ T27] ? rcu_lock_release+0x20/0x20 [ 573.395765][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.400380][ T27] ret_from_fork+0x1f/0x30 [ 573.404836][ T27] [ 573.407969][ T27] INFO: task syz-executor421:3530 blocked for more than 143 seconds. [ 573.416039][ T27] Not tainted 5.15.158-syzkaller #0 [ 573.421787][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 573.430476][ T27] task:syz-executor421 state:D stack:25088 pid: 3530 ppid: 3529 flags:0x00004006 [ 573.439834][ T27] Call Trace: [ 573.443135][ T27] [ 573.446072][ T27] __schedule+0x12c4/0x45b0 [ 573.450754][ T27] ? release_firmware_map_entry+0x190/0x190 [ 573.456675][ T27] ? __mutex_trylock_common+0x8d/0x2e0 [ 573.462202][ T27] ? do_raw_spin_unlock+0x137/0x8b0 [ 573.467442][ T27] schedule+0x11b/0x1f0 [ 573.471707][ T27] schedule_preempt_disabled+0xf/0x20 [ 573.477089][ T27] __mutex_lock_common+0xe34/0x25a0 [ 573.482468][ T27] ? usbdev_release+0x76/0x7c0 [ 573.487367][ T27] ? mutex_lock_io_nested+0x60/0x60 [ 573.492570][ T27] ? memset+0x1f/0x40 [ 573.496563][ T27] ? __fsnotify_update_child_dentry_flags+0x2a0/0x2a0 [ 573.503631][ T27] mutex_lock_nested+0x17/0x20 [ 573.508436][ T27] usbdev_release+0x76/0x7c0 [ 573.513020][ T27] ? ima_file_free+0xeb/0x3c0 [ 573.517793][ T27] ? usbdev_open+0x7a0/0x7a0 [ 573.522390][ T27] __fput+0x3bf/0x890 [ 573.526503][ T27] task_work_run+0x129/0x1a0 [ 573.531131][ T27] exit_to_user_mode_loop+0x106/0x130 [ 573.536541][ T27] exit_to_user_mode_prepare+0xb1/0x140 [ 573.542309][ T27] syscall_exit_to_user_mode+0x5d/0x240 [ 573.547888][ T27] do_syscall_64+0x47/0xb0 [ 573.552385][ T27] ? clear_bhb_loop+0x15/0x70 [ 573.557049][ T27] entry_SYSCALL_64_after_hwframe+0x66/0xd0 [ 573.563078][ T27] RIP: 0033:0x7f89df48e0e0 [ 573.567579][ T27] RSP: 002b:00007ffdf704cd58 EFLAGS: 00000202 ORIG_RAX: 0000000000000003 [ 573.575993][ T27] RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f89df48e0e0 [ 573.583983][ T27] RDX: 0000000000000007 RSI: 00007ffdf704c890 RDI: 0000000000000003 [ 573.592095][ T27] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 573.600263][ T27] R10: 0000000000000000 R11: 0000000000000202 R12: 00000000000f4240 [ 573.608278][ T27] R13: 00007ffdf704cff8 R14: 0000000000000001 R15: 00007ffdf704cd90 [ 573.616254][ T27] [ 573.619301][ T27] [ 573.619301][ T27] Showing all locks held in the system: [ 573.627376][ T27] 1 lock held by khungtaskd/27: [ 573.632234][ T27] #0: ffffffff8c91fae0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30 [ 573.641664][ T27] 5 locks held by kworker/1:2/1069: [ 573.646873][ T27] #0: ffff888015da7d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x78a/0x10c0 [ 573.657726][ T27] #1: ffffc9000490fd20 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7d0/0x10c0 [ 573.668988][ T27] #2: ffff8881483ae220 (&dev->mutex){....}-{3:3}, at: hub_event+0x208/0x54c0 [ 573.678009][ T27] #3: ffff8881483c25c0 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x2238/0x54c0 [ 573.688345][ T27] #4: ffff888148354368 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x2260/0x54c0 [ 573.698089][ T27] 1 lock held by klogd/2951: [ 573.702852][ T27] #0: ffff8880b9b3a358 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x26/0x140 [ 573.712960][ T27] 2 locks held by getty/3258: [ 573.717664][ T27] #0: ffff8880246a6098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 [ 573.727504][ T27] #1: ffffc9000209b2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6af/0x1db0 [ 573.737675][ T27] 1 lock held by syz-executor421/3530: [ 573.743126][ T27] #0: ffff8881483ae220 (&dev->mutex){....}-{3:3}, at: usbdev_release+0x76/0x7c0 [ 573.752446][ T27] [ 573.754791][ T27] ============================================= [ 573.754791][ T27] [ 573.763349][ T27] NMI backtrace for cpu 0 [ 573.767679][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.158-syzkaller #0 [ 573.775644][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 573.785761][ T27] Call Trace: [ 573.789214][ T27] [ 573.792128][ T27] dump_stack_lvl+0x1e3/0x2d0 [ 573.796888][ T27] ? io_uring_drop_tctx_refs+0x1a0/0x1a0 [ 573.802500][ T27] ? panic+0x860/0x860 [ 573.806611][ T27] ? nmi_cpu_backtrace+0x23b/0x4a0 [ 573.811748][ T27] nmi_cpu_backtrace+0x46a/0x4a0 [ 573.816691][ T27] ? __wake_up_klogd+0xd5/0x100 [ 573.821546][ T27] ? nmi_trigger_cpumask_backtrace+0x2a0/0x2a0 [ 573.827772][ T27] ? _printk+0xd1/0x120 [ 573.831996][ T27] ? panic+0x860/0x860 [ 573.836047][ T27] ? __wake_up_klogd+0xcc/0x100 [ 573.841055][ T27] ? panic+0x860/0x860 [ 573.845113][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.851217][ T27] nmi_trigger_cpumask_backtrace+0x181/0x2a0 [ 573.857452][ T27] watchdog+0xe72/0xeb0 [ 573.861737][ T27] kthread+0x3f6/0x4f0 [ 573.865779][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.870807][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.875391][ T27] ret_from_fork+0x1f/0x30 [ 573.879817][ T27] [ 573.883077][ T27] Sending NMI from CPU 0 to CPUs 1: [ 573.888335][ C1] NMI backtrace for cpu 1 [ 573.888346][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.15.158-syzkaller #0 [ 573.888361][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 573.888368][ C1] RIP: 0010:sched_clock_idle_wakeup_event+0x0/0x1c0 [ 573.888393][ C1] Code: 02 e9 09 ff ff ff e8 6f f4 c3 08 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 e8 1b 08 c4 08 89 c7 e9 34 f8 ff ff 0f 1f 40 00 <55> 48 89 e5 41 57 41 56 41 55 41 54 53 48 83 e4 e0 48 81 ec 80 00 [ 573.888405][ C1] RSP: 0018:ffffc90000dd0ed8 EFLAGS: 00000002 [ 573.888418][ C1] RAX: 0000000000000000 RBX: ffff8880b9b2ac40 RCX: 0000000000115a59 [ 573.888428][ C1] RDX: ffff88813fe68000 RSI: 0000000000000000 RDI: ffff8880b9b2ac58 [ 573.888438][ C1] RBP: ffffc90000dd0fc8 R08: ffffffff81732a9b R09: ffffed10173675bc [ 573.888448][ C1] R10: 0000000000000000 R11: dffffc0000000001 R12: ffff8880b9b2ac14 [ 573.888457][ C1] R13: dffffc0000000000 R14: 1ffff11017365582 R15: 1ffff920001ba1e4 [ 573.888468][ C1] FS: 0000000000000000(0000) GS:ffff8880b9b00000(0000) knlGS:0000000000000000 [ 573.888479][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 573.888489][ C1] CR2: 000055bc35580680 CR3: 0000000019fea000 CR4: 00000000003506e0 [ 573.888502][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 573.888510][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 573.888518][ C1] Call Trace: [ 573.888523][ C1] [ 573.888528][ C1] ? nmi_cpu_backtrace+0x39f/0x4a0 [ 573.888544][ C1] ? read_lock_is_recursive+0x10/0x10 [ 573.888560][ C1] ? nmi_trigger_cpumask_backtrace+0x2a0/0x2a0 [ 573.888574][ C1] ? unknown_nmi_error+0xd0/0xd0 [ 573.888680][ C1] ? nmi_cpu_backtrace_handler+0x8/0x10 [ 573.888700][ C1] ? nmi_handle+0xf7/0x370 [ 573.888714][ C1] ? sched_clock_idle_sleep_event+0x10/0x10 [ 573.888729][ C1] ? default_do_nmi+0x62/0x150 [ 573.888745][ C1] ? exc_nmi+0xa8/0x100 [ 573.888758][ C1] ? end_repeat_nmi+0x16/0x31 [ 573.888775][ C1] ? tick_irq_enter+0x1db/0x490 [ 573.888811][ C1] ? sched_clock_idle_sleep_event+0x10/0x10 [ 573.888826][ C1] ? sched_clock_idle_sleep_event+0x10/0x10 [ 573.888843][ C1] ? sched_clock_idle_sleep_event+0x10/0x10 [ 573.888858][ C1] [ 573.888862][ C1] [ 573.888866][ C1] tick_irq_enter+0x250/0x490 [ 573.888880][ C1] ? sched_clock_cpu+0x15/0x3b0 [ 573.888896][ C1] ? tick_nohz_idle_exit+0x550/0x550 [ 573.888910][ C1] ? __irq_exit_rcu+0x1a4/0x240 [ 573.888940][ C1] ? irq_exit_rcu+0x20/0x20 [ 573.888956][ C1] irq_enter_rcu+0x99/0xe0 [ 573.888968][ C1] sysvec_call_function_single+0x81/0xb0 [ 573.888984][ C1] [ 573.888987][ C1] [ 573.888992][ C1] asm_sysvec_call_function_single+0x16/0x20 [ 573.889006][ C1] RIP: 0010:acpi_idle_do_entry+0x10f/0x340 [ 573.889023][ C1] Code: 1d 59 f7 48 83 e3 08 0f 85 0a 01 00 00 4c 8d 74 24 20 e8 24 99 5f f7 0f 1f 44 00 00 e8 1a 19 59 f7 0f 00 2d b3 d9 bb 00 fb f4 <4c> 89 f3 48 c1 eb 03 42 80 3c 3b 00 74 08 4c 89 f7 e8 9b f1 a2 f7 [ 573.889035][ C1] RSP: 0018:ffffc90000d67b00 EFLAGS: 000002d3 [ 573.889046][ C1] RAX: ffffffff8a2743a6 RBX: 0000000000000000 RCX: ffff88813fe68000 [ 573.889056][ C1] RDX: 0000000000000000 RSI: ffffffff8a8b2980 RDI: ffffffff8ad8f600 [ 573.889065][ C1] RBP: ffffc90000d67b90 R08: ffffffff8186dcf0 R09: ffffed1027fcd001 [ 573.889075][ C1] R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffff920001acf60 [ 573.889084][ C1] R13: ffff888145906004 R14: ffffc90000d67b20 R15: dffffc0000000000 [ 573.889097][ C1] ? trace_hardirqs_on+0x30/0x80 [ 573.889129][ C1] ? acpi_idle_do_entry+0x106/0x340 [ 573.889148][ C1] ? acpi_idle_enter_bm+0x5c0/0x5c0 [ 573.889162][ C1] ? rcu_preempt_deferred_qs+0x6b/0x190 [ 573.889190][ C1] ? rcu_qs+0x190/0x190 [ 573.889205][ C1] acpi_idle_enter+0x352/0x4f0 [ 573.889222][ C1] cpuidle_enter_state+0x521/0xef0 [ 573.889287][ C1] ? cpuidle_enter_s2idle+0x6b0/0x6b0 [ 573.889302][ C1] ? menu_enable_device+0x380/0x380 [ 573.889318][ C1] cpuidle_enter+0x59/0x90 [ 573.889332][ C1] do_idle+0x3e4/0x670 [ 573.889349][ C1] ? idle_inject_timer_fn+0x60/0x60 [ 573.889365][ C1] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 573.889385][ C1] ? complete+0x56/0xa0 [ 573.889398][ C1] cpu_startup_entry+0x14/0x20 [ 573.889413][ C1] start_secondary+0x371/0x500 [ 573.889435][ C1] ? arch_scale_freq_tick+0x120/0x120 [ 573.889454][ C1] secondary_startup_64_no_verify+0xb1/0xbb [ 573.889477][ C1] [ 573.889483][ C1] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.147 msecs [ 573.902672][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 573.902691][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.158-syzkaller #0 [ 573.902709][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 573.902719][ T27] Call Trace: [ 573.902725][ T27] [ 573.902732][ T27] dump_stack_lvl+0x1e3/0x2d0 [ 573.902756][ T27] ? io_uring_drop_tctx_refs+0x1a0/0x1a0 [ 573.902774][ T27] ? panic+0x860/0x860 [ 573.902803][ T27] panic+0x318/0x860 [ 573.902820][ T27] ? schedule_preempt_disabled+0x20/0x20 [ 573.902840][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.902861][ T27] ? fb_is_primary_device+0xd0/0xd0 [ 573.902880][ T27] ? arch_trigger_cpumask_backtrace+0x10/0x10 [ 573.902902][ T27] ? nmi_trigger_cpumask_backtrace+0x221/0x2a0 [ 573.902919][ T27] ? nmi_trigger_cpumask_backtrace+0x281/0x2a0 [ 573.902938][ T27] ? nmi_trigger_cpumask_backtrace+0x286/0x2a0 [ 573.902958][ T27] watchdog+0xeb0/0xeb0 [ 573.902986][ T27] kthread+0x3f6/0x4f0 [ 573.903003][ T27] ? hungtask_pm_notify+0x50/0x50 [ 573.903020][ T27] ? kthread_blkcg+0xd0/0xd0 [ 573.903038][ T27] ret_from_fork+0x1f/0x30 [ 573.903066][ T27] [ 573.903401][ T27] Kernel Offset: disabled [ 574.451498][ T27] Rebooting in 86400 seconds..