All of lore.kernel.org
 help / color / mirror / Atom feed
* [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3)
@ 2021-11-10 17:00 syzbot
  2021-12-20  2:22 ` syzbot
  2022-04-23 22:52 ` syzbot
  0 siblings, 2 replies; 4+ messages in thread
From: syzbot @ 2021-11-10 17:00 UTC (permalink / raw)
  To: bfields, jlayton, linux-fsdevel, linux-kernel, syzkaller-bugs, viro

Hello,

syzbot found the following issue on:

HEAD commit:    cb690f5238d7 Merge tag 'for-5.16/drivers-2021-11-09' of gi..
git tree:       upstream
console output: https://syzkaller.appspot.com/x/log.txt?x=14db95c1b00000
kernel config:  https://syzkaller.appspot.com/x/.config?x=9d7259f0deb293aa
dashboard link: https://syzkaller.appspot.com/bug?extid=58740f570d9b0dacf2a3
compiler:       gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2

Unfortunately, I don't have any reproducer for this issue yet.

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+58740f570d9b0dacf2a3@syzkaller.appspotmail.com

=====================================================
WARNING: SOFTIRQ-safe -> SOFTIRQ-unsafe lock order detected
5.15.0-syzkaller #0 Not tainted
-----------------------------------------------------
syz-executor.3/27804 [HC0[0]:SC0[0]:HE0:SE1] is trying to acquire:
ffff88803102cd38 (&new->fa_lock){....}-{2:2}, at: kill_fasync_rcu fs/fcntl.c:1014 [inline]
ffff88803102cd38 (&new->fa_lock){....}-{2:2}, at: kill_fasync fs/fcntl.c:1035 [inline]
ffff88803102cd38 (&new->fa_lock){....}-{2:2}, at: kill_fasync+0x136/0x470 fs/fcntl.c:1028

and this task is already holding:
ffff88814af73948 (&timer->lock){....}-{2:2}, at: snd_timer_start1+0x5a/0x800 sound/core/timer.c:541
which would create a new lock dependency:
 (&timer->lock){....}-{2:2} -> (&new->fa_lock){....}-{2:2}

but this new dependency connects a SOFTIRQ-irq-safe lock:
 (&group->lock){..-.}-{2:2}

... which became SOFTIRQ-irq-safe at:
  lock_acquire kernel/locking/lockdep.c:5637 [inline]
  lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
  __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
  _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
  _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
  snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848
  loopback_jiffies_timer_function+0x1c4/0x240 sound/drivers/aloop.c:668
  call_timer_fn+0x1a5/0x6b0 kernel/time/timer.c:1421
  expire_timers kernel/time/timer.c:1466 [inline]
  __run_timers.part.0+0x675/0xa20 kernel/time/timer.c:1734
  __run_timers kernel/time/timer.c:1715 [inline]
  run_timer_softirq+0xb3/0x1d0 kernel/time/timer.c:1747
  __do_softirq+0x29b/0x9c2 kernel/softirq.c:558
  invoke_softirq kernel/softirq.c:432 [inline]
  __irq_exit_rcu+0x123/0x180 kernel/softirq.c:636
  irq_exit_rcu+0x5/0x20 kernel/softirq.c:648
  sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097
  asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
  __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
  _raw_spin_unlock_irqrestore+0x38/0x70 kernel/locking/spinlock.c:194
  __debug_check_no_obj_freed lib/debugobjects.c:1002 [inline]
  debug_check_no_obj_freed+0x20c/0x420 lib/debugobjects.c:1023
  slab_free_hook mm/slub.c:1698 [inline]
  slab_free_freelist_hook+0xeb/0x1c0 mm/slub.c:1749
  slab_free mm/slub.c:3513 [inline]
  kfree+0xf6/0x560 mm/slub.c:4561
  skb_free_head net/core/skbuff.c:655 [inline]
  skb_release_data+0x65a/0x790 net/core/skbuff.c:677
  skb_release_all net/core/skbuff.c:742 [inline]
  __kfree_skb net/core/skbuff.c:756 [inline]
  kfree_skb net/core/skbuff.c:774 [inline]
  kfree_skb+0x133/0x3f0 net/core/skbuff.c:768
  ieee80211_iface_work+0x411/0xd00 net/mac80211/iface.c:1522
  process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
  worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
  kthread+0x405/0x4f0 kernel/kthread.c:327
  ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295

to a SOFTIRQ-irq-unsafe lock:
 (tasklist_lock){.+.+}-{2:2}

... which became SOFTIRQ-irq-unsafe at:
...
  lock_acquire kernel/locking/lockdep.c:5637 [inline]
  lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
  __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
  _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
  do_wait+0x284/0xce0 kernel/exit.c:1511
  kernel_wait+0x9c/0x150 kernel/exit.c:1701
  call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
  call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
  process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
  worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
  kthread+0x405/0x4f0 kernel/kthread.c:327
  ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295

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 ***

3 locks held by syz-executor.3/27804:
 #0: ffff8880409bf568 (&tu->ioctl_lock){+.+.}-{3:3}, at: snd_timer_user_ioctl+0x4c/0xb0 sound/core/timer.c:2128
 #1: ffff88814af73948 (&timer->lock){....}-{2:2}, at: snd_timer_start1+0x5a/0x800 sound/core/timer.c:541
 #2: ffffffff8b983a20 (rcu_read_lock){....}-{1:2}, at: kill_fasync+0x41/0x470 fs/fcntl.c:1033

the dependencies between SOFTIRQ-irq-safe lock and the holding lock:
 -> (&group->lock){..-.}-{2:2} {
    IN-SOFTIRQ-W at:
                      lock_acquire kernel/locking/lockdep.c:5637 [inline]
                      lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                      __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                      _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
                      _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
                      snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848
                      loopback_jiffies_timer_function+0x1c4/0x240 sound/drivers/aloop.c:668
                      call_timer_fn+0x1a5/0x6b0 kernel/time/timer.c:1421
                      expire_timers kernel/time/timer.c:1466 [inline]
                      __run_timers.part.0+0x675/0xa20 kernel/time/timer.c:1734
                      __run_timers kernel/time/timer.c:1715 [inline]
                      run_timer_softirq+0xb3/0x1d0 kernel/time/timer.c:1747
                      __do_softirq+0x29b/0x9c2 kernel/softirq.c:558
                      invoke_softirq kernel/softirq.c:432 [inline]
                      __irq_exit_rcu+0x123/0x180 kernel/softirq.c:636
                      irq_exit_rcu+0x5/0x20 kernel/softirq.c:648
                      sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097
                      asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
                      __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
                      _raw_spin_unlock_irqrestore+0x38/0x70 kernel/locking/spinlock.c:194
                      __debug_check_no_obj_freed lib/debugobjects.c:1002 [inline]
                      debug_check_no_obj_freed+0x20c/0x420 lib/debugobjects.c:1023
                      slab_free_hook mm/slub.c:1698 [inline]
                      slab_free_freelist_hook+0xeb/0x1c0 mm/slub.c:1749
                      slab_free mm/slub.c:3513 [inline]
                      kfree+0xf6/0x560 mm/slub.c:4561
                      skb_free_head net/core/skbuff.c:655 [inline]
                      skb_release_data+0x65a/0x790 net/core/skbuff.c:677
                      skb_release_all net/core/skbuff.c:742 [inline]
                      __kfree_skb net/core/skbuff.c:756 [inline]
                      kfree_skb net/core/skbuff.c:774 [inline]
                      kfree_skb+0x133/0x3f0 net/core/skbuff.c:768
                      ieee80211_iface_work+0x411/0xd00 net/mac80211/iface.c:1522
                      process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
                      worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
                      kthread+0x405/0x4f0 kernel/kthread.c:327
                      ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
    INITIAL USE at:
                     lock_acquire kernel/locking/lockdep.c:5637 [inline]
                     lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                     __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
                     _raw_spin_lock_irq+0x32/0x50 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+0x12a/0x1990 sound/core/pcm_native.c:686
                     snd_pcm_kernel_ioctl+0x164/0x310 sound/core/pcm_native.c:3372
                     snd_pcm_oss_change_params_locked+0x1936/0x3a60 sound/core/oss/pcm_oss.c:947
                     snd_pcm_oss_change_params sound/core/oss/pcm_oss.c:1091 [inline]
                     snd_pcm_oss_get_active_substream+0x164/0x1c0 sound/core/oss/pcm_oss.c:1108
                     snd_pcm_oss_get_formats+0x75/0x340 sound/core/oss/pcm_oss.c:1830
                     snd_pcm_oss_set_format sound/core/oss/pcm_oss.c:1872 [inline]
                     snd_pcm_oss_ioctl+0x1034/0x3430 sound/core/oss/pcm_oss.c:2644
                     vfs_ioctl fs/ioctl.c:51 [inline]
                     __do_sys_ioctl fs/ioctl.c:874 [inline]
                     __se_sys_ioctl fs/ioctl.c:860 [inline]
                     __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                     do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                     entry_SYSCALL_64_after_hwframe+0x44/0xae
  }
  ... key      at: [<ffffffff90606fe0>] __key.9+0x0/0x40
