[ 3514.073743] run fstests btrfs/115 at 2023-09-25 21:52:32
[ 3514.528074] BTRFS: device fsid ec3e1159-917e-46d6-82d2-6d36aac552b0 devid 1 transid 2800158 /dev/mapper/vg0-lv0 scanned by mount (440930)
[ 3514.528877] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[ 3514.528884] BTRFS info (device dm-0): using free space tree
[ 3514.532722] BTRFS info (device dm-0): auto enabling async discard
[ 3514.753452] BTRFS: device fsid a5dc5890-3e6e-48b8-8007-74cbd243127c devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mount (440987)
[ 3514.754316] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[ 3514.754324] BTRFS info (device dm-9): turning on async discard
[ 3514.754326] BTRFS info (device dm-9): disk space caching is enabled
[ 3514.759245] BTRFS info (device dm-9): checking UUID tree
[ 3543.430609] 115 (440802): drop_caches: 3

[ 3544.371597] ======================================================
[ 3544.371908] WARNING: possible circular locking dependency detected
[ 3544.372228] 6.6.0-rc3+ #1313 Not tainted
[ 3544.372433] ------------------------------------------------------
[ 3544.372745] btrfs/441007 is trying to acquire lock:
[ 3544.372996] ffff8d5f504c4868 (&fs_info->cleaner_mutex){+.+.}-{3:3}, at: btrfs_quota_disable+0x3c/0x4b0
[ 3544.373474] 
               but task is already holding lock:
[ 3544.373771] ffff8d5f504c4be8 (&fs_info->subvol_sem){++++}-{3:3}, at: btrfs_ioctl+0x1a44/0x28b0
[ 3544.374211] 
               which lock already depends on the new lock.

[ 3544.374619] 
               the existing dependency chain (in reverse order) is:
[ 3544.374993] 
               -> #3 (&fs_info->subvol_sem){++++}-{3:3}:
[ 3544.375329]        down_read+0x3e/0x180
[ 3544.375531]        btrfs_rename+0x586/0xa90
[ 3544.375747]        btrfs_rename2+0x2e/0x70
[ 3544.375962]        vfs_rename+0x443/0xa30
[ 3544.376171]        do_renameat2+0x34c/0x530
[ 3544.376402]        __x64_sys_rename+0x40/0x50
[ 3544.376629]        do_syscall_64+0x38/0x90
[ 3544.376843]        entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 3544.377127] 
               -> #2 (&sb->s_type->i_mutex_key#15/4){+.+.}-{3:3}:
[ 3544.377502]        down_write_nested+0x41/0xe0
[ 3544.377736]        btrfs_remap_file_range+0x5b/0x4d0
[ 3544.377992]        vfs_copy_file_range+0x2f0/0x630
[ 3544.378243]        __do_sys_copy_file_range+0xc4/0x1f0
[ 3544.378507]        do_syscall_64+0x38/0x90
[ 3544.378719]        entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 3544.379003] 
               -> #1 (&sb->s_type->i_mutex_key#15){++++}-{3:3}:
[ 3544.379367]        down_write+0x3b/0xd0
[ 3544.379569]        btrfs_inode_lock+0x3c/0x70
[ 3544.379794]        prealloc_file_extent_cluster+0x9f/0x310
[ 3544.380073]        relocate_file_extent_cluster+0x8d/0x950
[ 3544.380357]        relocate_data_extent+0x115/0x170
[ 3544.380610]        relocate_block_group+0x4a8/0x590
[ 3544.380861]        btrfs_relocate_block_group+0x28f/0x3d0
[ 3544.381136]        btrfs_relocate_chunk+0x4c/0x1b0
[ 3544.381396]        btrfs_balance+0x8e7/0x11d0
[ 3544.381624]        btrfs_ioctl+0x1bb4/0x28b0
[ 3544.381849]        __x64_sys_ioctl+0x8b/0xc0
[ 3544.382076]        do_syscall_64+0x38/0x90
[ 3544.382295]        entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 3544.382579] 
               -> #0 (&fs_info->cleaner_mutex){+.+.}-{3:3}:
[ 3544.382923]        __lock_acquire+0x1415/0x2190
[ 3544.383159]        lock_acquire+0xc7/0x2b0
[ 3544.383379]        __mutex_lock+0x75/0xce0
[ 3544.383592]        btrfs_quota_disable+0x3c/0x4b0
[ 3544.383836]        btrfs_ioctl+0x2193/0x28b0
[ 3544.384059]        __x64_sys_ioctl+0x8b/0xc0
[ 3544.384287]        do_syscall_64+0x38/0x90
[ 3544.384501]        entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 3544.384785] 
               other info that might help us debug this:

