syzbot


possible deadlock in snd_pcm_period_elapsed (3)

Status: upstream: reported C repro on 2021/12/29 01:23
Reported-by: syzbot+669c9abf11a6a011dd09@syzkaller.appspotmail.com
First crash: 187d, last: 4d00h

Cause bisection: the issue happens on the oldest tested release (bisect log)
Crash: possible deadlock in snd_pcm_period_elapsed (log)
Repro: C syz .config
similar bugs (2):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream possible deadlock in snd_pcm_period_elapsed 96 622d 623d 0/22 closed as dup on 2020/12/06 08:32
upstream possible deadlock in snd_pcm_period_elapsed (2) 52 233d 340d 22/22 fixed on 2021/11/10 00:50
Patch testing requests:
Created Duration User Patch Repo Result
2022/04/24 03:04 15m hdanton@sina.com patch https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git/ 45ab9400e73f OK

Sample crash report:
========================================================
WARNING: possible irq lock inversion dependency detected
5.18.0-rc3-syzkaller-00196-g45ab9400e73f #0 Not tainted
--------------------------------------------------------
swapper/0/0 just changed the state of lock:
ffff888023b16110 (&group->lock){..-.}-{2:2}, at: snd_pcm_period_elapsed+0x2c/0x210 sound/core/pcm_lib.c:1848
but this lock took another, SOFTIRQ-READ-unsafe lock in the past:
 (tasklist_lock){.+.+}-{2:2}


and interrupts could create inverse lock ordering between them.


other info that might help us debug this:
Chain exists of:
  &group->lock --> &timer->lock --> tasklist_lock

 Possible interrupt unsafe locking scenario:

       CPU0                    CPU1
       ----                    ----
  lock(tasklist_lock);
                               local_irq_disable();
                               lock(&group->lock);
                               lock(&timer->lock);
  <Interrupt>
    lock(&group->lock);

 *** DEADLOCK ***

no locks held by swapper/0/0.