-> (&timer->lock){....}-{2:2} {
   INITIAL USE at:
                   lock_acquire kernel/locking/lockdep.c:5637 [inline]
                   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                   __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
                   _raw_spin_lock_irq+0x32/0x50 kernel/locking/spinlock.c:170
                   spin_lock_irq include/linux/spinlock.h:374 [inline]
                   snd_timer_close_locked+0x63/0xbb0 sound/core/timer.c:396
                   snd_timer_close+0x87/0xf0 sound/core/timer.c:463
                   snd_seq_timer_close+0x8c/0xe0 sound/core/seq/seq_timer.c:326
                   queue_delete+0x4a/0xa0 sound/core/seq/seq_queue.c:134
                   snd_seq_queue_delete+0x45/0x60 sound/core/seq/seq_queue.c:196
                   snd_seq_kernel_client_ctl+0x102/0x1e0 sound/core/seq/seq_clientmgr.c:2369
                   delete_seq_queue.part.0.isra.0+0xa2/0x110 sound/core/seq/oss/seq_oss_init.c:377
                   delete_seq_queue sound/core/seq/oss/seq_oss_init.c:373 [inline]
                   snd_seq_oss_release+0x10b/0x1a0 sound/core/seq/oss/seq_oss_init.c:422
                   odev_release+0x4f/0x70 sound/core/seq/oss/seq_oss.c:144
                   __fput+0x286/0x9f0 fs/file_table.c:280
                   task_work_run+0xdd/0x1a0 kernel/task_work.c:164
                   tracehook_notify_resume include/linux/tracehook.h:189 [inline]
                   exit_to_user_mode_loop kernel/entry/common.c:175 [inline]
                   exit_to_user_mode_prepare+0x27e/0x290 kernel/entry/common.c:207
                   __syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
                   syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
                   do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
                   entry_SYSCALL_64_after_hwframe+0x44/0xae
 }
 ... key      at: [<ffffffff90606780>] __key.12+0x0/0x40
 ... acquired at:
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
   snd_timer_notify sound/core/timer.c:1087 [inline]
   snd_timer_notify+0x10c/0x3d0 sound/core/timer.c:1074
   snd_pcm_timer_notify sound/core/pcm_native.c:595 [inline]
   snd_pcm_post_start+0x24a/0x310 sound/core/pcm_native.c:1392
   snd_pcm_action_single sound/core/pcm_native.c:1229 [inline]
   snd_pcm_action+0x143/0x170 sound/core/pcm_native.c:1310
   __snd_pcm_lib_xfer+0x1633/0x1d80 sound/core/pcm_lib.c:2221
   snd_pcm_oss_read3+0x1c4/0x400 sound/core/oss/pcm_oss.c:1267
   snd_pcm_oss_read2+0x300/0x3f0 sound/core/oss/pcm_oss.c:1478
   snd_pcm_oss_read1 sound/core/oss/pcm_oss.c:1525 [inline]
   snd_pcm_oss_read+0x626/0x7b0 sound/core/oss/pcm_oss.c:2769
   vfs_read+0x1b5/0x600 fs/read_write.c:479
   ksys_read+0x12d/0x250 fs/read_write.c:619
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae


the dependencies between the lock to be acquired
 and SOFTIRQ-irq-unsafe lock:
  -> (tasklist_lock){.+.+}-{2:2} {
     HARDIRQ-ON-R at:
                        lock_acquire kernel/locking/lockdep.c:5637 [inline]
                        lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                        __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                        _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                        do_wait+0x284/0xce0 kernel/exit.c:1511
                        kernel_wait+0x9c/0x150 kernel/exit.c:1701
                        call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                        call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                        process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
                        worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
                        kthread+0x405/0x4f0 kernel/kthread.c:327
                        ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
     SOFTIRQ-ON-R at:
                        lock_acquire kernel/locking/lockdep.c:5637 [inline]
                        lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                        __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                        _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                        do_wait+0x284/0xce0 kernel/exit.c:1511
                        kernel_wait+0x9c/0x150 kernel/exit.c:1701
                        call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                        call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                        process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
                        worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
                        kthread+0x405/0x4f0 kernel/kthread.c:327
                        ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
     INITIAL USE at:
                       lock_acquire kernel/locking/lockdep.c:5637 [inline]
                       lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                       __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline]
                       _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:316
                       copy_process+0x36c0/0x75a0 kernel/fork.c:2310
                       kernel_clone+0xe7/0xab0 kernel/fork.c:2581
                       kernel_thread+0xb5/0xf0 kernel/fork.c:2633
                       rest_init+0x23/0x3e0 init/main.c:690
                       start_kernel+0x47a/0x49b init/main.c:1135
                       secondary_startup_64_no_verify+0xb0/0xbb
     INITIAL READ USE at:
                            lock_acquire kernel/locking/lockdep.c:5637 [inline]
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                            __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                            _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                            do_wait+0x284/0xce0 kernel/exit.c:1511
                            kernel_wait+0x9c/0x150 kernel/exit.c:1701
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                            process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
                            worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
                            kthread+0x405/0x4f0 kernel/kthread.c:327
                            ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
   }
   ... key      at: [<ffffffff8b60a098>] tasklist_lock+0x18/0x40
   ... acquired at:
   __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
   _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
   send_sigio+0xab/0x380 fs/fcntl.c:810
   kill_fasync_rcu fs/fcntl.c:1021 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync+0x1f8/0x470 fs/fcntl.c:1028
   sock_wake_async+0xd2/0x160 net/socket.c:1368
   sk_wake_async include/net/sock.h:2400 [inline]
   sk_wake_async include/net/sock.h:2396 [inline]
   sock_def_readable+0x349/0x4e0 net/core/sock.c:3138
   unix_dgram_sendmsg+0xfa7/0x1950 net/unix/af_unix.c:1941
   sock_sendmsg_nosec net/socket.c:704 [inline]
   sock_sendmsg+0xcf/0x120 net/socket.c:724
   ____sys_sendmsg+0x331/0x810 net/socket.c:2409
   ___sys_sendmsg+0xf3/0x170 net/socket.c:2463
   __sys_sendmmsg+0x195/0x470 net/socket.c:2549
   __do_sys_sendmmsg net/socket.c:2578 [inline]
   __se_sys_sendmmsg net/socket.c:2575 [inline]
   __x64_sys_sendmmsg+0x99/0x100 net/socket.c:2575
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

 -> (&f->f_owner.lock){....}-{2:2} {
    INITIAL USE at:
                     lock_acquire kernel/locking/lockdep.c:5637 [inline]
                     lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                     __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline]
                     _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:316
                     f_modown+0x2a/0x390 fs/fcntl.c:91
                     __f_setown fs/fcntl.c:110 [inline]
                     f_setown+0xd7/0x230 fs/fcntl.c:138
                     do_fcntl+0x749/0x1210 fs/fcntl.c:393
                     __do_sys_fcntl fs/fcntl.c:472 [inline]
                     __se_sys_fcntl fs/fcntl.c:457 [inline]
                     __x64_sys_fcntl+0x165/0x1e0 fs/fcntl.c:457
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                     do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                     entry_SYSCALL_64_after_hwframe+0x44/0xae
    INITIAL READ USE at:
                          lock_acquire kernel/locking/lockdep.c:5637 [inline]
                          lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                          __raw_read_lock_irq include/linux/rwlock_api_smp.h:168 [inline]
                          _raw_read_lock_irq+0x63/0x80 kernel/locking/spinlock.c:244
                          f_getown+0x23/0x2a0 fs/fcntl.c:154
                          do_fcntl+0xbd8/0x1210 fs/fcntl.c:389
                          __do_sys_fcntl fs/fcntl.c:472 [inline]
                          __se_sys_fcntl fs/fcntl.c:457 [inline]
                          __x64_sys_fcntl+0x165/0x1e0 fs/fcntl.c:457
                          do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                          do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                          entry_SYSCALL_64_after_hwframe+0x44/0xae
  }
  ... key      at: [<ffffffff90307de0>] __key.5+0x0/0x40
  ... acquired at:
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
   send_sigio+0x24/0x380 fs/fcntl.c:796
   kill_fasync_rcu fs/fcntl.c:1021 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync+0x1f8/0x470 fs/fcntl.c:1028
   sock_wake_async+0xd2/0x160 net/socket.c:1368
   sk_wake_async include/net/sock.h:2400 [inline]
   sk_wake_async+0x108/0x290 include/net/sock.h:2396
   unix_release_sock+0x79d/0xbc0 net/unix/af_unix.c:570
   unix_release+0x84/0xe0 net/unix/af_unix.c:949
   __sock_release+0xcd/0x280 net/socket.c:649
   sock_close+0x18/0x20 net/socket.c:1314
   __fput+0x286/0x9f0 fs/file_table.c:280
   task_work_run+0xdd/0x1a0 kernel/task_work.c:164
   get_signal+0x1b80/0x21d0 kernel/signal.c:2593
   arch_do_signal_or_restart+0x2a9/0x1c40 arch/x86/kernel/signal.c:868
   handle_signal_work kernel/entry/common.c:148 [inline]
   exit_to_user_mode_loop kernel/entry/common.c:172 [inline]
   exit_to_user_mode_prepare+0x17d/0x290 kernel/entry/common.c:207
   __syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
   syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
   do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
   entry_SYSCALL_64_after_hwframe+0x44/0xae

