============================================ WARNING: possible recursive locking detected 4.14.305-syzkaller #0 Not tainted -------------------------------------------- syz-executor.1/10080 is trying to acquire lock: (&HFSPLUS_I(inode)->extents_lock){+.+.}, at: [] hfsplus_get_block+0x1f9/0x820 fs/hfsplus/extents.c:260 but task is already holding lock: (&HFSPLUS_I(inode)->extents_lock){+.+.}, at: [] hfsplus_file_extend+0x188/0xef0 fs/hfsplus/extents.c:452 other info that might help us debug this: Possible unsafe locking scenario: CPU0 ---- lock(&HFSPLUS_I(inode)->extents_lock); lock(&HFSPLUS_I(inode)->extents_lock); hid-generic 0000:0000:0000.0008: unknown main item tag 0x0 *** DEADLOCK *** May be due to missing lock nesting notation 5 locks held by syz-executor.1/10080: #0: (&type->s_umount_key#52/1){+.+.}, at: [] alloc_super fs/super.c:251 [inline] #0: (&type->s_umount_key#52/1){+.+.}, at: [] sget_userns+0x556/0xc10 fs/super.c:516 hid-generic 0000:0000:0000.0008: unknown main item tag 0x0 #1: (&sbi->vh_mutex){+.+.}, at: [] hfsplus_fill_super+0x1314/0x1850 fs/hfsplus/super.c:553 #2: (&tree->tree_lock){+.+.}, at: [] hfsplus_find_init+0x1a8/0x220 fs/hfsplus/bfind.c:30 #3: (&HFSPLUS_I(inode)->extents_lock){+.+.}, at: [] hfsplus_file_extend+0x188/0xef0 fs/hfsplus/extents.c:452 #4: hid-generic 0000:0000:0000.0008: unknown main item tag 0x0 ( hid-generic 0000:0000:0000.0008: hidraw0: HID v0.00 Device [syz1] on %z5 &sbi->alloc_mutex){+.+.}, at: [] hfsplus_block_allocate+0xd2/0x910 fs/hfsplus/bitmap.c:35 stack backtrace: CPU: 1 PID: 10080 Comm: syz-executor.1 Not tainted 4.14.305-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 print_deadlock_bug kernel/locking/lockdep.c:1800 [inline] check_deadlock kernel/locking/lockdep.c:1847 [inline] validate_chain kernel/locking/lockdep.c:2448 [inline] __lock_acquire.cold+0x180/0x97c kernel/locking/lockdep.c:3491 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 __mutex_lock_common kernel/locking/mutex.c:756 [inline] __mutex_lock+0xc4/0x1310 kernel/locking/mutex.c:893 hfsplus_get_block+0x1f9/0x820 fs/hfsplus/extents.c:260 block_read_full_page+0x25e/0x8d0 fs/buffer.c:2316 do_read_cache_page+0x38e/0xc10 mm/filemap.c:2713 read_mapping_page include/linux/pagemap.h:398 [inline] hfsplus_block_allocate+0x189/0x910 fs/hfsplus/bitmap.c:37 hfsplus_file_extend+0x421/0xef0 fs/hfsplus/extents.c:463 hfsplus_bmap_reserve+0x26e/0x410 fs/hfsplus/btree.c:357 hfsplus_create_cat+0x1af/0x10d0 fs/hfsplus/catalog.c:272 hfsplus_fill_super+0x1386/0x1850 fs/hfsplus/super.c:560 mount_bdev+0x2b3/0x360 fs/super.c:1134 mount_fs+0x92/0x2a0 fs/super.c:1237 vfs_kern_mount.part.0+0x5b/0x470 fs/namespace.c:1046 vfs_kern_mount fs/namespace.c:1036 [inline] do_new_mount fs/namespace.c:2572 [inline] do_mount+0xe65/0x2a30 fs/namespace.c:2905 SYSC_mount fs/namespace.c:3121 [inline] SyS_mount+0xa8/0x120 fs/namespace.c:3098 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 RIP: 0033:0x7f4e992b562a RSP: 002b:00007f4e97825f88 EFLAGS: 00000202 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 000000000000061b RCX: 00007f4e992b562a RDX: 0000000020000600 RSI: 00000000200001c0 RDI: 00007f4e97825fe0 RBP: 00007f4e97826020 R08: 00007f4e97826020 R09: 0000000001a00010 R10: 0000000001a00010 R11: 0000000000000202 R12: 0000000020000600 R13: 00000000200001c0 R14: 00007f4e97825fe0 R15: 0000000020000140 hid-generic 0000:0000:0000.0009: unknown main item tag 0x0 hid-generic 0000:0000:0000.0009: unknown main item tag 0x0 hid-generic 0000:0000:0000.0009: unknown main item tag 0x0 hid-generic 0000:0000:0000.0009: hidraw0: HID v0.00 Device [syz1] on %z5 kauditd_printk_skb: 7 callbacks suppressed audit: type=1804 audit(1676699440.447:12): pid=10144 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.5" name="/root/syzkaller-testdir3175109408/syzkaller.cKlOlQ/30/bus" dev="sda1" ino=13946 res=1 audit: type=1800 audit(1676699440.497:13): pid=10153 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.2" name="bus" dev="sda1" ino=13959 res=0 hid-generic 0000:0000:0000.000A: unknown main item tag 0x0 hid-generic 0000:0000:0000.000B: unknown main item tag 0x0 hid-generic 0000:0000:0000.000A: unknown main item tag 0x0 hid-generic 0000:0000:0000.000B: unknown main item tag 0x0 hid-generic 0000:0000:0000.000B: unknown main item tag 0x0 hid-generic 0000:0000:0000.000A: unknown main item tag 0x0 hid-generic 0000:0000:0000.000B: hidraw0: HID v0.00 Device [syz1] on %z5 print_req_error: I/O error, dev loop1, sector 0 hid-generic 0000:0000:0000.000A: hidraw1: HID v0.00 Device [syz1] on %z5 audit: type=1800 audit(1676699440.787:14): pid=10198 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.2" name="bus" dev="sda1" ino=13959 res=0 audit: type=1800 audit(1676699440.807:15): pid=10197 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="bus" dev="sda1" ino=13962 res=0 print_req_error: I/O error, dev loop1, sector 0 Bluetooth: hci5 command 0x0405 tx timeout print_req_error: I/O error, dev loop1, sector 0 print_req_error: I/O error, dev loop1, sector 0 IPv6: veth0_vlan: IPv6 duplicate address fe80::aa detected! audit: type=1800 audit(1676699441.267:16): pid=10225 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.2" name="bus" dev="sda1" ino=13900 res=0 audit: type=1800 audit(1676699441.317:17): pid=10234 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.1" name="bus" dev="sda1" ino=13969 res=0 hid-generic 0000:0000:0000.000C: unknown main item tag 0x0 audit: type=1800 audit(1676699441.327:18): pid=10238 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="bus" dev="sda1" ino=13970 res=0 hid-generic 0000:0000:0000.000C: unknown main item tag 0x0 hid-generic 0000:0000:0000.000D: unknown main item tag 0x0 hid-generic 0000:0000:0000.000D: unknown main item tag 0x0 hid-generic 0000:0000:0000.000D: unknown main item tag 0x0 hid-generic 0000:0000:0000.000C: unknown main item tag 0x0 hid-generic 0000:0000:0000.000D: hidraw0: HID v0.00 Device [syz1] on %z5 hid-generic 0000:0000:0000.000C: hidraw1: HID v0.00 Device [syz1] on %z5 audit: type=1800 audit(1676699441.517:19): pid=10269 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="bus" dev="sda1" ino=13947 res=0 audit: type=1800 audit(1676699441.517:20): pid=10272 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.1" name="bus" dev="sda1" ino=13970 res=0 audit: type=1800 audit(1676699441.667:21): pid=10279 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.1" name="bus" dev="sda1" ino=13970 res=0 hid-generic 0000:0000:0000.000E: unknown main item tag 0x0 hid-generic 0000:0000:0000.000E: unknown main item tag 0x0 hid-generic 0000:0000:0000.000E: unknown main item tag 0x0 hid-generic 0000:0000:0000.000E: hidraw0: HID v0.00 Device [syz1] on %z5 XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. syz-executor.5 (10353) used greatest stack depth: 23600 bytes left XFS (loop5): Unmounting Filesystem XFS (loop0): Mounting V4 Filesystem XFS (loop0): Ending clean mount XFS (loop0): Quotacheck needed: Please wait. XFS (loop0): Quotacheck: Done. XFS (loop5): Mounting V4 Filesystem XFS (loop0): Unmounting Filesystem XFS (loop3): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. XFS (loop3): Ending clean mount XFS (loop3): Quotacheck needed: Please wait. XFS (loop3): Quotacheck: Done. XFS (loop5): Unmounting Filesystem XFS (loop3): Unmounting Filesystem kvm: emulating exchange as write XFS (loop0): Mounting V4 Filesystem XFS (loop0): Ending clean mount F2FS-fs (loop1): Mismatch start address, segment0(512) cp_blkaddr(605) F2FS-fs (loop1): Can't find valid F2FS filesystem in 1th superblock XFS (loop0): Quotacheck needed: Please wait. F2FS-fs (loop1): invalid crc value F2FS-fs (loop1): Found nat_bits in checkpoint XFS (loop0): Quotacheck: Done. F2FS-fs (loop1): Mounted with checkpoint version = 753bd00b XFS (loop0): Unmounting Filesystem XFS (loop5): Mounting V4 Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop3): Mounting V4 Filesystem XFS (loop5): Quotacheck: Done. XFS (loop3): Ending clean mount XFS (loop3): Quotacheck needed: Please wait. XFS (loop5): Unmounting Filesystem XFS (loop3): Quotacheck: Done. XFS (loop3): Unmounting Filesystem unregister_netdevice: waiting for ip6gre0 to become free. Usage count = -1 XFS (loop0): Mounting V4 Filesystem XFS (loop0): Ending clean mount XFS (loop0): Quotacheck needed: Please wait. XFS (loop0): Quotacheck: Done. XFS (loop5): Mounting V4 Filesystem XFS (loop0): Unmounting Filesystem XFS (loop5): Ending clean mount XFS (loop5): Quotacheck needed: Please wait. XFS (loop5): Quotacheck: Done. kauditd_printk_skb: 19 callbacks suppressed audit: type=1800 audit(1676699445.737:41): pid=10661 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.2" name="file0" dev="sda1" ino=13950 res=0 F2FS-fs (loop1): Mismatch start address, segment0(512) cp_blkaddr(605) F2FS-fs (loop4): Mismatch start address, segment0(512) cp_blkaddr(605) F2FS-fs (loop1): Can't find valid F2FS filesystem in 1th superblock F2FS-fs (loop4): Can't find valid F2FS filesystem in 1th superblock XFS (loop5): Unmounting Filesystem F2FS-fs (loop4): invalid crc value audit: type=1804 audit(1676699445.747:42): pid=10661 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir819513802/syzkaller.V4IXX8/35/file0" dev="sda1" ino=13950 res=1 XFS (loop3): Mounting V4 Filesystem XFS (loop3): Ending clean mount XFS (loop3): Quotacheck needed: Please wait. XFS (loop3): Quotacheck: Done. audit: type=1800 audit(1676699446.247:43): pid=10625 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.4" name="bus" dev="loop4" ino=4 res=0 XFS (loop3): Unmounting Filesystem audit: type=1804 audit(1676699446.337:44): pid=10700 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.4" name="/root/syzkaller-testdir4096221382/syzkaller.wFZHJ3/29/bus/bus" dev="loop4" ino=4 res=1 audit: type=1800 audit(1676699446.357:45): pid=10630 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.1" name="bus" dev="loop1" ino=4 res=0 audit: type=1804 audit(1676699446.437:46): pid=10704 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.1" name="/root/syzkaller-testdir3180295856/syzkaller.WKpzpX/35/bus/bus" dev="loop1" ino=4 res=1 audit: type=1800 audit(1676699446.637:47): pid=10714 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.2" name="file0" dev="sda1" ino=13966 res=0 audit: type=1804 audit(1676699446.637:48): pid=10714 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.2" name="/root/syzkaller-testdir819513802/syzkaller.V4IXX8/36/file0" dev="sda1" ino=13966 res=1 audit: type=1800 audit(1676699447.218:49): pid=10692 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.5" name="bus" dev="loop5" ino=4 res=0 audit: type=1800 audit(1676699447.258:50): pid=10689 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed(directio)" comm="syz-executor.0" name="bus" dev="loop0" ino=4 res=0 f2fs_msg: 47 callbacks suppressed F2FS-fs (loop5): Mounted with checkpoint version = 753bd00b F2FS-fs (loop3): Mounted with checkpoint version = 753bd00b