[ 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.108' (ECDSA) to the list of known hosts. executing program executing program executing program executing program executing program executing program syzkaller login: [ 71.081468][ C1] [ 71.083850][ C1] ======================================================== [ 71.091042][ C1] WARNING: possible irq lock inversion dependency detected [ 71.098219][ C1] 5.9.0-rc5-next-20200918-syzkaller #0 Not tainted [ 71.104693][ C1] -------------------------------------------------------- [ 71.111860][ C1] swapper/1/0 just changed the state of lock: [ 71.117915][ C1] ffff88809a262908 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 71.127825][ C1] but this lock took another, SOFTIRQ-READ-unsafe lock in the past: [ 71.135790][ C1] (&card->ctl_files_rwlock){.+.+}-{2:2} [ 71.135806][ C1] [ 71.135806][ C1] [ 71.135806][ C1] and interrupts could create inverse lock ordering between them. [ 71.135806][ C1] [ 71.155723][ C1] [ 71.155723][ C1] other info that might help us debug this: [ 71.163809][ C1] Possible interrupt unsafe locking scenario: [ 71.163809][ C1] [ 71.172108][ C1] CPU0 CPU1 [ 71.177454][ C1] ---- ---- [ 71.182809][ C1] lock(&card->ctl_files_rwlock); [ 71.187921][ C1] local_irq_disable(); [ 71.194658][ C1] lock(&group->lock); [ 71.201319][ C1] lock(&card->ctl_files_rwlock); [ 71.209018][ C1] [ 71.212468][ C1] lock(&group->lock); [ 71.216789][ C1] [ 71.216789][ C1] *** DEADLOCK *** [ 71.216789][ C1] [ 71.224915][ C1] 1 lock held by swapper/1/0: [ 71.229576][ C1] #0: ffffc90000da8d80 ((&dpcm->timer)){+.-.}-{0:0}, at: call_timer_fn+0xd5/0x6b0 [ 71.238863][ C1] [ 71.238863][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 71.248253][ C1] -> (&card->ctl_files_rwlock){.+.+}-{2:2} { [ 71.254342][ C1] HARDIRQ-ON-R at: [ 71.258398][ C1] lock_acquire+0x1f2/0xaa0 [ 71.264708][ C1] _raw_read_lock+0x5b/0x70 [ 71.271034][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 71.278041][ C1] snd_ctl_notify+0x8f/0xb0 [ 71.284359][ C1] __snd_ctl_add_replace+0x638/0x800 [ 71.291465][ C1] snd_ctl_add_replace+0x76/0x130 [ 71.298304][ C1] snd_dummy_probe+0xc22/0x1180 [ 71.304979][ C1] platform_drv_probe+0x87/0x140 [ 71.311744][ C1] really_probe+0x282/0x9f0 [ 71.318082][ C1] driver_probe_device+0xfe/0x1d0 [ 71.325345][ C1] __device_attach_driver+0x1c2/0x220 [ 71.332521][ C1] bus_for_each_drv+0x15f/0x1e0 [ 71.339174][ C1] __device_attach+0x228/0x470 [ 71.345739][ C1] bus_probe_device+0x1e4/0x290 [ 71.352409][ C1] device_add+0xb17/0x1c40 [ 71.358630][ C1] platform_device_add+0x34f/0x6d0 [ 71.365549][ C1] platform_device_register_full+0x38c/0x4e0 [ 71.373348][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 71.380348][ C1] do_one_initcall+0x103/0x6f0 [ 71.386942][ C1] kernel_init_freeable+0x652/0x6d6 [ 71.393948][ C1] kernel_init+0xd/0x1b8 [ 71.400025][ C1] ret_from_fork+0x1f/0x30 [ 71.406255][ C1] SOFTIRQ-ON-R at: [ 71.410318][ C1] lock_acquire+0x1f2/0xaa0 [ 71.416634][ C1] _raw_read_lock+0x5b/0x70 [ 71.422957][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 71.429966][ C1] snd_ctl_notify+0x8f/0xb0 [ 71.436303][ C1] __snd_ctl_add_replace+0x638/0x800 [ 71.443393][ C1] snd_ctl_add_replace+0x76/0x130 [ 71.450218][ C1] snd_dummy_probe+0xc22/0x1180 [ 71.456874][ C1] platform_drv_probe+0x87/0x140 [ 71.463625][ C1] really_probe+0x282/0x9f0 [ 71.469960][ C1] driver_probe_device+0xfe/0x1d0 [ 71.476804][ C1] __device_attach_driver+0x1c2/0x220 [ 71.483981][ C1] bus_for_each_drv+0x15f/0x1e0 [ 71.490632][ C1] __device_attach+0x228/0x470 [ 71.497298][ C1] bus_probe_device+0x1e4/0x290 [ 71.504001][ C1] device_add+0xb17/0x1c40 [ 71.510226][ C1] platform_device_add+0x34f/0x6d0 [ 71.517142][ C1] platform_device_register_full+0x38c/0x4e0 [ 71.524964][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 71.532007][ C1] do_one_initcall+0x103/0x6f0 [ 71.538674][ C1] kernel_init_freeable+0x652/0x6d6 [ 71.545701][ C1] kernel_init+0xd/0x1b8 [ 71.551749][ C1] ret_from_fork+0x1f/0x30 [ 71.557963][ C1] (null) at: [ 71.561493][ C1] ================================================================================ [ 71.570771][ C1] UBSAN: array-index-out-of-bounds in kernel/locking/lockdep.c:2240:40 [ 71.579025][ C1] index 9 is out of range for type 'lock_trace *[9]' [ 71.585680][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 71.595718][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 71.605845][ C1] Call Trace: [ 71.609112][ C1] [ 71.611965][ C1] dump_stack+0x198/0x1fb [ 71.616282][ C1] ubsan_epilogue+0xb/0x5a [ 71.620695][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 71.626830][ C1] ? vprintk_func+0x95/0x1e0 [ 71.631409][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 71.638073][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 71.644128][ C1] mark_lock.cold+0x57/0x74 [ 71.648619][ C1] ? lock_chain_count+0x20/0x20 [ 71.653451][ C1] ? find_held_lock+0x2d/0x110 [ 71.658194][ C1] ? ktime_get+0x3e/0x140 [ 71.662503][ C1] ? lock_downgrade+0x830/0x830 [ 71.667335][ C1] ? find_held_lock+0x2d/0x110 [ 71.672091][ C1] __lock_acquire+0x118a/0x56d0 [ 71.676936][ C1] ? lock_chain_count+0x20/0x20 [ 71.681766][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 71.687730][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 71.692840][ C1] lock_acquire+0x1f2/0xaa0 [ 71.697324][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 71.703210][ C1] ? lock_release+0x890/0x890 [ 71.707910][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 71.714051][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 71.719233][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 71.725394][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 71.730782][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 71.735962][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 71.741852][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 71.748276][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 71.753545][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 71.759700][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 71.766185][ C1] call_timer_fn+0x1a5/0x6b0 [ 71.770752][ C1] ? add_timer_on+0x4a0/0x4a0 [ 71.775418][ C1] ? lock_downgrade+0x830/0x830 [ 71.780260][ C1] ? rwlock_bug.part.0+0x90/0x90 [ 71.785181][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 71.790383][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 71.796885][ C1] __run_timers.part.0+0x67c/0xa50 [ 71.801986][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 71.806743][ C1] ? lapic_next_event+0x4d/0x80 [ 71.811582][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 71.816762][ C1] ? sched_clock+0x2a/0x40 [ 71.821180][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 71.826022][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 71.831116][ C1] run_timer_softirq+0xb3/0x1d0 [ 71.835950][ C1] __do_softirq+0x203/0xab6 [ 71.840433][ C1] asm_call_on_stack+0xf/0x20 [ 71.845084][ C1] [ 71.848006][ C1] do_softirq_own_stack+0x9d/0xd0 [ 71.853025][ C1] irq_exit_rcu+0x235/0x280 [ 71.857526][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 71.863172][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 71.869176][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 71.874531][ 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 [ 71.894120][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 71.900177][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 71.908134][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 71.916100][ C1] RBP: ffff8880a6b1f864 R08: 0000000000000001 R09: 0000000000000001 [ 71.924137][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 71.932111][ C1] R13: ffff8880a6b1f800 R14: ffff8880a6b1f864 R15: ffff888218612004 [ 71.940074][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 71.945272][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 71.950285][ C1] acpi_idle_enter+0x35a/0x550 [ 71.955055][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 71.960163][ C1] cpuidle_enter+0x4a/0xa0 [ 71.964572][ C1] do_idle+0x48e/0x730 [ 71.968617][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 71.973620][ C1] cpu_startup_entry+0x14/0x20 [ 71.978387][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 71.984253][ C1] ================================================================================ [ 71.993509][ C1] Kernel panic - not syncing: panic_on_warn set ... [ 72.000076][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 72.009160][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 72.019198][ C1] Call Trace: [ 72.022463][ C1] [ 72.025296][ C1] dump_stack+0x198/0x1fb [ 72.029603][ C1] panic+0x382/0x7fb [ 72.033477][ C1] ? __warn_printk+0xf3/0xf3 [ 72.038049][ C1] ? secondary_startup_64_no_verify+0xa6/0xab [ 72.044094][ C1] ? ubsan_epilogue+0x3e/0x5a [ 72.048746][ C1] ? ubsan_epilogue+0x35/0x5a [ 72.053402][ C1] ubsan_epilogue+0x54/0x5a [ 72.057889][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 72.064046][ C1] ? vprintk_func+0x95/0x1e0 [ 72.068636][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 72.075306][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 72.081374][ C1] mark_lock.cold+0x57/0x74 [ 72.085865][ C1] ? lock_chain_count+0x20/0x20 [ 72.090717][ C1] ? find_held_lock+0x2d/0x110 [ 72.095491][ C1] ? ktime_get+0x3e/0x140 [ 72.099864][ C1] ? lock_downgrade+0x830/0x830 [ 72.104780][ C1] ? find_held_lock+0x2d/0x110 [ 72.109530][ C1] __lock_acquire+0x118a/0x56d0 [ 72.114381][ C1] ? lock_chain_count+0x20/0x20 [ 72.119230][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 72.125194][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 72.130303][ C1] lock_acquire+0x1f2/0xaa0 [ 72.134808][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.140681][ C1] ? lock_release+0x890/0x890 [ 72.145337][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 72.151471][ C1] ? lockdep_hardirqs_on+0x53/0x100 [ 72.156649][ C1] ? asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 72.162776][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 72.168146][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 72.173326][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.179213][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.184928][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 72.190196][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 72.196354][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.202854][ C1] call_timer_fn+0x1a5/0x6b0 [ 72.207435][ C1] ? add_timer_on+0x4a0/0x4a0 [ 72.212105][ C1] ? lock_downgrade+0x830/0x830 [ 72.216938][ C1] ? rwlock_bug.part.0+0x90/0x90 [ 72.221884][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 72.227087][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 72.233615][ C1] __run_timers.part.0+0x67c/0xa50 [ 72.238722][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 72.243461][ C1] ? lapic_next_event+0x4d/0x80 [ 72.248311][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 72.253487][ C1] ? sched_clock+0x2a/0x40 [ 72.257903][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 72.262746][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 72.267836][ C1] run_timer_softirq+0xb3/0x1d0 [ 72.272693][ C1] __do_softirq+0x203/0xab6 [ 72.277176][ C1] asm_call_on_stack+0xf/0x20 [ 72.281838][ C1] [ 72.284759][ C1] do_softirq_own_stack+0x9d/0xd0 [ 72.289769][ C1] irq_exit_rcu+0x235/0x280 [ 72.294279][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 72.299916][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 72.305905][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 72.311270][ 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.330865][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 72.336917][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 72.344882][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 72.352830][ C1] RBP: ffff8880a6b1f864 R08: 0000000000000001 R09: 0000000000000001 [ 72.360800][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 72.368802][ C1] R13: ffff8880a6b1f800 R14: ffff8880a6b1f864 R15: ffff888218612004 [ 72.376804][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 72.381999][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 72.387028][ C1] acpi_idle_enter+0x35a/0x550 [ 72.391786][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 72.396876][ C1] cpuidle_enter+0x4a/0xa0 [ 72.401272][ C1] do_idle+0x48e/0x730 [ 72.405318][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 72.410330][ C1] cpu_startup_entry+0x14/0x20 [ 72.415081][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 72.422013][ C1] Kernel Offset: disabled [ 72.426354][ C1] Rebooting in 86400 seconds..