R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872cab300 R15: 0000000000022000
 </TASK>
======================================================
WARNING: possible circular locking dependency detected
5.16.0-rc6-next-20211224 #1 Not tainted
------------------------------------------------------
syz-executor.5/4115 is trying to acquire lock:
ffff888041a78420 (&ctx->lock){....}-{2:2}, at: perf_event_context_sched_out kernel/events/core.c:3493 [inline]
ffff888041a78420 (&ctx->lock){....}-{2:2}, at: __perf_event_task_sched_out+0x519/0x1920 kernel/events/core.c:3601

but task is already holding lock:
ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested kernel/sched/core.c:489 [inline]
ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock kernel/sched/sched.h:1318 [inline]
ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: rq_lock kernel/sched/sched.h:1616 [inline]
ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: __schedule+0x1cf/0x2190 kernel/sched/core.c:6210

which lock already depends on the new lock.


the existing dependency chain (in reverse order) is:

-> #3 (&rq->__lock){-.-.}-{2:2}:
       _raw_spin_lock_nested+0x30/0x40 kernel/locking/spinlock.c:378
       raw_spin_rq_lock_nested+0x1e/0x30 kernel/sched/core.c:489
       raw_spin_rq_lock kernel/sched/sched.h:1318 [inline]
       rq_lock kernel/sched/sched.h:1616 [inline]
       task_fork_fair+0x63/0x4d0 kernel/sched/fair.c:11146
       sched_post_fork+0x343/0x490 kernel/sched/core.c:4462
       copy_process+0x5353/0x6e20 kernel/fork.c:2394
       kernel_clone+0xe7/0xa60 kernel/fork.c:2620
       kernel_thread+0xae/0xf0 kernel/fork.c:2672
       rest_init+0x24/0x3d0 init/main.c:692
       start_kernel+0x484/0x4a5 init/main.c:1141
       secondary_startup_64_no_verify+0xd5/0xdb

-> #2 (&p->pi_lock){-.-.}-{2:2}:
       __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
       _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
       try_to_wake_up+0xac/0x14c0 kernel/sched/core.c:4017
       up+0x75/0xb0 kernel/locking/semaphore.c:190
       __up_console_sem+0x6e/0x80 kernel/printk/printk.c:255
       console_unlock+0x53e/0xae0 kernel/printk/printk.c:2730
       vprintk_emit+0x198/0x450 kernel/printk/printk.c:2248
       vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
       _printk+0xba/0xed kernel/printk/printk.c:2269
       kauditd_printk_skb kernel/audit.c:538 [inline]
       kauditd_hold_skb.cold+0x41/0x50 kernel/audit.c:571
       kauditd_send_queue kernel/audit.c:734 [inline]
       kauditd_thread+0x86b/0x1080 kernel/audit.c:858
       kthread+0x2f0/0x3a0 kernel/kthread.c:377
       ret_from_fork+0x22/0x30 arch/x86/entry/entry_64.S:295

-> #1 ((console_sem).lock){-.-.}-{2:2}:
       __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
       _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
       down_trylock+0xe/0x60 kernel/locking/semaphore.c:138
       __down_trylock_console_sem+0x3b/0xd0 kernel/printk/printk.c:238
       console_trylock kernel/printk/printk.c:2545 [inline]
       console_trylock_spinning kernel/printk/printk.c:1846 [inline]
       vprintk_emit+0x146/0x450 kernel/printk/printk.c:2247
       vprintk+0x80/0x90 kernel/printk/printk_safe.c:50
       _printk+0xba/0xed kernel/printk/printk.c:2269
       show_trace_log_lvl+0x57/0x2bb arch/x86/kernel/dumpstack.c:195
       ex_handler_msr+0x311/0x3a0 arch/x86/mm/extable.c:101
       fixup_exception+0x1ca/0xdd0 arch/x86/mm/extable.c:212
       __exc_general_protection arch/x86/kernel/traps.c:601 [inline]
       exc_general_protection+0xed/0x2f0 arch/x86/kernel/traps.c:562
       asm_exc_general_protection+0x1e/0x30 arch/x86/include/asm/idtentry.h:562
       wrmsrl arch/x86/include/asm/msr.h:271 [inline]
       __x86_pmu_enable_event arch/x86/events/perf_event.h:1120 [inline]
       x86_pmu_enable_all+0x2f7/0x3c0 arch/x86/events/core.c:743
       x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
       perf_pmu_enable kernel/events/core.c:1207 [inline]
       perf_pmu_enable kernel/events/core.c:1203 [inline]
       ctx_resched+0x2b0/0x390 kernel/events/core.c:2754
       __perf_install_in_context+0x285/0x310 kernel/events/core.c:2821
       remote_function kernel/events/core.c:91 [inline]
       remote_function+0x125/0x1b0 kernel/events/core.c:71
       generic_exec_single+0x203/0x300 kernel/smp.c:518
       smp_call_function_single+0x189/0x460 kernel/smp.c:755
       task_function_call+0xe5/0x170 kernel/events/core.c:119
       perf_install_in_context+0x2cb/0x550 kernel/events/core.c:2922
       __do_sys_perf_event_open+0x1bf0/0x3040 kernel/events/core.c:12433
       do_syscall_x64 arch/x86/entry/common.c:50 [inline]
       do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
       entry_SYSCALL_64_after_hwframe+0x44/0xae