-> (&new->fa_lock){....}-{2:2} {
   INITIAL USE at:
                   lock_acquire kernel/locking/lockdep.c:5637 [inline]
                   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                   __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline]
                   _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:316
                   fasync_remove_entry+0xb6/0x1f0 fs/fcntl.c:891
                   fasync_helper+0x9e/0xb0 fs/fcntl.c:994
                   sock_fasync+0x94/0x140 net/socket.c:1339
                   __fput+0x846/0x9f0 fs/file_table.c:277
                   task_work_run+0xdd/0x1a0 kernel/task_work.c:164
                   tracehook_notify_resume include/linux/tracehook.h:189 [inline]
                   exit_to_user_mode_loop kernel/entry/common.c:175 [inline]
                   exit_to_user_mode_prepare+0x27e/0x290 kernel/entry/common.c:207
                   __syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
                   syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
                   do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
                   entry_SYSCALL_64_after_hwframe+0x44/0xae
   INITIAL READ USE at:
                        lock_acquire kernel/locking/lockdep.c:5637 [inline]
                        lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
                        __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
                        _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
                        kill_fasync_rcu fs/fcntl.c:1014 [inline]
                        kill_fasync fs/fcntl.c:1035 [inline]
                        kill_fasync+0x136/0x470 fs/fcntl.c:1028
                        sock_wake_async+0xd2/0x160 net/socket.c:1368
                        sk_wake_async include/net/sock.h:2400 [inline]
                        sk_wake_async+0x108/0x290 include/net/sock.h:2396
                        unix_release_sock+0x79d/0xbc0 net/unix/af_unix.c:570
                        unix_release+0x84/0xe0 net/unix/af_unix.c:949
                        __sock_release+0xcd/0x280 net/socket.c:649
                        sock_close+0x18/0x20 net/socket.c:1314
                        __fput+0x286/0x9f0 fs/file_table.c:280
                        task_work_run+0xdd/0x1a0 kernel/task_work.c:164
                        get_signal+0x1b80/0x21d0 kernel/signal.c:2593
                        arch_do_signal_or_restart+0x2a9/0x1c40 arch/x86/kernel/signal.c:868
                        handle_signal_work kernel/entry/common.c:148 [inline]
                        exit_to_user_mode_loop kernel/entry/common.c:172 [inline]
                        exit_to_user_mode_prepare+0x17d/0x290 kernel/entry/common.c:207
                        __syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
                        syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
                        do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
                        entry_SYSCALL_64_after_hwframe+0x44/0xae
 }
 ... key      at: [<ffffffff90308bc0>] __key.0+0x0/0x40
 ... acquired at:
   lock_acquire kernel/locking/lockdep.c:5637 [inline]
   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
   kill_fasync_rcu fs/fcntl.c:1014 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync+0x136/0x470 fs/fcntl.c:1028
   snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1387
   snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
   snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:697 [inline]
   snd_timer_start sound/core/timer.c:690 [inline]
   snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1985
   __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2108
   snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2129
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:874 [inline]
   __se_sys_ioctl fs/ioctl.c:860 [inline]
   __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae


stack backtrace:
CPU: 1 PID: 27804 Comm: syz-executor.3 Not tainted 5.15.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
 print_bad_irq_dependency kernel/locking/lockdep.c:2577 [inline]
 check_irq_usage.cold+0x4c1/0x6b0 kernel/locking/lockdep.c:2816
 check_prev_add kernel/locking/lockdep.c:3067 [inline]
 check_prevs_add kernel/locking/lockdep.c:3186 [inline]
 validate_chain kernel/locking/lockdep.c:3801 [inline]
 __lock_acquire+0x2a1f/0x54a0 kernel/locking/lockdep.c:5027
 lock_acquire kernel/locking/lockdep.c:5637 [inline]
 lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602
 __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
 _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
 kill_fasync_rcu fs/fcntl.c:1014 [inline]
 kill_fasync fs/fcntl.c:1035 [inline]
 kill_fasync+0x136/0x470 fs/fcntl.c:1028
 snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1387
 snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
 snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
 snd_timer_start sound/core/timer.c:697 [inline]
 snd_timer_start sound/core/timer.c:690 [inline]
 snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1985
 __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2108
 snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2129
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:874 [inline]
 __se_sys_ioctl fs/ioctl.c:860 [inline]
 __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f927e7d2ae9
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f927bd48188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f927e8e5f60 RCX: 00007f927e7d2ae9
RDX: 0000000000000000 RSI: 00000000000054a0 RDI: 0000000000000003
RBP: 00007f927e82cf6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffcc9c48d0f R14: 00007f927bd48300 R15: 0000000000022000
 </TASK>


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzkaller@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3)
  2021-11-10 17:00 [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3) syzbot
@ 2021-12-20  2:22 ` syzbot
  2022-04-23 22:52 ` syzbot
  1 sibling, 0 replies; 4+ messages in thread
From: syzbot @ 2021-12-20  2:22 UTC (permalink / raw)
  To: alsa-devel, bfields, jlayton, linux-fsdevel, linux-kernel, perex,
	syzkaller-bugs, tiwai, viro

syzbot has found a reproducer for the following issue on:

HEAD commit:    a76c3d035872 Merge tag 'irq_urgent_for_v5.16_rc6' of git:/..
git tree:       upstream
console output: https://syzkaller.appspot.com/x/log.txt?x=1564a349b00000
kernel config:  https://syzkaller.appspot.com/x/.config?x=fa556098924b78f0
dashboard link: https://syzkaller.appspot.com/bug?extid=58740f570d9b0dacf2a3
compiler:       gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
syz repro:      https://syzkaller.appspot.com/x/repro.syz?x=111bc7d5b00000

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+58740f570d9b0dacf2a3@syzkaller.appspotmail.com

