NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
======================================================
WARNING: possible circular locking dependency detected
4.14.295-syzkaller #0 Not tainted
------------------------------------------------------
syz-executor.0/12889 is trying to acquire lock:
 (&nilfs->ns_sem){++++}, at: [<ffffffff87085f04>] nilfs_set_error fs/nilfs2/super.c:95 [inline]
 (&nilfs->ns_sem){++++}, at: [<ffffffff87085f04>] __nilfs_error+0x176/0x399 fs/nilfs2/super.c:140

but task is already holding lock:
 (&dat_lock_key){.+.+}, at: [<ffffffff826b406e>] nilfs_get_block+0x17e/0x7a0 fs/nilfs2/inode.c:88

which lock already depends on the new lock.


the existing dependency chain (in reverse order) is:

-> #1 (&dat_lock_key){.+.+}:
       down_read+0x36/0x80 kernel/locking/rwsem.c:24
       nilfs_count_free_blocks+0x68/0x180 fs/nilfs2/the_nilfs.c:707
       nilfs_set_log_cursor fs/nilfs2/super.c:247 [inline]
       nilfs_cleanup_super+0x123/0x450 fs/nilfs2/super.c:329
       load_nilfs+0x6e2/0x1170 fs/nilfs2/the_nilfs.c:326
       nilfs_fill_super fs/nilfs2/super.c:1073 [inline]
       nilfs_mount+0x89f/0xd00 fs/nilfs2/super.c:1331
       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+0x46/0xbb

-> #0 (&nilfs->ns_sem){++++}:
       lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998
       down_write+0x34/0x90 kernel/locking/rwsem.c:54
       nilfs_set_error fs/nilfs2/super.c:95 [inline]
       __nilfs_error+0x176/0x399 fs/nilfs2/super.c:140
       nilfs_bmap_convert_error fs/nilfs2/bmap.c:44 [inline]
       nilfs_bmap_lookup_contig+0x130/0x170 fs/nilfs2/bmap.c:104
       nilfs_get_block+0x1bd/0x7a0 fs/nilfs2/inode.c:89
       do_mpage_readpage+0x615/0x1470 fs/mpage.c:211
       mpage_readpages+0x2d6/0x5f0 fs/mpage.c:383
       read_pages mm/readahead.c:121 [inline]
       __do_page_cache_readahead+0x522/0x940 mm/readahead.c:199
       ra_submit mm/internal.h:66 [inline]
       ondemand_readahead.isra.0+0x514/0xb60 mm/readahead.c:486
       page_cache_sync_readahead mm/readahead.c:518 [inline]
       page_cache_sync_readahead+0xa6/0xf0 mm/readahead.c:503
       generic_file_buffered_read mm/filemap.c:2003 [inline]
       generic_file_read_iter+0xfbc/0x21c0 mm/filemap.c:2273
       call_read_iter include/linux/fs.h:1774 [inline]
       new_sync_read fs/read_write.c:401 [inline]
       __vfs_read+0x449/0x620 fs/read_write.c:413
       integrity_kernel_read+0x11b/0x1b0 security/integrity/iint.c:199
       ima_calc_file_hash_tfm security/integrity/ima/ima_crypto.c:381 [inline]
       ima_calc_file_shash security/integrity/ima/ima_crypto.c:410 [inline]
       ima_calc_file_hash+0x3ee/0x780 security/integrity/ima/ima_crypto.c:467
       ima_collect_measurement+0x39d/0x430 security/integrity/ima/ima_api.c:227
       process_measurement+0x78b/0xb20 security/integrity/ima/ima_main.c:264
       do_last fs/namei.c:3435 [inline]
       path_openat+0x10ad/0x2970 fs/namei.c:3571
       do_filp_open+0x179/0x3c0 fs/namei.c:3605
       do_sys_open+0x296/0x410 fs/open.c:1081
       do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
       entry_SYSCALL_64_after_hwframe+0x46/0xbb

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.0/12889:
 #0:  (&iint->mutex){+.+.}, at: [<ffffffff82eef900>] process_measurement+0x270/0xb20 security/integrity/ima/ima_main.c:225
 #1:  (&dat_lock_key){.+.+}, at: [<ffffffff826b406e>] nilfs_get_block+0x17e/0x7a0 fs/nilfs2/inode.c:88

