Bluetooth: hci3: unexpected cc 0x0c03 length: 249 > 1 ====================================================== WARNING: possible circular locking dependency detected 6.10.0-rc2-syzkaller-00222-gd30d0e49da71 #0 Not tainted ------------------------------------------------------ kworker/u33:6/5224 is trying to acquire lock: ffff88806b329558 (krc.lock){..-.}-{2:2}, at: krc_this_cpu_lock kernel/rcu/tree.c:3298 [inline] ffff88806b329558 (krc.lock){..-.}-{2:2}, at: add_ptr_to_bulk_krc_lock kernel/rcu/tree.c:3697 [inline] ffff88806b329558 (krc.lock){..-.}-{2:2}, at: kvfree_call_rcu+0xda/0xbe0 kernel/rcu/tree.c:3782 but task is already holding lock: ffff88806b32a858 (&base->lock){-.-.}-{2:2}, at: lock_timer_base+0x5d/0x220 kernel/time/timer.c:1051 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 (&base->lock){-.-.}-{2:2}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0x3a/0x60 kernel/locking/spinlock.c:162 lock_timer_base+0x5d/0x220 kernel/time/timer.c:1051 __mod_timer+0x426/0xdc0 kernel/time/timer.c:1132 add_timer_global+0x8a/0xc0 kernel/time/timer.c:1330 __queue_delayed_work+0x1ba/0x2e0 kernel/workqueue.c:2543 queue_delayed_work_on+0x12a/0x150 kernel/workqueue.c:2572 kvfree_call_rcu+0x749/0xbe0 kernel/rcu/tree.c:3810 rtnl_register_internal+0x343/0x670 net/core/rtnetlink.c:265 rtnl_register+0x34/0x80 net/core/rtnetlink.c:315 ip_rt_init+0x34a/0x450 net/ipv4/route.c:3696 ip_init+0xe/0x20 net/ipv4/ip_output.c:1663 inet_init+0x3f0/0x6f0 net/ipv4/af_inet.c:1983 do_one_initcall+0x128/0x700 init/main.c:1267 do_initcall_level init/main.c:1329 [inline] do_initcalls init/main.c:1345 [inline] do_basic_setup init/main.c:1364 [inline] kernel_init_freeable+0x69d/0xca0 init/main.c:1578 kernel_init+0x1c/0x2b0 init/main.c:1467 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 -> #0 (krc.lock){..-.}-{2:2}: check_prev_add kernel/locking/lockdep.c:3134 [inline] check_prevs_add kernel/locking/lockdep.c:3253 [inline] validate_chain kernel/locking/lockdep.c:3869 [inline] __lock_acquire+0x2478/0x3b30 kernel/locking/lockdep.c:5137 lock_acquire kernel/locking/lockdep.c:5754 [inline] lock_acquire+0x1b1/0x560 kernel/locking/lockdep.c:5719 __raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline] _raw_spin_lock+0x2e/0x40 kernel/locking/spinlock.c:154 krc_this_cpu_lock kernel/rcu/tree.c:3298 [inline] add_ptr_to_bulk_krc_lock kernel/rcu/tree.c:3697 [inline] kvfree_call_rcu+0xda/0xbe0 kernel/rcu/tree.c:3782 trie_delete_elem+0x5c5/0x820 kernel/bpf/lpm_trie.c:540 ___bpf_prog_run+0x3e51/0xabd0 kernel/bpf/core.c:2012 __bpf_prog_run32+0xc1/0x100 kernel/bpf/core.c:2253 bpf_dispatcher_nop_func include/linux/bpf.h:1243 [inline] __bpf_prog_run include/linux/filter.h:691 [inline] bpf_prog_run include/linux/filter.h:698 [inline] __bpf_trace_run kernel/trace/bpf_trace.c:2403 [inline] bpf_trace_run2+0x231/0x590 kernel/trace/bpf_trace.c:2444 __bpf_trace_timer_start+0xc7/0x100 include/trace/events/timer.h:52 trace_timer_start include/trace/events/timer.h:52 [inline] enqueue_timer+0x2b4/0x550 kernel/time/timer.c:663 internal_add_timer kernel/time/timer.c:688 [inline] __mod_timer+0x8d7/0xdc0 kernel/time/timer.c:1183 add_timer_global+0x8a/0xc0 kernel/time/timer.c:1330 __queue_delayed_work+0x1ba/0x2e0 kernel/workqueue.c:2543 queue_delayed_work_on+0x12a/0x150 kernel/workqueue.c:2572 queue_delayed_work include/linux/workqueue.h:636 [inline] hci_cmd_work+0x380/0x710 net/bluetooth/hci_core.c:4150 process_one_work+0x9fb/0x1b60 kernel/workqueue.c:3231 process_scheduled_works kernel/workqueue.c:3312 [inline] worker_thread+0x6c8/0xf70 kernel/workqueue.c:3393 kthread+0x2c1/0x3a0 kernel/kthread.c:389 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 other info that might help us debug this: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&base->lock); lock(krc.lock); lock(&base->lock); lock(krc.lock); *** DEADLOCK *** 5 locks held by kworker/u33:6/5224: #0: ffff88802d5fd948 ((wq_completion)hci3#2){+.+.}-{0:0}, at: process_one_work+0x12bf/0x1b60 kernel/workqueue.c:3206 #1: ffffc90003507d80 ((work_completion)(&hdev->cmd_work)){+.+.}-{0:0}, at: process_one_work+0x957/0x1b60 kernel/workqueue.c:3207 #2: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:329 [inline] #2: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:781 [inline] #2: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: hci_cmd_work+0x272/0x710 net/bluetooth/hci_core.c:4145 #3: ffff88806b32a858 (&base->lock){-.-.}-{2:2}, at: lock_timer_base+0x5d/0x220 kernel/time/timer.c:1051 #4: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:329 [inline] #4: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:781 [inline] #4: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: __bpf_trace_run kernel/trace/bpf_trace.c:2402 [inline] #4: ffffffff8dbb1920 (rcu_read_lock){....}-{1:2}, at: bpf_trace_run2+0x1c2/0x590 kernel/trace/bpf_trace.c:2444 stack backtrace: CPU: 3 PID: 5224 Comm: kworker/u33:6 Not tainted 6.10.0-rc2-syzkaller-00222-gd30d0e49da71 #0 Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Workqueue: hci3 hci_cmd_work Call Trace: __dump_stack lib/dump_stack.c:88 [inline] dump_stack_lvl+0x116/0x1f0 lib/dump_stack.c:114 check_noncircular+0x31a/0x400 kernel/locking/lockdep.c:2187 check_prev_add kernel/locking/lockdep.c:3134 [inline] check_prevs_add kernel/locking/lockdep.c:3253 [inline] validate_chain kernel/locking/lockdep.c:3869 [inline] __lock_acquire+0x2478/0x3b30 kernel/locking/lockdep.c:5137 lock_acquire kernel/locking/lockdep.c:5754 [inline] lock_acquire+0x1b1/0x560 kernel/locking/lockdep.c:5719 __raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline] _raw_spin_lock+0x2e/0x40 kernel/locking/spinlock.c:154 krc_this_cpu_lock kernel/rcu/tree.c:3298 [inline] add_ptr_to_bulk_krc_lock kernel/rcu/tree.c:3697 [inline] kvfree_call_rcu+0xda/0xbe0 kernel/rcu/tree.c:3782 trie_delete_elem+0x5c5/0x820 kernel/bpf/lpm_trie.c:540 ___bpf_prog_run+0x3e51/0xabd0 kernel/bpf/core.c:2012 __bpf_prog_run32+0xc1/0x100 kernel/bpf/core.c:2253 bpf_dispatcher_nop_func include/linux/bpf.h:1243 [inline] __bpf_prog_run include/linux/filter.h:691 [inline] bpf_prog_run include/linux/filter.h:698 [inline] __bpf_trace_run kernel/trace/bpf_trace.c:2403 [inline] bpf_trace_run2+0x231/0x590 kernel/trace/bpf_trace.c:2444 __bpf_trace_timer_start+0xc7/0x100 include/trace/events/timer.h:52 trace_timer_start include/trace/events/timer.h:52 [inline] enqueue_timer+0x2b4/0x550 kernel/time/timer.c:663 internal_add_timer kernel/time/timer.c:688 [inline] __mod_timer+0x8d7/0xdc0 kernel/time/timer.c:1183 add_timer_global+0x8a/0xc0 kernel/time/timer.c:1330 __queue_delayed_work+0x1ba/0x2e0 kernel/workqueue.c:2543 queue_delayed_work_on+0x12a/0x150 kernel/workqueue.c:2572 queue_delayed_work include/linux/workqueue.h:636 [inline] hci_cmd_work+0x380/0x710 net/bluetooth/hci_core.c:4150 process_one_work+0x9fb/0x1b60 kernel/workqueue.c:3231 process_scheduled_works kernel/workqueue.c:3312 [inline] worker_thread+0x6c8/0xf70 kernel/workqueue.c:3393 kthread+0x2c1/0x3a0 kernel/kthread.c:389 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 Bluetooth: hci3: unexpected cc 0x1003 length: 249 > 9 Bluetooth: hci3: unexpected cc 0x1001 length: 249 > 9 Bluetooth: hci3: unexpected cc 0x0c23 length: 249 > 4 Bluetooth: hci3: unexpected cc 0x0c25 length: 249 > 3 Bluetooth: hci3: unexpected cc 0x0c38 length: 249 > 2 Bluetooth: hci0: command tx timeout Bluetooth: hci1: command tx timeout Bluetooth: hci1: command tx timeout