========================================================
WARNING: possible irq lock inversion dependency detected
5.16.0-rc5-syzkaller #0 Not tainted
--------------------------------------------------------
swapper/0/0 just changed the state of lock:
ffff8880226f5910 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170 sound/core/pcm_native.c:170
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 kernel/locking/lockdep.c:5637 [inline]
                            lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                            __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                            __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline] kernel/locking/spinlock.c:228
                            _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228 kernel/locking/spinlock.c:228
                            do_wait+0x284/0xce0 kernel/exit.c:1511 kernel/exit.c:1511
                            kernel_wait+0x9c/0x150 kernel/exit.c:1701 kernel/exit.c:1701
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline] kernel/umh.c:166
                            call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166 kernel/umh.c:166
                            process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298 kernel/workqueue.c:2298
                            worker_thread+0x658/0x11f0 kernel/workqueue.c:2445 kernel/workqueue.c:2445
                            kthread+0x405/0x4f0 kernel/kthread.c:327 kernel/kthread.c:327
                            ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 arch/x86/entry/entry_64.S:295
       SOFTIRQ-ON-R at:
                            lock_acquire kernel/locking/lockdep.c:5637 [inline]
                            lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                            __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                            __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline] kernel/locking/spinlock.c:228
                            _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228 kernel/locking/spinlock.c:228
                            do_wait+0x284/0xce0 kernel/exit.c:1511 kernel/exit.c:1511
                            kernel_wait+0x9c/0x150 kernel/exit.c:1701 kernel/exit.c:1701
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline] kernel/umh.c:166
                            call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166 kernel/umh.c:166
                            process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298 kernel/workqueue.c:2298
                            worker_thread+0x658/0x11f0 kernel/workqueue.c:2445 kernel/workqueue.c:2445
                            kthread+0x405/0x4f0 kernel/kthread.c:327 kernel/kthread.c:327
                            ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 arch/x86/entry/entry_64.S:295
       INITIAL USE at:
                           lock_acquire kernel/locking/lockdep.c:5637 [inline]
                           lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                           lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                           __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline]
                           __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline] kernel/locking/spinlock.c:316
                           _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:316 kernel/locking/spinlock.c:316
                           copy_process+0x36c8/0x75a0 kernel/fork.c:2311 kernel/fork.c:2311
                           kernel_clone+0xe7/0xab0 kernel/fork.c:2582 kernel/fork.c:2582
                           kernel_thread+0xb5/0xf0 kernel/fork.c:2634 kernel/fork.c:2634
                           rest_init+0x23/0x3e0 init/main.c:690 init/main.c:690
                           start_kernel+0x47a/0x49b init/main.c:1135 init/main.c:1135
                           secondary_startup_64_no_verify+0xb0/0xbb
       INITIAL READ USE at:
                                lock_acquire kernel/locking/lockdep.c:5637 [inline]
                                lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                                lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                                __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
                                __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline] kernel/locking/spinlock.c:228
                                _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228 kernel/locking/spinlock.c:228
                                do_wait+0x284/0xce0 kernel/exit.c:1511 kernel/exit.c:1511
                                kernel_wait+0x9c/0x150 kernel/exit.c:1701 kernel/exit.c:1701
                                call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                                call_usermodehelper_exec_sync kernel/umh.c:139 [inline] kernel/umh.c:166
                                call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166 kernel/umh.c:166
                                process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298 kernel/workqueue.c:2298
                                worker_thread+0x658/0x11f0 kernel/workqueue.c:2445 kernel/workqueue.c:2445
                                kthread+0x405/0x4f0 kernel/kthread.c:327 kernel/kthread.c:327
                                ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 arch/x86/entry/entry_64.S:295
     }
     ... key      at: [<ffffffff8b80a098>] tasklist_lock+0x18/0x40
     ... acquired at:
   __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline]
   __raw_read_lock include/linux/rwlock_api_smp.h:149 [inline] kernel/locking/spinlock.c:228
   _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228 kernel/locking/spinlock.c:228
   send_sigio+0xab/0x380 fs/fcntl.c:810 fs/fcntl.c:810
   kill_fasync_rcu fs/fcntl.c:1021 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync_rcu fs/fcntl.c:1021 [inline] fs/fcntl.c:1028
   kill_fasync fs/fcntl.c:1035 [inline] fs/fcntl.c:1028
   kill_fasync+0x1f8/0x470 fs/fcntl.c:1028 fs/fcntl.c:1028
   lease_break_callback+0x1f/0x30 fs/locks.c:477 fs/locks.c:477
   __break_lease+0x3d7/0x1420 fs/locks.c:1450 fs/locks.c:1450
   break_lease include/linux/fs.h:2633 [inline]
   break_lease include/linux/fs.h:2623 [inline]
   break_lease include/linux/fs.h:2633 [inline] fs/open.c:813
   break_lease include/linux/fs.h:2623 [inline] fs/open.c:813
   do_dentry_open+0x453/0x1250 fs/open.c:813 fs/open.c:813
   do_open fs/namei.c:3426 [inline]
   do_open fs/namei.c:3426 [inline] fs/namei.c:3559
   path_openat+0x1cad/0x2750 fs/namei.c:3559 fs/namei.c:3559
   do_filp_open+0x1aa/0x400 fs/namei.c:3586 fs/namei.c:3586
   do_sys_openat2+0x16d/0x4d0 fs/open.c:1212 fs/open.c:1212
   do_sys_open fs/open.c:1228 [inline]
   __do_sys_creat fs/open.c:1304 [inline]
   __se_sys_creat fs/open.c:1298 [inline]
   do_sys_open fs/open.c:1228 [inline] fs/open.c:1298
   __do_sys_creat fs/open.c:1304 [inline] fs/open.c:1298
   __se_sys_creat fs/open.c:1298 [inline] fs/open.c:1298
   __x64_sys_creat+0xc9/0x120 fs/open.c:1298 fs/open.c:1298
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

   -> (&f->f_owner.lock){....}-{2:2} {
      INITIAL USE at:
                         lock_acquire kernel/locking/lockdep.c:5637 [inline]
                         lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                         lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                         __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline]
                         __raw_write_lock_irq include/linux/rwlock_api_smp.h:194 [inline] kernel/locking/spinlock.c:316
                         _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:316 kernel/locking/spinlock.c:316
                         f_modown+0x2a/0x390 fs/fcntl.c:91 fs/fcntl.c:91
                         __f_setown fs/fcntl.c:110 [inline]
                         f_setown_ex fs/fcntl.c:200 [inline]
                         __f_setown fs/fcntl.c:110 [inline] fs/fcntl.c:399
                         f_setown_ex fs/fcntl.c:200 [inline] fs/fcntl.c:399
                         do_fcntl+0xb24/0x1210 fs/fcntl.c:399 fs/fcntl.c:399
                         __do_sys_fcntl fs/fcntl.c:472 [inline]
                         __se_sys_fcntl fs/fcntl.c:457 [inline]
                         __do_sys_fcntl fs/fcntl.c:472 [inline] fs/fcntl.c:457
                         __se_sys_fcntl fs/fcntl.c:457 [inline] fs/fcntl.c:457
                         __x64_sys_fcntl+0x165/0x1e0 fs/fcntl.c:457 fs/fcntl.c:457
                         do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                         do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
                         do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
                         entry_SYSCALL_64_after_hwframe+0x44/0xae
      INITIAL READ USE at:
                              lock_acquire kernel/locking/lockdep.c:5637 [inline]
                              lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                              lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                              __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
                              __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline] kernel/locking/spinlock.c:236
                              _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236 kernel/locking/spinlock.c:236
                              send_sigio+0x24/0x380 fs/fcntl.c:796 fs/fcntl.c:796
                              kill_fasync_rcu fs/fcntl.c:1021 [inline]
                              kill_fasync fs/fcntl.c:1035 [inline]
                              kill_fasync_rcu fs/fcntl.c:1021 [inline] fs/fcntl.c:1028
                              kill_fasync fs/fcntl.c:1035 [inline] fs/fcntl.c:1028
                              kill_fasync+0x1f8/0x470 fs/fcntl.c:1028 fs/fcntl.c:1028
                              snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386 sound/core/timer.c:1386
                              snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516 sound/core/timer.c:516
                              snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578 sound/core/timer.c:578
                              snd_timer_start sound/core/timer.c:696 [inline]
                              snd_timer_start sound/core/timer.c:689 [inline]
                              snd_timer_start sound/core/timer.c:696 [inline] sound/core/timer.c:1984
                              snd_timer_start sound/core/timer.c:689 [inline] sound/core/timer.c:1984
                              snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984 sound/core/timer.c:1984
                              __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2107 sound/core/timer.c:2107
                              snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128 sound/core/timer.c:2128
                              vfs_ioctl fs/ioctl.c:51 [inline]
                              __do_sys_ioctl fs/ioctl.c:874 [inline]
                              __se_sys_ioctl fs/ioctl.c:860 [inline]
                              vfs_ioctl fs/ioctl.c:51 [inline] fs/ioctl.c:860
                              __do_sys_ioctl fs/ioctl.c:874 [inline] fs/ioctl.c:860
                              __se_sys_ioctl fs/ioctl.c:860 [inline] fs/ioctl.c:860
                              __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860 fs/ioctl.c:860
                              do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                              do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
                              do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
                              entry_SYSCALL_64_after_hwframe+0x44/0xae
    }
    ... key      at: [<ffffffff90534da0>] __key.5+0x0/0x40
    ... acquired at:
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline] kernel/locking/spinlock.c:236
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236 kernel/locking/spinlock.c:236
   send_sigio+0x24/0x380 fs/fcntl.c:796 fs/fcntl.c:796
   kill_fasync_rcu fs/fcntl.c:1021 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync_rcu fs/fcntl.c:1021 [inline] fs/fcntl.c:1028
   kill_fasync fs/fcntl.c:1035 [inline] fs/fcntl.c:1028
   kill_fasync+0x1f8/0x470 fs/fcntl.c:1028 fs/fcntl.c:1028
   snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386 sound/core/timer.c:1386
   snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516 sound/core/timer.c:516
   snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_start sound/core/timer.c:689 [inline]
   snd_timer_start sound/core/timer.c:696 [inline] sound/core/timer.c:1984
   snd_timer_start sound/core/timer.c:689 [inline] sound/core/timer.c:1984
   snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984 sound/core/timer.c:1984
   __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2107 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:874 [inline]
   __se_sys_ioctl fs/ioctl.c:860 [inline]
   vfs_ioctl fs/ioctl.c:51 [inline] fs/ioctl.c:860
   __do_sys_ioctl fs/ioctl.c:874 [inline] fs/ioctl.c:860
   __se_sys_ioctl fs/ioctl.c:860 [inline] fs/ioctl.c:860
   __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860 fs/ioctl.c:860
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

  -> (&new->fa_lock){....}-{2:2} {
     INITIAL READ USE at:
                            lock_acquire kernel/locking/lockdep.c:5637 [inline]
                            lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                            __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
                            __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline] kernel/locking/spinlock.c:236
                            _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236 kernel/locking/spinlock.c:236
                            kill_fasync_rcu fs/fcntl.c:1014 [inline]
                            kill_fasync fs/fcntl.c:1035 [inline]
                            kill_fasync_rcu fs/fcntl.c:1014 [inline] fs/fcntl.c:1028
                            kill_fasync fs/fcntl.c:1035 [inline] fs/fcntl.c:1028
                            kill_fasync+0x136/0x470 fs/fcntl.c:1028 fs/fcntl.c:1028
                            snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386 sound/core/timer.c:1386
                            snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516 sound/core/timer.c:516
                            snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578 sound/core/timer.c:578
                            snd_timer_start sound/core/timer.c:696 [inline]
                            snd_timer_start sound/core/timer.c:689 [inline]
                            snd_timer_start sound/core/timer.c:696 [inline] sound/core/timer.c:1984
                            snd_timer_start sound/core/timer.c:689 [inline] sound/core/timer.c:1984
                            snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984 sound/core/timer.c:1984
                            __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2107 sound/core/timer.c:2107
                            snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128 sound/core/timer.c:2128
                            vfs_ioctl fs/ioctl.c:51 [inline]
                            __do_sys_ioctl fs/ioctl.c:874 [inline]
                            __se_sys_ioctl fs/ioctl.c:860 [inline]
                            vfs_ioctl fs/ioctl.c:51 [inline] fs/ioctl.c:860
                            __do_sys_ioctl fs/ioctl.c:874 [inline] fs/ioctl.c:860
                            __se_sys_ioctl fs/ioctl.c:860 [inline] fs/ioctl.c:860
                            __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860 fs/ioctl.c:860
                            do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                            do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
                            do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
                            entry_SYSCALL_64_after_hwframe+0x44/0xae
   }
   ... key      at: [<ffffffff90535b80>] __key.0+0x0/0x40
   ... acquired at:
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline]
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:159 [inline] kernel/locking/spinlock.c:236
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236 kernel/locking/spinlock.c:236
   kill_fasync_rcu fs/fcntl.c:1014 [inline]
   kill_fasync fs/fcntl.c:1035 [inline]
   kill_fasync_rcu fs/fcntl.c:1014 [inline] fs/fcntl.c:1028
   kill_fasync fs/fcntl.c:1035 [inline] fs/fcntl.c:1028
   kill_fasync+0x136/0x470 fs/fcntl.c:1028 fs/fcntl.c:1028
   snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386 sound/core/timer.c:1386
   snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516 sound/core/timer.c:516
   snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_start sound/core/timer.c:689 [inline]
   snd_timer_start sound/core/timer.c:696 [inline] sound/core/timer.c:1984
   snd_timer_start sound/core/timer.c:689 [inline] sound/core/timer.c:1984
   snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984 sound/core/timer.c:1984
   __snd_timer_user_ioctl.isra.0+0xda8/0x2490 sound/core/timer.c:2107 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:874 [inline]
   __se_sys_ioctl fs/ioctl.c:860 [inline]
   vfs_ioctl fs/ioctl.c:51 [inline] fs/ioctl.c:860
   __do_sys_ioctl fs/ioctl.c:874 [inline] fs/ioctl.c:860
   __se_sys_ioctl fs/ioctl.c:860 [inline] fs/ioctl.c:860
   __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860 fs/ioctl.c:860
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

 -> (&timer->lock){....}-{2:2} {
    INITIAL USE at:
                     lock_acquire kernel/locking/lockdep.c:5637 [inline]
                     lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                     lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                     __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                     __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] kernel/locking/spinlock.c:162
                     _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162 kernel/locking/spinlock.c:162
                     snd_timer_resolution+0x55/0x100 sound/core/timer.c:489 sound/core/timer.c:489
                     snd_timer_user_params.isra.0+0x18e/0x8c0 sound/core/timer.c:1851 sound/core/timer.c:1851
                     __snd_timer_user_ioctl.isra.0+0x1020/0x2490 sound/core/timer.c:2100 sound/core/timer.c:2100
                     snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128 sound/core/timer.c:2128
                     vfs_ioctl fs/ioctl.c:51 [inline]
                     __do_sys_ioctl fs/ioctl.c:874 [inline]
                     __se_sys_ioctl fs/ioctl.c:860 [inline]
                     vfs_ioctl fs/ioctl.c:51 [inline] fs/ioctl.c:860
                     __do_sys_ioctl fs/ioctl.c:874 [inline] fs/ioctl.c:860
                     __se_sys_ioctl fs/ioctl.c:860 [inline] fs/ioctl.c:860
                     __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860 fs/ioctl.c:860
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
                     do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
                     entry_SYSCALL_64_after_hwframe+0x44/0xae
  }
  ... key      at: [<ffffffff90833500>] __key.12+0x0/0x40
  ... acquired at:
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] kernel/locking/spinlock.c:162
   _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162 kernel/locking/spinlock.c:162
   snd_timer_notify sound/core/timer.c:1086 [inline]
   snd_timer_notify sound/core/timer.c:1086 [inline] sound/core/timer.c:1073
   snd_timer_notify+0x10c/0x3d0 sound/core/timer.c:1073 sound/core/timer.c:1073
   snd_pcm_timer_notify sound/core/pcm_native.c:595 [inline]
   snd_pcm_timer_notify sound/core/pcm_native.c:595 [inline] sound/core/pcm_native.c:1392
   snd_pcm_post_start+0x24a/0x310 sound/core/pcm_native.c:1392 sound/core/pcm_native.c:1392
   snd_pcm_action_single sound/core/pcm_native.c:1229 [inline]
   snd_pcm_action_single sound/core/pcm_native.c:1229 [inline] sound/core/pcm_native.c:1310
   snd_pcm_action+0x143/0x170 sound/core/pcm_native.c:1310 sound/core/pcm_native.c:1310
   __snd_pcm_lib_xfer+0x1289/0x1d80 sound/core/pcm_lib.c:2286 sound/core/pcm_lib.c:2286
   snd_pcm_oss_write3+0x103/0x250 sound/core/oss/pcm_oss.c:1241 sound/core/oss/pcm_oss.c:1241
   io_playback_transfer+0x27e/0x330 sound/core/oss/io.c:47 sound/core/oss/io.c:47
   snd_pcm_plug_write_transfer+0x2cd/0x3f0 sound/core/oss/pcm_plugin.c:627 sound/core/oss/pcm_plugin.c:627
   snd_pcm_oss_write2+0x245/0x3f0 sound/core/oss/pcm_oss.c:1373 sound/core/oss/pcm_oss.c:1373
   snd_pcm_oss_write1 sound/core/oss/pcm_oss.c:1439 [inline]
   snd_pcm_oss_write1 sound/core/oss/pcm_oss.c:1439 [inline] sound/core/oss/pcm_oss.c:2805
   snd_pcm_oss_write+0x75f/0x9c0 sound/core/oss/pcm_oss.c:2805 sound/core/oss/pcm_oss.c:2805
   vfs_write+0x28e/0xae0 fs/read_write.c:588 fs/read_write.c:588
   ksys_write+0x12d/0x250 fs/read_write.c:643 fs/read_write.c:643
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

