Re: [Bug report] kernel panic: System is deadlocked on memory

[Pavel Begunkov]

On 5/17/23 13:02, yang lan wrote:
> Hi,
>
> We use our modified Syzkaller to fuzz the Linux kernel and found the
> following issue:
>
> Head Commit: f1b32fda06d2cfb8eea9680b0ba7a8b0d5b81eeb
> Git Tree: stable
>
> Console output: https://pastebin.com/raw/Ssz6eVA6
> Kernel config: https://pastebin.com/raw/BiggLxRg
> C reproducer: https://pastebin.com/raw/tM1iyfjr
> Syz reproducer: https://pastebin.com/raw/CEF1R2jg
>
> root@syzkaller:~# uname -a
> Linux syzkaller 5.10.179 #5 SMP PREEMPT Mon May 1 23:59:32 CST 2023
> x86_64 GNU/Linux
> root@syzkaller:~# gcc poc_io_uring_enter.c -o poc_io_uring_enter
> root@syzkaller:~# ./poc_io_uring_enter
> ...
> [  244.945440][ T3106]
> oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0-1,global_oom,task_memcg=/,task=dhclient,pid=4526,uid=0
> [  244.946537][ T3106] Out of memory: Killed process 4526 (dhclient)
> total-vm:20464kB, anon-rss:1112kB, file-rss:0kB, shmem-rss:0kB, UID:0
> pgtables:76kB oom_score_adj:0
> [  244.953740][ T9068] syz-executor.0 invoked oom-killer:
> gfp_mask=0xcc0(GFP_KERNEL), order=0, oom_score_adj=1000
> [  244.954411][ T9068] CPU: 0 PID: 9068 Comm: syz-executor.0 Not
> tainted 5.10.179 #5
> [  244.954903][ T9068] Hardware name: QEMU Standard PC (i440FX + PIIX,
> 1996), BIOS 1.12.0-1 04/01/2014
> [  244.955515][ T9068] Call Trace:
> [  244.955738][ T9068]  dump_stack+0x106/0x162
> [  244.956026][ T9068]  dump_header+0x117/0x6f8
> [  244.956315][ T9068]  ? ___ratelimit+0x1fc/0x430
> [  244.956621][ T9068]  oom_kill_process.cold.34+0x10/0x15
> [  244.956970][ T9068]  out_of_memory+0x122c/0x1540
> [  244.957283][ T9068]  ? oom_killer_disable+0x270/0x270
> [  244.957627][ T9068]  ? mutex_trylock+0x249/0x2c0
> [  244.957937][ T9068]  ? __alloc_pages_slowpath.constprop.104+0x9fa/0x2250
> [  244.958378][ T9068]  __alloc_pages_slowpath.constprop.104+0x1bec/0x2250
> [  244.958818][ T9068]  ? warn_alloc+0x130/0x130
> [  244.959117][ T9068]  ? find_held_lock+0x33/0x1c0
> [  244.959429][ T9068]  ? __alloc_pages_nodemask+0x3e8/0x6c0
> [  244.959789][ T9068]  ? lock_downgrade+0x6a0/0x6a0
> [  244.960104][ T9068]  ? lock_release+0x660/0x660
> [  244.960412][ T9068]  __alloc_pages_nodemask+0x5dd/0x6c0
> [  244.960762][ T9068]  ? __alloc_pages_slowpath.constprop.104+0x2250/0x2250
> [  244.961210][ T9068]  ? mark_held_locks+0xb0/0x110
> [  244.961531][ T9068]  alloc_pages_current+0x100/0x200
> [  244.961864][ T9068]  allocate_slab+0x302/0x490
> [  244.962166][ T9068]  ___slab_alloc+0x4eb/0x820
> [  244.962472][ T9068]  ? io_issue_sqe+0xf26/0x5d50
> [  244.962782][ T9068]  ? __slab_alloc.isra.78+0x64/0xa0
> [  244.963118][ T9068]  ? io_issue_sqe+0xf26/0x5d50
> [  244.963427][ T9068]  ? __slab_alloc.isra.78+0x8b/0xa0
> [  244.963762][ T9068]  __slab_alloc.isra.78+0x8b/0xa0
> [  244.964106][ T9068]  ? should_failslab+0x5/0x10
> [  244.964419][ T9068]  ? io_issue_sqe+0xf26/0x5d50
> [  244.964727][ T9068]  kmem_cache_alloc_trace+0x22a/0x270
> [  244.965077][ T9068]  io_issue_sqe+0xf26/0x5d50
> [  244.965379][ T9068]  ? io_write+0xf50/0xf50
> [  244.965662][ T9068]  ? io_submit_flush_completions+0x6a1/0x930
> [  244.966051][ T9068]  ? io_req_free_batch+0x710/0x710
> [  244.966380][ T9068]  ? allocate_slab+0x38c/0x490
> [  244.966690][ T9068]  __io_queue_sqe.part.124+0xb1/0xb00
> [  244.967036][ T9068]  ? kasan_unpoison_shadow+0x30/0x40
> [  244.967378][ T9068]  ? __kasan_kmalloc.constprop.10+0xc1/0xd0
> [  244.967760][ T9068]  ? io_issue_sqe+0x5d50/0x5d50
> [  244.968075][ T9068]  ? kmem_cache_alloc_bulk+0xe1/0x250
> [  244.968420][ T9068]  ? io_submit_sqes+0x1c47/0x7b00
> [  244.968744][ T9068]  io_submit_sqes+0x1c47/0x7b00
> [  244.969080][ T9068]  ? __x64_sys_io_uring_enter+0xcdd/0x11a0
> [  244.969456][ T9068]  __x64_sys_io_uring_enter+0xcdd/0x11a0
> [  244.969821][ T9068]  ? __io_uring_cancel+0x20/0x20
> [  244.970144][ T9068]  ? get_vtime_delta+0x23d/0x360
> [  244.970467][ T9068]  ? syscall_enter_from_user_mode+0x26/0x70
> [  244.970849][ T9068]  do_syscall_64+0x2d/0x70
> [  244.971136][ T9068]  entry_SYSCALL_64_after_hwframe+0x61/0xc6
> [  244.971514][ T9068] RIP: 0033:0x46a8c9
> [  244.971771][ T9068] Code: Unable to access opcode bytes at RIP 0x46a89f.
> [  244.972208][ T9068] RSP: 002b:00007f4d887e0c38 EFLAGS: 00000246
> ORIG_RAX: 00000000000001aa
> [  244.972747][ T9068] RAX: ffffffffffffffda RBX: 000000000057bf80
> RCX: 000000000046a8c9
> [  244.973253][ T9068] RDX: 0000000000000000 RSI: 00000000000051cd
> RDI: 0000000000000003
> [  244.973792][ T9068] RBP: 00000000004c9f3b R08: 0000000000000000
> R09: 0000000000000000
> [  244.974299][ T9068] R10: 0000000000000000 R11: 0000000000000246
> R12: 000000000057bf80
> [  244.974802][ T9068] R13: 00007ffd88d30d4f R14: 000000000057bf80
> R15: 00007ffd88d30f00
> [  244.980610][ T9068] Mem-Info:
> [  244.980840][ T9068] active_anon:166 inactive_anon:8300 isolated_anon:0
> [  244.980840][ T9068]  active_file:2 inactive_file:3 isolated_file:0
> [  244.980840][ T9068]  unevictable:0 dirty:0 writeback:0
> [  244.980840][ T9068]  slab_reclaimable:12481 slab_unreclaimable:279862
> [  244.980840][ T9068]  mapped:52225 shmem:6769 pagetables:446 bounce:0
> [  244.980840][ T9068]  free:9671 free_pcp:453 free_cma:0
> ...
> [  245.694692][ T2959] Kernel Offset: disabled
> [  245.695139][ T2959] Rebooting in 86400 seconds..
>
> Please let me know if I can provide any more information, and I hope I
> didn't mess up this bug report.

I think we should backport the commit below. It'll somewhat
degrade perf but we probably don't care that much about 5.10.



commit 91f245d5d5de0802428a478802ec051f7de2f5d6
Author: Jens Axboe <axboe@xxxxxxxxx>
Date:   Tue Feb 9 13:48:50 2021 -0700

    io_uring: enable kmemcg account for io_uring requests
    
    This puts io_uring under the memory cgroups accounting and limits for
    requests.
    
    Signed-off-by: Jens Axboe <axboe@xxxxxxxxx>



--
Pavel Begunkov