NILFS (loop3): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds NILFS error (device loop3): nilfs_ifile_get_inode_block: bad inode number: 1 ====================================================== WARNING: possible circular locking dependency detected 4.19.211-syzkaller #0 Not tainted ------------------------------------------------------ syz-executor.3/19116 is trying to acquire lock: 000000002eb75948 (&nilfs->ns_sem){++++}, at: nilfs_set_error fs/nilfs2/super.c:86 [inline] 000000002eb75948 (&nilfs->ns_sem){++++}, at: __nilfs_error+0x195/0x401 fs/nilfs2/super.c:131 but task is already holding lock: 00000000a5c7853e (&dat_lock_key){.+.+}, at: __nilfs_read_inode fs/nilfs2/inode.c:482 [inline] 00000000a5c7853e (&dat_lock_key){.+.+}, at: nilfs_iget+0x1cf/0x860 fs/nilfs2/inode.c:592 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #1 (&dat_lock_key){.+.+}: nilfs_count_free_blocks+0x68/0x180 fs/nilfs2/the_nilfs.c:698 nilfs_set_log_cursor fs/nilfs2/super.c:237 [inline] nilfs_cleanup_super+0x133/0x490 fs/nilfs2/super.c:319 nilfs_put_super+0x152/0x1a0 fs/nilfs2/super.c:473 generic_shutdown_super+0x144/0x370 fs/super.c:456 kill_block_super+0x97/0xf0 fs/super.c:1185 deactivate_locked_super+0x94/0x160 fs/super.c:329 deactivate_super+0x174/0x1a0 fs/super.c:360 cleanup_mnt+0x1a8/0x290 fs/namespace.c:1098 task_work_run+0x148/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe -> #0 (&nilfs->ns_sem){++++}: down_write+0x34/0x90 kernel/locking/rwsem.c:70 nilfs_set_error fs/nilfs2/super.c:86 [inline] __nilfs_error+0x195/0x401 fs/nilfs2/super.c:131 nilfs_ifile_get_inode_block+0x12a/0x170 fs/nilfs2/ifile.c:139 __nilfs_read_inode fs/nilfs2/inode.c:483 [inline] nilfs_iget+0x204/0x860 fs/nilfs2/inode.c:592 nilfs_lookup fs/nilfs2/namei.c:63 [inline] nilfs_lookup+0xfd/0x130 fs/nilfs2/namei.c:54 lookup_open+0x698/0x1a20 fs/namei.c:3214 do_last fs/namei.c:3327 [inline] path_openat+0x1804/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 other info that might help us debug this: Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&dat_lock_key); lock(&nilfs->ns_sem); lock(&dat_lock_key); lock(&nilfs->ns_sem); *** DEADLOCK *** 2 locks held by syz-executor.3/19116: #0: 0000000035485c0e (&type->i_mutex_dir_key#16){.+.+}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 0000000035485c0e (&type->i_mutex_dir_key#16){.+.+}, at: do_last fs/namei.c:3326 [inline] #0: 0000000035485c0e (&type->i_mutex_dir_key#16){.+.+}, at: path_openat+0x17ec/0x2df0 fs/namei.c:3537 #1: 00000000a5c7853e (&dat_lock_key){.+.+}, at: __nilfs_read_inode fs/nilfs2/inode.c:482 [inline] #1: 00000000a5c7853e (&dat_lock_key){.+.+}, at: nilfs_iget+0x1cf/0x860 fs/nilfs2/inode.c:592 stack backtrace: CPU: 1 PID: 19116 Comm: syz-executor.3 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 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 down_write+0x34/0x90 kernel/locking/rwsem.c:70 nilfs_set_error fs/nilfs2/super.c:86 [inline] __nilfs_error+0x195/0x401 fs/nilfs2/super.c:131 nilfs_ifile_get_inode_block+0x12a/0x170 fs/nilfs2/ifile.c:139 __nilfs_read_inode fs/nilfs2/inode.c:483 [inline] nilfs_iget+0x204/0x860 fs/nilfs2/inode.c:592 nilfs_lookup fs/nilfs2/namei.c:63 [inline] nilfs_lookup+0xfd/0x130 fs/nilfs2/namei.c:54 lookup_open+0x698/0x1a20 fs/namei.c:3214 do_last fs/namei.c:3327 [inline] path_openat+0x1804/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 RIP: 0033:0x7f2e62da60a9 Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 f1 19 00 00 90 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 XFS (loop5): Mounting V4 Filesystem RSP: 002b:00007f2e61318168 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 00007f2e62ec5f80 RCX: 00007f2e62da60a9 RDX: 0000000000000000 RSI: 00000000200003c0 RDI: 0000000000000004 RBP: 00007f2e62e01ae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff341f735f R14: 00007f2e61318300 R15: 0000000000022000 Remounting filesystem read-only XFS (loop5): Ending clean mount XFS (loop5): Unmounting Filesystem NILFS (loop3): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds mac80211_hwsim hwsim5 : renamed from wlan1 NILFS (loop3): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds ********************************************************** ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** ** ** ** trace_printk() being used. Allocating extra memory. ** ** ** ** This means that this is a DEBUG kernel and it is ** ** unsafe for production use. ** ** ** ** If you see this message and you are not debugging ** ** the kernel, report this immediately to your vendor! ** ** ** ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** ********************************************************** x_tables: duplicate underflow at hook 1 IPVS: ftp: loaded support on port[0] = 21 UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) netlink: 'syz-executor.0': attribute type 4 has an invalid length. UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) BTRFS info (device loop3): using free space tree BTRFS info (device loop3): has skinny extents UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) netlink: 'syz-executor.0': attribute type 4 has an invalid length. BTRFS error (device loop3): fail to start transaction for status update: -28 netlink: 'syz-executor.0': attribute type 4 has an invalid length. netlink: 'syz-executor.0': attribute type 4 has an invalid length. UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) netlink: 'syz-executor.1': attribute type 4 has an invalid length. UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) netlink: 'syz-executor.1': attribute type 4 has an invalid length. BTRFS info (device loop3): using free space tree BTRFS info (device loop3): has skinny extents netlink: 'syz-executor.0': attribute type 4 has an invalid length. netlink: 'syz-executor.0': attribute type 4 has an invalid length. netlink: 'syz-executor.1': attribute type 4 has an invalid length. BTRFS error (device loop3): fail to start transaction for status update: -28 netlink: 'syz-executor.1': attribute type 4 has an invalid length. BTRFS info (device loop5): using free space tree kauditd_printk_skb: 3 callbacks suppressed audit: type=1800 audit(1672719132.357:182): pid=19679 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed comm="syz-executor.0" name="SYSV00000000" dev="hugetlbfs" ino=0 res=0 BTRFS info (device loop5): has skinny extents audit: type=1800 audit(1672719132.587:183): pid=19713 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed comm="syz-executor.0" name="SYSV00000000" dev="hugetlbfs" ino=65537 res=0 UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) BTRFS error (device loop5): fail to start transaction for status update: -28 audit: type=1800 audit(1672719132.757:184): pid=19726 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed comm="syz-executor.0" name="SYSV00000000" dev="hugetlbfs" ino=131074 res=0 BTRFS info (device loop3): using free space tree BTRFS info (device loop3): has skinny extents BTRFS error (device loop3): fail to start transaction for status update: -28 audit: type=1800 audit(1672719133.237:185): pid=19779 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed comm="syz-executor.5" name="SYSV00000000" dev="hugetlbfs" ino=65538 res=0 audit: type=1800 audit(1672719133.607:186): pid=19812 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.3" name="file0" dev="sda1" ino=14838 res=0 audit: type=1804 audit(1672719133.617:187): pid=19812 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir2135188483/syzkaller.yN6rl3/278/file0" dev="sda1" ino=14838 res=1 audit: type=1804 audit(1672719133.697:188): pid=19814 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir2135188483/syzkaller.yN6rl3/278/file0" dev="sda1" ino=14838 res=1 IPVS: ftp: loaded support on port[0] = 21 UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) audit: type=1800 audit(1672719134.427:189): pid=19863 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.3" name="file0" dev="sda1" ino=14766 res=0 UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) IPVS: ftp: loaded support on port[0] = 21 validate_nla: 8 callbacks suppressed netlink: 'syz-executor.1': attribute type 4 has an invalid length. UDF-fs: INFO Mounting volume 'LinuxUDF', timestamp 2022/11/22 14:59 (1000) IPVS: ftp: loaded support on port[0] = 21