-> (&group->lock){..-.}-{2:2} {
   IN-SOFTIRQ-W at:
                    lock_acquire kernel/locking/lockdep.c:5637 [inline]
                    lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                    lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                    __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                    __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] kernel/locking/spinlock.c:162
                    _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162 kernel/locking/spinlock.c:162
                    _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170 sound/core/pcm_native.c:170
                    snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848 sound/core/pcm_lib.c:1848
                    dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377 sound/drivers/dummy.c:377
                    __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
                    __run_hrtimer kernel/time/hrtimer.c:1685 [inline] kernel/time/hrtimer.c:1749
                    __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749 kernel/time/hrtimer.c:1749
                    hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766 kernel/time/hrtimer.c:1766
                    __do_softirq+0x29b/0x9c2 kernel/softirq.c:558 kernel/softirq.c:558
                    invoke_softirq kernel/softirq.c:432 [inline]
                    invoke_softirq kernel/softirq.c:432 [inline] kernel/softirq.c:637
                    __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637 kernel/softirq.c:637
                    irq_exit_rcu+0x5/0x20 kernel/softirq.c:649 kernel/softirq.c:649
                    sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097 arch/x86/kernel/apic/apic.c:1097
                    asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638 arch/x86/include/asm/idtentry.h:638
                    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:109 [inline]
                    native_safe_halt arch/x86/include/asm/irqflags.h:51 [inline] drivers/acpi/processor_idle.c:553
                    arch_safe_halt arch/x86/include/asm/irqflags.h:89 [inline] drivers/acpi/processor_idle.c:553
                    acpi_safe_halt drivers/acpi/processor_idle.c:109 [inline] drivers/acpi/processor_idle.c:553
                    acpi_idle_do_entry+0x1c6/0x250 drivers/acpi/processor_idle.c:553 drivers/acpi/processor_idle.c:553
                    acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:688 drivers/acpi/processor_idle.c:688
                    cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237 drivers/cpuidle/cpuidle.c:237
                    cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351 drivers/cpuidle/cpuidle.c:351
                    call_cpuidle kernel/sched/idle.c:158 [inline]
                    cpuidle_idle_call kernel/sched/idle.c:239 [inline]
                    call_cpuidle kernel/sched/idle.c:158 [inline] kernel/sched/idle.c:306
                    cpuidle_idle_call kernel/sched/idle.c:239 [inline] kernel/sched/idle.c:306
                    do_idle+0x3e8/0x590 kernel/sched/idle.c:306 kernel/sched/idle.c:306
                    cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:403 kernel/sched/idle.c:403
                    start_kernel+0x47a/0x49b init/main.c:1135 init/main.c:1135
                    secondary_startup_64_no_verify+0xb0/0xbb
   INITIAL USE at:
                   lock_acquire kernel/locking/lockdep.c:5637 [inline]
                   lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
                   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
                   __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
                   __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline] kernel/locking/spinlock.c:170
                   _raw_spin_lock_irq+0x32/0x50 kernel/locking/spinlock.c:170 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]
                   spin_lock_irq include/linux/spinlock.h:374 [inline] sound/core/pcm_native.c:686
                   snd_pcm_group_lock_irq sound/core/pcm_native.c:97 [inline] sound/core/pcm_native.c:686
                   snd_pcm_stream_lock_irq sound/core/pcm_native.c:136 [inline] sound/core/pcm_native.c:686
                   snd_pcm_hw_params+0x12a/0x1990 sound/core/pcm_native.c:686 sound/core/pcm_native.c:686
                   snd_pcm_kernel_ioctl+0x164/0x310 sound/core/pcm_native.c:3372 sound/core/pcm_native.c:3372
                   snd_pcm_oss_change_params_locked+0x13c8/0x3bf0 sound/core/oss/pcm_oss.c:960 sound/core/oss/pcm_oss.c:960
                   snd_pcm_oss_make_ready_locked+0xb3/0x130 sound/core/oss/pcm_oss.c:1186 sound/core/oss/pcm_oss.c:1186
                   snd_pcm_oss_write1 sound/core/oss/pcm_oss.c:1404 [inline]
                   snd_pcm_oss_write1 sound/core/oss/pcm_oss.c:1404 [inline] sound/core/oss/pcm_oss.c:2805
                   snd_pcm_oss_write+0x4b2/0x9c0 sound/core/oss/pcm_oss.c:2805 sound/core/oss/pcm_oss.c:2805
                   vfs_write+0x28e/0xae0 fs/read_write.c:588 fs/read_write.c:588
                   ksys_write+0x12d/0x250 fs/read_write.c:643 fs/read_write.c:643
                   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                   do_syscall_x64 arch/x86/entry/common.c:50 [inline] arch/x86/entry/common.c:80
                   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 arch/x86/entry/common.c:80
                   entry_SYSCALL_64_after_hwframe+0x44/0xae
 }
 ... key      at: [<ffffffff90833d60>] __key.9+0x0/0x40
 ... acquired at:
   mark_usage kernel/locking/lockdep.c:4500 [inline]
   mark_usage kernel/locking/lockdep.c:4500 [inline] kernel/locking/lockdep.c:4981
   __lock_acquire+0x11d5/0x54a0 kernel/locking/lockdep.c:4981 kernel/locking/lockdep.c:4981
   lock_acquire kernel/locking/lockdep.c:5637 [inline]
   lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] kernel/locking/spinlock.c:162
   _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162 kernel/locking/spinlock.c:162
   _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170 sound/core/pcm_native.c:170
   snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848 sound/core/pcm_lib.c:1848
   dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377 sound/drivers/dummy.c:377
   __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
   __run_hrtimer kernel/time/hrtimer.c:1685 [inline] kernel/time/hrtimer.c:1749
   __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749 kernel/time/hrtimer.c:1749
   hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766 kernel/time/hrtimer.c:1766
   __do_softirq+0x29b/0x9c2 kernel/softirq.c:558 kernel/softirq.c:558
   invoke_softirq kernel/softirq.c:432 [inline]
   invoke_softirq kernel/softirq.c:432 [inline] kernel/softirq.c:637
   __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637 kernel/softirq.c:637
   irq_exit_rcu+0x5/0x20 kernel/softirq.c:649 kernel/softirq.c:649
   sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097 arch/x86/kernel/apic/apic.c:1097
   asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638 arch/x86/include/asm/idtentry.h:638
   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:109 [inline]
   native_safe_halt arch/x86/include/asm/irqflags.h:51 [inline] drivers/acpi/processor_idle.c:553
   arch_safe_halt arch/x86/include/asm/irqflags.h:89 [inline] drivers/acpi/processor_idle.c:553
   acpi_safe_halt drivers/acpi/processor_idle.c:109 [inline] drivers/acpi/processor_idle.c:553
   acpi_idle_do_entry+0x1c6/0x250 drivers/acpi/processor_idle.c:553 drivers/acpi/processor_idle.c:553
   acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:688 drivers/acpi/processor_idle.c:688
   cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237 drivers/cpuidle/cpuidle.c:237
   cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351 drivers/cpuidle/cpuidle.c:351
   call_cpuidle kernel/sched/idle.c:158 [inline]
   cpuidle_idle_call kernel/sched/idle.c:239 [inline]
   call_cpuidle kernel/sched/idle.c:158 [inline] kernel/sched/idle.c:306
   cpuidle_idle_call kernel/sched/idle.c:239 [inline] kernel/sched/idle.c:306
   do_idle+0x3e8/0x590 kernel/sched/idle.c:306 kernel/sched/idle.c:306
   cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:403 kernel/sched/idle.c:403
   start_kernel+0x47a/0x49b init/main.c:1135 init/main.c:1135
   secondary_startup_64_no_verify+0xb0/0xbb


