bisecting fixing commit since 3207316b3beec7e38e5dbe2f463df0cec71e0b97 building syzkaller on 79264ae39c1ef4b4875ab67d6f0c8c3e75aa6a34 testing commit 3207316b3beec7e38e5dbe2f463df0cec71e0b97 with gcc (GCC) 8.4.1 20210217 kernel signature: 4c01dbb654a72e9bbf7f94ebfc4d49b33f3bbc52072fa8bd6da62a2a03661327 run #0: crashed: inconsistent lock state in sco_sock_timeout run #1: crashed: inconsistent lock state in sco_sock_timeout run #2: crashed: inconsistent lock state in sco_sock_timeout run #3: crashed: inconsistent lock state in sco_sock_timeout run #4: crashed: inconsistent lock state in sco_sock_timeout run #5: crashed: inconsistent lock state in sco_sock_timeout run #6: crashed: inconsistent lock state in sco_sock_timeout run #7: crashed: inconsistent lock state in sco_sock_timeout run #8: crashed: inconsistent lock state in sco_conn_del run #9: crashed: inconsistent lock state in sco_conn_del run #10: crashed: inconsistent lock state in sco_conn_del run #11: crashed: inconsistent lock state in sco_conn_del run #12: crashed: inconsistent lock state in sco_conn_del run #13: crashed: inconsistent lock state in sco_conn_del run #14: crashed: inconsistent lock state in sco_conn_del run #15: crashed: inconsistent lock state in sco_conn_del run #16: crashed: inconsistent lock state in sco_conn_del run #17: crashed: WARNING: Unsupported flag value(s) of 0x%x in DT_FLAGS_1. run #18: crashed: inconsistent lock state in sco_conn_del run #19: crashed: WARNING: Unsupported flag value(s) of 0x%x in DT_FLAGS_1. testing current HEAD 2965db2e004cf9c92b87c1f559e9812c0ae878c1 testing commit 2965db2e004cf9c92b87c1f559e9812c0ae878c1 with gcc (GCC) 8.4.1 20210217 kernel signature: e5492f4842bfbf783c9e18fb01bfd5d77893f2bc30dc98f84a9a7d55590e3535 run #0: crashed: inconsistent lock state in sco_sock_timeout run #1: crashed: inconsistent lock state in sco_sock_timeout run #2: crashed: inconsistent lock state in sco_sock_timeout run #3: crashed: inconsistent lock state in sco_conn_del run #4: crashed: inconsistent lock state in sco_sock_timeout run #5: crashed: inconsistent lock state in sco_sock_timeout run #6: crashed: inconsistent lock state in sco_sock_timeout run #7: crashed: inconsistent lock state in sco_sock_timeout run #8: crashed: inconsistent lock state in sco_conn_del run #9: crashed: inconsistent lock state in sco_conn_del revisions tested: 2, total time: 35m35.944599122s (build: 15m10.635054274s, test: 19m56.983234629s) the crash still happens on HEAD commit msg: Linux 4.19.188 crash: inconsistent lock state in sco_conn_del ================================ WARNING: inconsistent lock state 4.19.188-syzkaller #0 Not tainted -------------------------------- inconsistent {IN-SOFTIRQ-W} -> {SOFTIRQ-ON-W} usage. syz-executor191/29432 [HC0[0]:SC0[0]:HE1:SE1] takes: 0000000070de4b4f (slock-AF_BLUETOOTH-BTPROTO_SCO){+.?.}, at: spin_lock include/linux/spinlock.h:329 [inline] 0000000070de4b4f (slock-AF_BLUETOOTH-BTPROTO_SCO){+.?.}, at: sco_conn_del+0xcc/0x170 net/bluetooth/sco.c:175 {IN-SOFTIRQ-W} state was registered at: lock_acquire+0x180/0x3a0 kernel/locking/lockdep.c:3907 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2d/0x40 kernel/locking/spinlock.c:144 spin_lock include/linux/spinlock.h:329 [inline] sco_sock_timeout+0x27/0x120 net/bluetooth/sco.c:82 call_timer_fn+0x14c/0x510 kernel/time/timer.c:1338 expire_timers+0x255/0x3a0 kernel/time/timer.c:1375 __run_timers kernel/time/timer.c:1696 [inline] run_timer_softirq+0x1dc/0x570 kernel/time/timer.c:1709 __do_softirq+0x25f/0x919 kernel/softirq.c:292 invoke_softirq kernel/softirq.c:372 [inline] irq_exit+0x17f/0x1c0 kernel/softirq.c:412 exiting_irq arch/x86/include/asm/apic.h:535 [inline] smp_apic_timer_interrupt+0x13e/0x540 arch/x86/kernel/apic/apic.c:1098 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894 native_safe_halt+0x12/0x20 arch/x86/include/asm/irqflags.h:60 arch_safe_halt arch/x86/include/asm/paravirt.h:94 [inline] default_idle+0x51/0x310 arch/x86/kernel/process.c:557 arch_cpu_idle+0xa/0x10 arch/x86/kernel/process.c:548 default_idle_call+0x6d/0x90 kernel/sched/idle.c:93 cpuidle_idle_call kernel/sched/idle.c:153 [inline] do_idle+0x451/0x570 kernel/sched/idle.c:263 cpu_startup_entry+0xc8/0xe0 kernel/sched/idle.c:369 start_secondary+0x459/0x5d0 arch/x86/kernel/smpboot.c:271 secondary_startup_64+0xa4/0xb0 arch/x86/kernel/head_64.S:243 irq event stamp: 2279 hardirqs last enabled at (2279): [] __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:168 [inline] hardirqs last enabled at (2279): [] _raw_spin_unlock_irq+0x27/0x90 kernel/locking/spinlock.c:192 hardirqs last disabled at (2278): [] __raw_spin_lock_irq include/linux/spinlock_api_smp.h:126 [inline] hardirqs last disabled at (2278): [] _raw_spin_lock_irq+0x3c/0x90 kernel/locking/spinlock.c:160 softirqs last enabled at (0): [] copy_process.part.2+0x176b/0x7960 kernel/fork.c:1855 softirqs last disabled at (0): [<0000000000000000>] (null) other info that might help us debug this: Possible unsafe locking scenario: CPU0 ---- lock(slock-AF_BLUETOOTH-BTPROTO_SCO); lock(slock-AF_BLUETOOTH-BTPROTO_SCO); *** DEADLOCK *** 3 locks held by syz-executor191/29432: #0: 0000000085721330 (&hdev->req_lock){+.+.}, at: hci_dev_do_close+0x17a/0xe10 net/bluetooth/hci_core.c:1618 #1: 0000000072917a10 (&hdev->lock){+.+.}, at: hci_dev_do_close+0x278/0xe10 net/bluetooth/hci_core.c:1655 #2: 00000000bbf6cbce (hci_cb_list_lock){+.+.}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:1258 [inline] #2: 00000000bbf6cbce (hci_cb_list_lock){+.+.}, at: hci_conn_hash_flush+0xd0/0x230 net/bluetooth/hci_conn.c:1512 stack backtrace: CPU: 1 PID: 29432 Comm: syz-executor191 Not tainted 4.19.188-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x17c/0x226 lib/dump_stack.c:118 print_usage_bug.cold.38+0x433/0x563 kernel/locking/lockdep.c:2544 valid_state kernel/locking/lockdep.c:2557 [inline] mark_lock_irq kernel/locking/lockdep.c:2751 [inline] mark_lock+0xd44/0x12f0 kernel/locking/lockdep.c:3131 mark_irqflags kernel/locking/lockdep.c:3027 [inline] __lock_acquire+0x732/0x47c0 kernel/locking/lockdep.c:3372 lock_acquire+0x180/0x3a0 kernel/locking/lockdep.c:3907 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2d/0x40 kernel/locking/spinlock.c:144 spin_lock include/linux/spinlock.h:329 [inline] sco_conn_del+0xcc/0x170 net/bluetooth/sco.c:175 sco_disconn_cfm net/bluetooth/sco.c:1133 [inline] sco_disconn_cfm+0x56/0x90 net/bluetooth/sco.c:1126 hci_disconn_cfm include/net/bluetooth/hci_core.h:1261 [inline] hci_conn_hash_flush+0x114/0x230 net/bluetooth/hci_conn.c:1512 hci_dev_do_close+0x57e/0xe10 net/bluetooth/hci_core.c:1668 hci_unregister_dev+0x167/0x890 net/bluetooth/hci_core.c:3273 vhci_release+0x6b/0xe0 drivers/bluetooth/hci_vhci.c:354 __fput+0x249/0x7f0 fs/file_table.c:278 ____fput+0x9/0x10 fs/file_table.c:309 task_work_run+0x108/0x180 kernel/task_work.c:113 exit_task_work include/linux/task_work.h:22 [inline] do_exit+0xa6a/0x2d90 kernel/exit.c:870 do_group_exit+0xf8/0x2c0 kernel/exit.c:967 get_signal+0x30b/0x1970 kernel/signal.c:2589 do_signal+0x87/0x1870 arch/x86/kernel/signal.c:799 exit_to_usermode_loop+0x159/0x1e0 arch/x86/entry/common.c:163 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x413/0x4e0 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x44af09 Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 61 16 00 00 90 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 b8 ff ff ff f7 d8 64 89 01 48 RSP: 002b:00007fedbb5b32e8 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00000000004d72a0 RCX: 000000000044af09 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00000000004d72a8 RBP: 00000000004a04e8 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffe901bfa7e R13: 0000000000000000 R14: 00007fedbb5b3400 R15: 00000000004d72a8 batman_adv: batadv0: Interface deactivated: batadv_slave_0 batman_adv: batadv0: Removing interface: batadv_slave_0 batman_adv: batadv0: Interface deactivated: batadv_slave_1 batman_adv: batadv0: Removing interface: batadv_slave_1 device bridge_slave_1 left promiscuous mode bridge0: port 2(bridge_slave_1) entered disabled state device bridge_slave_0 left promiscuous mode bridge0: port 1(bridge_slave_0) entered disabled state device veth1_macvtap left promiscuous mode device veth0_macvtap left promiscuous mode device veth1_vlan left promiscuous mode device veth0_vlan left promiscuous mode Bluetooth: hci4: command 0x0407 tx timeout device hsr_slave_1 left promiscuous mode device hsr_slave_0 left promiscuous mode team0 (unregistering): Port device team_slave_1 removed team0 (unregistering): Port device team_slave_0 removed bond0 (unregistering): Releasing backup interface bond_slave_1 bond0 (unregistering): Releasing backup interface bond_slave_0 bond0 (unregistering): Released all slaves batman_adv: batadv0: Interface deactivated: batadv_slave_0 batman_adv: batadv0: Removing interface: batadv_slave_0 batman_adv: batadv0: Interface deactivated: batadv_slave_1 batman_adv: batadv0: Removing interface: batadv_slave_1 device bridge_slave_1 left promiscuous mode bridge0: port 2(bridge_slave_1) entered disabled state device bridge_slave_0 left promiscuous mode bridge0: port 1(bridge_slave_0) entered disabled state device veth1_macvtap left promiscuous mode device veth0_macvtap left promiscuous mode device veth1_vlan left promiscuous mode device veth0_vlan left promiscuous mode