[ 3544.385181] Chain exists of:
                 &fs_info->cleaner_mutex --> &sb->s_type->i_mutex_key#15/4 --> &fs_info->subvol_sem

[ 3544.385836]  Possible unsafe locking scenario:

[ 3544.386134]        CPU0                    CPU1
[ 3544.386372]        ----                    ----
[ 3544.386606]   lock(&fs_info->subvol_sem);
[ 3544.386815]                                lock(&sb->s_type->i_mutex_key#15/4);
[ 3544.387186]                                lock(&fs_info->subvol_sem);
[ 3544.387520]   lock(&fs_info->cleaner_mutex);
[ 3544.387746] 
                *** DEADLOCK ***

[ 3544.388049] 2 locks held by btrfs/441007:
[ 3544.388303]  #0: ffff8d5e33c60410 (sb_writers#12){.+.+}-{0:0}, at: btrfs_ioctl+0x3c8/0x28b0
[ 3544.388727]  #1: ffff8d5f504c4be8 (&fs_info->subvol_sem){++++}-{3:3}, at: btrfs_ioctl+0x1a44/0x28b0
[ 3544.389191] 
               stack backtrace:
[ 3544.389463] CPU: 1 PID: 441007 Comm: btrfs Not tainted 6.6.0-rc3+ #1313
[ 3544.389798] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 3544.390229] Call Trace:
[ 3544.390406]  
[ 3544.390526]  dump_stack_lvl+0x58/0x90
[ 3544.390723]  check_noncircular+0x101/0x110
[ 3544.390937]  ? get_page_from_freelist+0x1120/0x1a00
[ 3544.391190]  __lock_acquire+0x1415/0x2190
[ 3544.391408]  lock_acquire+0xc7/0x2b0
[ 3544.391598]  ? btrfs_quota_disable+0x3c/0x4b0
[ 3544.391830]  __mutex_lock+0x75/0xce0
[ 3544.392020]  ? btrfs_quota_disable+0x3c/0x4b0
[ 3544.392253]  ? btrfs_quota_disable+0x3c/0x4b0
[ 3544.392482]  ? lock_is_held_type+0xe2/0x140
[ 3544.392703]  btrfs_quota_disable+0x3c/0x4b0
[ 3544.392922]  btrfs_ioctl+0x2193/0x28b0
[ 3544.393180]  ? ioctl_has_perm.constprop.0.isra.0+0x9e/0xf0
[ 3544.393475]  ? lock_release+0x134/0x270
[ 3544.393682]  ? __x64_sys_ioctl+0x8b/0xc0
[ 3544.393891]  __x64_sys_ioctl+0x8b/0xc0
[ 3544.394092]  do_syscall_64+0x38/0x90
[ 3544.394290]  entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 3544.394556] RIP: 0033:0x7fb183b954cb
[ 3544.394749] Code: 89 d8 49 8d 3c 1c 48 f7 d8 49 39 c4 72 b5 e8 1c ff ff ff 85 c0 78 ba 4c 89 e0 5b 5d 41 5c c3 f3 0f 1e fa b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 7d b9 0c 00 f7 d8 64 89 01 48
[ 3544.395678] RSP: 002b:00007ffe17b81528 EFLAGS: 00000206 ORIG_RAX: 0000000000000010
[ 3544.396062] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fb183b954cb
[ 3544.396431] RDX: 00007ffe17b81540 RSI: 00000000c0109428 RDI: 0000000000000003
[ 3544.396795] RBP: 0000000000000003 R08: 00000000013802a0 R09: 00007fb183c61a60
[ 3544.397157] R10: fffffffffffffb0e R11: 0000000000000206 R12: 00007ffe17b82ce1
[ 3544.397525] R13: 0000000000000001 R14: 0000000000498099 R15: 00007ffe17b816e8
[ 3544.397894]  
[ 3544.399077] BTRFS info (device dm-9): qgroup scan paused
[ 3545.914433] BTRFS: device fsid a5dc5890-3e6e-48b8-8007-74cbd243127c devid 1 transid 10 /dev/mapper/vg0-lv9 scanned by mount (441026)
[ 3545.915862] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[ 3545.916189] BTRFS info (device dm-9): turning on async discard
[ 3545.916417] BTRFS info (device dm-9): disk space caching is enabled