the shortest dependencies between 2nd lock and 1st lock:
    -> (tasklist_lock){.+.+}-{2:2} {
       HARDIRQ-ON-R at:
                            lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                            __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                            _raw_read_lock+0x32/0x40 kernel/locking/spinlock.c:228
                            do_wait+0x224/0x9d0 kernel/exit.c:1508
                            kernel_wait+0xe4/0x230 kernel/exit.c:1698
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_work+0xb4/0x220 kernel/umh.c:166
                            process_one_work+0x81c/0xd10 kernel/workqueue.c:2289
                            worker_thread+0xb14/0x1330 kernel/workqueue.c:2436
                            kthread+0x266/0x300 kernel/kthread.c:376
                            ret_from_fork+0x1f/0x30
       SOFTIRQ-ON-R at:
                            lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                            __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                            _raw_read_lock+0x32/0x40 kernel/locking/spinlock.c:228
                            do_wait+0x224/0x9d0 kernel/exit.c:1508
                            kernel_wait+0xe4/0x230 kernel/exit.c:1698
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_work+0xb4/0x220 kernel/umh.c:166
                            process_one_work+0x81c/0xd10 kernel/workqueue.c:2289
                            worker_thread+0xb14/0x1330 kernel/workqueue.c:2436
                            kthread+0x266/0x300 kernel/kthread.c:376
                            ret_from_fork+0x1f/0x30
       INITIAL USE at:
                           lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                           __raw_write_lock_irq include/linux/rwlock_api_smp.h:195 [inline]
                           _raw_write_lock_irq+0xcf/0x110 kernel/locking/spinlock.c:326
                           copy_process+0x234d/0x3f70 kernel/fork.c:2368
                           kernel_clone+0x22f/0x7a0 kernel/fork.c:2639
                           kernel_thread+0x167/0x1e0 kernel/fork.c:2691
                           rest_init+0x21/0x2e0 init/main.c:691
                           start_kernel+0x4bf/0x56e init/main.c:1140
                           secondary_startup_64_no_verify+0xc4/0xcb
       INITIAL READ USE at:
                                lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                                __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                                _raw_read_lock+0x32/0x40 kernel/locking/spinlock.c:228
                                do_wait+0x224/0x9d0 kernel/exit.c:1508
                                kernel_wait+0xe4/0x230 kernel/exit.c:1698
                                call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                                call_usermodehelper_exec_work+0xb4/0x220 kernel/umh.c:166
                                process_one_work+0x81c/0xd10 kernel/workqueue.c:2289
                                worker_thread+0xb14/0x1330 kernel/workqueue.c:2436
                                kthread+0x266/0x300 kernel/kthread.c:376
                                ret_from_fork+0x1f/0x30
     }
     ... key      at: [<ffffffff8c80a058>] tasklist_lock+0x18/0x40
     ... acquired at:
   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
   __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
   _raw_read_lock+0x32/0x40 kernel/locking/spinlock.c:228
   send_sigio+0xbe/0x300 fs/fcntl.c:792
   dnotify_handle_event+0x136/0x450 fs/notify/dnotify/dnotify.c:115
   fsnotify+0xc84/0x1270 fs/notify/fsnotify.c:564
   fsnotify_name include/linux/fsnotify.h:36 [inline]
   fsnotify_dirent include/linux/fsnotify.h:42 [inline]
   fsnotify_create include/linux/fsnotify.h:207 [inline]
   open_last_lookups fs/namei.c:3402 [inline]
   path_openat+0x14b3/0x2ec0 fs/namei.c:3606
   do_filp_open+0x277/0x4f0 fs/namei.c:3636
   do_sys_openat2+0x13b/0x500 fs/open.c:1213
   do_sys_open fs/open.c:1229 [inline]
   __do_sys_creat fs/open.c:1305 [inline]
   __se_sys_creat fs/open.c:1299 [inline]
   __x64_sys_creat+0x11f/0x160 fs/open.c:1299
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

   -> (&f->f_owner.lock){....}-{2:2} {
      INITIAL USE at:
                         lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                         __raw_write_lock_irq include/linux/rwlock_api_smp.h:195 [inline]
                         _raw_write_lock_irq+0xcf/0x110 kernel/locking/spinlock.c:326
                         f_modown+0x38/0x340 fs/fcntl.c:91
                         __f_setown fs/fcntl.c:110 [inline]
                         f_setown+0x113/0x1a0 fs/fcntl.c:138
                         do_fcntl+0x128/0x13b0 fs/fcntl.c:377
                         __do_sys_fcntl fs/fcntl.c:454 [inline]
                         __se_sys_fcntl+0xd5/0x1b0 fs/fcntl.c:439
                         do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                         do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
                         entry_SYSCALL_64_after_hwframe+0x44/0xae
      INITIAL READ USE at:
                              lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                              __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
                              _raw_read_lock_irqsave+0xd9/0x120 kernel/locking/spinlock.c:236
                              send_sigio+0x2f/0x300 fs/fcntl.c:778
                              kill_fasync_rcu fs/fcntl.c:1003 [inline]
                              kill_fasync+0x1e4/0x430 fs/fcntl.c:1017
                              snd_timer_user_ccallback+0x370/0x540 sound/core/timer.c:1386
                              snd_timer_notify1+0x1ad/0x350 sound/core/timer.c:516
                              snd_timer_start1+0x53d/0x640 sound/core/timer.c:578
                              snd_timer_start sound/core/timer.c:696 [inline]
                              snd_timer_user_start sound/core/timer.c:1984 [inline]
                              __snd_timer_user_ioctl+0xae7/0x54c0 sound/core/timer.c:2107
                              snd_timer_user_ioctl+0x5d/0x80 sound/core/timer.c:2128
                              vfs_ioctl fs/ioctl.c:51 [inline]
                              __do_sys_ioctl fs/ioctl.c:870 [inline]
                              __se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
                              do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                              do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
                              entry_SYSCALL_64_after_hwframe+0x44/0xae
    }
    ... key      at: [<ffffffff90c42cc0>] __alloc_file.__key+0x0/0x10
    ... acquired at:
   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
   _raw_read_lock_irqsave+0xd9/0x120 kernel/locking/spinlock.c:236
   send_sigio+0x2f/0x300 fs/fcntl.c:778
   kill_fasync_rcu fs/fcntl.c:1003 [inline]
   kill_fasync+0x1e4/0x430 fs/fcntl.c:1017
   snd_timer_user_ccallback+0x370/0x540 sound/core/timer.c:1386
   snd_timer_notify1+0x1ad/0x350 sound/core/timer.c:516
   snd_timer_start1+0x53d/0x640 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_user_start sound/core/timer.c:1984 [inline]
   __snd_timer_user_ioctl+0xae7/0x54c0 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x5d/0x80 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:870 [inline]
   __se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

  -> (&new->fa_lock){....}-{2:2} {
     INITIAL READ USE at:
                            lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                            __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
                            _raw_read_lock_irqsave+0xd9/0x120 kernel/locking/spinlock.c:236
                            kill_fasync_rcu fs/fcntl.c:996 [inline]
                            kill_fasync+0x13b/0x430 fs/fcntl.c:1017
                            snd_timer_user_ccallback+0x370/0x540 sound/core/timer.c:1386
                            snd_timer_notify1+0x1ad/0x350 sound/core/timer.c:516
                            snd_timer_start1+0x53d/0x640 sound/core/timer.c:578
                            snd_timer_start sound/core/timer.c:696 [inline]
                            snd_timer_user_start sound/core/timer.c:1984 [inline]
                            __snd_timer_user_ioctl+0xae7/0x54c0 sound/core/timer.c:2107
                            snd_timer_user_ioctl+0x5d/0x80 sound/core/timer.c:2128
                            vfs_ioctl fs/ioctl.c:51 [inline]
                            __do_sys_ioctl fs/ioctl.c:870 [inline]
                            __se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
                            do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                            do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
                            entry_SYSCALL_64_after_hwframe+0x44/0xae
   }
   ... key      at: [<ffffffff90c43940>] fasync_insert_entry.__key+0x0/0x20
   ... acquired at:
   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
   _raw_read_lock_irqsave+0xd9/0x120 kernel/locking/spinlock.c:236
   kill_fasync_rcu fs/fcntl.c:996 [inline]
   kill_fasync+0x13b/0x430 fs/fcntl.c:1017
   snd_timer_user_ccallback+0x370/0x540 sound/core/timer.c:1386
   snd_timer_notify1+0x1ad/0x350 sound/core/timer.c:516
   snd_timer_start1+0x53d/0x640 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_user_start sound/core/timer.c:1984 [inline]
   __snd_timer_user_ioctl+0xae7/0x54c0 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x5d/0x80 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:870 [inline]
   __se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

 -> (&timer->lock){....}-{2:2} {
    INITIAL USE at:
                     lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                     __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                     _raw_spin_lock_irqsave+0xd1/0x120 kernel/locking/spinlock.c:162
                     snd_timer_resolution sound/core/timer.c:489 [inline]
                     snd_timer_user_params sound/core/timer.c:1851 [inline]
                     __snd_timer_user_ioctl+0x1a3f/0x54c0 sound/core/timer.c:2100
                     snd_timer_user_ioctl+0x5d/0x80 sound/core/timer.c:2128
                     vfs_ioctl fs/ioctl.c:51 [inline]
                     __do_sys_ioctl fs/ioctl.c:870 [inline]
                     __se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                     do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
                     entry_SYSCALL_64_after_hwframe+0x44/0xae
  }
  ... key      at: [<ffffffff90f96160>] snd_timer_new.__key+0x0/0x20
  ... acquired at:
   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   _raw_spin_lock_irqsave+0xd1/0x120 kernel/locking/spinlock.c:162
   snd_timer_notify+0x105/0x3e0 sound/core/timer.c:1086
   snd_pcm_action sound/core/pcm_native.c:1364 [inline]
   snd_pcm_start+0x383/0x400 sound/core/pcm_native.c:1470
   __snd_pcm_lib_xfer+0x13e0/0x18a0 sound/core/pcm_lib.c:2308
   snd_pcm_oss_write3+0x202/0x390 sound/core/oss/pcm_oss.c:1253
   snd_pcm_oss_write2 sound/core/oss/pcm_oss.c:1393 [inline]
   snd_pcm_oss_sync1+0x3a6/0x7f0 sound/core/oss/pcm_oss.c:1627
   snd_pcm_oss_sync+0x9cf/0xf00 sound/core/oss/pcm_oss.c:1693
   snd_pcm_oss_release+0x119/0x270 sound/core/oss/pcm_oss.c:2590
   __fput+0x3b9/0x820 fs/file_table.c:317
   task_work_run+0x146/0x1c0 kernel/task_work.c:164
   exit_task_work include/linux/task_work.h:37 [inline]
   do_exit+0x547/0x1eb0 kernel/exit.c:795
   do_group_exit+0x23b/0x2f0 kernel/exit.c:925
   __do_sys_exit_group kernel/exit.c:936 [inline]
   __se_sys_exit_group kernel/exit.c:934 [inline]
   __x64_sys_exit_group+0x3b/0x40 kernel/exit.c:934
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

