syzbot


KASAN: use-after-free Read in xlog_cil_committed

Status: auto-obsoleted due to no activity on 2023/09/12 13:46
Reported-by: syzbot+a3a4c9a511f8f3e701f0@syzkaller.appspotmail.com
First crash: 536d, last: 437d
Bug presence (1)
Date Name Commit Repro Result
2023/05/20 upstream (ToT) d635f6cc934b C Didn't crash

Sample crash report:
XFS (loop2): Log I/O Error (0x2) detected at xlog_ioend_work+0xc2/0x120 fs/xfs/xfs_log.c:1364 (fs/xfs/xfs_log.c:1364).  Shutting down filesystem.
XFS (loop2): Please unmount the filesystem and rectify the problem(s)
XFS (loop4): log I/O error -5
==================================================================
BUG: KASAN: use-after-free in __lock_acquire+0x74/0x1ff0 kernel/locking/lockdep.c:4881
Read of size 8 at addr ffff8880799c2158 by task kworker/1:1H/263

CPU: 1 PID: 263 Comm: kworker/1:1H Not tainted 5.15.103-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
Workqueue: xfs-log/loop4 xlog_ioend_work
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1e3/0x2cb lib/dump_stack.c:106
 print_address_description+0x63/0x3b0 mm/kasan/report.c:248
 __kasan_report mm/kasan/report.c:434 [inline]
 kasan_report+0x16b/0x1c0 mm/kasan/report.c:451
 __lock_acquire+0x74/0x1ff0 kernel/locking/lockdep.c:4881
 lock_acquire+0x1ff/0x570 kernel/locking/lockdep.c:5622
 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline]
 _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:154
 spin_lock include/linux/spinlock.h:363 [inline]
 xlog_cil_committed+0x33c/0xe50 fs/xfs/xfs_log_cil.c:638
 xlog_cil_process_committed+0x155/0x1a0 fs/xfs/xfs_log_cil.c:659
 xlog_state_shutdown_callbacks+0x2b6/0x3a0 fs/xfs/xfs_log.c:516
 xlog_force_shutdown+0x1e7/0x200 fs/xfs/xfs_log.c:3896
 xfs_do_force_shutdown+0x11d/0x520 fs/xfs/xfs_fsops.c:529
 xlog_ioend_work+0xc2/0x120 fs/xfs/xfs_log.c:1364
 process_one_work+0x90d/0x1270 kernel/workqueue.c:2306
 worker_thread+0xaca/0x1280 kernel/workqueue.c:2453
 kthread+0x3f6/0x4f0 kernel/kthread.c:319
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298
 </TASK>

Allocated by task 13323:
 kasan_save_stack mm/kasan/common.c:38 [inline]
 kasan_set_track mm/kasan/common.c:46 [inline]
 set_alloc_info mm/kasan/common.c:434 [inline]
 ____kasan_kmalloc+0xba/0xf0 mm/kasan/common.c:513
 kasan_kmalloc include/linux/kasan.h:264 [inline]
 __kmalloc+0x152/0x290 mm/slub.c:4407
 kmalloc include/linux/slab.h:596 [inline]
 kmem_alloc+0x1c4/0x470 fs/xfs/kmem.c:21
 kmem_zalloc fs/xfs/kmem.h:69 [inline]
 xlog_cil_init+0x20/0x410 fs/xfs/xfs_log_cil.c:1454
 xlog_alloc_log+0x10bb/0x1380 fs/xfs/xfs_log.c:1625
 xfs_log_mount+0xd8/0x720 fs/xfs/xfs_log.c:633
 xfs_mountfs+0xb7a/0x1ca0 fs/xfs/xfs_mount.c:764
 xfs_fs_fill_super+0x100c/0x1240 fs/xfs/xfs_super.c:1658
 get_tree_bdev+0x3fe/0x620 fs/super.c:1294
 vfs_get_tree+0x88/0x270 fs/super.c:1499
 do_new_mount+0x28b/0xad0 fs/namespace.c:2994
 do_mount fs/namespace.c:3337 [inline]
 __do_sys_mount fs/namespace.c:3545 [inline]
 __se_sys_mount+0x2d5/0x3c0 fs/namespace.c:3522
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3d/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x61/0xcb