stack backtrace:
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.16.0-rc5-syzkaller #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 lib/dump_stack.c:88 [inline] lib/dump_stack.c:106
 dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106 lib/dump_stack.c:106
 print_irq_inversion_bug kernel/locking/lockdep.c:203 [inline]
 check_usage_forwards kernel/locking/lockdep.c:4043 [inline]
 mark_lock_irq kernel/locking/lockdep.c:4175 [inline]
 print_irq_inversion_bug kernel/locking/lockdep.c:203 [inline] kernel/locking/lockdep.c:4605
 check_usage_forwards kernel/locking/lockdep.c:4043 [inline] kernel/locking/lockdep.c:4605
 mark_lock_irq kernel/locking/lockdep.c:4175 [inline] kernel/locking/lockdep.c:4605
 mark_lock.cold+0x86/0x8e kernel/locking/lockdep.c:4605 kernel/locking/lockdep.c:4605
 mark_usage kernel/locking/lockdep.c:4500 [inline]
 mark_usage kernel/locking/lockdep.c:4500 [inline] kernel/locking/lockdep.c:4981
 __lock_acquire+0x11d5/0x54a0 kernel/locking/lockdep.c:4981 kernel/locking/lockdep.c:4981
 lock_acquire kernel/locking/lockdep.c:5637 [inline]
 lock_acquire kernel/locking/lockdep.c:5637 [inline] kernel/locking/lockdep.c:5602
 lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5602 kernel/locking/lockdep.c:5602
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] kernel/locking/spinlock.c:162
 _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162 kernel/locking/spinlock.c:162
 _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170 sound/core/pcm_native.c:170
 snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848 sound/core/pcm_lib.c:1848
 dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377 sound/drivers/dummy.c:377
 __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
 __run_hrtimer kernel/time/hrtimer.c:1685 [inline] kernel/time/hrtimer.c:1749
 __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749 kernel/time/hrtimer.c:1749
 hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766 kernel/time/hrtimer.c:1766
 __do_softirq+0x29b/0x9c2 kernel/softirq.c:558 kernel/softirq.c:558
 invoke_softirq kernel/softirq.c:432 [inline]
 invoke_softirq kernel/softirq.c:432 [inline] kernel/softirq.c:637
 __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637 kernel/softirq.c:637
 irq_exit_rcu+0x5/0x20 kernel/softirq.c:649 kernel/softirq.c:649
 sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097 arch/x86/kernel/apic/apic.c:1097
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638 arch/x86/include/asm/idtentry.h:638
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:29 [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:132 [inline]
RIP: 0010:acpi_safe_halt drivers/acpi/processor_idle.c:110 [inline]
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:29 [inline] drivers/acpi/processor_idle.c:553
RIP: 0010:arch_local_save_flags arch/x86/include/asm/irqflags.h:70 [inline] drivers/acpi/processor_idle.c:553
RIP: 0010:arch_irqs_disabled arch/x86/include/asm/irqflags.h:132 [inline] drivers/acpi/processor_idle.c:553
RIP: 0010:acpi_safe_halt drivers/acpi/processor_idle.c:110 [inline] drivers/acpi/processor_idle.c:553
RIP: 0010:acpi_idle_do_entry+0x1c6/0x250 drivers/acpi/processor_idle.c:553 drivers/acpi/processor_idle.c:553
Code: 89 de e8 6d 5e 30 f8 84 db 75 ac e8 84 5a 30 f8 e8 cf 9e 36 f8 eb 0c e8 78 5a 30 f8 0f 00 2d d1 b4 c9 00 e8 6c 5a 30 f8 fb f4 <9c> 5b 81 e3 00 02 00 00 fa 31 ff 48 89 de e8 e7 5c 30 f8 48 85 db
RSP: 0018:ffffffff8b807d60 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffffffff8b8bc6c0 RSI: ffffffff89475854 RDI: 0000000000000000
RBP: ffff888011a74864 R08: 0000000000000001 R09: 0000000000000001
R10: ffffffff817df748 R11: 0000000000000000 R12: 0000000000000001
R13: ffff888011a74800 R14: ffff888011a74864 R15: ffff888145d9c804
 acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:688 drivers/acpi/processor_idle.c:688
 cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237 drivers/cpuidle/cpuidle.c:237
 cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351 drivers/cpuidle/cpuidle.c:351
 call_cpuidle kernel/sched/idle.c:158 [inline]
 cpuidle_idle_call kernel/sched/idle.c:239 [inline]
 call_cpuidle kernel/sched/idle.c:158 [inline] kernel/sched/idle.c:306
 cpuidle_idle_call kernel/sched/idle.c:239 [inline] kernel/sched/idle.c:306
 do_idle+0x3e8/0x590 kernel/sched/idle.c:306 kernel/sched/idle.c:306
 cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:403 kernel/sched/idle.c:403
 start_kernel+0x47a/0x49b init/main.c:1135 init/main.c:1135
 secondary_startup_64_no_verify+0xb0/0xbb
 </TASK>
----------------
Code disassembly (best guess):
   0:	89 de                	mov    %ebx,%esi
   2:	e8 6d 5e 30 f8       	callq  0xf8305e74
   7:	84 db                	test   %bl,%bl
   9:	75 ac                	jne    0xffffffb7
   b:	e8 84 5a 30 f8       	callq  0xf8305a94
  10:	e8 cf 9e 36 f8       	callq  0xf8369ee4
  15:	eb 0c                	jmp    0x23
  17:	e8 78 5a 30 f8       	callq  0xf8305a94
  1c:	0f 00 2d d1 b4 c9 00 	verw   0xc9b4d1(%rip)        # 0xc9b4f4
  23:	e8 6c 5a 30 f8       	callq  0xf8305a94
  28:	fb                   	sti
  29:	f4                   	hlt
* 2a:	9c                   	pushfq <-- trapping instruction
  2b:	5b                   	pop    %rbx
  2c:	81 e3 00 02 00 00    	and    $0x200,%ebx
  32:	fa                   	cli
  33:	31 ff                	xor    %edi,%edi
  35:	48 89 de             	mov    %rbx,%rsi
  38:	e8 e7 5c 30 f8       	callq  0xf8305d24
  3d:	48 85 db             	test   %rbx,%rbx
----------------
Code disassembly (best guess):
   0:	89 de                	mov    %ebx,%esi
   2:	e8 6d 5e 30 f8       	callq  0xf8305e74
   7:	84 db                	test   %bl,%bl
   9:	75 ac                	jne    0xffffffb7
   b:	e8 84 5a 30 f8       	callq  0xf8305a94
  10:	e8 cf 9e 36 f8       	callq  0xf8369ee4
  15:	eb 0c                	jmp    0x23
  17:	e8 78 5a 30 f8       	callq  0xf8305a94
  1c:	0f 00 2d d1 b4 c9 00 	verw   0xc9b4d1(%rip)        # 0xc9b4f4
  23:	e8 6c 5a 30 f8       	callq  0xf8305a94
  28:	fb                   	sti
  29:	f4                   	hlt
* 2a:	9c                   	pushfq <-- trapping instruction
  2b:	5b                   	pop    %rbx
  2c:	81 e3 00 02 00 00    	and    $0x200,%ebx
  32:	fa                   	cli
  33:	31 ff                	xor    %edi,%edi
  35:	48 89 de             	mov    %rbx,%rsi
  38:	e8 e7 5c 30 f8       	callq  0xf8305d24
  3d:	48 85 db             	test   %rbx,%rbx


^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3)
  2021-11-10 17:00 [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3) syzbot
  2021-12-20  2:22 ` syzbot
@ 2022-04-23 22:52 ` syzbot
  1 sibling, 0 replies; 4+ messages in thread
From: syzbot @ 2022-04-23 22:52 UTC (permalink / raw)
  To: alsa-devel-owner, alsa-devel, bfields, jlayton, linux-fsdevel,
	linux-kernel, perex, syzkaller-bugs, tiwai, viro

syzbot has found a reproducer for the following issue on:

HEAD commit:    13bc32bad705 Merge tag 'drm-fixes-2022-04-23' of git://ano..
git tree:       upstream
console output: https://syzkaller.appspot.com/x/log.txt?x=11371798f00000
kernel config:  https://syzkaller.appspot.com/x/.config?x=71bf5c8488a4e33a
dashboard link: https://syzkaller.appspot.com/bug?extid=58740f570d9b0dacf2a3
compiler:       gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
syz repro:      https://syzkaller.appspot.com/x/repro.syz?x=129b3992f00000
C reproducer:   https://syzkaller.appspot.com/x/repro.c?x=17a6b6fcf00000

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+58740f570d9b0dacf2a3@syzkaller.appspotmail.com