-> (&group->lock){..-.}-{2:2} {
   IN-SOFTIRQ-W at:
                    lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                    __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                    _raw_spin_lock_irqsave+0xd1/0x120 kernel/locking/spinlock.c:162
                    snd_pcm_period_elapsed+0x2c/0x210 sound/core/pcm_lib.c:1848
                    dummy_hrtimer_callback+0x87/0x190 sound/drivers/dummy.c:377
                    __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
                    __hrtimer_run_queues+0x50b/0xa60 kernel/time/hrtimer.c:1749
                    hrtimer_run_softirq+0x1a1/0x580 kernel/time/hrtimer.c:1766
                    __do_softirq+0x382/0x793 kernel/softirq.c:558
                    __irq_exit_rcu+0xec/0x170 kernel/softirq.c:637
                    irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
                    sysvec_apic_timer_interrupt+0x91/0xb0 arch/x86/kernel/apic/apic.c:1097
                    asm_sysvec_apic_timer_interrupt+0x12/0x20
                    native_safe_halt arch/x86/include/asm/irqflags.h:51 [inline]
                    arch_safe_halt arch/x86/include/asm/irqflags.h:89 [inline]
                    acpi_safe_halt drivers/acpi/processor_idle.c:115 [inline]
                    acpi_idle_do_entry drivers/acpi/processor_idle.c:556 [inline]
                    acpi_idle_enter+0x42d/0x790 drivers/acpi/processor_idle.c:691
                    cpuidle_enter_state+0x517/0xed0 drivers/cpuidle/cpuidle.c:237
                    cpuidle_enter+0x59/0x90 drivers/cpuidle/cpuidle.c:351
                    call_cpuidle kernel/sched/idle.c:155 [inline]
                    cpuidle_idle_call kernel/sched/idle.c:236 [inline]
                    do_idle+0x3d2/0x640 kernel/sched/idle.c:303
                    cpu_startup_entry+0x15/0x20 kernel/sched/idle.c:400
                    start_kernel+0x4bf/0x56e init/main.c:1140
                    secondary_startup_64_no_verify+0xc4/0xcb
   INITIAL USE at:
                   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
                   __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
                   _raw_spin_lock_irq+0xcf/0x110 kernel/locking/spinlock.c:170
                   spin_lock_irq include/linux/spinlock.h:374 [inline]
                   snd_pcm_group_lock_irq sound/core/pcm_native.c:97 [inline]
                   snd_pcm_stream_lock_irq sound/core/pcm_native.c:136 [inline]
                   snd_pcm_hw_params+0x164/0x1860 sound/core/pcm_native.c:726
                   snd_pcm_oss_change_params_locked+0x1f21/0x3c80 sound/core/oss/pcm_oss.c:976
                   snd_pcm_oss_make_ready_locked sound/core/oss/pcm_oss.c:1198 [inline]
                   snd_pcm_oss_write1+0x249/0x1130 sound/core/oss/pcm_oss.c:1416
                   vfs_write+0x303/0xd40 fs/read_write.c:589
                   ksys_write+0x19b/0x2c0 fs/read_write.c:644
                   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                   do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
                   entry_SYSCALL_64_after_hwframe+0x44/0xae
 }
 ... key      at: [<ffffffff90f96980>] snd_pcm_group_init.__key+0x0/0x20
 ... acquired at:
   mark_lock+0x21c/0x350 kernel/locking/lockdep.c:4607
   __lock_acquire+0xb81/0x1f80 kernel/locking/lockdep.c:4983
   lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   _raw_spin_lock_irqsave+0xd1/0x120 kernel/locking/spinlock.c:162
   snd_pcm_period_elapsed+0x2c/0x210 sound/core/pcm_lib.c:1848
   dummy_hrtimer_callback+0x87/0x190 sound/drivers/dummy.c:377
   __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
   __hrtimer_run_queues+0x50b/0xa60 kernel/time/hrtimer.c:1749
   hrtimer_run_softirq+0x1a1/0x580 kernel/time/hrtimer.c:1766
   __do_softirq+0x382/0x793 kernel/softirq.c:558
   __irq_exit_rcu+0xec/0x170 kernel/softirq.c:637
   irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
   sysvec_apic_timer_interrupt+0x91/0xb0 arch/x86/kernel/apic/apic.c:1097
   asm_sysvec_apic_timer_interrupt+0x12/0x20
   native_safe_halt arch/x86/include/asm/irqflags.h:51 [inline]
   arch_safe_halt arch/x86/include/asm/irqflags.h:89 [inline]
   acpi_safe_halt drivers/acpi/processor_idle.c:115 [inline]
   acpi_idle_do_entry drivers/acpi/processor_idle.c:556 [inline]
   acpi_idle_enter+0x42d/0x790 drivers/acpi/processor_idle.c:691
   cpuidle_enter_state+0x517/0xed0 drivers/cpuidle/cpuidle.c:237
   cpuidle_enter+0x59/0x90 drivers/cpuidle/cpuidle.c:351
   call_cpuidle kernel/sched/idle.c:155 [inline]
   cpuidle_idle_call kernel/sched/idle.c:236 [inline]
   do_idle+0x3d2/0x640 kernel/sched/idle.c:303
   cpu_startup_entry+0x15/0x20 kernel/sched/idle.c:400
   start_kernel+0x4bf/0x56e init/main.c:1140
   secondary_startup_64_no_verify+0xc4/0xcb