Freed by task 3675:
 kasan_save_stack mm/kasan/common.c:38 [inline]
 kasan_set_track+0x4b/0x80 mm/kasan/common.c:46
 kasan_set_free_info+0x1f/0x40 mm/kasan/generic.c:360
 ____kasan_slab_free+0xd8/0x120 mm/kasan/common.c:366
 kasan_slab_free include/linux/kasan.h:230 [inline]
 slab_free_hook mm/slub.c:1705 [inline]
 slab_free_freelist_hook+0xdd/0x160 mm/slub.c:1731
 slab_free mm/slub.c:3499 [inline]
 kfree+0x115/0x2e0 mm/slub.c:4559
 xlog_dealloc_log+0x28/0x240 fs/xfs/xfs_log.c:2064
 xfs_unmountfs+0x1bf/0x270 fs/xfs/xfs_mount.c:1040
 xfs_fs_put_super+0x65/0x2b0 fs/xfs/xfs_super.c:1090
 generic_shutdown_super+0x136/0x2c0 fs/super.c:466
 kill_block_super+0x7a/0xe0 fs/super.c:1396
 deactivate_locked_super+0xa0/0x110 fs/super.c:335
 cleanup_mnt+0x44e/0x500 fs/namespace.c:1143
 task_work_run+0x129/0x1a0 kernel/task_work.c:164
 tracehook_notify_resume include/linux/tracehook.h:189 [inline]
 exit_to_user_mode_loop+0x106/0x130 kernel/entry/common.c:175
 exit_to_user_mode_prepare+0xb1/0x140 kernel/entry/common.c:207
 __syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
 syscall_exit_to_user_mode+0x5d/0x2b0 kernel/entry/common.c:300
 do_syscall_64+0x49/0xb0 arch/x86/entry/common.c:86
 entry_SYSCALL_64_after_hwframe+0x61/0xcb

Last potentially related work creation:
 kasan_save_stack+0x36/0x60 mm/kasan/common.c:38
 kasan_record_aux_stack+0xba/0x100 mm/kasan/generic.c:348
 __call_rcu kernel/rcu/tree.c:2993 [inline]
 call_rcu+0x1c4/0xa70 kernel/rcu/tree.c:3073
 process_one_work+0x90d/0x1270 kernel/workqueue.c:2306
 worker_thread+0xaca/0x1280 kernel/workqueue.c:2453
 kthread+0x3f6/0x4f0 kernel/kthread.c:319
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298

Second to last potentially related work creation:
 kasan_save_stack+0x36/0x60 mm/kasan/common.c:38
 kasan_record_aux_stack+0xba/0x100 mm/kasan/generic.c:348
 __call_rcu kernel/rcu/tree.c:2993 [inline]
 call_rcu+0x1c4/0xa70 kernel/rcu/tree.c:3073
 process_one_work+0x90d/0x1270 kernel/workqueue.c:2306
 worker_thread+0xaca/0x1280 kernel/workqueue.c:2453
 kthread+0x3f6/0x4f0 kernel/kthread.c:319
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298

The buggy address belongs to the object at ffff8880799c2000
 which belongs to the cache kmalloc-1k of size 1024
The buggy address is located 344 bytes inside of
 1024-byte region [ffff8880799c2000, ffff8880799c2400)
The buggy address belongs to the page:
page:ffffea0001e67000 refcount:1 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x799c0
head:ffffea0001e67000 order:3 compound_mapcount:0 compound_pincount:0
flags: 0xfff00000010200(slab|head|node=0|zone=1|lastcpupid=0x7ff)
raw: 00fff00000010200 dead000000000100 dead000000000122 ffff888011c41dc0
raw: 0000000000000000 0000000000100010 00000001ffffffff 0000000000000000
page dumped because: kasan: bad access detected
page_owner tracks the page as allocated
page last allocated via order 3, migratetype Unmovable, gfp_mask 0xd20c0(__GFP_IO|__GFP_FS|__GFP_NOWARN|__GFP_NORETRY|__GFP_COMP|__GFP_NOMEMALLOC), pid 3675, ts 962984574210, free_ts 962456515812
 prep_new_page mm/page_alloc.c:2426 [inline]
 get_page_from_freelist+0x32dd/0x3470 mm/page_alloc.c:4159
 __alloc_pages+0x272/0x790 mm/page_alloc.c:5421
 alloc_slab_page mm/slub.c:1775 [inline]
 allocate_slab mm/slub.c:1912 [inline]
 new_slab+0xbb/0x4b0 mm/slub.c:1975
 ___slab_alloc+0x6f6/0xe10 mm/slub.c:3008
 __slab_alloc mm/slub.c:3095 [inline]
 slab_alloc_node mm/slub.c:3186 [inline]
 __kmalloc_node+0x1eb/0x320 mm/slub.c:4451
 kmalloc_node include/linux/slab.h:614 [inline]
 kzalloc_node include/linux/slab.h:732 [inline]
 qdisc_alloc+0x95/0xaf0 net/sched/sch_generic.c:888
 qdisc_create_dflt+0x5e/0x560 net/sched/sch_generic.c:950
 attach_one_default_qdisc net/sched/sch_generic.c:1113 [inline]
 netdev_for_each_tx_queue include/linux/netdevice.h:2378 [inline]
 attach_default_qdiscs net/sched/sch_generic.c:1131 [inline]
 dev_activate+0x33c/0x12c0 net/sched/sch_generic.c:1190
 __dev_open+0x3eb/0x500 net/core/dev.c:1495
 __dev_change_flags+0x1db/0x6e0 net/core/dev.c:8783
 dev_change_flags+0x87/0x190 net/core/dev.c:8854
 do_setlink+0xcd1/0x3af0 net/core/rtnetlink.c:2721
 __rtnl_newlink net/core/rtnetlink.c:3395 [inline]
 rtnl_newlink+0x177d/0x2060 net/core/rtnetlink.c:3510
 rtnetlink_rcv_msg+0x993/0xee0 net/core/rtnetlink.c:5587
 netlink_rcv_skb+0x1cf/0x410 net/netlink/af_netlink.c:2533
 netlink_unicast_kernel net/netlink/af_netlink.c:1330 [inline]
 netlink_unicast+0x7b6/0x980 net/netlink/af_netlink.c:1356