-> #0 (&ctx->lock){....}-{2:2}:
       check_prev_add kernel/locking/lockdep.c:3063 [inline]
       check_prevs_add kernel/locking/lockdep.c:3186 [inline]
       validate_chain kernel/locking/lockdep.c:3801 [inline]
       __lock_acquire+0x2a14/0x5b70 kernel/locking/lockdep.c:5027
       lock_acquire kernel/locking/lockdep.c:5639 [inline]
       lock_acquire+0x1a2/0x4d0 kernel/locking/lockdep.c:5604
       __raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline]
       _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:154
       perf_event_context_sched_out kernel/events/core.c:3493 [inline]
       __perf_event_task_sched_out+0x519/0x1920 kernel/events/core.c:3601
       perf_event_task_sched_out include/linux/perf_event.h:1245 [inline]
       prepare_task_switch kernel/sched/core.c:4796 [inline]
       context_switch kernel/sched/core.c:4938 [inline]
       __schedule+0xead/0x2190 kernel/sched/core.c:6296
       preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
       __cond_resched+0x13/0x20 kernel/sched/core.c:8175
       might_resched include/linux/kernel.h:110 [inline]
       __mutex_lock_common kernel/locking/mutex.c:577 [inline]
       __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
       __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
       do_syscall_x64 arch/x86/entry/common.c:50 [inline]
       do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
       entry_SYSCALL_64_after_hwframe+0x44/0xae

other info that might help us debug this:

Chain exists of:
  &ctx->lock --> &p->pi_lock --> &rq->__lock

 Possible unsafe locking scenario:

       CPU0                    CPU1
       ----                    ----
  lock(&rq->__lock);
                               lock(&p->pi_lock);
                               lock(&rq->__lock);
  lock(&ctx->lock);

 *** DEADLOCK ***

1 lock held by syz-executor.5/4115:
 #0: ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested kernel/sched/core.c:489 [inline]
 #0: ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock kernel/sched/sched.h:1318 [inline]
 #0: ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: rq_lock kernel/sched/sched.h:1616 [inline]
 #0: ffff88806ce37a58 (&rq->__lock){-.-.}-{2:2}, at: __schedule+0x1cf/0x2190 kernel/sched/core.c:6210

