Bug 110744

Summary: [CI][DRMTIP] igt@gem_linear_blits@normal - dmesg-warn - page allocation failure
Product: DRI Reporter: Lakshmi <lakshminarayana.vudum>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: RESOLVED DUPLICATE QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: medium CC: intel-gfx-bugs
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard: ReadyForDev
i915 platform: I965G i915 features: GEM/Other

Description Lakshmi 2019-05-23 16:11:42 UTC 
https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_292/fi-bwr-2160/igt@gem_linear_blits@normal.html

<6> [248.430296] Console: switching to colour dummy device 80x25
<6> [248.430831] [IGT] gem_linear_blits: executing
<6> [248.440440] [IGT] gem_linear_blits: starting subtest normal
<6> [339.501883] perf: interrupt took too long (4928 > 4927), lowering kernel.perf_event_max_sample_rate to 40000
<4> [385.887415] gem_linear_blit: page allocation failure: order:0, mode:0x400d0(__GFP_IO|__GFP_FS|__GFP_COMP|__GFP_RECLAIMABLE), nodemask=(null)
<4> [385.887459] CPU: 1 PID: 1100 Comm: gem_linear_blit Tainted: G     U            5.2.0-rc1-g8691fe536e41-drmtip_292+ #1
<4> [385.887463] Hardware name: Dell Inc.                 OptiPlex 745                 /0GW726, BIOS 2.3.1  05/21/2007
<4> [385.887466] Call Trace:
<4> [385.887477]  dump_stack+0x67/0x9b
<4> [385.887485]  warn_alloc+0xfa/0x180
<4> [385.887502]  __alloc_pages_nodemask+0xd5c/0x1130
<4> [385.887521]  ? ___slab_alloc.constprop.35+0x33b/0x380
<4> [385.887525]  ? xas_alloc+0x7e/0xa0
<4> [385.887535]  new_slab+0x323/0x440
<4> [385.887545]  ___slab_alloc.constprop.35+0x2d3/0x380
<4> [385.887550]  ? xas_nomem+0x38/0x50
<4> [385.887553]  ? xas_alloc+0x7e/0xa0
<4> [385.887560]  ? rcu_read_lock_sched_held+0x6f/0x80
<4> [385.887564]  ? kmem_cache_alloc+0x24d/0x280
<4> [385.887575]  ? xas_nomem+0x38/0x50
<4> [385.887580]  ? __slab_alloc.isra.28.constprop.34+0x3d/0x70
<4> [385.887584]  __slab_alloc.isra.28.constprop.34+0x3d/0x70
<4> [385.887590]  ? xas_nomem+0x38/0x50
<4> [385.887595]  kmem_cache_alloc+0x21c/0x280
<4> [385.887603]  xas_nomem+0x38/0x50
<4> [385.887608]  add_to_swap_cache+0x2bb/0x370
<4> [385.887623]  __read_swap_cache_async+0xed/0x1d0
<4> [385.887632]  swap_cluster_readahead+0x1ae/0x280
<4> [385.887649]  ? shmem_swapin+0x7b/0xa0
<4> [385.887654]  shmem_swapin+0x7b/0xa0
<4> [385.887666]  ? find_get_entry+0x149/0x300
<4> [385.887685]  shmem_swapin_page+0x568/0x770
<4> [385.887701]  shmem_getpage_gfp.isra.8+0x2c2/0x850
<4> [385.887719]  shmem_read_mapping_page_gfp+0x3e/0x70
<4> [385.887868]  i915_gem_object_get_pages_gtt+0x203/0x680 [i915]
<4> [385.887955]  ? __i915_gem_object_get_pages+0x18/0xb0 [i915]
<4> [385.887968]  ? lock_acquire+0xa6/0x1c0
<4> [385.888047]  ____i915_gem_object_get_pages+0x1d/0xa0 [i915]
<4> [385.888123]  __i915_gem_object_get_pages+0x59/0xb0 [i915]
<4> [385.888201]  i915_gem_pread_ioctl+0x46e/0x790 [i915]
<4> [385.888282]  ? i915_gem_object_get_page+0xc0/0xc0 [i915]
<4> [385.888291]  drm_ioctl_kernel+0x83/0xf0
<4> [385.888301]  drm_ioctl+0x2f3/0x3b0
<4> [385.888378]  ? i915_gem_object_get_page+0xc0/0xc0 [i915]
<4> [385.888389]  ? finish_task_switch+0x95/0x260
<4> [385.888399]  ? _raw_spin_unlock_irq+0x24/0x50
<4> [385.888404]  ? lockdep_hardirqs_on+0xe3/0x1b0
<4> [385.888414]  do_vfs_ioctl+0xa0/0x6e0
<4> [385.888421]  ? __schedule+0x319/0x840
<4> [385.888431]  ksys_ioctl+0x35/0x60
<4> [385.888439]  __x64_sys_ioctl+0x11/0x20
<4> [385.888444]  do_syscall_64+0x55/0x1c0
<4> [385.888450]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
<4> [385.888454] RIP: 0033:0x7fa8a1c305d7
<4> [385.888460] 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> [385.888464] RSP: 002b:00007ffeded41818 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
<4> [385.888469] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fa8a1c305d7
<4> [385.888472] RDX: 00007ffeded41850 RSI: 000000004020645c RDI: 0000000000000005
<4> [385.888475] RBP: 00007ffeded41850 R08: 0000000000100000 R09: 000000000003ffff
<4> [385.888479] R10: fffffffffffff6bf R11: 0000000000000246 R12: 000000004020645c
<4> [385.888482] R13: 0000000000000005 R14: 0000000000000000 R15: 0000555c76c12b48
<4> [385.888599] Mem-Info:
<4> [385.888607] active_anon:4816 inactive_anon:113709 isolated_anon:0
 active_file:382 inactive_file:342 isolated_file:0
 unevictable:82133 dirty:4 writeback:7 unstable:0
 slab_reclaimable:7654 slab_unreclaimable:13425
 mapped:662 shmem:84450 pagetables:1170 bounce:0
 free:13577 free_pcp:125 free_cma:0
