Re: [syzbot] [ext4?] KASAN: slab-out-of-bounds Read in ext4_group_desc_csum

From: Dmitry Vyukov
Date: Tue Mar 14 2023 - 05:33:50 EST


On Tue, 14 Mar 2023 at 09:49, Jan Kara <jack@xxxxxxx> wrote:
>
> On Mon 13-03-23 15:53:57, Dmitry Vyukov wrote:
> > On Mon, 13 Mar 2023 at 12:57, Jan Kara <jack@xxxxxxx> wrote:
> > >
> > > Hi Tudor!
> > >
> > > On Mon 13-03-23 11:11:18, Tudor Ambarus wrote:
> > > > On 3/7/23 11:02, Tudor Ambarus wrote:
> > > > > On 3/7/23 10:39, Jan Kara wrote:
> > > > >> On Wed 01-03-23 12:13:51, Tudor Ambarus wrote:
> > > > >>> On 2/13/23 15:56, syzbot wrote:
> > > > >>>> syzbot has found a reproducer for the following issue on:
> > > > >>>>
> > > > >>>> HEAD commit: ceaa837f96ad Linux 6.2-rc8
> > > > >>>> git tree: upstream
> > > > >>>> console output:
> > > > >>>> https://syzkaller.appspot.com/x/log.txt?x=11727cc7480000
> > > > >>>> kernel config:
> > > > >>>> https://syzkaller.appspot.com/x/.config?x=42ba4da8e1e6af9f
> > > > >>>> dashboard link:
> > > > >>>> https://syzkaller.appspot.com/bug?extid=8785e41224a3afd04321
> > > > >>>> compiler: Debian clang version 15.0.7, GNU ld (GNU Binutils
> > > > >>>> for Debian) 2.35.2
> > > > >>>> syz repro:
> > > > >>>> https://syzkaller.appspot.com/x/repro.syz?x=14392a4f480000
> > > > >>>>
> > > > >>>> Downloadable assets:
> > > > >>>> disk image:
> > > > >>>> https://storage.googleapis.com/syzbot-assets/88042f9b5fc8/disk-ceaa837f.raw.xz
> > > > >>>> vmlinux:
> > > > >>>> https://storage.googleapis.com/syzbot-assets/9945b57ec9ee/vmlinux-ceaa837f.xz
> > > > >>>> kernel image:
> > > > >>>> https://storage.googleapis.com/syzbot-assets/72ff118ed96b/bzImage-ceaa837f.xz
> > > > >>>> mounted in repro:
> > > > >>>> https://storage.googleapis.com/syzbot-assets/dabec17b2679/mount_0.gz
> > > > >>>>
> > > > >>>> IMPORTANT: if you fix the issue, please add the following tag to the
> > > > >>>> commit:
> > > > >>>> Reported-by: syzbot+8785e41224a3afd04321@xxxxxxxxxxxxxxxxxxxxxxxxx
> > > > >>>>
> > > > >>>> ==================================================================
> > > > >>>> BUG: KASAN: use-after-free in crc16+0x1fb/0x280 lib/crc16.c:58
> > > > >>>> Read of size 1 at addr ffff88807de00000 by task syz-executor.1/5339
> > > > >>>>
> > > > >>>> CPU: 1 PID: 5339 Comm: syz-executor.1 Not tainted
> > > > >>>> 6.2.0-rc8-syzkaller #0
> > > > >>>> Hardware name: Google Google Compute Engine/Google Compute Engine,
> > > > >>>> BIOS Google 01/21/2023
> > > > >>>> Call Trace:
> > > > >>>> <TASK>
> > > > >>>> __dump_stack lib/dump_stack.c:88 [inline]
> > > > >>>> dump_stack_lvl+0x1e7/0x2d0 lib/dump_stack.c:106
> > > > >>>> print_address_description mm/kasan/report.c:306 [inline]
> > > > >>>> print_report+0x163/0x4f0 mm/kasan/report.c:417
> > > > >>>> kasan_report+0x13a/0x170 mm/kasan/report.c:517
> > > > >>>> crc16+0x1fb/0x280 lib/crc16.c:58
> > > > >>>> ext4_group_desc_csum+0x90f/0xc50 fs/ext4/super.c:3187
> > > > >>>> ext4_group_desc_csum_set+0x19b/0x240 fs/ext4/super.c:3210
> > > > >>>> ext4_mb_clear_bb fs/ext4/mballoc.c:6027 [inline]
> > > > >>>> ext4_free_blocks+0x1c57/0x3010 fs/ext4/mballoc.c:6173
> > > > >>>> ext4_remove_blocks fs/ext4/extents.c:2527 [inline]
> > > > >>>> ext4_ext_rm_leaf fs/ext4/extents.c:2710 [inline]
> > > > >>>> ext4_ext_remove_space+0x289e/0x5270 fs/ext4/extents.c:2958
> > > > >>>> ext4_ext_truncate+0x176/0x210 fs/ext4/extents.c:4416
> > > > >>>> ext4_truncate+0xafa/0x1450 fs/ext4/inode.c:4342
> > > > >>>> ext4_evict_inode+0xc40/0x1230 fs/ext4/inode.c:286
> > > > >>>> evict+0x2a4/0x620 fs/inode.c:664
> > > > >>>> do_unlinkat+0x4f1/0x930 fs/namei.c:4327
> > > > >>>> __do_sys_unlink fs/namei.c:4368 [inline]
> > > > >>>> __se_sys_unlink fs/namei.c:4366 [inline]
> > > > >>>> __x64_sys_unlink+0x49/0x50 fs/namei.c:4366
> > > > >>>> do_syscall_x64 arch/x86/entry/common.c:50 [inline]
> > > > >>>> do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
> > > > >>>> entry_SYSCALL_64_after_hwframe+0x63/0xcd
> > > > >>>> RIP: 0033:0x7fbc85a8c0f9
> > > > >>>> 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
> > > > >>>> RSP: 002b:00007fbc86838168 EFLAGS: 00000246 ORIG_RAX: 0000000000000057
> > > > >>>> RAX: ffffffffffffffda RBX: 00007fbc85babf80 RCX: 00007fbc85a8c0f9
> > > > >>>> RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000000
> > > > >>>> RBP: 00007fbc85ae7ae9 R08: 0000000000000000 R09: 0000000000000000
> > > > >>>> R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
> > > > >>>> R13: 00007ffd5743beaf R14: 00007fbc86838300 R15: 0000000000022000
> > > > >>>> </TASK>
> > > > >>>>
> > > > >>>> The buggy address belongs to the physical page:
> > > > >>>> page:ffffea0001f78000 refcount:0 mapcount:-128
> > > > >>>> mapping:0000000000000000 index:0x0 pfn:0x7de00
> > > > >>>> flags: 0xfff00000000000(node=0|zone=1|lastcpupid=0x7ff)
> > > > >>>> raw: 00fff00000000000 ffffea0001f86008 ffffea0001db2a08
> > > > >>>> 0000000000000000
> > > > >>>> raw: 0000000000000000 0000000000000001 00000000ffffff7f
> > > > >>>> 0000000000000000
> > > > >>>> page dumped because: kasan: bad access detected
> > > > >>>> page_owner tracks the page as freed
> > > > >>>> page last allocated via order 1, migratetype Unmovable, gfp_mask
> > > > >>>> 0xd20c0(__GFP_IO|__GFP_FS|__GFP_NOWARN|__GFP_NORETRY|__GFP_COMP|__GFP_NOMEMALLOC), pid 4855, tgid 4855 (sshd), ts 43553490210, free_ts 58249059760
> > > > >>>> prep_new_page mm/page_alloc.c:2531 [inline]
> > > > >>>> get_page_from_freelist+0x3449/0x35c0 mm/page_alloc.c:4283
> > > > >>>> __alloc_pages+0x291/0x7e0 mm/page_alloc.c:5549
> > > > >>>> alloc_slab_page+0x6a/0x160 mm/slub.c:1851
> > > > >>>> allocate_slab mm/slub.c:1998 [inline]
> > > > >>>> new_slab+0x84/0x2f0 mm/slub.c:2051
> > > > >>>> ___slab_alloc+0xa85/0x10a0 mm/slub.c:3193
> > > > >>>> __kmem_cache_alloc_bulk mm/slub.c:3951 [inline]
> > > > >>>> kmem_cache_alloc_bulk+0x160/0x430 mm/slub.c:4026
> > > > >>>> mt_alloc_bulk lib/maple_tree.c:157 [inline]
> > > > >>>> mas_alloc_nodes+0x381/0x640 lib/maple_tree.c:1257
> > > > >>>> mas_node_count_gfp lib/maple_tree.c:1316 [inline]
> > > > >>>> mas_preallocate+0x131/0x350 lib/maple_tree.c:5724
> > > > >>>> vma_expand+0x277/0x850 mm/mmap.c:541
> > > > >>>> mmap_region+0xc43/0x1fb0 mm/mmap.c:2592
> > > > >>>> do_mmap+0x8c9/0xf70 mm/mmap.c:1411
> > > > >>>> vm_mmap_pgoff+0x1ce/0x2e0 mm/util.c:520
> > > > >>>> do_syscall_x64 arch/x86/entry/common.c:50 [inline]
> > > > >>>> do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
> > > > >>>> entry_SYSCALL_64_after_hwframe+0x63/0xcd
> > > > >>>> page last free stack trace:
> > > > >>>> reset_page_owner include/linux/page_owner.h:24 [inline]
> > > > >>>> free_pages_prepare mm/page_alloc.c:1446 [inline]
> > > > >>>> free_pcp_prepare mm/page_alloc.c:1496 [inline]
> > > > >>>> free_unref_page_prepare+0xf3a/0x1040 mm/page_alloc.c:3369
> > > > >>>> free_unref_page+0x37/0x3f0 mm/page_alloc.c:3464
> > > > >>>> qlist_free_all+0x22/0x60 mm/kasan/quarantine.c:187
> > > > >>>> kasan_quarantine_reduce+0x15a/0x170 mm/kasan/quarantine.c:294
> > > > >>>> __kasan_slab_alloc+0x23/0x80 mm/kasan/common.c:302
> > > > >>>> kasan_slab_alloc include/linux/kasan.h:201 [inline]
> > > > >>>> slab_post_alloc_hook+0x68/0x390 mm/slab.h:761
> > > > >>>> slab_alloc_node mm/slub.c:3452 [inline]
> > > > >>>> kmem_cache_alloc_node+0x158/0x2c0 mm/slub.c:3497
> > > > >>>> __alloc_skb+0xd6/0x2d0 net/core/skbuff.c:552
> > > > >>>> alloc_skb include/linux/skbuff.h:1270 [inline]
> > > > >>>> alloc_skb_with_frags+0xa8/0x750 net/core/skbuff.c:6194
> > > > >>>> sock_alloc_send_pskb+0x919/0xa50 net/core/sock.c:2743
> > > > >>>> unix_dgram_sendmsg+0x5b5/0x2050 net/unix/af_unix.c:1943
> > > > >>>> sock_sendmsg_nosec net/socket.c:714 [inline]
> > > > >>>> sock_sendmsg net/socket.c:734 [inline]
> > > > >>>> __sys_sendto+0x475/0x5f0 net/socket.c:2117
> > > > >>>> __do_sys_sendto net/socket.c:2129 [inline]
> > > > >>>> __se_sys_sendto net/socket.c:2125 [inline]
> > > > >>>> __x64_sys_sendto+0xde/0xf0 net/socket.c:2125
> > > > >>>> do_syscall_x64 arch/x86/entry/common.c:50 [inline]
> > > > >>>> do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
> > > > >>>> entry_SYSCALL_64_after_hwframe+0x63/0xcd
> > > > >>>>
> > > > >>>> Memory state around the buggy address:
> > > > >>>> ffff88807ddfff00: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
> > > > >>>> ffff88807ddfff80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
> > > > >>>>> ffff88807de00000: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
> > > > >>>> ^
> > > > >>>> ffff88807de00080: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
> > > > >>>> ffff88807de00100: ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
> > > > >>>> ==================================================================
> > > > >>>>
> > > > >>>
> > > > >>>
> > > > >>> I think the patch from below should fix it.
> > > > >>>
> > > > >>> I printed le16_to_cpu(sbi->s_es->s_desc_size) and it was greater than
> > > > >>> EXT4_MAX_DESC_SIZE. What I think it happens is that the contents of the
> > > > >>> super block in the buffer get corrupted sometime after the .get_tree
> > > > >>> (which eventually calls __ext4_fill_super()) is called. So instead of
> > > > >>> relying on the contents of the buffer, we should instead rely on the
> > > > >>> s_desc_size initialized at the __ext4_fill_super() time.
> > > > >>>
> > > > >>> If someone finds this good (or bad), or has a more in depth explanation,
> > > > >>> please let me know, it will help me better understand the subsystem. In
> > > > >>> the meantime I'll continue to investigate this and prepare a patch for
> > > > >>> it.
> > > > >>
> > > > >> If there's something corrupting the superblock while the filesystem is
> > > > >> mounted, we need to find what is corrupting the SB and fix *that*. Not
> > > > >> try
> > > > >> to paper over the problem by not using the on-disk data... Maybe journal
> > > > >> replay is corrupting the value or something like that?
> > > > >>
> > > > >> Honza
> > > > >>
> > > > >
> > > > > Ok, I agree. First thing would be to understand the reproducer and to
> > > > > simplify it if possible. I haven't yet decoded what the syz repro is
> > > > > doing at
> > > > > https://syzkaller.appspot.com/text?tag=ReproSyz&x=16ce3de4c80000
> > > > > Will reply to this email thread once I understand what's happening. If
> > > > > you or someone else can decode the syz repro faster than me, shoot.
> > > > >
> > > >
> > > > I can now explain how the contents of the super block of the buffer get
> > > > corrupted. After the ext4 fs is mounted to the target ("./bus"), the
> > > > reproducer maps 6MB of data starting at offset 0 in the target's file
> > > > ("./bus"), then it starts overriding the data with something else, by
> > > > using memcpy, memset, individual byte inits. Does that mean that we
> > > > shouldn't rely on the contents of the super block in the buffer after we
> > > > mount the file system? If so, then my patch stands. I'll be happy to
> > > > extend it if needed. Below one may find a step by step interpretation of
> > > > the reproducer.
> > > >
> > > > We have a strace log for the same bug, but on Android 5.15:
> > > > https://syzkaller.appspot.com/text?tag=CrashLog&x=14ecec8cc80000
> > > >
> > > > Look for pid 328. You notice that the bpf() syscalls return error, so I
> > > > commented them out in the c repro to confirm that they are not the
> > > > cause. The bug reproduced without the bpf() calls. One can find the c
> > > > repro at:
> > > > https://syzkaller.appspot.com/text?tag=ReproC&x=17c5fc50c80000
> > > >
> > > > Let's look at these calls, just before the bug was hit:
> > > > [pid 328] open("./bus",
> > > > O_RDWR|O_CREAT|O_TRUNC|O_NONBLOCK|O_SYNC|O_DIRECT|O_LARGEFILE|O_NOATIME,
> > > > 000) = 4
> > > > [pid 328] mount("/dev/loop0", "./bus", NULL, MS_BIND, NULL) = 0
> > > > [pid 328] open("./bus", O_RDWR|O_SYNC|O_NOATIME|0x3c) = 5
> > > > [pid 328] mmap(0x20000000, 6291456,
> > > > PROT_READ|PROT_WRITE|PROT_EXEC|PROT_SEM|0x47ffff0, MAP_SHARED|MAP_FIXED,
> > > > 5, 0) = 0x20000000
> > >
> > > Yeah, looking at the reproducer, before this the reproducer also mounts
> > > /dev/loop0 as ext4 filesystem.
> > >
> > > > - ./bus is created (if it does not exist), fd 4 is returned.
> > > > - /dev/loop0 is mounted to ./bus
> > > > - then it creates a new file descriptor (5) for the same ./bus
> > > > - then it creates a mapping for ./bus starting at offset zero. The
> > > > mapped area is at 0x20000000 and is of 0x600000ul length.
> > >
> > > So the result is that the reproducer modified the block device while it is
> > > mounted by the filesystem. We know cases like this can crash the kernel and
> > > it is inherently difficult to fix. We have to trust the buffer cache
> > > contents as otherwise the performance will be unacceptable. For historical
> > > reasons we also have to allow modifications of buffer cache while ext4 is
> > > mounted because tune2fs uses this to e.g. update the label of a mounted
> > > filesystem.
> > >
> > > Long-term we are moving ext4 in a direction where we can disallow block
> > > device modifications while the fs is mounted but we are not there yet. I've
> > > discussed some shorter-term solution to avoid such known problems with syzbot
> > > developers and what seems plausible would be a kconfig option to disallow
> > > writing to a block device when it is exclusively open by someone else.
> > > But so far I didn't get to trying whether this would reasonably work. Would
> > > you be interested in having a look into this?
> >
> > Does this affect only the loop device or also USB storage devices?
> > Say, if the USB device returns different contents during mount and on
> > subsequent reads?
>
> So if USB returns a different content, we are fine because we verify the
> content each time when loading it into the buffer cache. But if something
> in the software opens the block device and modifies it, it modifies
> directly the buffer cache and thus bypasses any checks we do when loading
> data from the storage.

Thanks, I see. This is good.