stack backtrace:
CPU: 0 PID: 4115 Comm: syz-executor.5 Not tainted 5.16.0-rc6-next-20211224 #1
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.14.0-0-g155821a1990b-prebuilt.qemu.org 04/01/2014
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x8b/0xb3 lib/dump_stack.c:106
 check_noncircular+0x25f/0x2e0 kernel/locking/lockdep.c:2143
 check_prev_add kernel/locking/lockdep.c:3063 [inline]
 check_prevs_add kernel/locking/lockdep.c:3186 [inline]
 validate_chain kernel/locking/lockdep.c:3801 [inline]
 __lock_acquire+0x2a14/0x5b70 kernel/locking/lockdep.c:5027
 lock_acquire kernel/locking/lockdep.c:5639 [inline]
 lock_acquire+0x1a2/0x4d0 kernel/locking/lockdep.c:5604
 __raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline]
 _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:154
 perf_event_context_sched_out kernel/events/core.c:3493 [inline]
 __perf_event_task_sched_out+0x519/0x1920 kernel/events/core.c:3601
 perf_event_task_sched_out include/linux/perf_event.h:1245 [inline]
 prepare_task_switch kernel/sched/core.c:4796 [inline]
 context_switch kernel/sched/core.c:4938 [inline]
 __schedule+0xead/0x2190 kernel/sched/core.c:6296
 preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
 __cond_resched+0x13/0x20 kernel/sched/core.c:8175
 might_resched include/linux/kernel.h:110 [inline]
 __mutex_lock_common kernel/locking/mutex.c:577 [inline]
 __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
 __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872cab188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875848f60 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872cab300 R15: 0000000000022000
 </TASK>
Call Trace:
 <TASK>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 perf_event_context_sched_out kernel/events/core.c:3500 [inline]
 __perf_event_task_sched_out+0x764/0x1920 kernel/events/core.c:3601
 perf_event_task_sched_out include/linux/perf_event.h:1245 [inline]
 prepare_task_switch kernel/sched/core.c:4796 [inline]
 context_switch kernel/sched/core.c:4938 [inline]
 __schedule+0xead/0x2190 kernel/sched/core.c:6296
 preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
 __cond_resched+0x13/0x20 kernel/sched/core.c:8175
 might_resched include/linux/kernel.h:110 [inline]
 __mutex_lock_common kernel/locking/mutex.c:577 [inline]
 __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
 __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872cab188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875848f60 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872cab300 R15: 0000000000022000
 </TASK>
loop7: detected capacity change from 0 to 512
EXT4-fs (loop7): mounted filesystem without journal. Quota mode: none.
Call Trace:
 <IRQ>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 ctx_resched+0x2b0/0x390 kernel/events/core.c:2754
 __perf_install_in_context+0x285/0x310 kernel/events/core.c:2821
 remote_function kernel/events/core.c:91 [inline]
 remote_function+0x125/0x1b0 kernel/events/core.c:71
 flush_smp_call_function_queue+0x1df/0x610 kernel/smp.c:628
 __sysvec_call_function_single+0x92/0x3a0 arch/x86/kernel/smp.c:248
 sysvec_call_function_single+0x89/0xc0 arch/x86/kernel/smp.c:243
 </IRQ>
 <TASK>
 asm_sysvec_call_function_single+0x12/0x20 arch/x86/include/asm/idtentry.h:646