<4> [385.888614] Node 0 active_anon:19264kB inactive_anon:454836kB active_file:1528kB inactive_file:1368kB unevictable:328532kB isolated(anon):0kB isolated(file):0kB mapped:2648kB dirty:16kB writeback:28kB shmem:337800kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 2048kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
<4> [385.888620] DMA free:4404kB min:740kB low:924kB high:1108kB active_anon:8kB inactive_anon:5944kB active_file:0kB inactive_file:0kB unevictable:5168kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [385.888623] lowmem_reserve[]: 0 928 928 928
<4> [385.888634] DMA32 free:49904kB min:50456kB low:61532kB high:72608kB active_anon:19256kB inactive_anon:448920kB active_file:1528kB inactive_file:1368kB unevictable:323364kB writepending:0kB present:1021948kB managed:954416kB mlocked:0kB kernel_stack:2032kB pagetables:4680kB bounce:0kB free_pcp:500kB local_pcp:248kB free_cma:0kB
<4> [385.888637] lowmem_reserve[]: 0 0 0 0
<4> [385.888643] DMA: 3*4kB (U) 1*8kB (U) 6*16kB (UE) 4*32kB (U) 1*64kB (E) 2*128kB (UE) 1*256kB (E) 1*512kB (E) 1*1024kB (U) 1*2048kB (U) 0*4096kB = 4404kB
<4> [385.888663] DMA32: 928*4kB (UMH) 610*8kB (UMH) 526*16kB (UMH) 346*32kB (UMEH) 177*64kB (UMEH) 62*128kB (UME) 8*256kB (M) 1*512kB (E) 0*1024kB 0*2048kB 0*4096kB = 49904kB
<6> [385.888683] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
<4> [385.888686] 198315 total pagecache pages
<4> [385.888693] 113143 pages in swap cache
<4> [385.888697] Swap cache stats: add 1850648, delete 1737456, find 22547602/22636016
<4> [385.888700] Free swap  = 1545724kB
<4> [385.888702] Total swap = 2097148kB
<4> [385.888705] 259485 pages RAM
<4> [385.888708] 0 pages HighMem/MovableOnly
<4> [385.888711] 16904 pages reserved
<4> [385.888765] SLUB: Unable to allocate memory on node -1, gfp=0xc0(__GFP_IO|__GFP_FS)
<4> [385.888769]   cache: radix_tree_node, object size: 576, buffer size: 912, default order: 3, min order: 0
<4> [385.888774]   node 0: slabs: 332, objs: 7373, free: 0
<6> [410.950177] [IGT] gem_linear_blits: exiting, ret=0
<5> [410.958982] Setting dangerous option reset - tainting kernel
<6> [410.968861] Console: switching to colour frame buffer device 240x67
<6> [411.118903] gem_linear_blit (1100) used greatest stack depth: 9104 bytes left
Comment 1 CI Bug Log 2019-05-23 16:13:21 UTC 
The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* BWR: igt@gem_linear_blits@normal - dmesg-warn - page allocation failure 
  - https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_292/fi-bwr-2160/igt@gem_linear_blits@normal.html
Comment 2 Chris Wilson 2019-05-23 20:45:13 UTC 
Same old (and I mean old) alloc failure under swapping.

*** This bug has been marked as a duplicate of bug 108686 ***

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.