========================================================
WARNING: possible irq lock inversion dependency detected
5.18.0-rc3-syzkaller-00218-g13bc32bad705 #0 Not tainted
--------------------------------------------------------
swapper/0/0 just changed the state of lock:
ffff888022e8b110 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
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 kernel/locking/lockdep.c:5641 [inline]
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                            __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                            _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                            do_wait+0x284/0xce0 kernel/exit.c:1508
                            kernel_wait+0x9c/0x150 kernel/exit.c:1698
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                            process_one_work+0x996/0x1610 kernel/workqueue.c:2289
                            worker_thread+0x665/0x1080 kernel/workqueue.c:2436
                            kthread+0x2e9/0x3a0 kernel/kthread.c:376
                            ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298
       SOFTIRQ-ON-R at:
                            lock_acquire kernel/locking/lockdep.c:5641 [inline]
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                            __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                            _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                            do_wait+0x284/0xce0 kernel/exit.c:1508
                            kernel_wait+0x9c/0x150 kernel/exit.c:1698
                            call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                            call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                            process_one_work+0x996/0x1610 kernel/workqueue.c:2289
                            worker_thread+0x665/0x1080 kernel/workqueue.c:2436
                            kthread+0x2e9/0x3a0 kernel/kthread.c:376
                            ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298
       INITIAL USE at:
                           lock_acquire kernel/locking/lockdep.c:5641 [inline]
                           lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                           __raw_write_lock_irq include/linux/rwlock_api_smp.h:195 [inline]
                           _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:326
                           copy_process+0x4364/0x6fe0 kernel/fork.c:2368
                           kernel_clone+0xe7/0xab0 kernel/fork.c:2639
                           kernel_thread+0xb5/0xf0 kernel/fork.c:2691
                           rest_init+0x23/0x3e0 init/main.c:691
                           start_kernel+0x47f/0x4a0 init/main.c:1140
                           secondary_startup_64_no_verify+0xc3/0xcb
       INITIAL READ USE at:
                                lock_acquire kernel/locking/lockdep.c:5641 [inline]
                                lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                                __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
                                _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
                                do_wait+0x284/0xce0 kernel/exit.c:1508
                                kernel_wait+0x9c/0x150 kernel/exit.c:1698
                                call_usermodehelper_exec_sync kernel/umh.c:139 [inline]
                                call_usermodehelper_exec_work+0xf5/0x180 kernel/umh.c:166
                                process_one_work+0x996/0x1610 kernel/workqueue.c:2289
                                worker_thread+0x665/0x1080 kernel/workqueue.c:2436
                                kthread+0x2e9/0x3a0 kernel/kthread.c:376
                                ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298
     }
     ... key      at: [<ffffffff8ba0a098>] tasklist_lock+0x18/0x40
     ... acquired at:
   __raw_read_lock include/linux/rwlock_api_smp.h:150 [inline]
   _raw_read_lock+0x5b/0x70 kernel/locking/spinlock.c:228
   send_sigio+0xab/0x380 fs/fcntl.c:792
   dnotify_handle_event+0x148/0x280 fs/notify/dnotify/dnotify.c:115
   fsnotify_handle_inode_event.isra.0+0x209/0x350 fs/notify/fsnotify.c:264
   fsnotify_handle_event fs/notify/fsnotify.c:323 [inline]
   send_to_group fs/notify/fsnotify.c:377 [inline]
   fsnotify+0xeaf/0x13d0 fs/notify/fsnotify.c:564
   fsnotify_name include/linux/fsnotify.h:36 [inline]
   fsnotify_name include/linux/fsnotify.h:29 [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+0x1232/0x2910 fs/namei.c:3606
   do_filp_open+0x1aa/0x400 fs/namei.c:3636
   do_sys_openat2+0x16d/0x4c0 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+0xc9/0x120 fs/open.c:1299
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

   -> (&f->f_owner.lock){....}-{2:2} {
      INITIAL USE at:
                         lock_acquire kernel/locking/lockdep.c:5641 [inline]
                         lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                         __raw_write_lock_irq include/linux/rwlock_api_smp.h:195 [inline]
                         _raw_write_lock_irq+0x32/0x50 kernel/locking/spinlock.c:326
                         f_modown+0x2a/0x390 fs/fcntl.c:91
                         __f_setown fs/fcntl.c:110 [inline]
                         f_setown+0xd7/0x230 fs/fcntl.c:138
                         do_fcntl+0x748/0x10b0 fs/fcntl.c:377
                         __do_sys_fcntl fs/fcntl.c:454 [inline]
                         __se_sys_fcntl fs/fcntl.c:439 [inline]
                         __x64_sys_fcntl+0x15f/0x1d0 fs/fcntl.c:439
                         do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                         do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                         entry_SYSCALL_64_after_hwframe+0x44/0xae
      INITIAL READ USE at:
                              lock_acquire kernel/locking/lockdep.c:5641 [inline]
                              lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                              __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
                              _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
                              send_sigio+0x24/0x380 fs/fcntl.c:778
                              kill_fasync_rcu fs/fcntl.c:1003 [inline]
                              kill_fasync fs/fcntl.c:1017 [inline]
                              kill_fasync+0x1f8/0x470 fs/fcntl.c:1010
                              snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386
                              snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
                              snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
                              snd_timer_start sound/core/timer.c:696 [inline]
                              snd_timer_start sound/core/timer.c:689 [inline]
                              snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984
                              __snd_timer_user_ioctl.isra.0+0xda4/0x2490 sound/core/timer.c:2107
                              snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128
                              vfs_ioctl fs/ioctl.c:51 [inline]
                              __do_sys_ioctl fs/ioctl.c:870 [inline]
                              __se_sys_ioctl fs/ioctl.c:856 [inline]
                              __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:856
                              do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                              do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                              entry_SYSCALL_64_after_hwframe+0x44/0xae
    }
    ... key      at: [<ffffffff9061aa40>] __key.5+0x0/0x40
    ... acquired at:
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
   send_sigio+0x24/0x380 fs/fcntl.c:778
   kill_fasync_rcu fs/fcntl.c:1003 [inline]
   kill_fasync fs/fcntl.c:1017 [inline]
   kill_fasync+0x1f8/0x470 fs/fcntl.c:1010
   snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386
   snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
   snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_start sound/core/timer.c:689 [inline]
   snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984
   __snd_timer_user_ioctl.isra.0+0xda4/0x2490 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:870 [inline]
   __se_sys_ioctl fs/ioctl.c:856 [inline]
   __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:856
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

  -> (&new->fa_lock){....}-{2:2} {
     INITIAL READ USE at:
                            lock_acquire kernel/locking/lockdep.c:5641 [inline]
                            lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                            __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
                            _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
                            kill_fasync_rcu fs/fcntl.c:996 [inline]
                            kill_fasync fs/fcntl.c:1017 [inline]
                            kill_fasync+0x136/0x470 fs/fcntl.c:1010
                            snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386
                            snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
                            snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
                            snd_timer_start sound/core/timer.c:696 [inline]
                            snd_timer_start sound/core/timer.c:689 [inline]
                            snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984
                            __snd_timer_user_ioctl.isra.0+0xda4/0x2490 sound/core/timer.c:2107
                            snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128
                            vfs_ioctl fs/ioctl.c:51 [inline]
                            __do_sys_ioctl fs/ioctl.c:870 [inline]
                            __se_sys_ioctl fs/ioctl.c:856 [inline]
                            __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:856
                            do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                            do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                            entry_SYSCALL_64_after_hwframe+0x44/0xae
   }
   ... key      at: [<ffffffff9061b820>] __key.0+0x0/0x40
   ... acquired at:
   __raw_read_lock_irqsave include/linux/rwlock_api_smp.h:160 [inline]
   _raw_read_lock_irqsave+0x70/0x90 kernel/locking/spinlock.c:236
   kill_fasync_rcu fs/fcntl.c:996 [inline]
   kill_fasync fs/fcntl.c:1017 [inline]
   kill_fasync+0x136/0x470 fs/fcntl.c:1010
   snd_timer_user_ccallback+0x298/0x330 sound/core/timer.c:1386
   snd_timer_notify1+0x11c/0x3b0 sound/core/timer.c:516
   snd_timer_start1+0x4d4/0x800 sound/core/timer.c:578
   snd_timer_start sound/core/timer.c:696 [inline]
   snd_timer_start sound/core/timer.c:689 [inline]
   snd_timer_user_start.isra.0+0x1e3/0x260 sound/core/timer.c:1984
   __snd_timer_user_ioctl.isra.0+0xda4/0x2490 sound/core/timer.c:2107
   snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128
   vfs_ioctl fs/ioctl.c:51 [inline]
   __do_sys_ioctl fs/ioctl.c:870 [inline]
   __se_sys_ioctl fs/ioctl.c:856 [inline]
   __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:856
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

 -> (&timer->lock){....}-{2:2} {
    INITIAL USE at:
                     lock_acquire kernel/locking/lockdep.c:5641 [inline]
                     lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                     __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                     _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
                     snd_timer_resolution+0x55/0x100 sound/core/timer.c:489
                     snd_timer_user_params.isra.0+0x18e/0x8c0 sound/core/timer.c:1851
                     __snd_timer_user_ioctl.isra.0+0x101c/0x2490 sound/core/timer.c:2100
                     snd_timer_user_ioctl+0x77/0xb0 sound/core/timer.c:2128
                     vfs_ioctl fs/ioctl.c:51 [inline]
                     __do_sys_ioctl fs/ioctl.c:870 [inline]
                     __se_sys_ioctl fs/ioctl.c:856 [inline]
                     __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:856
                     do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                     do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                     entry_SYSCALL_64_after_hwframe+0x44/0xae
  }
  ... key      at: [<ffffffff909196a0>] __key.10+0x0/0x40
  ... acquired at:
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
   snd_timer_notify sound/core/timer.c:1086 [inline]
   snd_timer_notify+0x10c/0x3d0 sound/core/timer.c:1073
   snd_pcm_timer_notify sound/core/pcm_native.c:608 [inline]
   snd_pcm_post_start+0x24a/0x310 sound/core/pcm_native.c:1451
   snd_pcm_action_single+0xf4/0x130 sound/core/pcm_native.c:1283
   snd_pcm_action+0x6e/0x90 sound/core/pcm_native.c:1364
   __snd_pcm_lib_xfer+0x14d0/0x1e10 sound/core/pcm_lib.c:2308
   snd_pcm_oss_write3+0x103/0x250 sound/core/oss/pcm_oss.c:1253
   snd_pcm_oss_write2+0x30e/0x3f0 sound/core/oss/pcm_oss.c:1393
   snd_pcm_oss_sync1+0x187/0x440 sound/core/oss/pcm_oss.c:1627
   snd_pcm_oss_sync+0x638/0x800 sound/core/oss/pcm_oss.c:1704
   snd_pcm_oss_release+0x276/0x300 sound/core/oss/pcm_oss.c:2590
   __fput+0x277/0x9d0 fs/file_table.c:317
   task_work_run+0xdd/0x1a0 kernel/task_work.c:164
   exit_task_work include/linux/task_work.h:37 [inline]
   do_exit+0xaff/0x2a00 kernel/exit.c:795
   do_group_exit+0xd2/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+0x3a/0x50 kernel/exit.c:934
   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
   entry_SYSCALL_64_after_hwframe+0x44/0xae

-> (&group->lock){..-.}-{2:2} {
   IN-SOFTIRQ-W at:
                    lock_acquire kernel/locking/lockdep.c:5641 [inline]
                    lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                    __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
                    _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
                    _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
                    snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848
                    dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377
                    __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
                    __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749
                    hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766
                    __do_softirq+0x29b/0x9c2 kernel/softirq.c:558
                    invoke_softirq kernel/softirq.c:432 [inline]
                    __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637
                    irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
                    sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097
                    asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:645
                    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+0x1c6/0x250 drivers/acpi/processor_idle.c:556
                    acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:691
                    cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237
                    cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351
                    call_cpuidle kernel/sched/idle.c:155 [inline]
                    cpuidle_idle_call kernel/sched/idle.c:236 [inline]
                    do_idle+0x3e8/0x590 kernel/sched/idle.c:303
                    cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:400
                    start_kernel+0x47f/0x4a0 init/main.c:1140
                    secondary_startup_64_no_verify+0xc3/0xcb
   INITIAL USE at:
                   lock_acquire kernel/locking/lockdep.c:5641 [inline]
                   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
                   __raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
                   _raw_spin_lock_irq+0x32/0x50 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+0x14b/0x19f0 sound/core/pcm_native.c:726
                   snd_pcm_kernel_ioctl+0x164/0x310 sound/core/pcm_native.c:3435
                   snd_pcm_oss_change_params_locked+0x14e2/0x3a70 sound/core/oss/pcm_oss.c:976
                   snd_pcm_oss_make_ready_locked+0xb3/0x130 sound/core/oss/pcm_oss.c:1198
                   snd_pcm_oss_write1 sound/core/oss/pcm_oss.c:1416 [inline]
                   snd_pcm_oss_write+0x4ac/0x9c0 sound/core/oss/pcm_oss.c:2811
                   vfs_write+0x269/0xac0 fs/read_write.c:589
                   ksys_write+0x127/0x250 fs/read_write.c:644
                   do_syscall_x64 arch/x86/entry/common.c:50 [inline]
                   do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
                   entry_SYSCALL_64_after_hwframe+0x44/0xae
 }
 ... key      at: [<ffffffff90919f00>] __key.8+0x0/0x40
 ... acquired at:
   mark_lock kernel/locking/lockdep.c:4571 [inline]
   mark_usage kernel/locking/lockdep.c:4502 [inline]
   __lock_acquire+0x11e7/0x56c0 kernel/locking/lockdep.c:4983
   lock_acquire kernel/locking/lockdep.c:5641 [inline]
   lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
   __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
   _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
   _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
   snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848
   dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377
   __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
   __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749
   hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766
   __do_softirq+0x29b/0x9c2 kernel/softirq.c:558
   invoke_softirq kernel/softirq.c:432 [inline]
   __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637
   irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
   sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097
   asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:645
   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+0x1c6/0x250 drivers/acpi/processor_idle.c:556
   acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:691
   cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237
   cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351
   call_cpuidle kernel/sched/idle.c:155 [inline]
   cpuidle_idle_call kernel/sched/idle.c:236 [inline]
   do_idle+0x3e8/0x590 kernel/sched/idle.c:303
   cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:400
   start_kernel+0x47f/0x4a0 init/main.c:1140
   secondary_startup_64_no_verify+0xc3/0xcb


stack backtrace:
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.18.0-rc3-syzkaller-00218-g13bc32bad705 #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+0xcd/0x134 lib/dump_stack.c:106
 print_irq_inversion_bug kernel/locking/lockdep.c:192 [inline]
 check_usage_forwards kernel/locking/lockdep.c:4045 [inline]
 mark_lock_irq kernel/locking/lockdep.c:4177 [inline]
 mark_lock.part.0.cold+0x86/0xd8 kernel/locking/lockdep.c:4607
 mark_lock kernel/locking/lockdep.c:4571 [inline]
 mark_usage kernel/locking/lockdep.c:4502 [inline]
 __lock_acquire+0x11e7/0x56c0 kernel/locking/lockdep.c:4983
 lock_acquire kernel/locking/lockdep.c:5641 [inline]
 lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5606
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
 _snd_pcm_stream_lock_irqsave+0x9f/0xd0 sound/core/pcm_native.c:170
 snd_pcm_period_elapsed+0x1d/0x50 sound/core/pcm_lib.c:1848
 dummy_hrtimer_callback+0x94/0x1b0 sound/drivers/dummy.c:377
 __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
 __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749
 hrtimer_run_softirq+0x17b/0x360 kernel/time/hrtimer.c:1766
 __do_softirq+0x29b/0x9c2 kernel/softirq.c:558
 invoke_softirq kernel/softirq.c:432 [inline]
 __irq_exit_rcu+0x123/0x180 kernel/softirq.c:637
 irq_exit_rcu+0x5/0x20 kernel/softirq.c:649
 sysvec_apic_timer_interrupt+0x93/0xc0 arch/x86/kernel/apic/apic.c:1097
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:29 [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+0x1c6/0x250 drivers/acpi/processor_idle.c:556
Code: 89 de e8 7d 6e 0c f8 84 db 75 ac e8 94 6a 0c f8 e8 ff b2 12 f8 eb 0c e8 88 6a 0c f8 0f 00 2d 51 07 c6 00 e8 7c 6a 0c f8 fb f4 <9c> 5b 81 e3 00 02 00 00 fa 31 ff 48 89 de e8 f7 6c 0c f8 48 85 db
RSP: 0018:ffffffff8ba07d60 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffffffff8babc700 RSI: ffffffff896cc614 RDI: 0000000000000000
RBP: ffff8880165b4864 R08: 0000000000000001 R09: 0000000000000001
R10: ffffffff817f7938 R11: 0000000000000000 R12: 0000000000000001
R13: ffff8880165b4800 R14: ffff8880165b4864 R15: ffff8881407ed004
 acpi_idle_enter+0x361/0x500 drivers/acpi/processor_idle.c:691
 cpuidle_enter_state+0x1b1/0xc80 drivers/cpuidle/cpuidle.c:237
 cpuidle_enter+0x4a/0xa0 drivers/cpuidle/cpuidle.c:351
 call_cpuidle kernel/sched/idle.c:155 [inline]
 cpuidle_idle_call kernel/sched/idle.c:236 [inline]
 do_idle+0x3e8/0x590 kernel/sched/idle.c:303
 cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:400
 start_kernel+0x47f/0x4a0 init/main.c:1140
 second
----------------
Code disassembly (best guess):
   0:	89 de                	mov    %ebx,%esi
   2:	e8 7d 6e 0c f8       	callq  0xf80c6e84
   7:	84 db                	test   %bl,%bl
   9:	75 ac                	jne    0xffffffb7
   b:	e8 94 6a 0c f8       	callq  0xf80c6aa4
  10:	e8 ff b2 12 f8       	callq  0xf812b314
  15:	eb 0c                	jmp    0x23
  17:	e8 88 6a 0c f8       	callq  0xf80c6aa4
  1c:	0f 00 2d 51 07 c6 00 	verw   0xc60751(%rip)        # 0xc60774
  23:	e8 7c 6a 0c f8       	callq  0xf80c6aa4
  28:	fb                   	sti
  29:	f4                   	hlt
* 2a:	9c                   	pushfq <-- trapping instruction
  2b:	5b                   	pop    %rbx
  2c:	81 e3 00 02 00 00    	and    $0x200,%ebx
  32:	fa                   	cli
  33:	31 ff                	xor    %edi,%edi
  35:	48 89 de             	mov    %rbx,%rsi
  38:	e8 f7 6c 0c f8       	callq  0xf80c6d34
  3d:	48 85 db             	test   %rbx,%rbx


^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3)
       [not found] <20220424010128.3062-1-hdanton@sina.com>
@ 2022-04-24  2:36 ` syzbot
  0 siblings, 0 replies; 4+ messages in thread
From: syzbot @ 2022-04-24  2:36 UTC (permalink / raw)
  To: hdanton, linux-kernel, syzkaller-bugs

Hello,

syzbot has tested the proposed patch and the reproducer did not trigger any issue:

Reported-and-tested-by: syzbot+58740f570d9b0dacf2a3@syzkaller.appspotmail.com

Tested on:

commit:         13bc32ba Merge tag 'drm-fixes-2022-04-23' of git://ano..
git tree:       https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git/
kernel config:  https://syzkaller.appspot.com/x/.config?x=71bf5c8488a4e33a
dashboard link: https://syzkaller.appspot.com/bug?extid=58740f570d9b0dacf2a3
compiler:       gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
patch:          https://syzkaller.appspot.com/x/patch.diff?x=17585ddcf00000

Note: testing is done by a robot and is best-effort only.

^ permalink raw reply	[flat|nested] 4+ messages in thread

end of thread, other threads:[~2022-04-24  2:36 UTC | newest]

Thread overview: 4+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2021-11-10 17:00 [syzbot] possible deadlock in _snd_pcm_stream_lock_irqsave (3) syzbot
2021-12-20  2:22 ` syzbot
2022-04-23 22:52 ` syzbot
     [not found] <20220424010128.3062-1-hdanton@sina.com>
2022-04-24  2:36 ` syzbot

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.