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/10098 is trying to acquire lock: (sb_writers#6){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] (sb_writers#6){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 but task is already holding lock: (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] inode_lock include/linux/fs.h:719 [inline] (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] vfs_setxattr+0xb1/0x230 fs/xattr.c:255 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 (&ovl_i_mutex_dir_key[depth]#2){++++}: 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_rename+0x57d/0xe50 fs/overlayfs/dir.c:959 vfs_rename+0x560/0x1820 fs/namei.c:4498 SYSC_renameat2 fs/namei.c:4646 [inline] SyS_renameat2+0x95b/0xad0 fs/namei.c:4535 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 -> #0 (sb_writers#6){.+.+}: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 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_xattr_set+0x4d/0x290 fs/overlayfs/inode.c:214 ovl_posix_acl_xattr_set+0x2b7/0x830 fs/overlayfs/super.c:762 __vfs_setxattr+0xdc/0x130 fs/xattr.c:150 __vfs_setxattr_noperm+0xfd/0x3d0 fs/xattr.c:181 __vfs_setxattr_locked+0x14d/0x250 fs/xattr.c:239 vfs_setxattr+0xcf/0x230 fs/xattr.c:256 setxattr+0x1a9/0x300 fs/xattr.c:523 path_setxattr+0x118/0x130 fs/xattr.c:542 SYSC_setxattr fs/xattr.c:557 [inline] SyS_setxattr+0x36/0x50 fs/xattr.c:553 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(&ovl_i_mutex_dir_key[depth]#2); lock(sb_writers#6); lock(&ovl_i_mutex_dir_key[depth]#2); lock(sb_writers#6); *** DEADLOCK *** 2 locks held by syz-executor.4/10098: #0: (sb_writers#15){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#15){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] inode_lock include/linux/fs.h:719 [inline] #1: (&ovl_i_mutex_dir_key[depth]#2){++++}, at: [] vfs_setxattr+0xb1/0x230 fs/xattr.c:255 stack backtrace: CPU: 0 PID: 10098 Comm: syz-executor.4 Not tainted 4.14.306-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_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 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_xattr_set+0x4d/0x290 fs/overlayfs/inode.c:214 ovl_posix_acl_xattr_set+0x2b7/0x830 fs/overlayfs/super.c:762 __vfs_setxattr+0xdc/0x130 fs/xattr.c:150 __vfs_setxattr_noperm+0xfd/0x3d0 fs/xattr.c:181 __vfs_setxattr_locked+0x14d/0x250 fs/xattr.c:239 vfs_setxattr+0xcf/0x230 fs/xattr.c:256 setxattr+0x1a9/0x300 fs/xattr.c:523 path_setxattr+0x118/0x130 fs/xattr.c:542 SYSC_setxattr fs/xattr.c:557 [inline] SyS_setxattr+0x36/0x50 fs/xattr.c:553 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x5e/0xd3 RIP: 0033:0x7fe6658490f9 RSP: 002b:00007fe663dbb168 EFLAGS: 00000246 ORIG_RAX: 00000000000000bc RAX: ffffffffffffffda RBX: 00007fe665968f80 RCX: 00007fe6658490f9 RDX: 0000000020000800 RSI: 00000000200001c0 RDI: 0000000020000140 RBP: 00007fe6658a4ae9 R08: 0000000000000002 R09: 0000000000000000 R10: 0000000000000064 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffeacb986ff R14: 00007fe663dbb300 R15: 0000000000022000 L1TF CPU bug present and SMT on, data leak possible. See CVE-2018-3646 and https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/l1tf.html for details. kvm [10127]: vcpu0, guest rIP: 0x9186 disabled perfctr wrmsr: 0xc1 data 0x0 kvm [10127]: vcpu0, guest rIP: 0x9206 disabled perfctr wrmsr: 0xc2 data 0x0 netlink: 12 bytes leftover after parsing attributes in process `syz-executor.1'. hub 9-0:1.0: USB hub found hub 9-0:1.0: 8 ports detected BTRFS: device fsid 24c7a497-3402-47dd-bef8-82358f5f30e0 devid 1 transid 8 /dev/loop4 BTRFS info (device loop4): using free space tree BTRFS info (device loop4): has skinny extents hub 9-0:1.0: USB hub found hub 9-0:1.0: 8 ports detected BTRFS info (device loop4): using free space tree BTRFS info (device loop4): has skinny extents hub 9-0:1.0: USB hub found hub 9-0:1.0: 8 ports detected UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) hub 9-0:1.0: USB hub found hub 9-0:1.0: 8 ports detected BTRFS info (device loop4): using free space tree BTRFS info (device loop4): has skinny extents audit: type=1804 audit(1677165728.224:2): pid=10375 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/27/bus" dev="sda1" ino=14012 res=1 audit: type=1804 audit(1677165728.224:3): pid=10375 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/27/bus" dev="sda1" ino=14012 res=1 audit: type=1804 audit(1677165728.224:4): pid=10375 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/27/bus" dev="sda1" ino=14012 res=1 BTRFS info (device loop4): using free space tree BTRFS info (device loop4): has skinny extents audit: type=1804 audit(1677165729.314:5): pid=10474 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/28/bus" dev="sda1" ino=14008 res=1 audit: type=1804 audit(1677165729.314:6): pid=10474 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/28/bus" dev="sda1" ino=14008 res=1 audit: type=1804 audit(1677165729.314:7): pid=10474 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/28/bus" dev="sda1" ino=14008 res=1 audit: type=1804 audit(1677165730.424:8): pid=10548 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/29/bus" dev="sda1" ino=13969 res=1 audit: type=1804 audit(1677165730.444:9): pid=10548 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="ToMToU" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/29/bus" dev="sda1" ino=13969 res=1 audit: type=1804 audit(1677165730.474:10): pid=10548 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/29/bus" dev="sda1" ino=13969 res=1 audit: type=1804 audit(1677165731.464:11): pid=10608 uid=0 auid=4294967295 ses=4294967295 op="invalid_pcr" cause="open_writers" comm="syz-executor.3" name="/root/syzkaller-testdir3318589924/syzkaller.go1JBj/30/bus" dev="sda1" ino=14030 res=1 kauditd_printk_skb: 3 callbacks suppressed audit: type=1400 audit(1677165733.314:15): apparmor="DENIED" operation="change_profile" info="label not found" error=-2 profile="unconfined" name="&=21)" pid=10683 comm="syz-executor.4" audit: type=1400 audit(1677165733.374:16): apparmor="DENIED" operation="change_profile" info="label not found" error=-2 profile="unconfined" name="&=21)" pid=10697 comm="syz-executor.4" audit: type=1400 audit(1677165733.434:17): apparmor="DENIED" operation="change_profile" info="label not found" error=-2 profile="unconfined" name="&=21)" pid=10709 comm="syz-executor.4"