RIP: 0010:stack_trace_consume_entry+0xd3/0x160 kernel/stacktrace.c:93
Code: 02 00 0f 85 92 00 00 00 8d 45 01 89 43 10 48 8b 03 48 8d 2c e8 48 b8 00 00 00 00 00 fc ff df 48 89 ea 48 c1 ea 03 80 3c 02 00 <75> 5c 48 89 75 00 8b 43 08 39 43 10 0f 92 c0 48 83 c4 08 5b 5d c3
RSP: 0018:ffff88801e397158 EFLAGS: 00000246
RAX: dffffc0000000000 RBX: ffff88801e397240 RCX: 0000000000000000
RDX: 1ffff11003c72e5a RSI: ffffffff8173f1a9 RDI: ffff88801e39724c
RBP: ffff88801e3972d0 R08: ffffffff85c7bed4 R09: ffffffff85c7bed8
R10: ffffed1003c72e3c R11: 000000000003403a R12: ffff88801e397240
R13: 0000000000000000 R14: ffff88800f939ac0 R15: 0000000000092c40
 arch_stack_walk+0x73/0xf0 arch/x86/kernel/stacktrace.c:27
 stack_trace_save+0x8c/0xc0 kernel/stacktrace.c:122
 kasan_save_stack+0x1e/0x40 mm/kasan/common.c:38
 kasan_set_track mm/kasan/common.c:45 [inline]
 set_alloc_info mm/kasan/common.c:436 [inline]
 __kasan_slab_alloc+0x66/0x80 mm/kasan/common.c:469
 kasan_slab_alloc include/linux/kasan.h:260 [inline]
 slab_post_alloc_hook mm/slab.h:741 [inline]
 slab_alloc_node mm/slub.c:3230 [inline]
 slab_alloc mm/slub.c:3238 [inline]
 kmem_cache_alloc+0x1aa/0x480 mm/slub.c:3243
 mem_pool_alloc mm/kmemleak.c:430 [inline]
 create_object.isra.0+0x3a/0xa20 mm/kmemleak.c:586
 kmemleak_alloc_recursive include/linux/kmemleak.h:43 [inline]
 slab_post_alloc_hook mm/slab.h:744 [inline]
 slab_alloc_node mm/slub.c:3230 [inline]
 slab_alloc mm/slub.c:3238 [inline]
 kmem_cache_alloc+0x239/0x480 mm/slub.c:3243
 kmem_cache_zalloc include/linux/slab.h:705 [inline]
 ext4_mb_new_blocks+0x64b/0x4a00 fs/ext4/mballoc.c:5562
 ext4_ext_map_blocks+0x1f76/0x5ca0 fs/ext4/extents.c:4285
 ext4_map_blocks+0x652/0x18d0 fs/ext4/inode.c:638
 ext4_getblk+0x144/0x6b0 fs/ext4/inode.c:848
 ext4_bread+0x2a/0x1c0 fs/ext4/inode.c:901
 ext4_append+0x155/0x380 fs/ext4/namei.c:67
 ext4_init_new_dir+0x25e/0x4d0 fs/ext4/namei.c:2893
 ext4_mkdir+0x3cf/0xb20 fs/ext4/namei.c:2939
 vfs_mkdir+0x1d0/0x3c0 fs/namei.c:3933
 do_mkdirat+0x17b/0x2e0 fs/namei.c:3959
 __do_sys_mkdir fs/namei.c:3979 [inline]
 __se_sys_mkdir fs/namei.c:3977 [inline]
 __x64_sys_mkdir+0xf2/0x140 fs/namei.c:3977
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f4197e1fc27
Code: 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 b8 53 00 00 00 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:00007ffda48d14d8 EFLAGS: 00000206 ORIG_RAX: 0000000000000053
RAX: ffffffffffffffda RBX: 00007ffda48d1560 RCX: 00007f4197e1fc27
RDX: 0000000000000000 RSI: 00000000000001ff RDI: 00007ffda48d1560
RBP: 00007ffda48d153c R08: 0000000000000000 R09: 0000000000000003
R10: 00007ffda48d1277 R11: 0000000000000206 R12: 0000000000000032
R13: 00000000000236e8 R14: 0000000000000007 R15: 00007ffda48d15a0
 </TASK>
audit: type=1400 audit(1640664477.679:9): avc:  denied  { read } for  pid=4105 comm="syz-executor.5" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=perf_event permissive=1
Call Trace:
 <TASK>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 ctx_resched+0x2b0/0x390 kernel/events/core.c:2754
 __perf_install_in_context+0x285/0x310 kernel/events/core.c:2821
 remote_function kernel/events/core.c:91 [inline]
 remote_function+0x125/0x1b0 kernel/events/core.c:71
 generic_exec_single+0x203/0x300 kernel/smp.c:518
 smp_call_function_single+0x189/0x460 kernel/smp.c:755
 task_function_call+0xe5/0x170 kernel/events/core.c:119
 perf_install_in_context+0x2cb/0x550 kernel/events/core.c:2922
 __do_sys_perf_event_open+0x1bf0/0x3040 kernel/events/core.c:12433
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872c8a188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875849020 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872c8a300 R15: 0000000000022000
 </TASK>
Call Trace:
 <TASK>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 perf_event_context_sched_out kernel/events/core.c:3500 [inline]
 __perf_event_task_sched_out+0x764/0x1920 kernel/events/core.c:3601
 perf_event_task_sched_out include/linux/perf_event.h:1245 [inline]
 prepare_task_switch kernel/sched/core.c:4796 [inline]
 context_switch kernel/sched/core.c:4938 [inline]
 __schedule+0xead/0x2190 kernel/sched/core.c:6296
 preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
 __cond_resched+0x13/0x20 kernel/sched/core.c:8175
 might_resched include/linux/kernel.h:110 [inline]
 __mutex_lock_common kernel/locking/mutex.c:577 [inline]
 __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
 __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872c8a188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875849020 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872c8a300 R15: 0000000000022000
 </TASK>
