[ 409.849305][ T142] input input188: Limiting number of effects to 32 (device reports 71) [ 409.873244][ T142] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 409.903264][ T142] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 409.923231][ T142] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 409.953279][ T142] iforce 1-1:0.0: usb_submit_urb failed: -71 [ 409.960276][ T142] input: Unknown I-Force Device [%04x:%04x] as /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input188 [ 409.973554][ T2961] iforce_close(ffff888021580000) start [ 409.974602][ T142] usb 1-1: USB disconnect, device number 59 [ 409.979029][ T2961] iforce_send_packet(ffff888021580000) start [ 409.993290][ T142] iforce_usb_disconnect(ffff888021580000) start Warning: Permanently added '10.128.10.7' (ECDSA) to the list of known hosts. [ 437.999043][ T8] device hsr_slave_0 left promiscuous mode [ 438.005669][ T8] device hsr_slave_1 left promiscuous mode [ 438.011851][ T8] batman_adv: batadv0: Interface deactivated: batadv_slave_0 [ 438.019583][ T8] batman_adv: batadv0: Removing interface: batadv_slave_0 [ 438.027655][ T8] batman_adv: batadv0: Interface deactivated: batadv_slave_1 [ 438.035223][ T8] batman_adv: batadv0: Removing interface: batadv_slave_1 [ 438.042900][ T8] device bridge_slave_1 left promiscuous mode [ 438.049160][ T8] bridge0: port 2(bridge_slave_1) entered disabled state [ 438.057062][ T8] device bridge_slave_0 left promiscuous mode [ 438.063309][ T8] bridge0: port 1(bridge_slave_0) entered disabled state [ 438.072328][ T8] device veth1_macvtap left promiscuous mode [ 438.078445][ T8] device veth0_macvtap left promiscuous mode [ 438.084918][ T8] device veth1_vlan left promiscuous mode [ 438.090692][ T8] device veth0_vlan left promiscuous mode [ 438.162914][ T8] team0 (unregistering): Port device team_slave_1 removed [ 438.172965][ T8] team0 (unregistering): Port device team_slave_0 removed [ 438.184143][ T8] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 438.195529][ T8] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 438.226675][ T8] bond0 (unregistering): Released all slaves [ 439.774027][ T1238] ieee802154 phy0 wpan0: encryption failed: -22 [ 439.780536][ T1238] ieee802154 phy1 wpan1: encryption failed: -22 [ 470.823905][ T2976] udevd[2976]: worker [4065] /devices/platform/dummy_hcd.0/usb1/1-1/1-1:0.0/input/input188/event4 is taking a long time [ 501.214153][ T1238] ieee802154 phy0 wpan0: encryption failed: -22 [ 501.220637][ T1238] ieee802154 phy1 wpan1: encryption failed: -22 [ 561.383126][ T27] INFO: task kworker/1:2:142 blocked for more than 143 seconds. [ 561.390814][ T27] Not tainted 5.19.0-rc8-syzkaller-00214-ge0dccc3b76fb-dirty #0 [ 561.399004][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 561.407714][ T27] task:kworker/1:2 state:D stack:24968 pid: 142 ppid: 2 flags:0x00004000 [ 561.417076][ T27] Workqueue: usb_hub_wq hub_event [ 561.422242][ T27] Call Trace: [ 561.425564][ T27] [ 561.428502][ T27] __schedule+0xa00/0x4b50 [ 561.433192][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 561.438690][ T27] ? lock_acquire+0x480/0x570 [ 561.443424][ T27] ? wq_worker_sleeping+0x1e5/0x250 [ 561.448642][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 561.453591][ T27] ? io_schedule_timeout+0x140/0x140 [ 561.458899][ T27] ? trace_hardirqs_on+0x2d/0x120 [ 561.463960][ T27] schedule+0xd2/0x1f0 [ 561.468047][ T27] schedule_preempt_disabled+0xf/0x20 [ 561.473674][ T27] __mutex_lock+0xa70/0x1350 [ 561.478352][ T27] ? __input_unregister_device+0x24/0x470 [ 561.484191][ T27] ? mutex_lock_io_nested+0x1190/0x1190 [ 561.489775][ T27] ? record_print_text.cold+0x16/0x16 [ 561.495229][ T27] __input_unregister_device+0x24/0x470 [ 561.500792][ T27] input_unregister_device+0xb4/0xf0 [ 561.506112][ T27] iforce_usb_disconnect+0x97/0x11d [ 561.511520][ T27] usb_unbind_interface+0x1d8/0x8e0 [ 561.516755][ T27] ? usb_unbind_device+0x1a0/0x1a0 [ 561.521878][ T27] device_remove+0x11f/0x170 [ 561.526587][ T27] device_release_driver_internal+0x4a1/0x700 [ 561.532668][ T27] ? put_device+0x1b/0x30 [ 561.537020][ T27] bus_remove_device+0x2eb/0x5a0 [ 561.541977][ T27] device_del+0x4f3/0xc80 [ 561.546386][ T27] ? __device_link_del+0x380/0x380 [ 561.551511][ T27] ? kobject_put+0x1f3/0x540 [ 561.556193][ T27] usb_disable_device+0x35b/0x7b0 [ 561.561257][ T27] usb_disconnect.cold+0x278/0x6ec [ 561.566460][ T27] hub_event+0x1e83/0x4690 [ 561.570890][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 561.575851][ T27] ? hub_port_debounce+0x3c0/0x3c0 [ 561.581054][ T27] ? irq_matrix_reserve+0x61/0x2f0 [ 561.586387][ T27] ? lock_acquire+0x480/0x570 [ 561.591115][ T27] ? lock_release+0x780/0x780 [ 561.595959][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 561.600834][ T27] ? do_raw_spin_lock+0x120/0x2a0 [ 561.605963][ T27] ? read_word_at_a_time+0xe/0x20 [ 561.611212][ T27] ? strscpy+0xa1/0x2a0 [ 561.615716][ T27] process_one_work+0x996/0x1610 [ 561.620848][ T27] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 561.626449][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 561.631419][ T27] worker_thread+0x854/0x1080 [ 561.636256][ T27] ? __kthread_parkme+0x15f/0x220 [ 561.641303][ T27] ? process_one_work+0x1610/0x1610 [ 561.646564][ T27] kthread+0x2e9/0x3a0 [ 561.650639][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 561.656304][ T27] ret_from_fork+0x1f/0x30 [ 561.660762][ T27] [ 561.664010][ T27] [ 561.664010][ T27] Showing all threads with locks held in the system: [ 561.672863][ T27] task:kworker/0:0 state:I stack:24232 pid: 6 ppid: 2 flags:0x00004000 [ 561.682137][ T27] Workqueue: 0x0 (rcu_gp) [ 561.686594][ T27] Call Trace: [ 561.689885][ T27] [ 561.692809][ T27] __schedule+0xa00/0x4b50 [ 561.697440][ T27] ? pwq_dec_nr_in_flight+0x162/0x2a0 [ 561.702824][ T27] ? put_pwq+0x87/0x1b0 [ 561.707026][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 561.712505][ T27] ? lock_release+0x560/0x780 [ 561.717206][ T27] ? worker_thread+0x157/0x1080 [ 561.722066][ T27] ? io_schedule_timeout+0x140/0x140 [ 561.727449][ T27] ? 0xffffffff81000000 [ 561.731611][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 561.736602][ T27] schedule+0xd2/0x1f0 [ 561.740682][ T27] worker_thread+0x15c/0x1080 [ 561.745417][ T27] ? process_one_work+0x1610/0x1610 [ 561.750637][ T27] kthread+0x2e9/0x3a0 [ 561.754776][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 561.760426][ T27] ret_from_fork+0x1f/0x30 [ 561.764884][ T27] [ 561.767909][ T27] INFO: lockdep is turned off. [ 561.772650][ T27] task:kworker/u4:1 state:I stack:24232 pid: 11 ppid: 2 flags:0x00004000 [ 561.781882][ T27] Workqueue: 0x0 (bat_events) [ 561.786682][ T27] Call Trace: [ 561.789963][ T27] [ 561.792896][ T27] __schedule+0xa00/0x4b50 [ 561.797375][ T27] ? pwq_dec_nr_in_flight+0x162/0x2a0 [ 561.802777][ T27] ? put_pwq+0x87/0x1b0 [ 561.807067][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 561.812566][ T27] ? lock_release+0x560/0x780 [ 561.817413][ T27] ? worker_thread+0x157/0x1080 [ 561.822295][ T27] ? io_schedule_timeout+0x140/0x140 [ 561.827623][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 561.832657][ T27] schedule+0xd2/0x1f0 [ 561.836847][ T27] worker_thread+0x15c/0x1080 [ 561.841562][ T27] ? process_one_work+0x1610/0x1610 [ 561.846881][ T27] kthread+0x2e9/0x3a0 [ 561.850966][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 561.856836][ T27] ret_from_fork+0x1f/0x30 [ 561.861297][ T27] [ 561.864377][ T27] INFO: lockdep is turned off. [ 561.869157][ T27] task:kworker/u4:4 state:I stack:23152 pid: 92 ppid: 2 flags:0x00004000 [ 561.878400][ T27] Workqueue: 0x0 (events_unbound) [ 561.883624][ T27] Call Trace: [ 561.886898][ T27] [ 561.889834][ T27] __schedule+0xa00/0x4b50 [ 561.894407][ T27] ? pwq_dec_nr_in_flight+0x162/0x2a0 [ 561.899911][ T27] ? put_pwq+0x87/0x1b0 [ 561.904118][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 561.909607][ T27] ? lock_release+0x560/0x780 [ 561.914331][ T27] ? worker_thread+0x157/0x1080 [ 561.919277][ T27] ? io_schedule_timeout+0x140/0x140 [ 561.924597][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 561.929541][ T27] schedule+0xd2/0x1f0 [ 561.933657][ T27] worker_thread+0x15c/0x1080 [ 561.938351][ T27] ? __kthread_parkme+0x15f/0x220 [ 561.943576][ T27] ? process_one_work+0x1610/0x1610 [ 561.948782][ T27] kthread+0x2e9/0x3a0 [ 561.952844][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 561.958532][ T27] ret_from_fork+0x1f/0x30 [ 561.963079][ T27] [ 561.966103][ T27] INFO: lockdep is turned off. [ 561.970964][ T27] task:kworker/1:2 state:D stack:24968 pid: 142 ppid: 2 flags:0x00004000 [ 561.980217][ T27] Workqueue: usb_hub_wq hub_event [ 561.985289][ T27] Call Trace: [ 561.988594][ T27] [ 561.991534][ T27] __schedule+0xa00/0x4b50 [ 561.995995][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 562.001562][ T27] ? lock_acquire+0x480/0x570 [ 562.006287][ T27] ? wq_worker_sleeping+0x1e5/0x250 [ 562.011592][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 562.016658][ T27] ? io_schedule_timeout+0x140/0x140 [ 562.021960][ T27] ? trace_hardirqs_on+0x2d/0x120 [ 562.027018][ T27] schedule+0xd2/0x1f0 [ 562.031098][ T27] schedule_preempt_disabled+0xf/0x20 [ 562.036677][ T27] __mutex_lock+0xa70/0x1350 [ 562.041276][ T27] ? __input_unregister_device+0x24/0x470 [ 562.047024][ T27] ? mutex_lock_io_nested+0x1190/0x1190 [ 562.052577][ T27] ? record_print_text.cold+0x16/0x16 [ 562.058001][ T27] __input_unregister_device+0x24/0x470 [ 562.063566][ T27] input_unregister_device+0xb4/0xf0 [ 562.068861][ T27] iforce_usb_disconnect+0x97/0x11d [ 562.074108][ T27] usb_unbind_interface+0x1d8/0x8e0 [ 562.079328][ T27] ? usb_unbind_device+0x1a0/0x1a0 [ 562.088162][ T27] device_remove+0x11f/0x170 [ 562.092768][ T27] device_release_driver_internal+0x4a1/0x700 [ 562.098880][ T27] ? put_device+0x1b/0x30 [ 562.103230][ T27] bus_remove_device+0x2eb/0x5a0 [ 562.108263][ T27] device_del+0x4f3/0xc80 [ 562.112697][ T27] ? __device_link_del+0x380/0x380 [ 562.118027][ T27] ? kobject_put+0x1f3/0x540 [ 562.122745][ T27] usb_disable_device+0x35b/0x7b0 [ 562.127912][ T27] usb_disconnect.cold+0x278/0x6ec [ 562.133070][ T27] hub_event+0x1e83/0x4690 [ 562.137513][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 562.142550][ T27] ? hub_port_debounce+0x3c0/0x3c0 [ 562.147894][ T27] ? irq_matrix_reserve+0x61/0x2f0 [ 562.153080][ T27] ? lock_acquire+0x480/0x570 [ 562.157767][ T27] ? lock_release+0x780/0x780 [ 562.162431][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 562.167342][ T27] ? do_raw_spin_lock+0x120/0x2a0 [ 562.172384][ T27] ? read_word_at_a_time+0xe/0x20 [ 562.177451][ T27] ? strscpy+0xa1/0x2a0 [ 562.181620][ T27] process_one_work+0x996/0x1610 [ 562.186586][ T27] ? pwq_dec_nr_in_flight+0x2a0/0x2a0 [ 562.192486][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 562.197465][ T27] worker_thread+0x854/0x1080 [ 562.202312][ T27] ? __kthread_parkme+0x15f/0x220 [ 562.207384][ T27] ? process_one_work+0x1610/0x1610 [ 562.212601][ T27] kthread+0x2e9/0x3a0 [ 562.216892][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 562.222532][ T27] ret_from_fork+0x1f/0x30 [ 562.226988][ T27] [ 562.230010][ T27] INFO: lockdep is turned off. [ 562.234850][ T27] task:getty state:S stack:23360 pid: 3286 ppid: 1 flags:0x00000000 [ 562.244182][ T27] Call Trace: [ 562.247450][ T27] [ 562.250414][ T27] __schedule+0xa00/0x4b50 [ 562.254895][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 562.261036][ T27] ? io_schedule_timeout+0x140/0x140 [ 562.266470][ T27] schedule+0xd2/0x1f0 [ 562.270558][ T27] schedule_timeout+0x1db/0x2a0 [ 562.275469][ T27] ? usleep_range_state+0x1b0/0x1b0 [ 562.282496][ T27] ? __up_read+0x194/0x720 [ 562.286962][ T27] ? down_read+0x198/0x440 [ 562.291381][ T27] ? up_write+0x470/0x470 [ 562.295732][ T27] ? _raw_spin_unlock_irqrestore+0x50/0x70 [ 562.301546][ T27] wait_woken+0x18b/0x1f0 [ 562.305898][ T27] n_tty_read+0x104c/0x13c0 [ 562.310495][ T27] ? n_tty_receive_signal_char+0x150/0x150 [ 562.316423][ T27] ? __init_waitqueue_head+0xd0/0xd0 [ 562.321816][ T27] tty_read+0x33a/0x5d0 [ 562.326004][ T27] ? do_SAK+0x70/0x70 [ 562.329989][ T27] ? aa_file_perm+0x595/0x1230 [ 562.334831][ T27] ? __fsnotify_parent+0x498/0xa60 [ 562.339953][ T27] new_sync_read+0x384/0x5f0 [ 562.344581][ T27] ? ksys_lseek+0x1b0/0x1b0 [ 562.349089][ T27] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 562.355113][ T27] ? security_file_permission+0xab/0xd0 [ 562.360759][ T27] vfs_read+0x492/0x5d0 [ 562.364951][ T27] ksys_read+0x127/0x250 [ 562.369204][ T27] ? vfs_write+0xac0/0xac0 [ 562.373652][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 562.379551][ T27] ? syscall_enter_from_user_mode+0x21/0x70 [ 562.387574][ T27] do_syscall_64+0x35/0xb0 [ 562.392063][ T27] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 562.398115][ T27] RIP: 0033:0x7f179d1dd8fe [ 562.402550][ T27] RSP: 002b:00007ffc6cbbe648 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 [ 562.411007][ T27] RAX: ffffffffffffffda RBX: 000055ae847b1910 RCX: 00007f179d1dd8fe [ 562.419261][ T27] RDX: 0000000000000001 RSI: 00007ffc6cbbe660 RDI: 0000000000000000 [ 562.427255][ T27] RBP: 000055ae847b1970 R08: 0000000000000007 R09: 000055ae847b2cd0 [ 562.435257][ T27] R10: 0000000000000063 R11: 0000000000000246 R12: 000055ae847b19ac [ 562.443346][ T27] R13: 00007ffc6cbbe660 R14: 0000000000000000 R15: 000055ae847b19ac [ 562.451327][ T27] [ 562.454392][ T27] INFO: lockdep is turned off. [ 562.460810][ T27] task:kworker/1:5 state:I stack:24720 pid: 3621 ppid: 2 flags:0x00004000 [ 562.470043][ T27] Workqueue: 0x0 (rcu_gp) [ 562.474486][ T27] Call Trace: [ 562.478013][ T27] [ 562.480950][ T27] __schedule+0xa00/0x4b50 [ 562.485404][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 562.490973][ T27] ? lock_release+0x560/0x780 [ 562.495678][ T27] ? io_schedule_timeout+0x140/0x140 [ 562.500988][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 562.505951][ T27] ? kasan_check_range+0x30/0x180 [ 562.511070][ T27] schedule+0xd2/0x1f0 [ 562.515187][ T27] worker_thread+0x15c/0x1080 [ 562.519890][ T27] ? __kthread_parkme+0x15f/0x220 [ 562.524961][ T27] ? process_one_work+0x1610/0x1610 [ 562.530259][ T27] kthread+0x2e9/0x3a0 [ 562.534450][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 562.540091][ T27] ret_from_fork+0x1f/0x30 [ 562.544538][ T27] [ 562.547663][ T27] INFO: lockdep is turned off. [ 562.552431][ T27] [ 562.554800][ T27] ============================================= [ 562.554800][ T27] [ 562.563355][ T27] NMI backtrace for cpu 1 [ 562.567750][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.19.0-rc8-syzkaller-00214-ge0dccc3b76fb-dirty #0 [ 562.578410][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 562.588451][ T27] Call Trace: [ 562.591719][ T27] [ 562.594634][ T27] dump_stack_lvl+0xcd/0x134 [ 562.599270][ T27] nmi_cpu_backtrace.cold+0x47/0x144 [ 562.604562][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 562.609860][ T27] nmi_trigger_cpumask_backtrace+0x1e6/0x230 [ 562.615833][ T27] watchdog+0xc53/0xf80 [ 562.619978][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 562.625962][ T27] kthread+0x2e9/0x3a0 [ 562.630016][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 562.635650][ T27] ret_from_fork+0x1f/0x30 [ 562.640078][ T27] [ 562.643154][ T27] Sending NMI from CPU 1 to CPUs 0: [ 562.648376][ C0] NMI backtrace for cpu 0 skipped: idling at acpi_idle_do_entry+0x1c9/0x240 [ 562.649381][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 562.664922][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.19.0-rc8-syzkaller-00214-ge0dccc3b76fb-dirty #0 [ 562.675416][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 562.685483][ T27] Call Trace: [ 562.688756][ T27] [ 562.691678][ T27] dump_stack_lvl+0xcd/0x134 [ 562.696273][ T27] panic+0x2d7/0x636 [ 562.700164][ T27] ? panic_print_sys_info.part.0+0x10b/0x10b [ 562.706238][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 562.711454][ T27] ? preempt_schedule_thunk+0x16/0x18 [ 562.716857][ T27] ? watchdog.cold+0x135/0x426 [ 562.721924][ T27] watchdog.cold+0x146/0x426 [ 562.726780][ T27] ? proc_dohung_task_timeout_secs+0x80/0x80 [ 562.732762][ T27] kthread+0x2e9/0x3a0 [ 562.737088][ T27] ? kthread_complete_and_exit+0x40/0x40 [ 562.742725][ T27] ret_from_fork+0x1f/0x30 [ 562.747231][ T27] [ 562.750435][ T27] Kernel Offset: disabled [ 562.754767][ T27] Rebooting in 86400 seconds..