stack backtrace:
CPU: 0 PID: 12889 Comm: syz-executor.0 Not tainted 4.14.295-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/22/2022
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
 down_write+0x34/0x90 kernel/locking/rwsem.c:54
 nilfs_set_error fs/nilfs2/super.c:95 [inline]
 __nilfs_error+0x176/0x399 fs/nilfs2/super.c:140
 nilfs_bmap_convert_error fs/nilfs2/bmap.c:44 [inline]
 nilfs_bmap_lookup_contig+0x130/0x170 fs/nilfs2/bmap.c:104
 nilfs_get_block+0x1bd/0x7a0 fs/nilfs2/inode.c:89
 do_mpage_readpage+0x615/0x1470 fs/mpage.c:211
 mpage_readpages+0x2d6/0x5f0 fs/mpage.c:383
 read_pages mm/readahead.c:121 [inline]
 __do_page_cache_readahead+0x522/0x940 mm/readahead.c:199
 ra_submit mm/internal.h:66 [inline]
 ondemand_readahead.isra.0+0x514/0xb60 mm/readahead.c:486
 page_cache_sync_readahead mm/readahead.c:518 [inline]
 page_cache_sync_readahead+0xa6/0xf0 mm/readahead.c:503
 generic_file_buffered_read mm/filemap.c:2003 [inline]
 generic_file_read_iter+0xfbc/0x21c0 mm/filemap.c:2273
 call_read_iter include/linux/fs.h:1774 [inline]
 new_sync_read fs/read_write.c:401 [inline]
 __vfs_read+0x449/0x620 fs/read_write.c:413
 integrity_kernel_read+0x11b/0x1b0 security/integrity/iint.c:199
 ima_calc_file_hash_tfm security/integrity/ima/ima_crypto.c:381 [inline]
 ima_calc_file_shash security/integrity/ima/ima_crypto.c:410 [inline]
 ima_calc_file_hash+0x3ee/0x780 security/integrity/ima/ima_crypto.c:467
 ima_collect_measurement+0x39d/0x430 security/integrity/ima/ima_api.c:227
 process_measurement+0x78b/0xb20 security/integrity/ima/ima_main.c:264
 do_last fs/namei.c:3435 [inline]
 path_openat+0x10ad/0x2970 fs/namei.c:3571
 do_filp_open+0x179/0x3c0 fs/namei.c:3605
 do_sys_open+0x296/0x410 fs/open.c:1081
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7f9cbeb5c5a9
RSP: 002b:00007f9cbd4cf168 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f9cbec7cf80 RCX: 00007f9cbeb5c5a9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000880
RBP: 00007f9cbebb7580 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc7e8ec58f R14: 00007f9cbd4cf300 R15: 0000000000022000
Remounting filesystem read-only
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
audit: type=1800 audit(1666038823.610:31): pid=12889 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed" comm="syz-executor.0" name="file2" dev="loop0" ino=16 res=0
EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue
EXT4-fs (loop2): mounted filesystem without journal. Opts: ,errors=continue
EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue
NILFS (loop0): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds
NILFS (loop0): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
xt_cluster: you have exceeded the maximum number of cluster nodes (4096 > 32)
Remounting filesystem read-only
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
audit: type=1800 audit(1666038825.620:32): pid=13084 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed" comm="syz-executor.0" name="file2" dev="loop0" ino=16 res=0
blktrace: Concurrent blktraces are not allowed on sg0
blktrace: Concurrent blktraces are not allowed on sg0
blktrace: Concurrent blktraces are not allowed on sg0
NILFS (loop0): segctord starting. Construction interval = 5 seconds, CP frequency < 30 seconds
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
Remounting filesystem read-only
blktrace: Concurrent blktraces are not allowed on sg0
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
blktrace: Concurrent blktraces are not allowed on sg0
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
NILFS (loop0): bad btree node (ino=16, blocknr=15): level = 0, flags = 0x0, nchildren = 0
NILFS error (device loop0): nilfs_bmap_lookup_contig: broken bmap (inode number=16)
audit: type=1800 audit(1666038826.330:33): pid=13223 uid=0 auid=4294967295 ses=4294967295 op="collect_data" cause="failed" comm="syz-executor.0" name="file2" dev="loop0" ino=16 res=0
nla_parse: 4 callbacks suppressed
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'.
FAT-fs (loop5): bogus number of reserved sectors
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'.
FAT-fs (loop5): Can't find a valid FAT filesystem
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'.
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.0'.
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
FAT-fs (loop0): bogus number of reserved sectors
FAT-fs (loop0): Can't find a valid FAT filesystem
Process accounting resumed
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop0): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
FAT-fs (loop0): Can't find a valid FAT filesystem
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
FAT-fs (loop0): bogus number of reserved sectors
FAT-fs (loop0): Can't find a valid FAT filesystem
FAT-fs (loop5): bogus number of reserved sectors
FAT-fs (loop5): Can't find a valid FAT filesystem
Process accounting resumed
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'.
f2fs_msg: 22 callbacks suppressed
F2FS-fs (loop3): Found nat_bits in checkpoint
F2FS-fs (loop3): Mounted with checkpoint version = 753bd00b
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.3'.
F2FS-fs (loop3): Found nat_bits in checkpoint
netlink: 24 bytes leftover after parsing attributes in process `syz-executor.1'.
F2FS-fs (loop3): Mounted with checkpoint version = 753bd00b
F2FS-fs (loop1): Found nat_bits in checkpoint
F2FS-fs (loop1): Mounted with checkpoint version = 753bd00b
unregister_netdevice: waiting for ip6gre0 to become free. Usage count = -1