stack backtrace:
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.18.0-rc3-syzkaller-00196-g45ab9400e73f #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1e3/0x2cb lib/dump_stack.c:106
 print_irq_inversion_bug+0x58c/0x6f0 kernel/locking/lockdep.c:4014
 mark_lock_irq+0x9d2/0xf00 kernel/locking/lockdep.c:4177
 mark_lock+0x21c/0x350 kernel/locking/lockdep.c:4607
 __lock_acquire+0xb81/0x1f80 kernel/locking/lockdep.c:4983
 lock_acquire+0x1a7/0x400 kernel/locking/lockdep.c:5641
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 _raw_spin_lock_irqsave+0xd1/0x120 kernel/locking/spinlock.c:162
 snd_pcm_period_elapsed+0x2c/0x210 sound/core/pcm_lib.c:1848
 dummy_hrtimer_callback+0x87/0x190 sound/drivers/dummy.c:377
 __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
 __hrtimer_run_queues+0x50b/0xa60 kernel/time/hrtimer.c:1749
 hrtimer_run_softirq+0x1a1/0x580 kernel/time/hrtimer.c:1766
 __do_softirq+0x382/0x793 kernel/softirq.c:558
 __irq_exit_rcu+0xec/0x170 kernel/softirq.c:637
 irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
 sysvec_apic_timer_interrupt+0x91/0xb0 arch/x86/kernel/apic/apic.c:1097
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x12/0x20
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:22 [inline]
RIP: 0010:arch_local_save_flags arch/x86/include/asm/irqflags.h:70 [inline]
RIP: 0010:arch_irqs_disabled arch/x86/include/asm/irqflags.h:130 [inline]
RIP: 0010:acpi_safe_halt drivers/acpi/processor_idle.c:116 [inline]
RIP: 0010:acpi_idle_do_entry drivers/acpi/processor_idle.c:556 [inline]
RIP: 0010:acpi_idle_enter+0x42d/0x790 drivers/acpi/processor_idle.c:691
Code: fc 48 83 e3 08 44 8b 7c 24 04 0f 85 22 01 00 00 4c 8d 74 24 40 e8 93 fd 00 fd eb 0c e8 ac 59 fa fc 0f 00 2d f5 a1 68 06 fb f4 <4c> 89 f3 48 c1 eb 03 42 80 3c 23 00 74 08 4c 89 f7 e8 5d 3f 4b fd
RSP: 0018:ffffffff8c807bc0 EFLAGS: 00000282
RAX: ea48baa34ad6ff00 RBX: 0000000000000000 RCX: ffffffff90b7a603
RDX: dffffc0000000000 RSI: ffffffff8a8d0480 RDI: ffffffff8ae88c20
RBP: ffffffff8c807c70 R08: ffffffff818ca320 R09: fffffbfff19176c9
R10: fffffbfff19176c9 R11: 1ffffffff19176c8 R12: dffffc0000000000
R13: ffff888016bdf064 R14: ffffffff8c807c00 R15: 0000000000000001
 cpuidle_enter_state+0x517/0xed0 drivers/cpuidle/cpuidle.c:237
