XFS (loop3): log I/O error -5 ================================================================== BUG: KASAN: use-after-free in xlog_cil_committed+0xce/0xd60 fs/xfs/xfs_log_cil.c:614 Read of size 8 at addr ffff8880767c7000 by task kworker/1:1H/150 CPU: 1 PID: 150 Comm: kworker/1:1H Not tainted 5.15.117-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/2023 Workqueue: xfs-log/loop3 xlog_ioend_work Call Trace: __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 xlog_cil_committed+0xce/0xd60 fs/xfs/xfs_log_cil.c:614 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/0x430 fs/xfs/xfs_fsops.c:529 xlog_ioend_work+0xc2/0x120 fs/xfs/xfs_log.c:1364 process_one_work+0x8a1/0x10c0 kernel/workqueue.c:2307 worker_thread+0xaca/0x1280 kernel/workqueue.c:2454 kthread+0x3f6/0x4f0 kernel/kthread.c:319 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:298 Allocated by task 17421: 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+0x168/0x300 mm/slub.c:4407 kmalloc include/linux/slab.h:596 [inline] kmem_alloc+0x136/0x380 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:1303 vfs_get_tree+0x88/0x270 fs/super.c:1508 do_new_mount+0x28b/0xae0 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 3560: 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+0xf1/0x270 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:475 kill_block_super+0x7a/0xe0 fs/super.c:1405 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:208 __syscall_exit_to_user_mode_work kernel/entry/common.c:290 [inline] syscall_exit_to_user_mode+0x5d/0x250 kernel/entry/common.c:301 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:2994 [inline] call_rcu+0x1c4/0xa70 kernel/rcu/tree.c:3074 sctp_association_free+0x664/0x7b0 net/sctp/associola.c:381 sctp_cmd_delete_tcb net/sctp/sm_sideeffect.c:944 [inline] sctp_cmd_interpreter net/sctp/sm_sideeffect.c:1328 [inline] sctp_side_effects net/sctp/sm_sideeffect.c:1199 [inline] sctp_do_sm+0x3c58/0x5c50 net/sctp/sm_sideeffect.c:1170 sctp_assoc_bh_rcv+0x3ed/0x640 net/sctp/associola.c:1053 sctp_backlog_rcv+0x16f/0x3c0 net/sctp/input.c:346 sk_backlog_rcv include/net/sock.h:1059 [inline] __release_sock+0x198/0x4b0 net/core/sock.c:2690 release_sock+0x5d/0x1c0 net/core/sock.c:3231 sctp_close+0x701/0x910 net/sctp/socket.c:1533 inet_release+0x174/0x1f0 net/ipv4/af_inet.c:431 __sock_release net/socket.c:649 [inline] sock_close+0xcd/0x230 net/socket.c:1317 __fput+0x3bf/0x890 fs/file_table.c:280 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:208 __syscall_exit_to_user_mode_work kernel/entry/common.c:290 [inline] syscall_exit_to_user_mode+0x5d/0x250 kernel/entry/common.c:301 do_syscall_64+0x49/0xb0 arch/x86/entry/common.c:86 entry_SYSCALL_64_after_hwframe+0x61/0xcb 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:2994 [inline] call_rcu+0x1c4/0xa70 kernel/rcu/tree.c:3074 sctp_association_free+0x664/0x7b0 net/sctp/associola.c:381 sctp_cmd_delete_tcb net/sctp/sm_sideeffect.c:944 [inline] sctp_cmd_interpreter net/sctp/sm_sideeffect.c:1328 [inline] sctp_side_effects net/sctp/sm_sideeffect.c:1199 [inline] sctp_do_sm+0x3c58/0x5c50 net/sctp/sm_sideeffect.c:1170 sctp_assoc_bh_rcv+0x3ed/0x640 net/sctp/associola.c:1053 sctp_backlog_rcv+0x16f/0x3c0 net/sctp/input.c:346 sk_backlog_rcv include/net/sock.h:1059 [inline] __release_sock+0x198/0x4b0 net/core/sock.c:2690 release_sock+0x5d/0x1c0 net/core/sock.c:3231 sctp_wait_for_connect+0x3c9/0x6e0 net/sctp/socket.c:9329 __sctp_connect+0xb50/0xe10 net/sctp/socket.c:1244 sctp_connect net/sctp/socket.c:4812 [inline] sctp_inet_connect+0x145/0x1e0 net/sctp/socket.c:4827 __sys_connect_file net/socket.c:1899 [inline] __sys_connect+0x38b/0x410 net/socket.c:1916 __do_sys_connect net/socket.c:1926 [inline] __se_sys_connect net/socket.c:1923 [inline] __x64_sys_connect+0x76/0x80 net/socket.c:1923 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 The buggy address belongs to the object at ffff8880767c7000 which belongs to the cache kmalloc-1k of size 1024 The buggy address is located 0 bytes inside of 1024-byte region [ffff8880767c7000, ffff8880767c7400) The buggy address belongs to the page: page:ffffea0001d9f000 refcount:1 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x767c0 head:ffffea0001d9f000 order:3 compound_mapcount:0 compound_pincount:0 flags: 0xfff00000010200(slab|head|node=0|zone=1|lastcpupid=0x7ff) raw: 00fff00000010200 ffffea00004aac00 0000000400000004 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 0xd2a20(GFP_ATOMIC|__GFP_NOWARN|__GFP_NORETRY|__GFP_COMP|__GFP_NOMEMALLOC), pid 3503, ts 75729855112, free_ts 75729353518 prep_new_page mm/page_alloc.c:2426 [inline] get_page_from_freelist+0x322a/0x33c0 mm/page_alloc.c:4159 __alloc_pages+0x272/0x700 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_track_caller+0x1f6/0x390 mm/slub.c:4958 kmalloc_reserve net/core/skbuff.c:356 [inline] __alloc_skb+0x12c/0x590 net/core/skbuff.c:427 alloc_skb include/linux/skbuff.h:1167 [inline] __tcp_send_ack+0x9c/0x630 net/ipv4/tcp_output.c:3963 tcp_rcv_established+0x135b/0x1e20 net/ipv4/tcp_input.c:5931 tcp_v4_do_rcv+0x423/0x960 net/ipv4/tcp_ipv4.c:1727 sk_backlog_rcv include/net/sock.h:1059 [inline] __release_sock+0x198/0x4b0 net/core/sock.c:2690 release_sock+0x5d/0x1c0 net/core/sock.c:3231 tcp_recvmsg+0x25d/0x7f0 net/ipv4/tcp.c:2560 inet_recvmsg+0x157/0x280 net/ipv4/af_inet.c:856 sock_recvmsg_nosec net/socket.c:947 [inline] sock_recvmsg net/socket.c:965 [inline] sock_read_iter+0x353/0x480 net/socket.c:1038 call_read_iter include/linux/fs.h:2097 [inline] new_sync_read fs/read_write.c:404 [inline] vfs_read+0xa9f/0xe10 fs/read_write.c:485 ksys_read+0x1a2/0x2c0 fs/read_write.c:623 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+0xc34/0xcf0 mm/page_alloc.c:3317 free_unref_page+0x95/0x2d0 mm/page_alloc.c:3396 skb_free_frag include/linux/skbuff.h:3024 [inline] skb_free_head net/core/skbuff.c:653 [inline] skb_release_data+0x749/0x8a0 net/core/skbuff.c:677 skb_release_all net/core/skbuff.c:742 [inline] __kfree_skb+0x4c/0x60 net/core/skbuff.c:756 sk_eat_skb include/net/sock.h:2696 [inline] tcp_recvmsg_locked+0x1629/0x29b0 net/ipv4/tcp.c:2512 tcp_recvmsg+0x24e/0x7f0 net/ipv4/tcp.c:2558 inet_recvmsg+0x157/0x280 net/ipv4/af_inet.c:856 sock_recvmsg_nosec net/socket.c:947 [inline] sock_recvmsg net/socket.c:965 [inline] sock_read_iter+0x353/0x480 net/socket.c:1038 call_read_iter include/linux/fs.h:2097 [inline] new_sync_read fs/read_write.c:404 [inline] vfs_read+0xa9f/0xe10 fs/read_write.c:485 ksys_read+0x1a2/0x2c0 fs/read_write.c:623 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: ffff8880767c6f00: fc fc fc fc fc fc fc fc fc fc fc fc fc fc fc fc ffff8880767c6f80: fc fc fc fc fc fc fc fc fc fc fc fc fc fc fc fc >ffff8880767c7000: fa fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb ^ ffff8880767c7080: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb ffff8880767c7100: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb ==================================================================