igt@gem_exec_gttfill@basic - page allocation failure: order:0
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7596/fi-pnv-d510/igt@gem_exec_gttfill@basic.html
<6> [78.085811] Console: switching to colour dummy device 80x25
<6> [78.087377] [IGT] gem_exec_gttfill: executing
<5> [78.109780] Setting dangerous option reset - tainting kernel
<6> [78.130352] [IGT] gem_exec_gttfill: starting subtest basic
<6> [78.133246] gem_exec_gttfil (1011): drop_caches: 4
<4> [84.271399] gem_exec_gttfil: page allocation failure: order:0, mode:0x400d0(__GFP_IO|__GFP_FS|__GFP_COMP|__GFP_RECLAIMABLE), nodemask=(null)
<4> [84.271473] CPU: 1 PID: 1013 Comm: gem_exec_gttfil Tainted: G U 5.5.0-rc2-CI-CI_DRM_7596+ #1
<4> [84.271484] Hardware name: /D510MO, BIOS MOPNV10J.86A.0311.2010.0802.2346 08/02/2010
<4> [84.271493] Call Trace:
<4> [84.271515] dump_stack+0x71/0x9b
<4> [84.271536] warn_alloc+0xed/0x150
<4> [84.271591] __alloc_pages_slowpath+0x9a5/0xdd0
<4> [84.271664] __alloc_pages_nodemask+0x2dc/0x340
<4> [84.271700] alloc_slab_page+0x2c/0x800
<4> [84.271715] ? find_held_lock+0x2d/0x90
<4> [84.271741] new_slab+0x2c4/0x310
<4> [84.271773] ___slab_alloc.constprop.89+0x5b1/0x7a0
<4> [84.271795] ? xas_nomem+0x49/0x70
<4> [84.271822] ? kmem_cache_alloc+0x27b/0x2a0
<4> [84.271847] ? xas_alloc+0x97/0xb0
<4> [84.271868] ? xas_nomem+0x49/0x70
<4> [84.271885] ? __slab_alloc.isra.83.constprop.88+0x3d/0x70
<4> [84.271896] __slab_alloc.isra.83.constprop.88+0x3d/0x70
<4> [84.271916] ? xas_nomem+0x49/0x70
<4> [84.271930] kmem_cache_alloc+0x24a/0x2a0
<4> [84.271956] xas_nomem+0x49/0x70
<4> [84.271972] add_to_swap_cache+0x2bb/0x370
<4> [84.272004] __read_swap_cache_async+0x118/0x230
<4> [84.272004] swap_cluster_readahead+0x1b2/0x260
<4> [84.272004] ? shmem_swapin+0x7b/0xa0
<4> [84.272004] shmem_swapin+0x7b/0xa0
<4> [84.272004] ? find_get_entry+0x14d/0x300
<4> [84.272004] shmem_swapin_page+0x555/0x750
<4> [84.272004] shmem_getpage_gfp+0x329/0x890
<4> [84.272004] shmem_read_mapping_page_gfp+0x40/0x80
<4> [84.272004] shmem_get_pages+0x193/0x710 [i915]
<4> [84.272004] ? __i915_gem_object_get_pages+0x1b/0xd0 [i915]
<4> [84.272004] ? find_held_lock+0x2d/0x90
<4> [84.272004] ____i915_gem_object_get_pages+0x21/0xb0 [i915]
<4> [84.272004] __i915_gem_object_get_pages+0x5c/0xd0 [i915]
<4> [84.272004] i915_vma_pin+0xa33/0x11c0 [i915]
<4> [84.272004] eb_lookup_vmas+0x207/0x1380 [i915]
<4> [84.272004] ? __mutex_unlock_slowpath+0x3e/0x2a0
<4> [84.272004] i915_gem_do_execbuffer+0x629/0x2520 [i915]
<4> [84.272004] ? __lock_acquire+0x460/0x15d0
<4> [84.272004] i915_gem_execbuffer2_ioctl+0x11f/0x470 [i915]
<4> [84.272004] ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915]
<4> [84.272004] drm_ioctl_kernel+0xa7/0xf0
<4> [84.272004] drm_ioctl+0x2e1/0x390
<4> [84.272004] ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915]
<4> [84.272004] do_vfs_ioctl+0x9c/0x730
<4> [84.272004] ? __do_page_fault+0x2da/0x4f0
<4> [84.272004] ksys_ioctl+0x35/0x60
<4> [84.272004] __x64_sys_ioctl+0x11/0x20
<4> [84.272004] do_syscall_64+0x4f/0x220
<4> [84.272004] entry_SYSCALL_64_after_hwframe+0x49/0xbe
<4> [84.272004] RIP: 0033:0x7f62250c75d7
<4> [84.272004] Code: b3 66 90 48 8b 05 b1 48 2d 00 64 c7 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 81 48 2d 00 f7 d8 64 89 01 48
<4> [84.272004] RSP: 002b:00007ffd1ac58ad8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
<4> [84.272004] RAX: ffffffffffffffda RBX: 00007ffd1ac58c70 RCX: 00007f62250c75d7
<4> [84.272004] RDX: 00007ffd1ac58c30 RSI: 0000000040406469 RDI: 0000000000000005
<4> [84.272004] RBP: 00007ffd1ac58c30 R08: 0000562ec5983de0 R09: 0000000000000081
<4> [84.272004] R10: 0000000000000056 R11: 0000000000000246 R12: 0000000040406469
<4> [84.272004] R13: 0000000000000005 R14: 00007ffd1ac58c30 R15: 0000000000000005
<4> [84.272004] Mem-Info:
<4> [84.272004] active_anon:30588 inactive_anon:127098 isolated_anon:16
active_file:13634 inactive_file:5254 isolated_file:0
unevictable:6 dirty:15 writeback:19 unstable:0
slab_reclaimable:6194 slab_unreclaimable:12702
mapped:18959 shmem:128072 pagetables:1423 bounce:0
free:37011 free_pcp:220 free_cma:0
<4> [84.272004] Node 0 active_anon:122352kB inactive_anon:508392kB active_file:54536kB inactive_file:21016kB unevictable:24kB isolated(anon):64kB isolated(file):0kB mapped:75836kB dirty:60kB writeback:76kB shmem:512288kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 26624kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
<4> [84.272004] DMA free:4388kB min:748kB low:932kB high:1116kB reserved_highatomic:0KB active_anon:1596kB inactive_anon:9828kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:48kB present:15984kB managed:15900kB mlocked:0kB kernel_stack:0kB pagetables:16kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [84.272004] lowmem_reserve[]: 0 915 915 915
<4> [84.272004] DMA32 free:143656kB min:143988kB low:155064kB high:166140kB reserved_highatomic:0KB active_anon:120608kB inactive_anon:498472kB active_file:54668kB inactive_file:21416kB unevictable:0kB writepending:0kB present:1015244kB managed:943132kB mlocked:0kB kernel_stack:2368kB pagetables:5676kB bounce:0kB free_pcp:880kB local_pcp:612kB free_cma:0kB
<4> [84.272004] lowmem_reserve[]: 0 0 0 0
<4> [84.272004] DMA: 1*4kB (U) 2*8kB (UE) 0*16kB 3*32kB (UE) 1*64kB (U) 1*128kB (U) 2*256kB (UE) 1*512kB (E) 1*1024kB (U) 1*2048kB (M) 0*4096kB = 4404kB
<4> [84.272004] DMA32: 3941*4kB (UM) 2149*8kB (UM) 1151*16kB (UME) 541*32kB (ME) 256*64kB (ME) 113*128kB (UME) 62*256kB (UME) 36*512kB (UM) 8*1024kB (ME) 1*2048kB (M) 0*4096kB = 144076kB
<6> [84.272004] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
<4> [84.272004] 148079 total pagecache pages
<4> [84.272004] 1137 pages in swap cache
<4> [84.272004] Swap cache stats: add 5270, delete 4133, find 253/299
<4> [84.272004] Free swap = 1010684kB
<4> [84.272004] Total swap = 1030140kB
<4> [84.272004] 257807 pages RAM
<4> [84.272004] 0 pages HighMem/MovableOnly
<4> [84.272004] 18049 pages reserved
<4> [84.272004] SLUB: Unable to allocate memory on node -1, gfp=0xc0(__GFP_IO|__GFP_FS)
<4> [84.272004] cache: radix_tree_node, object size: 576, buffer size: 912, default order: 2, min order: 0
<4> [84.272004] node 0: slabs: 198, objs: 3366, free: 2
<6> [86.085616] gem_exec_gttfil (1013) used greatest stack depth: 10992 bytes left
<6> [86.661697] [IGT] gem_exec_gttfill: exiting, ret=0
<5> [86.667220] Setting dangerous option reset - tainting kernel
<6> [86.692857] Console: switching to colour frame buffer device 128x48
<6> [86.751397] gem_exec_gttfil (1011) used greatest stack depth: 10128 bytes left
Edited by Chris Wilson