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

From: Pavel Begunkov
Date: Wed May 17 2023 - 09:05:03 EST


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