----------------
Code disassembly (best guess):
   0:	fc                   	cld
   1:	48 83 e3 08          	and    $0x8,%rbx
   5:	44 8b 7c 24 04       	mov    0x4(%rsp),%r15d
   a:	0f 85 22 01 00 00    	jne    0x132
  10:	4c 8d 74 24 40       	lea    0x40(%rsp),%r14
  15:	e8 93 fd 00 fd       	callq  0xfd00fdad
  1a:	eb 0c                	jmp    0x28
  1c:	e8 ac 59 fa fc       	callq  0xfcfa59cd
  21:	0f 00 2d f5 a1 68 06 	verw   0x668a1f5(%rip)        # 0x668a21d
  28:	fb                   	sti
  29:	f4                   	hlt
* 2a:	4c 89 f3             	mov    %r14,%rbx <-- trapping instruction
  2d:	48 c1 eb 03          	shr    $0x3,%rbx
  31:	42 80 3c 23 00       	cmpb   $0x0,(%rbx,%r12,1)
  36:	74 08                	je     0x40
  38:	4c 89 f7             	mov    %r14,%rdi
  3b:	e8 5d 3f 4b fd       	callq  0xfd4b3f9d

Fix bisection attempts:
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-kasan-gce-smack-root 2022/06/26 04:08 upstream 0840a7914caa 131df97d .config log report syz C
Crashes (17):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-kasan-gce-smack-root 2022/04/23 22:25 upstream 45ab9400e73f 131df97d .config log report syz C possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/21 17:55 upstream 3b5e1590a267 7268fa62 .config log report syz possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/25 03:34 upstream aa051d36ce4a 647c0e27 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/23 22:55 upstream 1e57930e9f40 4c7657cb .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/23 10:34 upstream 4b0986a3613c 4c7657cb .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/23 01:56 upstream 4b0986a3613c 7268fa62 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/20 16:49 upstream 3d7285a335ed bd37ad7e .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/19 13:09 upstream f993aed406ea 50c53f39 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/05/18 01:43 upstream 210e04ff7681 744a39e2 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/04/23 19:03 upstream 45ab9400e73f 131df97d .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/04/22 01:10 upstream 59f0c2447e25 2738b391 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/04/22 00:19 upstream 59f0c2447e25 2738b391 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/04/21 17:10 upstream b253435746d9 2738b391 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/04/21 00:18 upstream 559089e0a93d 160a3f31 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/03/05 18:05 upstream ac84e82f78cb 7bdd8b2c .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2022/02/03 06:27 upstream 27bb0b18c208 4ebb2798 .config log report info possible deadlock in snd_pcm_period_elapsed
ci-upstream-kasan-gce-smack-root 2021/12/25 01:21 upstream b927dfc67d05 6caa12e4 .config log report info possible deadlock in snd_pcm_period_elapsed