overlayfs: fs on 'file0' does not support file handles, falling back to index=off. overlayfs: fs on './file0' does not support file handles, falling back to index=off. ====================================================== WARNING: possible circular locking dependency detected 4.14.306-syzkaller #0 Not tainted ------------------------------------------------------ syz-executor.4/10653 is trying to acquire lock: (&ovl_i_mutex_dir_key[depth]){++++}, at: [] iterate_dir+0x387/0x5e0 fs/readdir.c:43 but task is already holding lock: (sb_writers#3){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] (sb_writers#3){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 (sb_writers#3){.+.+}: percpu_down_read_preempt_disable include/linux/percpu-rwsem.h:36 [inline] percpu_down_read include/linux/percpu-rwsem.h:59 [inline] __sb_start_write+0x64/0x260 fs/super.c:1342 sb_start_write include/linux/fs.h:1551 [inline] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 ovl_create_object+0x75/0x1d0 fs/overlayfs/dir.c:538 lookup_open+0x77a/0x1750 fs/namei.c:3241 do_last fs/namei.c:3334 [inline] path_openat+0xe08/0x2970 fs/namei.c:3571 do_filp_open+0x179/0x3c0 fs/namei.c:3605 do_sys_open+0x296/0x410 fs/open.c:1081 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 -> #0 (&ovl_i_mutex_dir_key[depth]){++++}: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 down_write_killable+0x37/0xb0 kernel/locking/rwsem.c:68 iterate_dir+0x387/0x5e0 fs/readdir.c:43 ovl_dir_read fs/overlayfs/readdir.c:306 [inline] ovl_dir_read_merged+0x2c5/0x430 fs/overlayfs/readdir.c:365 ovl_check_empty_dir+0x6e/0x200 fs/overlayfs/readdir.c:870 ovl_check_empty_and_clear+0x72/0xe0 fs/overlayfs/dir.c:306 ovl_remove_and_whiteout fs/overlayfs/dir.c:647 [inline] ovl_do_remove+0x565/0xb90 fs/overlayfs/dir.c:775 vfs_rmdir.part.0+0x144/0x390 fs/namei.c:3910 vfs_rmdir fs/namei.c:3895 [inline] do_rmdir+0x334/0x3c0 fs/namei.c:3970 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 other info that might help us debug this: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(sb_writers#3); lock(&ovl_i_mutex_dir_key[depth]); lock(sb_writers#3); lock(&ovl_i_mutex_dir_key[depth]); *** DEADLOCK *** 4 locks held by syz-executor.4/10653: #0: (sb_writers#17){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#17){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&ovl_i_mutex_dir_key[depth]#2/1){+.+.}, at: [] inode_lock_nested include/linux/fs.h:754 [inline] #1: (&ovl_i_mutex_dir_key[depth]#2/1){+.+.}, at: [] do_rmdir+0x1de/0x3c0 fs/namei.c:3958 #2: (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] inode_lock include/linux/fs.h:719 [inline] #2: (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] vfs_rmdir.part.0+0x5c/0x390 fs/namei.c:3899 #3: (sb_writers#3){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #3: (sb_writers#3){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 stack backtrace: CPU: 1 PID: 10653 Comm: syz-executor.4 Not tainted 4.14.306-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 print_circular_bug.constprop.0.cold+0x2d7/0x41e kernel/locking/lockdep.c:1258 check_prev_add kernel/locking/lockdep.c:1905 [inline] check_prevs_add kernel/locking/lockdep.c:2022 [inline] validate_chain kernel/locking/lockdep.c:2464 [inline] __lock_acquire+0x2e0e/0x3f20 kernel/locking/lockdep.c:3491 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 down_write_killable+0x37/0xb0 kernel/locking/rwsem.c:68 iterate_dir+0x387/0x5e0 fs/readdir.c:43 ovl_dir_read fs/overlayfs/readdir.c:306 [inline] ovl_dir_read_merged+0x2c5/0x430 fs/overlayfs/readdir.c:365 ovl_check_empty_dir+0x6e/0x200 fs/overlayfs/readdir.c:870 ovl_check_empty_and_clear+0x72/0xe0 fs/overlayfs/dir.c:306 ovl_remove_and_whiteout fs/overlayfs/dir.c:647 [inline] ovl_do_remove+0x565/0xb90 fs/overlayfs/dir.c:775 vfs_rmdir.part.0+0x144/0x390 fs/namei.c:3910 vfs_rmdir fs/namei.c:3895 [inline] do_rmdir+0x334/0x3c0 fs/namei.c:3970 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 RIP: 0033:0x7f6abad930f9 RSP: 002b:00007f6ab9305168 EFLAGS: 00000246 ORIG_RAX: 0000000000000054 RAX: ffffffffffffffda RBX: 00007f6abaeb2f80 RCX: 00007f6abad930f9 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000400 RBP: 00007f6abadeeae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffc02c3994f R14: 00007f6ab9305300 R15: 0000000000022000 EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue audit: type=1804 audit(1677261511.374:19): pid=10641 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/39/file0/bus" dev="loop2" ino=18 res=1 audit: type=1804 audit(1677261511.374:20): pid=10641 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/39/file0/bus" dev="loop2" ino=18 res=1 EXT4-fs error (device loop2): ext4_mb_generate_buddy:754: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 EXT4-fs (loop2): This should not happen!! Data will be lost EXT4-fs (loop2): Total free blocks count 0 EXT4-fs (loop2): Free/Dirty block details EXT4-fs (loop2): free_blocks=2415919104 EXT4-fs (loop2): dirty_blocks=16 EXT4-fs (loop2): Block reservation details EXT4-fs (loop2): i_reserved_data_blocks=1 syz-executor.2 (10641) used greatest stack depth: 24176 bytes left overlayfs: fs on 'file0' does not support file handles, falling back to index=off. overlayfs: fs on './file0' does not support file handles, falling back to index=off. EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue ISO 9660 Extensions: Microsoft Joliet Level 0 audit: type=1804 audit(1677261511.744:21): pid=10720 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2268161982/syzkaller.WO479J/38/file0/bus" dev="loop3" ino=18 res=1 EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue rock: corrupted directory entry. extent=32, offset=2044, size=237 audit: type=1804 audit(1677261511.914:22): pid=10735 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/40/file0/bus" dev="loop2" ino=18 res=1 audit: type=1804 audit(1677261511.944:23): pid=10735 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/40/file0/bus" dev="loop2" ino=18 res=1 IPVS: ftp: loaded support on port[0] = 21 EXT4-fs error (device loop2): ext4_mb_generate_buddy:754: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 EXT4-fs (loop2): This should not happen!! Data will be lost EXT4-fs (loop2): Total free blocks count 0 EXT4-fs (loop2): Free/Dirty block details EXT4-fs (loop2): free_blocks=2415919104 EXT4-fs (loop2): dirty_blocks=16 EXT4-fs (loop2): Block reservation details EXT4-fs (loop2): i_reserved_data_blocks=1 overlayfs: fs on './file0' does not support file handles, falling back to index=off. ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue audit: type=1804 audit(1677261512.574:24): pid=10795 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2268161982/syzkaller.WO479J/39/file0/bus" dev="loop3" ino=18 res=1 EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue audit: type=1804 audit(1677261512.704:25): pid=10810 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/41/file0/bus" dev="loop2" ino=18 res=1 audit: type=1804 audit(1677261512.734:26): pid=10810 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/41/file0/bus" dev="loop2" ino=18 res=1 EXT4-fs error (device loop2): ext4_mb_generate_buddy:754: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters overlayfs: fs on './file0' does not support file handles, falling back to index=off. EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 EXT4-fs (loop2): This should not happen!! Data will be lost EXT4-fs (loop2): Total free blocks count 0 EXT4-fs (loop2): Free/Dirty block details EXT4-fs (loop2): free_blocks=2415919104 EXT4-fs (loop2): dirty_blocks=16 EXT4-fs (loop2): Block reservation details EXT4-fs (loop2): i_reserved_data_blocks=1 ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 audit: type=1804 audit(1677261513.144:27): pid=10857 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2268161982/syzkaller.WO479J/40/file0/bus" dev="loop3" ino=18 res=1 EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue overlayfs: fs on './file0' does not support file handles, falling back to index=off. audit: type=1804 audit(1677261513.254:28): pid=10865 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir3276720663/syzkaller.CLYDPF/42/file0/bus" dev="loop2" ino=18 res=1 EXT4-fs error (device loop2): ext4_mb_generate_buddy:754: group 0, block bitmap and bg descriptor inconsistent: 25 vs 150994969 free clusters EXT4-fs (loop2): Delayed block allocation failed for inode 18 at logical offset 0 with max blocks 1 with error 28 EXT4-fs (loop2): This should not happen!! Data will be lost EXT4-fs (loop2): Total free blocks count 0 EXT4-fs (loop2): Free/Dirty block details EXT4-fs (loop2): free_blocks=2415919104 EXT4-fs (loop2): dirty_blocks=16 EXT4-fs (loop2): Block reservation details EXT4-fs (loop2): i_reserved_data_blocks=1 ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 overlayfs: fs on './file0' does not support file handles, falling back to index=off. ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). overlayfs: fs on './file0' does not support file handles, falling back to index=off. ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 overlayfs: fs on './file0' does not support file handles, falling back to index=off. ISOFS: Interleaved files not (yet) supported. ISOFS: File unit size != 0 for ISO file (1856). ISO 9660 Extensions: Microsoft Joliet Level 0 rock: corrupted directory entry. extent=32, offset=2044, size=237 REISERFS (device loop3): found reiserfs format "3.5" with non-standard journal REISERFS (device loop3): using ordered data mode reiserfs: using flush barriers REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30 REISERFS (device loop3): checking transaction log (loop3) REISERFS (device loop3): Using r5 hash to sort names REISERFS (device loop3): using 3.5.x disk format REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage. REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS error (device loop3): PAP-5660 reiserfs_do_truncate: wrong result -1 of search for [2 2 0xffffffff DIRECT] REISERFS (device loop3): Remounting filesystem read-only overlayfs: fs on './file0' does not support file handles, falling back to index=off. REISERFS (device loop3): found reiserfs format "3.5" with non-standard journal REISERFS (device loop3): using ordered data mode reiserfs: using flush barriers REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30 REISERFS (device loop3): checking transaction log (loop3) REISERFS (device loop3): Using r5 hash to sort names REISERFS (device loop3): using 3.5.x disk format REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage. ISOFS: Interleaved files not (yet) supported. REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) ISOFS: File unit size != 0 for ISO file (1856). REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS error (device loop3): PAP-5660 reiserfs_do_truncate: wrong result -1 of search for [2 2 0xffffffff DIRECT] REISERFS (device loop3): Remounting filesystem read-only REISERFS (device loop3): found reiserfs format "3.5" with non-standard journal REISERFS (device loop3): using ordered data mode reiserfs: using flush barriers REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30 REISERFS (device loop3): checking transaction log (loop3) REISERFS (device loop3): Using r5 hash to sort names REISERFS (device loop3): using 3.5.x disk format REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage. REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS error (device loop3): PAP-5660 reiserfs_do_truncate: wrong result -1 of search for [2 2 0xffffffff DIRECT] REISERFS (device loop3): Remounting filesystem read-only REISERFS (device loop3): found reiserfs format "3.5" with non-standard journal REISERFS (device loop3): using ordered data mode reiserfs: using flush barriers REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30 REISERFS (device loop3): checking transaction log (loop3) REISERFS (device loop3): Using r5 hash to sort names REISERFS (device loop3): using 3.5.x disk format REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage. kauditd_printk_skb: 8 callbacks suppressed audit: type=1800 audit(1677261516.684:37): pid=11136 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.3" name="bus" dev="loop3" ino=2 res=0 REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS warning (device loop3): vs-13060 reiserfs_update_sd_size: stat data of object [2 3 0x0 SD] (nlink == 1) not found (pos 0) REISERFS error (device loop3): PAP-5660 reiserfs_do_truncate: wrong result -1 of search for [2 2 0xffffffff DIRECT] REISERFS (device loop3): Remounting filesystem read-only audit: type=1804 audit(1677261516.894:38): pid=11136 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir2268161982/syzkaller.WO479J/54/file0/bus" dev="loop3" ino=2 res=1 XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. syz-executor.5 (11225) used greatest stack depth: 23600 bytes left syz-executor.5 (11218) used greatest stack depth: 22928 bytes left XFS (loop5): Unmounting Filesystem BTRFS: device fsid 24c7a497-3402-47dd-bef8-82358f5f30e0 devid 1 transid 8 /dev/loop0 BTRFS info (device loop0): enabling inode map caching BTRFS warning (device loop0): excessive commit interval 622039222 BTRFS info (device loop0): force zlib compression BTRFS info (device loop0): using free space tree BTRFS info (device loop0): has skinny extents XFS (loop3): Mounting V4 Filesystem XFS (loop2): Mounting V4 Filesystem XFS (loop3): Ending clean mount XFS (loop2): Ending clean mount XFS (loop2): Quotacheck needed: Please wait. XFS (loop2): Quotacheck: Done. XFS (loop3): Quotacheck needed: Please wait. XFS (loop3): Quotacheck: Done. XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. XFS (loop2): Unmounting Filesystem XFS (loop3): Unmounting Filesystem XFS (loop5): Unmounting Filesystem BTRFS info (device loop0): enabling inode map caching BTRFS warning (device loop0): excessive commit interval 622039222 BTRFS info (device loop0): force zlib compression BTRFS info (device loop0): using free space tree BTRFS info (device loop0): has skinny extents