[ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Load/Save RF Kill Switch Status. [ OK ] Started Update UTMP about System Runlevel Changes. Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.0.191' (ECDSA) to the list of known hosts. executing program executing program executing program executing program executing program executing program syzkaller login: [ 71.689435][ C1] [ 71.691802][ C1] ======================================================== [ 71.699032][ C1] WARNING: possible irq lock inversion dependency detected [ 71.706220][ C1] 5.9.0-rc5-next-20200918-syzkaller #0 Not tainted [ 71.712693][ C1] -------------------------------------------------------- [ 71.720043][ C1] swapper/1/0 just changed the state of lock: [ 71.726096][ C1] ffff888099d30908 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 71.736014][ C1] but this lock took another, SOFTIRQ-READ-unsafe lock in the past: [ 71.743968][ C1] (&card->ctl_files_rwlock){.+.+}-{2:2} [ 71.743982][ C1] [ 71.743982][ C1] [ 71.743982][ C1] and interrupts could create inverse lock ordering between them. [ 71.743982][ C1] [ 71.763902][ C1] [ 71.763902][ C1] other info that might help us debug this: [ 71.771952][ C1] Possible interrupt unsafe locking scenario: [ 71.771952][ C1] [ 71.780254][ C1] CPU0 CPU1 [ 71.785624][ C1] ---- ---- [ 71.791042][ C1] lock(&card->ctl_files_rwlock); [ 71.796135][ C1] local_irq_disable(); [ 71.802989][ C1] lock(&group->lock); [ 71.809665][ C1] lock(&card->ctl_files_rwlock); [ 71.817298][ C1] [ 71.820736][ C1] lock(&group->lock); [ 71.825059][ C1] [ 71.825059][ C1] *** DEADLOCK *** [ 71.825059][ C1] [ 71.833210][ C1] 1 lock held by swapper/1/0: [ 71.838117][ C1] #0: ffffc90000da8d80 ((&dpcm->timer)){+.-.}-{0:0}, at: call_timer_fn+0xd5/0x6b0 [ 71.847486][ C1] [ 71.847486][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 71.856863][ C1] -> (&card->ctl_files_rwlock){.+.+}-{2:2} { [ 71.862919][ C1] HARDIRQ-ON-R at: [ 71.866971][ C1] lock_acquire+0x1f2/0xaa0 [ 71.873274][ C1] _raw_read_lock+0x5b/0x70 [ 71.879589][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 71.886594][ C1] snd_ctl_notify+0x8f/0xb0 [ 71.892901][ C1] __snd_ctl_add_replace+0x638/0x800 [ 71.899988][ C1] snd_ctl_add_replace+0x76/0x130 [ 71.906821][ C1] snd_dummy_probe+0xc22/0x1180 [ 71.913472][ C1] platform_drv_probe+0x87/0x140 [ 71.920235][ C1] really_probe+0x282/0x9f0 [ 71.926566][ C1] driver_probe_device+0xfe/0x1d0 [ 71.933405][ C1] __device_attach_driver+0x1c2/0x220 [ 71.940596][ C1] bus_for_each_drv+0x15f/0x1e0 [ 71.947246][ C1] __device_attach+0x228/0x470 [ 71.953809][ C1] bus_probe_device+0x1e4/0x290 [ 71.960477][ C1] device_add+0xb17/0x1c40 [ 71.966693][ C1] platform_device_add+0x34f/0x6d0 [ 71.973604][ C1] platform_device_register_full+0x38c/0x4e0 [ 71.981470][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 71.988466][ C1] do_one_initcall+0x103/0x6f0 [ 71.995046][ C1] kernel_init_freeable+0x652/0x6d6 [ 72.002042][ C1] kernel_init+0xd/0x1b8 [ 72.008088][ C1] ret_from_fork+0x1f/0x30 [ 72.014471][ C1] SOFTIRQ-ON-R at: [ 72.018541][ C1] lock_acquire+0x1f2/0xaa0 [ 72.024844][ C1] _raw_read_lock+0x5b/0x70 [ 72.031147][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 72.038143][ C1] snd_ctl_notify+0x8f/0xb0 [ 72.045315][ C1] __snd_ctl_add_replace+0x638/0x800 [ 72.052399][ C1] snd_ctl_add_replace+0x76/0x130 [ 72.059229][ C1] snd_dummy_probe+0xc22/0x1180 [ 72.065882][ C1] platform_drv_probe+0x87/0x140 [ 72.072615][ C1] really_probe+0x282/0x9f0 [ 72.078927][ C1] driver_probe_device+0xfe/0x1d0 [ 72.085750][ C1] __device_attach_driver+0x1c2/0x220 [ 72.092933][ C1] bus_for_each_drv+0x15f/0x1e0 [ 72.099579][ C1] __device_attach+0x228/0x470 [ 72.106144][ C1] bus_probe_device+0x1e4/0x290 [ 72.116280][ C1] device_add+0xb17/0x1c40 [ 72.122502][ C1] platform_device_add+0x34f/0x6d0 [ 72.129410][ C1] platform_device_register_full+0x38c/0x4e0 [ 72.137202][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 72.144198][ C1] do_one_initcall+0x103/0x6f0 [ 72.150759][ C1] kernel_init_freeable+0x652/0x6d6 [ 72.157766][ C1] kernel_init+0xd/0x1b8 [ 72.163821][ C1] ret_from_fork+0x1f/0x30 [ 72.170041][ C1] (null) at: [ 72.173561][ C1] ================================================================================ [ 72.182826][ C1] UBSAN: array-index-out-of-bounds in kernel/locking/lockdep.c:2240:40 [ 72.191032][ C1] index 9 is out of range for type 'lock_trace *[9]' [ 72.197679][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 72.206753][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 72.216791][ C1] Call Trace: [ 72.220061][ C1] [ 72.222916][ C1] dump_stack+0x198/0x1fb [ 72.227221][ C1] ubsan_epilogue+0xb/0x5a [ 72.231613][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 72.237758][ C1] ? vprintk_func+0x95/0x1e0 [ 72.242343][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 72.248994][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 72.255035][ C1] mark_lock.cold+0x57/0x74 [ 72.259514][ C1] ? lock_chain_count+0x20/0x20 [ 72.264341][ C1] ? lock_is_held_type+0xbb/0xf0 [ 72.269265][ C1] ? find_held_lock+0x2d/0x110 [ 72.274037][ C1] ? debug_object_activate+0x287/0x3e0 [ 72.279584][ C1] ? lock_downgrade+0x830/0x830 [ 72.284418][ C1] __lock_acquire+0x118a/0x56d0 [ 72.289248][ C1] ? lock_downgrade+0x830/0x830 [ 72.294086][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 72.300052][ C1] ? mark_lock+0xf7/0x2420 [ 72.304456][ C1] lock_acquire+0x1f2/0xaa0 [ 72.308937][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.314814][ C1] ? lock_release+0x890/0x890 [ 72.319480][ C1] ? find_held_lock+0x2d/0x110 [ 72.324222][ C1] ? loopback_jiffies_timer_function+0x188/0x220 [ 72.330532][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 72.335881][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 72.341058][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.346942][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.352646][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 72.357997][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 72.364130][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.370866][ C1] call_timer_fn+0x1a5/0x6b0 [ 72.375440][ C1] ? add_timer_on+0x4a0/0x4a0 [ 72.380107][ C1] ? lock_downgrade+0x830/0x830 [ 72.384943][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 72.390129][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.396603][ C1] __run_timers.part.0+0x67c/0xa50 [ 72.401701][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 72.406449][ C1] ? lapic_next_event+0x4d/0x80 [ 72.411297][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 72.416486][ C1] ? sched_clock+0x2a/0x40 [ 72.420893][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 72.425753][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 72.430947][ C1] run_timer_softirq+0xb3/0x1d0 [ 72.435896][ C1] __do_softirq+0x203/0xab6 [ 72.440381][ C1] asm_call_on_stack+0xf/0x20 [ 72.445031][ C1] [ 72.447988][ C1] do_softirq_own_stack+0x9d/0xd0 [ 72.452999][ C1] irq_exit_rcu+0x235/0x280 [ 72.457495][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 72.463121][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 72.469099][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 72.474443][ C1] Code: 89 ef e8 a5 99 76 f9 e9 86 fe ff ff 48 89 df e8 98 99 76 f9 e9 7b ff ff ff cc cc cc e9 07 00 00 00 0f 00 2d c4 14 49 00 fb f4 90 e9 07 00 00 00 0f 00 2d b4 14 49 00 f4 c3 cc cc 55 53 e8 09 [ 72.494022][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 72.500061][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 72.508007][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 72.515967][ C1] RBP: ffff8880a62f4864 R08: 0000000000000001 R09: 0000000000000001 [ 72.523929][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 72.531878][ C1] R13: ffff8880a62f4800 R14: ffff8880a62f4864 R15: ffff888218f5c804 [ 72.539834][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 72.545025][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 72.550033][ C1] acpi_idle_enter+0x35a/0x550 [ 72.554788][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 72.559878][ C1] cpuidle_enter+0x4a/0xa0 [ 72.564288][ C1] do_idle+0x48e/0x730 [ 72.568333][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 72.573333][ C1] ? _raw_write_unlock_irqrestore+0x10/0x90 [ 72.579208][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 72.584401][ C1] cpu_startup_entry+0x14/0x20 [ 72.589662][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 72.595527][ C1] ================================================================================ [ 72.604791][ C1] Kernel panic - not syncing: panic_on_warn set ... [ 72.611371][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 72.620473][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 72.630533][ C1] Call Trace: [ 72.634017][ C1] [ 72.636851][ C1] dump_stack+0x198/0x1fb [ 72.641158][ C1] panic+0x382/0x7fb [ 72.645027][ C1] ? __warn_printk+0xf3/0xf3 [ 72.649597][ C1] ? secondary_startup_64_no_verify+0xa6/0xab [ 72.655638][ C1] ? ubsan_epilogue+0x3e/0x5a [ 72.660288][ C1] ? ubsan_epilogue+0x35/0x5a [ 72.664943][ C1] ubsan_epilogue+0x54/0x5a [ 72.669438][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 72.675743][ C1] ? vprintk_func+0x95/0x1e0 [ 72.680338][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 72.687076][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 72.693117][ C1] mark_lock.cold+0x57/0x74 [ 72.697595][ C1] ? lock_chain_count+0x20/0x20 [ 72.702427][ C1] ? lock_is_held_type+0xbb/0xf0 [ 72.707340][ C1] ? find_held_lock+0x2d/0x110 [ 72.712091][ C1] ? debug_object_activate+0x287/0x3e0 [ 72.717538][ C1] ? lock_downgrade+0x830/0x830 [ 72.722378][ C1] __lock_acquire+0x118a/0x56d0 [ 72.727205][ C1] ? lock_downgrade+0x830/0x830 [ 72.732029][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 72.737981][ C1] ? mark_lock+0xf7/0x2420 [ 72.742371][ C1] lock_acquire+0x1f2/0xaa0 [ 72.746851][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.752718][ C1] ? lock_release+0x890/0x890 [ 72.757369][ C1] ? find_held_lock+0x2d/0x110 [ 72.762122][ C1] ? loopback_jiffies_timer_function+0x188/0x220 [ 72.768423][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 72.773788][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 72.778986][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.784867][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.790569][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 72.795844][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 72.801984][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.808457][ C1] call_timer_fn+0x1a5/0x6b0 [ 72.813024][ C1] ? add_timer_on+0x4a0/0x4a0 [ 72.817675][ C1] ? lock_downgrade+0x830/0x830 [ 72.822517][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 72.827703][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.834201][ C1] __run_timers.part.0+0x67c/0xa50 [ 72.839288][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 72.844040][ C1] ? lapic_next_event+0x4d/0x80 [ 72.848887][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 72.854060][ C1] ? sched_clock+0x2a/0x40 [ 72.858449][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 72.863287][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 72.868372][ C1] run_timer_softirq+0xb3/0x1d0 [ 72.873196][ C1] __do_softirq+0x203/0xab6 [ 72.877677][ C1] asm_call_on_stack+0xf/0x20 [ 72.882332][ C1] [ 72.885270][ C1] do_softirq_own_stack+0x9d/0xd0 [ 72.890290][ C1] irq_exit_rcu+0x235/0x280 [ 72.894783][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 72.900397][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 72.906353][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 72.911713][ C1] Code: 89 ef e8 a5 99 76 f9 e9 86 fe ff ff 48 89 df e8 98 99 76 f9 e9 7b ff ff ff cc cc cc e9 07 00 00 00 0f 00 2d c4 14 49 00 fb f4 90 e9 07 00 00 00 0f 00 2d b4 14 49 00 f4 c3 cc cc 55 53 e8 09 [ 72.931309][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 72.937358][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 72.945395][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 72.953345][ C1] RBP: ffff8880a62f4864 R08: 0000000000000001 R09: 0000000000000001 [ 72.961379][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 72.969342][ C1] R13: ffff8880a62f4800 R14: ffff8880a62f4864 R15: ffff888218f5c804 [ 72.977301][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 72.982487][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 72.987505][ C1] acpi_idle_enter+0x35a/0x550 [ 72.992261][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 72.997362][ C1] cpuidle_enter+0x4a/0xa0 [ 73.001758][ C1] do_idle+0x48e/0x730 [ 73.005813][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 73.010830][ C1] ? _raw_write_unlock_irqrestore+0x10/0x90 [ 73.016705][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 73.021971][ C1] cpu_startup_entry+0x14/0x20 [ 73.027408][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 73.034648][ C1] Kernel Offset: disabled [ 73.038964][ C1] Rebooting in 86400 seconds..