kauditd_printk_skb: 7 callbacks suppressed audit: type=1800 audit(1676260316.595:475): pid=19692 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.3" name="bus" dev="sda1" ino=13972 res=0 ====================================================== WARNING: possible circular locking dependency detected 4.19.211-syzkaller #0 Not tainted ------------------------------------------------------ syz-executor.2/19693 is trying to acquire lock: 00000000ee4ef1ab (&HFSPLUS_I(inode)->extents_lock){+.+.}, at: hfsplus_file_extend+0x1bb/0xf40 fs/hfsplus/extents.c:457 but task is already holding lock: 00000000b0c40ec1 (&tree->tree_lock#2){+.+.}, at: hfsplus_find_init+0x1b7/0x220 fs/hfsplus/bfind.c:30 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 (&tree->tree_lock#2){+.+.}: hfsplus_file_truncate+0xde7/0x1040 fs/hfsplus/extents.c:595 hfsplus_setattr+0x1e7/0x310 fs/hfsplus/inode.c:263 notify_change+0x70b/0xfc0 fs/attr.c:334 do_truncate+0x134/0x1f0 fs/open.c:63 handle_truncate fs/namei.c:3009 [inline] do_last fs/namei.c:3427 [inline] path_openat+0x2308/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_sys_open+0x3b3/0x520 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #0 (&HFSPLUS_I(inode)->extents_lock){+.+.}: __mutex_lock_common kernel/locking/mutex.c:937 [inline] __mutex_lock+0xd7/0x1190 kernel/locking/mutex.c:1078 hfsplus_file_extend+0x1bb/0xf40 fs/hfsplus/extents.c:457 hfsplus_bmap_reserve+0x298/0x440 fs/hfsplus/btree.c:357 hfsplus_rename_cat+0x272/0x1490 fs/hfsplus/catalog.c:456 hfsplus_unlink+0x49c/0x820 fs/hfsplus/dir.c:376 vfs_unlink+0x27d/0x4e0 fs/namei.c:4002 do_unlinkat+0x3b8/0x660 fs/namei.c:4065 do_coredump+0x1f9c/0x2d60 fs/coredump.c:687 get_signal+0xed9/0x1f70 kernel/signal.c:2583 do_signal+0x8f/0x1670 arch/x86/kernel/signal.c:799 exit_to_usermode_loop+0x204/0x2a0 arch/x86/entry/common.c:163 prepare_exit_to_usermode+0x277/0x2d0 arch/x86/entry/common.c:198 retint_user+0x8/0x18 other info that might help us debug this: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&tree->tree_lock#2); lock(&HFSPLUS_I(inode)->extents_lock); lock(&tree->tree_lock#2); lock(&HFSPLUS_I(inode)->extents_lock); *** DEADLOCK *** 5 locks held by syz-executor.2/19693: #0: 0000000055e79427 (sb_writers#27){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000055e79427 (sb_writers#27){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 audit: type=1804 audit(1676260316.665:476): pid=19612 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/171/bus" dev="sda1" ino=13988 res=1 #1: 000000007a9a3204 (&type->i_mutex_dir_key#19/1){+.+.}, at: inode_lock_nested include/linux/fs.h:783 [inline] #1: 000000007a9a3204 (&type->i_mutex_dir_key#19/1){+.+.}, at: do_unlinkat+0x27d/0x660 fs/namei.c:4051 #2: 00000000544eb6eb (&sb->s_type->i_mutex_key#32){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #2: 00000000544eb6eb (&sb->s_type->i_mutex_key#32){+.+.}, at: vfs_unlink+0xca/0x4e0 fs/namei.c:3993 #3: 00000000337f2cf1 (&sbi->vh_mutex){+.+.}, at: hfsplus_unlink+0x140/0x820 fs/hfsplus/dir.c:370 #4: 00000000b0c40ec1 (&tree->tree_lock#2){+.+.}, at: hfsplus_find_init+0x1b7/0x220 fs/hfsplus/bfind.c:30 stack backtrace: CPU: 1 PID: 19693 Comm: syz-executor.2 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 print_circular_bug.constprop.0.cold+0x2d7/0x41e kernel/locking/lockdep.c:1222 check_prev_add kernel/locking/lockdep.c:1866 [inline] check_prevs_add kernel/locking/lockdep.c:1979 [inline] validate_chain kernel/locking/lockdep.c:2420 [inline] __lock_acquire+0x30c9/0x3ff0 kernel/locking/lockdep.c:3416 lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3908 __mutex_lock_common kernel/locking/mutex.c:937 [inline] __mutex_lock+0xd7/0x1190 kernel/locking/mutex.c:1078 hfsplus_file_extend+0x1bb/0xf40 fs/hfsplus/extents.c:457 hfsplus_bmap_reserve+0x298/0x440 fs/hfsplus/btree.c:357 hfsplus_rename_cat+0x272/0x1490 fs/hfsplus/catalog.c:456 hfsplus_unlink+0x49c/0x820 fs/hfsplus/dir.c:376 vfs_unlink+0x27d/0x4e0 fs/namei.c:4002 do_unlinkat+0x3b8/0x660 fs/namei.c:4065 do_coredump+0x1f9c/0x2d60 fs/coredump.c:687 audit: type=1804 audit(1676260316.765:477): pid=19698 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/171/bus" dev="sda1" ino=13988 res=1 get_signal+0xed9/0x1f70 kernel/signal.c:2583 do_signal+0x8f/0x1670 arch/x86/kernel/signal.c:799 exit_to_usermode_loop+0x204/0x2a0 arch/x86/entry/common.c:163 prepare_exit_to_usermode+0x277/0x2d0 arch/x86/entry/common.c:198 retint_user+0x8/0x18 RIP: 0033: (null) Code: Bad RIP value. RSP: 002b:0000000020000188 EFLAGS: 00010217 RAX: 0000000000000000 RBX: 00007f8db4e8b120 RCX: 00007f8db4d6b0f9 RDX: 0000000000000000 RSI: 0000000020000180 RDI: 0000000000000000 RBP: 00007f8db4dc6ae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffde7fa890f R14: 00007f8db329b300 R15: 0000000000022000 audit: type=1804 audit(1676260316.765:478): pid=19698 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/171/bus" dev="sda1" ino=13988 res=1 nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based firewall rule not found. Use the iptables CT target to attach helpers instead. device lo entered promiscuous mode IPVS: ftp: loaded support on port[0] = 21 IPVS: ftp: loaded support on port[0] = 21 audit: type=1804 audit(1676260318.456:479): pid=19759 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/173/bus" dev="sda1" ino=13910 res=1 audit: type=1804 audit(1676260318.506:480): pid=19759 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/173/bus" dev="sda1" ino=13910 res=1 audit: type=1804 audit(1676260318.506:481): pid=19760 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.4" name="/root/syzkaller-testdir350870761/syzkaller.odcbkz/173/bus" dev="sda1" ino=13910 res=1 Y4`Ҙ: renamed from lo ubi0: attaching mtd0 ubi0: scanning is finished ubi0: empty MTD device detected netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. ubi0: attached mtd0 (name "mtdram test device", size 0 MiB) ubi0: PEB size: 4096 bytes (4 KiB), LEB size: 3968 bytes ubi0: min./max. I/O unit sizes: 1/64, sub-page size 1 ubi0: VID header offset: 64 (aligned 64), data offset: 128 ubi0: good PEBs: 32, bad PEBs: 0, corrupted PEBs: 0 ubi0: user volume: 0, internal volumes: 1, max. volumes count: 23 ubi0: max/mean erase counter: 0/0, WL threshold: 4096, image sequence number: 1126114832 ubi0: available PEBs: 28, total reserved PEBs: 4, PEBs reserved for bad PEB handling: 0 ubi0: background thread "ubi_bgt0d" started, PID 19854 device lo entered promiscuous mode Y4`Ҙ: renamed from lo ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'. ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'. ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 ubi: mtd0 is already attached to ubi0 netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'. overlayfs: fs on './file0' does not support file handles, falling back to index=off,nfs_export=off. resize option for remount only netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'. device lo entered promiscuous mode resize option for remount only Y4`Ҙ: renamed from lo audit: type=1804 audit(1676260321.316:482): pid=20023 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.1" name="/root/syzkaller-testdir3157097164/syzkaller.h4ueuQ/14/cgroup.controllers" dev="sda1" ino=14641 res=1 resize option for remount only audit: type=1800 audit(1676260321.506:483): pid=20088 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14499 res=0 audit: type=1800 audit(1676260321.526:484): pid=20088 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14499 res=0 audit: type=1800 audit(1676260321.666:485): pid=20113 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14641 res=0 audit: type=1800 audit(1676260321.686:486): pid=20118 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14641 res=0 audit: type=1804 audit(1676260321.796:487): pid=20122 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.1" name="/root/syzkaller-testdir3157097164/syzkaller.h4ueuQ/15/cgroup.controllers" dev="sda1" ino=14787 res=1 audit: type=1800 audit(1676260321.836:488): pid=20137 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.2" name="bus" dev="sda1" ino=14641 res=0 audit: type=1800 audit(1676260321.836:489): pid=20137 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.2" name="bus" dev="sda1" ino=14641 res=0 audit: type=1800 audit(1676260321.936:490): pid=20145 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14778 res=0 audit: type=1800 audit(1676260321.966:491): pid=20145 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14778 res=0 audit: type=1800 audit(1676260321.966:492): pid=20145 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14778 res=0 audit: type=1800 audit(1676260321.966:493): pid=20145 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14778 res=0 audit: type=1800 audit(1676260321.966:494): pid=20145 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.0" name="bus" dev="sda1" ino=14778 res=0 device lo entered promiscuous mode Y4`Ҙ: renamed from lo netlink: 28 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 28 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 28 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 'syz-executor.0': attribute type 1 has an invalid length. netlink: 28 bytes leftover after parsing attributes in process `syz-executor.3'. netlink: 'syz-executor.0': attribute type 1 has an invalid length. netlink: 'syz-executor.0': attribute type 1 has an invalid length. netlink: 'syz-executor.0': attribute type 1 has an invalid length.