[ OK ] Started Getty on tty2. [ OK ] Started Serial Getty on ttyS0. [ OK ] Started Getty on tty1. [ OK ] Started getty on tty2-tty6 if dbus and logind are not available. [ OK ] Started OpenBSD Secure Shell server. Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.0.98' (ECDSA) to the list of known hosts. executing program executing program executing program executing program executing program executing program syzkaller login: [ 64.754833][ C1] [ 64.757204][ C1] ======================================================== [ 64.764384][ C1] WARNING: possible irq lock inversion dependency detected [ 64.771573][ C1] 5.9.0-rc5-next-20200918-syzkaller #0 Not tainted [ 64.778047][ C1] -------------------------------------------------------- [ 64.785222][ C1] swapper/1/0 just changed the state of lock: [ 64.791355][ C1] ffff88809a15b108 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 64.801257][ C1] but this lock took another, SOFTIRQ-READ-unsafe lock in the past: [ 64.809270][ C1] (&card->ctl_files_rwlock){.+.+}-{2:2} [ 64.809283][ C1] [ 64.809283][ C1] [ 64.809283][ C1] and interrupts could create inverse lock ordering between them. [ 64.809283][ C1] [ 64.829156][ C1] [ 64.829156][ C1] other info that might help us debug this: [ 64.837186][ C1] Possible interrupt unsafe locking scenario: [ 64.837186][ C1] [ 64.845477][ C1] CPU0 CPU1 [ 64.850820][ C1] ---- ---- [ 64.856163][ C1] lock(&card->ctl_files_rwlock); [ 64.861261][ C1] local_irq_disable(); [ 64.867989][ C1] lock(&group->lock); [ 64.874637][ C1] lock(&card->ctl_files_rwlock); [ 64.882238][ C1] [ 64.885664][ C1] lock(&group->lock); [ 64.889990][ C1] [ 64.889990][ C1] *** DEADLOCK *** [ 64.889990][ C1] [ 64.898111][ C1] 1 lock held by swapper/1/0: [ 64.902768][ C1] #0: ffffc90000da8d80 ((&dpcm->timer)){+.-.}-{0:0}, at: call_timer_fn+0xd5/0x6b0 [ 64.912064][ C1] [ 64.912064][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 64.921412][ C1] -> (&card->ctl_files_rwlock){.+.+}-{2:2} { [ 64.927460][ C1] HARDIRQ-ON-R at: [ 64.931513][ C1] lock_acquire+0x1f2/0xaa0 [ 64.937841][ C1] _raw_read_lock+0x5b/0x70 [ 64.944157][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 64.951166][ C1] snd_ctl_notify+0x8f/0xb0 [ 64.957469][ C1] __snd_ctl_add_replace+0x638/0x800 [ 64.964552][ C1] snd_ctl_add_replace+0x76/0x130 [ 64.971394][ C1] snd_dummy_probe+0xc22/0x1180 [ 64.978043][ C1] platform_drv_probe+0x87/0x140 [ 64.984781][ C1] really_probe+0x282/0x9f0 [ 64.991080][ C1] driver_probe_device+0xfe/0x1d0 [ 64.997899][ C1] __device_attach_driver+0x1c2/0x220 [ 65.005065][ C1] bus_for_each_drv+0x15f/0x1e0 [ 65.011711][ C1] __device_attach+0x228/0x470 [ 65.018272][ C1] bus_probe_device+0x1e4/0x290 [ 65.024919][ C1] device_add+0xb17/0x1c40 [ 65.031131][ C1] platform_device_add+0x34f/0x6d0 [ 65.038041][ C1] platform_device_register_full+0x38c/0x4e0 [ 65.045819][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 65.052814][ C1] do_one_initcall+0x103/0x6f0 [ 65.059384][ C1] kernel_init_freeable+0x652/0x6d6 [ 65.066427][ C1] kernel_init+0xd/0x1b8 [ 65.072477][ C1] ret_from_fork+0x1f/0x30 [ 65.078688][ C1] SOFTIRQ-ON-R at: [ 65.082772][ C1] lock_acquire+0x1f2/0xaa0 [ 65.089084][ C1] _raw_read_lock+0x5b/0x70 [ 65.095387][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 65.102381][ C1] snd_ctl_notify+0x8f/0xb0 [ 65.108681][ C1] __snd_ctl_add_replace+0x638/0x800 [ 65.115772][ C1] snd_ctl_add_replace+0x76/0x130 [ 65.122619][ C1] snd_dummy_probe+0xc22/0x1180 [ 65.129266][ C1] platform_drv_probe+0x87/0x140 [ 65.136006][ C1] really_probe+0x282/0x9f0 [ 65.142310][ C1] driver_probe_device+0xfe/0x1d0 [ 65.149180][ C1] __device_attach_driver+0x1c2/0x220 [ 65.156353][ C1] bus_for_each_drv+0x15f/0x1e0 [ 65.162999][ C1] __device_attach+0x228/0x470 [ 65.169567][ C1] bus_probe_device+0x1e4/0x290 [ 65.176236][ C1] device_add+0xb17/0x1c40 [ 65.182458][ C1] platform_device_add+0x34f/0x6d0 [ 65.189373][ C1] platform_device_register_full+0x38c/0x4e0 [ 65.197160][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 65.204179][ C1] do_one_initcall+0x103/0x6f0 [ 65.210742][ C1] kernel_init_freeable+0x652/0x6d6 [ 65.217747][ C1] kernel_init+0xd/0x1b8 [ 65.223786][ C1] ret_from_fork+0x1f/0x30 [ 65.229998][ C1] (null) at: [ 65.233525][ C1] ================================================================================ [ 65.242772][ C1] UBSAN: array-index-out-of-bounds in kernel/locking/lockdep.c:2240:40 [ 65.250976][ C1] index 9 is out of range for type 'lock_trace *[9]' [ 65.257622][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 65.266694][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 65.276721][ C1] Call Trace: [ 65.279979][ C1] [ 65.282807][ C1] dump_stack+0x198/0x1fb [ 65.287111][ C1] ubsan_epilogue+0xb/0x5a [ 65.291519][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 65.297661][ C1] ? vprintk_func+0x95/0x1e0 [ 65.302227][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 65.308884][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 65.314935][ C1] mark_lock.cold+0x57/0x74 [ 65.320018][ C1] ? lock_chain_count+0x20/0x20 [ 65.324840][ C1] ? find_held_lock+0x2d/0x110 [ 65.329583][ C1] ? ktime_get+0x3e/0x140 [ 65.333886][ C1] ? lock_downgrade+0x830/0x830 [ 65.338708][ C1] ? find_held_lock+0x2d/0x110 [ 65.343445][ C1] __lock_acquire+0x118a/0x56d0 [ 65.348270][ C1] ? lock_chain_count+0x20/0x20 [ 65.353093][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 65.359047][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 65.364142][ C1] lock_acquire+0x1f2/0xaa0 [ 65.368629][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.374494][ C1] ? lock_release+0x890/0x890 [ 65.379175][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.385312][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 65.390532][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.396657][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 65.402278][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 65.407451][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.413317][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.419011][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 65.424274][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 65.430399][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 65.436871][ C1] call_timer_fn+0x1a5/0x6b0 [ 65.441452][ C1] ? add_timer_on+0x4a0/0x4a0 [ 65.446115][ C1] ? lock_downgrade+0x830/0x830 [ 65.450950][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 65.456126][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 65.462610][ C1] __run_timers.part.0+0x67c/0xa50 [ 65.467704][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 65.472448][ C1] ? lapic_next_event+0x4d/0x80 [ 65.477456][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 65.482624][ C1] ? sched_clock+0x2a/0x40 [ 65.487026][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 65.491848][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 65.496933][ C1] run_timer_softirq+0xb3/0x1d0 [ 65.501755][ C1] __do_softirq+0x203/0xab6 [ 65.506254][ C1] asm_call_on_stack+0xf/0x20 [ 65.510903][ C1] [ 65.513827][ C1] do_softirq_own_stack+0x9d/0xd0 [ 65.518824][ C1] irq_exit_rcu+0x235/0x280 [ 65.523304][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 65.528921][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.534875][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 65.540221][ 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 [ 65.559799][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 65.565847][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 65.573802][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 65.581746][ C1] RBP: ffff88821a8e2864 R08: 0000000000000001 R09: 0000000000000001 [ 65.589701][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 65.597674][ C1] R13: ffff88821a8e2800 R14: ffff88821a8e2864 R15: ffff8880a3c60004 [ 65.605648][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 65.610829][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 65.615839][ C1] acpi_idle_enter+0x35a/0x550 [ 65.620575][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 65.625657][ C1] cpuidle_enter+0x4a/0xa0 [ 65.630065][ C1] do_idle+0x48e/0x730 [ 65.634116][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 65.639120][ C1] cpu_startup_entry+0x14/0x20 [ 65.643859][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 65.649731][ C1] ================================================================================ [ 65.658979][ C1] Kernel panic - not syncing: panic_on_warn set ... [ 65.665538][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 65.674616][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 65.684642][ C1] Call Trace: [ 65.687897][ C1] [ 65.690722][ C1] dump_stack+0x198/0x1fb [ 65.695025][ C1] panic+0x382/0x7fb [ 65.698896][ C1] ? __warn_printk+0xf3/0xf3 [ 65.703461][ C1] ? secondary_startup_64_no_verify+0xa6/0xab [ 65.709511][ C1] ? ubsan_epilogue+0x3e/0x5a [ 65.714162][ C1] ? ubsan_epilogue+0x35/0x5a [ 65.718825][ C1] ubsan_epilogue+0x54/0x5a [ 65.723299][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 65.729429][ C1] ? vprintk_func+0x95/0x1e0 [ 65.734003][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 65.740666][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 65.746705][ C1] mark_lock.cold+0x57/0x74 [ 65.751181][ C1] ? lock_chain_count+0x20/0x20 [ 65.756013][ C1] ? find_held_lock+0x2d/0x110 [ 65.760753][ C1] ? ktime_get+0x3e/0x140 [ 65.765055][ C1] ? lock_downgrade+0x830/0x830 [ 65.769877][ C1] ? find_held_lock+0x2d/0x110 [ 65.774614][ C1] __lock_acquire+0x118a/0x56d0 [ 65.779452][ C1] ? lock_chain_count+0x20/0x20 [ 65.784373][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 65.790431][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 65.795518][ C1] lock_acquire+0x1f2/0xaa0 [ 65.799997][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.805876][ C1] ? lock_release+0x890/0x890 [ 65.810527][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.816655][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 65.821828][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.827954][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 65.833296][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 65.838482][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.844347][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 65.850039][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 65.855298][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 65.861430][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 65.867907][ C1] call_timer_fn+0x1a5/0x6b0 [ 65.872479][ C1] ? add_timer_on+0x4a0/0x4a0 [ 65.877129][ C1] ? lock_downgrade+0x830/0x830 [ 65.881952][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 65.887124][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 65.893597][ C1] __run_timers.part.0+0x67c/0xa50 [ 65.898695][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 65.903441][ C1] ? lapic_next_event+0x4d/0x80 [ 65.908266][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 65.913436][ C1] ? sched_clock+0x2a/0x40 [ 65.917837][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 65.922660][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 65.927743][ C1] run_timer_softirq+0xb3/0x1d0 [ 65.932568][ C1] __do_softirq+0x203/0xab6 [ 65.937046][ C1] asm_call_on_stack+0xf/0x20 [ 65.941690][ C1] [ 65.944604][ C1] do_softirq_own_stack+0x9d/0xd0 [ 65.949601][ C1] irq_exit_rcu+0x235/0x280 [ 65.954082][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 65.959690][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 65.965652][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 65.971002][ 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 [ 65.990626][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 65.996795][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 66.004743][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 66.012689][ C1] RBP: ffff88821a8e2864 R08: 0000000000000001 R09: 0000000000000001 [ 66.020634][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 66.028582][ C1] R13: ffff88821a8e2800 R14: ffff88821a8e2864 R15: ffff8880a3c60004 [ 66.036539][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 66.041721][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 66.046724][ C1] acpi_idle_enter+0x35a/0x550 [ 66.051483][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 66.056569][ C1] cpuidle_enter+0x4a/0xa0 [ 66.060960][ C1] do_idle+0x48e/0x730 [ 66.065003][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 66.070035][ C1] cpu_startup_entry+0x14/0x20 [ 66.074772][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 66.081830][ C1] Kernel Offset: disabled [ 66.086160][ C1] Rebooting in 86400 seconds..