page last free stack trace:
 reset_page_owner include/linux/page_owner.h:24 [inline]
 free_pages_prepare mm/page_alloc.c:1340 [inline]
 free_pcp_prepare mm/page_alloc.c:1391 [inline]
 free_unref_page_prepare+0xcb7/0xd70 mm/page_alloc.c:3317
 free_unref_page+0x95/0x2d0 mm/page_alloc.c:3396
 do_slab_free mm/slub.c:3487 [inline]
 ___cache_free+0xe3/0x100 mm/slub.c:3506
 qlist_free_all+0x36/0x90 mm/kasan/quarantine.c:176
 kasan_quarantine_reduce+0x162/0x180 mm/kasan/quarantine.c:283
 __kasan_slab_alloc+0x2f/0xc0 mm/kasan/common.c:444
 kasan_slab_alloc include/linux/kasan.h:254 [inline]
 slab_post_alloc_hook+0x53/0x380 mm/slab.h:519
 slab_alloc_node mm/slub.c:3220 [inline]
 kmem_cache_alloc_node+0x121/0x320 mm/slub.c:3256
 __alloc_skb+0xdd/0x590 net/core/skbuff.c:415
 alloc_skb include/linux/skbuff.h:1166 [inline]
 netlink_alloc_large_skb net/netlink/af_netlink.c:1202 [inline]
 netlink_sendmsg+0x6f8/0xd60 net/netlink/af_netlink.c:1927
 sock_sendmsg_nosec net/socket.c:704 [inline]
 sock_sendmsg net/socket.c:724 [inline]
 __sys_sendto+0x564/0x720 net/socket.c:2039
 __do_sys_sendto net/socket.c:2051 [inline]
 __se_sys_sendto net/socket.c:2047 [inline]
 __x64_sys_sendto+0xda/0xf0 net/socket.c:2047
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3d/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x61/0xcb

Memory state around the buggy address:
 ffff8880799c2000: fa fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb
 ffff8880799c2080: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb
>ffff8880799c2100: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb
                                                    ^
 ffff8880799c2180: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb
 ffff8880799c2200: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb
==================================================================

Crashes (19):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/03/21 15:23 linux-5.15.y 8020ae3c051d 7939252e .config console log report syz [disk image] [vmlinux] [kernel image] [mounted in repro] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/28 14:44 linux-5.15.y 4af60700a60c 4cd5bb25 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/25 15:19 linux-5.15.y f67653019430 79782afc .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/22 00:39 linux-5.15.y f67653019430 79782afc .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/20 03:13 linux-5.15.y 471e639e59d1 09ffe269 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/19 22:01 linux-5.15.y 471e639e59d1 d521bc56 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/13 14:50 linux-5.15.y 7349e40704a0 749afb64 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/08 19:43 linux-5.15.y d7af3e5ba454 058b3a5a .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/05/25 22:40 linux-5.15.y 1fe619a7d252 0513b3e6 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/05/13 22:26 linux-5.15.y b0ece631f84a 2b9ba477 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/05/09 20:47 linux-5.15.y 8a7f2a5c5aa1 30aa2a7e .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/05/06 04:58 linux-5.15.y 8a7f2a5c5aa1 de870ca5 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan KASAN: use-after-free Read in xlog_cil_committed
2023/06/16 01:40 linux-5.15.y 471e639e59d1 f3921d4d .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/26 03:25 linux-5.15.y 3299fb36854f 65320f8e .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/20 23:46 linux-5.15.y 3299fb36854f 2b32bd34 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/13 21:13 linux-5.15.y 4fdad925aa1a 3cfcaa1b .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/12 06:54 linux-5.15.y d86dfc4d95cd 49faf98d .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/12 01:35 linux-5.15.y d86dfc4d95cd 49faf98d .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
2023/04/11 16:50 linux-5.15.y d86dfc4d95cd 49faf98d .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan-arm64 KASAN: use-after-free Read in xlog_cil_committed
* Struck through repros no longer work on HEAD.