RBP: 00007f55bb096040 R08: 00007f55bb096040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000206 R12: 0000000020000000
R13: 0000000020000100 R14: 00007f55bb096000 R15: 0000000020011300
======================================================
WARNING: possible circular locking dependency detected
5.10.214 #1 Not tainted
------------------------------------------------------
syz-executor.6/10368 is trying to acquire lock:
ffff888017ce4ae8 ((work_completion)(&hdev->tx_work)){+.+.}-{0:0}, at: __flush_work+0xdd/0xa90 kernel/workqueue.c:3050
but task is already holding lock:
ffff888017ce4f40 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close+0xef/0x1240 net/bluetooth/hci_core.c:1734
which lock already depends on the new lock.
the existing dependency chain (in reverse order) is:
-> #3 (&hdev->req_lock){+.+.}-{3:3}:
__mutex_lock_common kernel/locking/mutex.c:968 [inline]
__mutex_lock+0x13d/0x10b0 kernel/locking/mutex.c:1109
hci_dev_do_close+0xef/0x1240 net/bluetooth/hci_core.c:1734
hci_rfkill_set_block+0x166/0x1a0 net/bluetooth/hci_core.c:2223
rfkill_set_block+0x1fd/0x540 net/rfkill/core.c:341
rfkill_fop_write+0x253/0x4b0 net/rfkill/core.c:1240
vfs_write+0x29a/0xa70 fs/read_write.c:603
ksys_write+0x1f6/0x260 fs/read_write.c:658
do_syscall_64+0x33/0x40 arch/x86/entry/common.c:46
entry_SYSCALL_64_after_hwframe+0x62/0xc7
-> #2 (rfkill_global_mutex){+.+.}-{3:3}:
__mutex_lock_common kernel/locking/mutex.c:968 [inline]
__mutex_lock+0x13d/0x10b0 kernel/locking/mutex.c:1109
rfkill_register+0x36/0xa10 net/rfkill/core.c:1016
hci_register_dev+0x42e/0xc00 net/bluetooth/hci_core.c:3774
__vhci_create_device+0x2c8/0x5c0 drivers/bluetooth/hci_vhci.c:129
vhci_create_device drivers/bluetooth/hci_vhci.c:153 [inline]
vhci_open_timeout+0x38/0x50 drivers/bluetooth/hci_vhci.c:310
process_one_work+0x9a9/0x14b0 kernel/workqueue.c:2282
worker_thread+0x61d/0x1310 kernel/workqueue.c:2428
kthread+0x38f/0x470 kernel/kthread.c:313
ret_from_fork+0x22/0x30 arch/x86/entry/entry_64.S:299
-> #1 (&data->open_mutex){+.+.}-{3:3}:
__mutex_lock_common kernel/locking/mutex.c:968 [inline]
__mutex_lock+0x13d/0x10b0 kernel/locking/mutex.c:1109
vhci_send_frame+0x63/0xa0 drivers/bluetooth/hci_vhci.c:71
hci_send_frame+0x1b9/0x320 net/bluetooth/hci_core.c:4061
hci_sched_acl_pkt net/bluetooth/hci_core.c:4586 [inline]
hci_sched_acl net/bluetooth/hci_core.c:4671 [inline]
hci_tx_work+0x10af/0x1660 net/bluetooth/hci_core.c:4742
process_one_work+0x9a9/0x14b0 kernel/workqueue.c:2282
worker_thread+0x61d/0x1310 kernel/workqueue.c:2428
kthread+0x38f/0x470 kernel/kthread.c:313
ret_from_fork+0x22/0x30 arch/x86/entry/entry_64.S:299
-> #0 ((work_completion)(&hdev->tx_work)){+.+.}-{0:0}:
check_prev_add kernel/locking/lockdep.c:2988 [inline]
check_prevs_add kernel/locking/lockdep.c:3113 [inline]
validate_chain kernel/locking/lockdep.c:3729 [inline]
__lock_acquire+0x29e7/0x5b00 kernel/locking/lockdep.c:4955
lock_acquire kernel/locking/lockdep.c:5566 [inline]
lock_acquire+0x197/0x470 kernel/locking/lockdep.c:5531
__flush_work+0x105/0xa90 kernel/workqueue.c:3053
hci_dev_do_close+0x131/0x1240 net/bluetooth/hci_core.c:1745
hci_rfkill_set_block+0x166/0x1a0 net/bluetooth/hci_core.c:2223
rfkill_set_block+0x1fd/0x540 net/rfkill/core.c:341
rfkill_fop_write+0x253/0x4b0 net/rfkill/core.c:1240
vfs_write+0x29a/0xa70 fs/read_write.c:603
ksys_write+0x1f6/0x260 fs/read_write.c:658
do_syscall_64+0x33/0x40 arch/x86/entry/common.c:46
entry_SYSCALL_64_after_hwframe+0x62/0xc7
other info that might help us debug this:
Chain exists of:
(work_completion)(&hdev->tx_work) --> rfkill_global_mutex --> &hdev->req_lock
Possible unsafe locking scenario:
CPU0 CPU1
---- ----
lock(&hdev->req_lock);
lock(rfkill_global_mutex);
lock(&hdev->req_lock);
lock((work_completion)(&hdev->tx_work));
*** DEADLOCK ***
2 locks held by syz-executor.6/10368:
#0: ffffffff8561a8c8 (rfkill_global_mutex){+.+.}-{3:3}, at: rfkill_fop_write+0xff/0x4b0 net/rfkill/core.c:1232
#1: ffff888017ce4f40 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close+0xef/0x1240 net/bluetooth/hci_core.c:1734
stack backtrace:
CPU: 0 PID: 10368 Comm: syz-executor.6 Not tainted 5.10.214 #1
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x107/0x167 lib/dump_stack.c:118
check_noncircular+0x263/0x2e0 kernel/locking/lockdep.c:2123
check_prev_add kernel/locking/lockdep.c:2988 [inline]
check_prevs_add kernel/locking/lockdep.c:3113 [inline]
validate_chain kernel/locking/lockdep.c:3729 [inline]
__lock_acquire+0x29e7/0x5b00 kernel/locking/lockdep.c:4955
lock_acquire kernel/locking/lockdep.c:5566 [inline]
lock_acquire+0x197/0x470 kernel/locking/lockdep.c:5531
__flush_work+0x105/0xa90 kernel/workqueue.c:3053
hci_dev_do_close+0x131/0x1240 net/bluetooth/hci_core.c:1745
hci_rfkill_set_block+0x166/0x1a0 net/bluetooth/hci_core.c:2223
rfkill_set_block+0x1fd/0x540 net/rfkill/core.c:341
rfkill_fop_write+0x253/0x4b0 net/rfkill/core.c:1240
vfs_write+0x29a/0xa70 fs/read_write.c:603
ksys_write+0x1f6/0x260 fs/read_write.c:658
do_syscall_64+0x33/0x40 arch/x86/entry/common.c:46
entry_SYSCALL_64_after_hwframe+0x62/0xc7
RIP: 0033:0x7fca6d1c5b19
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:00007fca6a71a188 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 00007fca6d2d9020 RCX: 00007fca6d1c5b19
RDX: 0000000000000008 RSI: 0000000020000080 RDI: 0000000000000004
RBP: 00007fca6d21ff6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffccc72766f R14: 00007fca6a71a300 R15: 0000000000022000
mmap: syz-executor.7 (10377) uses deprecated remap_file_pages() syscall. See Documentation/vm/remap_file_pages.rst.
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
print_req_error: 39 callbacks suppressed
blk_update_request: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
buffer_io_error: 38 callbacks suppressed
Buffer I/O error on dev sr0, logical block 0, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 1 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 1, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 2 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 2, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 3 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 3, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 4 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 4, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 5 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 5, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 6 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 6, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 7 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 7, async page read
netlink: 8 bytes leftover after parsing attributes in process `syz-executor.7'.
ieee80211 phy54: Selected rate control algorithm 'minstrel_ht'
SELinux: unrecognized netlink message: protocol=0 nlmsg_type=63809 sclass=netlink_route_socket pid=10383 comm=syz-executor.2
FAULT_INJECTION: forcing a failure.
name failslab, interval 1, probability 0, space 0, times 0
CPU: 0 PID: 10387 Comm: syz-executor.3 Not tainted 5.10.214 #1
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0x107/0x167 lib/dump_stack.c:118
fail_dump lib/fault-inject.c:52 [inline]
should_fail.cold+0x5/0xa lib/fault-inject.c:146
should_failslab+0x5/0x20 mm/slab_common.c:1193
slab_pre_alloc_hook mm/slab.h:515 [inline]
slab_alloc_node mm/slub.c:2821 [inline]
slab_alloc mm/slub.c:2904 [inline]
kmem_cache_alloc+0x5b/0x310 mm/slub.c:2909
mem_pool_alloc mm/kmemleak.c:423 [inline]
create_object.isra.0+0x3a/0xa20 mm/kmemleak.c:578
kmemleak_alloc_recursive include/linux/kmemleak.h:43 [inline]
slab_post_alloc_hook mm/slab.h:534 [inline]
slab_alloc_node mm/slub.c:2896 [inline]
slab_alloc mm/slub.c:2904 [inline]
__kmalloc_track_caller+0x177/0x370 mm/slub.c:4465
memdup_user+0x22/0xd0 mm/util.c:173
strndup_user+0x74/0xe0 mm/util.c:232
copy_mount_string fs/namespace.c:3148 [inline]
__do_sys_mount fs/namespace.c:3446 [inline]
__se_sys_mount fs/namespace.c:3438 [inline]
__x64_sys_mount+0x133/0x300 fs/namespace.c:3438
do_syscall_64+0x33/0x40 arch/x86/entry/common.c:46
entry_SYSCALL_64_after_hwframe+0x62/0xc7
RIP: 0033:0x7f55bdb2204a
Code: 48 c7 c2 bc ff ff ff f7 d8 64 89 02 b8 ff ff ff ff eb d2 e8 b8 04 00 00 0f 1f 84 00 00 00 00 00 49 89 ca b8 a5 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:00007f55bb095fa8 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 0000000020000200 RCX: 00007f55bdb2204a
RDX: 0000000020000000 RSI: 0000000020000100 RDI: 00007f55bb096000
RBP: 00007f55bb096040 R08: 00007f55bb096040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000206 R12: 0000000020000000
R13: 0000000020000100 R14: 00007f55bb096000 R15: 0000000020011300
FAT-fs (loop3): Invalid FSINFO signature: 0x00000000, 0x00000000 (sector = 1)
FAT-fs (loop3): error, fat_get_cluster: invalid start cluster (i_pos 1, start 00000001)
FAT-fs (loop3): Filesystem has been set read-only
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 0, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
blk_update_request: I/O error, dev sr0, sector 1 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 0
Buffer I/O error on dev sr0, logical block 1, async page read
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
sr 1:0:0:0: [sr0] tag#0 unaligned transfer
sr 1:0:0:0: [sr0] tag#0 unaligned transfer