IPVS: ftp: loaded support on port[0] = 21 ====================================================== WARNING: possible circular locking dependency detected 4.19.211-syzkaller #0 Not tainted ------------------------------------------------------ syz-executor.1/21195 is trying to acquire lock: 000000009337225b (&sig->cred_guard_mutex){+.+.}, at: do_io_accounting fs/proc/base.c:2750 [inline] 000000009337225b (&sig->cred_guard_mutex){+.+.}, at: proc_tgid_io_accounting+0x1cf/0x7f0 fs/proc/base.c:2799 but task is already holding lock: 0000000026c24449 (&p->lock){+.+.}, at: seq_read+0x6b/0x11c0 fs/seq_file.c:164 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #3 (&p->lock){+.+.}: seq_read+0x6b/0x11c0 fs/seq_file.c:164 proc_reg_read+0x1bd/0x2d0 fs/proc/inode.c:231 do_loop_readv_writev fs/read_write.c:701 [inline] do_loop_readv_writev fs/read_write.c:688 [inline] do_iter_read+0x471/0x630 fs/read_write.c:925 vfs_readv+0xe5/0x150 fs/read_write.c:987 kernel_readv fs/splice.c:362 [inline] default_file_splice_read+0x457/0xa00 fs/splice.c:417 do_splice_to+0x10e/0x160 fs/splice.c:881 snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present splice_direct_to_actor+0x2b9/0x8d0 fs/splice.c:959 do_splice_direct+0x1a7/0x270 fs/splice.c:1068 do_sendfile+0x550/0xc30 fs/read_write.c:1447 __do_sys_sendfile64 fs/read_write.c:1508 [inline] __se_sys_sendfile64+0x147/0x160 fs/read_write.c:1494 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #2 (sb_writers#3){.+.+}: sb_start_write include/linux/fs.h:1579 [inline] mnt_want_write+0x3a/0xb0 fs/namespace.c:360 ovl_xattr_set+0x53/0x600 fs/overlayfs/inode.c:338 __vfs_setxattr+0x10e/0x170 fs/xattr.c:149 __vfs_setxattr_noperm+0x11a/0x420 fs/xattr.c:180 __vfs_setxattr_locked+0x176/0x250 fs/xattr.c:238 vfs_setxattr+0xe5/0x270 fs/xattr.c:255 setxattr+0x23d/0x330 fs/xattr.c:520 path_setxattr+0x170/0x190 fs/xattr.c:539 __do_sys_setxattr fs/xattr.c:554 [inline] __se_sys_setxattr fs/xattr.c:550 [inline] __x64_sys_setxattr+0xc0/0x160 fs/xattr.c:550 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #1 (&ovl_i_mutex_key[depth]){+.+.}: inode_lock include/linux/fs.h:748 [inline] process_measurement+0x926/0x1440 security/integrity/ima/ima_main.c:205 ima_file_check+0xb9/0x100 security/integrity/ima/ima_main.c:391 do_last fs/namei.c:3425 [inline] path_openat+0x7e4/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_open_execat+0x11d/0x5b0 fs/exec.c:853 __do_execve_file+0x1a8b/0x2360 fs/exec.c:1770 do_execveat_common fs/exec.c:1879 [inline] do_execve+0x35/0x50 fs/exec.c:1896 __do_sys_execve fs/exec.c:1977 [inline] __se_sys_execve fs/exec.c:1972 [inline] __x64_sys_execve+0x7c/0xa0 fs/exec.c:1972 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #0 (&sig->cred_guard_mutex){+.+.}: __mutex_lock_common kernel/locking/mutex.c:937 [inline] __mutex_lock+0xd7/0x1190 kernel/locking/mutex.c:1078 do_io_accounting fs/proc/base.c:2750 [inline] proc_tgid_io_accounting+0x1cf/0x7f0 fs/proc/base.c:2799 proc_single_show+0xeb/0x170 fs/proc/base.c:755 seq_read+0x4e0/0x11c0 fs/seq_file.c:232 __vfs_read+0xf7/0x750 fs/read_write.c:416 vfs_read+0x194/0x3c0 fs/read_write.c:452 ksys_read+0x12b/0x2a0 fs/read_write.c:579 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe other info that might help us debug this: Chain exists of: &sig->cred_guard_mutex --> sb_writers#3 --> &p->lock Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&p->lock); lock(sb_writers#3); lock(&p->lock); lock(&sig->cred_guard_mutex); *** DEADLOCK *** 2 locks held by syz-executor.1/21195: #0: 0000000054fb68cf (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 #1: 0000000026c24449 (&p->lock){+.+.}, at: seq_read+0x6b/0x11c0 fs/seq_file.c:164 stack backtrace: CPU: 1 PID: 21195 Comm: syz-executor.1 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 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 do_io_accounting fs/proc/base.c:2750 [inline] proc_tgid_io_accounting+0x1cf/0x7f0 fs/proc/base.c:2799 proc_single_show+0xeb/0x170 fs/proc/base.c:755 seq_read+0x4e0/0x11c0 fs/seq_file.c:232 __vfs_read+0xf7/0x750 fs/read_write.c:416 vfs_read+0x194/0x3c0 fs/read_write.c:452 ksys_read+0x12b/0x2a0 fs/read_write.c:579 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f42423f1109 Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48 RSP: 002b:00007f4240d66168 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 00007f4242503f60 RCX: 00007f42423f1109 RDX: 0000000000002020 RSI: 0000000020004a00 RDI: 0000000000000005 RBP: 00007f424244b05d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffd3964d2af R14: 00007f4240d66300 R15: 0000000000022000 IPVS: ftp: loaded support on port[0] = 21 FAT-fs (loop3): Unrecognized mount option "appraise_type=imasig" or missing value snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present BFS-fs: bfs_fill_super(): No BFS filesystem on loop3 (magic=26574c49) new mount options do not match the existing superblock, will be ignored IPVS: ftp: loaded support on port[0] = 21 IPVS: ftp: loaded support on port[0] = 21 new mount options do not match the existing superblock, will be ignored BFS-fs: bfs_fill_super(): loop3 is unclean, continuing audit: type=1400 audit(1655445462.064:196): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21453 comm="syz-executor.1" IPVS: ftp: loaded support on port[0] = 21 audit: type=1400 audit(1655445462.124:197): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21479 comm="syz-executor.1" snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic MTD: Attempt to mount non-MTD device "/dev/loop2" cramfs: wrong magic kauditd_printk_skb: 4 callbacks suppressed audit: type=1400 audit(1655445463.814:202): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21689 comm="syz-executor.4" audit: type=1400 audit(1655445463.954:203): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21708 comm="syz-executor.4" blktrace: Concurrent blktraces are not allowed on loop7 blktrace: Concurrent blktraces are not allowed on loop7 audit: type=1400 audit(1655445464.754:204): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21747 comm="syz-executor.3" blktrace: Concurrent blktraces are not allowed on loop7 audit: type=1400 audit(1655445464.854:205): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21757 comm="syz-executor.4" audit: type=1400 audit(1655445464.964:206): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21761 comm="syz-executor.3" audit: type=1400 audit(1655445465.024:207): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21767 comm="syz-executor.4" audit: type=1400 audit(1655445465.544:208): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21775 comm="syz-executor.4" audit: type=1400 audit(1655445465.594:209): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21776 comm="syz-executor.3" audit: type=1400 audit(1655445465.654:210): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21788 comm="syz-executor.4" snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present blktrace: Concurrent blktraces are not allowed on loop7 blktrace: Concurrent blktraces are not allowed on loop7 audit: type=1400 audit(1655445466.425:211): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21814 comm="syz-executor.4" snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present kauditd_printk_skb: 8 callbacks suppressed audit: type=1400 audit(1655445469.045:220): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21935 comm="syz-executor.3" snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present audit: type=1400 audit(1655445469.175:221): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21955 comm="syz-executor.3" audit: type=1400 audit(1655445469.895:222): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21976 comm="syz-executor.3" audit: type=1400 audit(1655445469.975:223): apparmor="DENIED" operation="setprocattr" info="current" error=-22 profile="unconfined" pid=21987 comm="syz-executor.3" snd_dummy snd_dummy.0: control 0:0:117440512:syz1:0 is already present