UDC core: couldn't find an available UDC or it's busy: -19
misc raw-gadget: fail, usb_gadget_probe_driver returned -19
Call Trace:
 <TASK>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 perf_event_context_sched_in kernel/events/core.c:3893 [inline]
 __perf_event_task_sched_in+0x5e4/0x770 kernel/events/core.c:3931
UDC core: couldn't find an available UDC or it's busy: -19
 perf_event_task_sched_in include/linux/perf_event.h:1222 [inline]
 finish_task_switch.isra.0+0x45c/0x870 kernel/sched/core.c:4861
misc raw-gadget: fail, usb_gadget_probe_driver returned -19
 context_switch kernel/sched/core.c:4989 [inline]
 __schedule+0x88a/0x2190 kernel/sched/core.c:6296
 preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
 __cond_resched+0x13/0x20 kernel/sched/core.c:8175
 might_resched include/linux/kernel.h:110 [inline]
 __mutex_lock_common kernel/locking/mutex.c:577 [inline]
 __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
 __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872c8a188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875849020 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872c8a300 R15: 0000000000022000
 </TASK>
Call Trace:
 <TASK>
 x86_pmu_enable+0x580/0xd90 arch/x86/events/core.c:1350
 perf_pmu_enable kernel/events/core.c:1207 [inline]
 perf_pmu_enable kernel/events/core.c:1203 [inline]
 perf_event_context_sched_out kernel/events/core.c:3500 [inline]
 __perf_event_task_sched_out+0x764/0x1920 kernel/events/core.c:3601
 perf_event_task_sched_out include/linux/perf_event.h:1245 [inline]
 prepare_task_switch kernel/sched/core.c:4796 [inline]
 context_switch kernel/sched/core.c:4938 [inline]
 __schedule+0xead/0x2190 kernel/sched/core.c:6296
 preempt_schedule_common+0x45/0xc0 kernel/sched/core.c:6462
 __cond_resched+0x13/0x20 kernel/sched/core.c:8175
 might_resched include/linux/kernel.h:110 [inline]
 __mutex_lock_common kernel/locking/mutex.c:577 [inline]
 __mutex_lock+0xa3/0x1480 kernel/locking/mutex.c:733
 __do_sys_perf_event_open+0x1d13/0x3040 kernel/events/core.c:12445
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0x90 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f8875735b19
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:00007f8872c8a188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f8875849020 RCX: 00007f8875735b19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040
RBP: 00007f887578ff6d R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff1a332b9f R14: 00007f8872c8a300 R15: 0000000000022000
 </TASK>
----------------
Code disassembly (best guess):
   0:	02 00                	add    (%rax),%al
   2:	0f 85 92 00 00 00    	jne    0x9a
   8:	8d 45 01             	lea    0x1(%rbp),%eax
   b:	89 43 10             	mov    %eax,0x10(%rbx)
   e:	48 8b 03             	mov    (%rbx),%rax
  11:	48 8d 2c e8          	lea    (%rax,%rbp,8),%rbp
  15:	48 b8 00 00 00 00 00 	movabs $0xdffffc0000000000,%rax
  1c:	fc ff df
  1f:	48 89 ea             	mov    %rbp,%rdx
  22:	48 c1 ea 03          	shr    $0x3,%rdx
  26:	80 3c 02 00          	cmpb   $0x0,(%rdx,%rax,1)
* 2a:	75 5c                	jne    0x88 <-- trapping instruction
  2c:	48 89 75 00          	mov    %rsi,0x0(%rbp)
  30:	8b 43 08             	mov    0x8(%rbx),%eax
  33:	39 43 10             	cmp    %eax,0x10(%rbx)
  36:	0f 92 c0             	setb   %al
  39:	48 83 c4 08          	add    $0x8,%rsp
  3d:	5b                   	pop    %rbx
  3e:	5d                   	pop    %rbp
  3f:	c3                   	retq