Bug 105913 - [IGT] igt@gem_shrink@pread Test assertion failure function gem_read, file ioctl_wrappers.c
Summary: [IGT] igt@gem_shrink@pread Test assertion failure function gem_read, file ioc...
Status: CLOSED NOTABUG
Alias: None
Product: DRI
Classification: Unclassified
Component: IGT (show other bugs)
Version: DRI git
Hardware: x86-64 (AMD64) Linux (All)
: medium normal
Assignee: Default DRI bug account
QA Contact:
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2018-04-05 20:00 UTC by Ricardo Perez
Modified: 2018-08-23 14:25 UTC (History)
0 users

See Also:
i915 platform:
i915 features:


Attachments
dmesg and kern-logs (66.52 KB, application/gzip)
2018-04-05 20:00 UTC, Ricardo Perez
no flags Details

Description Ricardo Perez 2018-04-05 20:00:39 UTC
Created attachment 138639 [details]
dmesg and kern-logs

CNL QA System is failing the following test:

igt@gem_shrink@pread


Software Version:

IGT-Version: 1.22-g0721161 (x86_64) (Linux: 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ x86_64)
Using 62 processes and 128MiB per process
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [gem_read+0x91]
  #2 [<unknown>+0x91]
child 0 died with signal 9, Killed
Subtest pread: FAIL (179.205s)

Stderr:
	
(gem_shrink:10628) ioctl-wrappers-CRITICAL: Test assertion failure function gem_read, file ioctl_wrappers.c:387:
(gem_shrink:10628) ioctl-wrappers-CRITICAL: Failed assertion: __gem_read(fd, handle, offset, buf, length) == 0
(gem_shrink:10628) ioctl-wrappers-CRITICAL: Last errno: 12, Cannot allocate memory
(gem_shrink:10628) ioctl-wrappers-CRITICAL: error: -12 != 0
Subtest pread failed.
No log.

Dmesg:

[  260.304006] 1 and 0 pages still available in the bound and unbound GPU page lists.
[  260.304085] kworker/u9:2 invoked oom-killer: gfp_mask=0x14002c0(GFP_KERNEL|__GFP_NOWARN), nodemask=(null), order=0, oom_score_adj=0
[  260.304090] CPU: 2 PID: 348 Comm: kworker/u9:2 Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  260.304091] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  260.304101] Workqueue: rb_allocator iwl_pcie_rx_allocator_work [iwlwifi]
[  260.304102] Call Trace:
[  260.304109]  dump_stack+0x5c/0x85
[  260.304112]  dump_header+0x6b/0x27c
[  260.304115]  oom_kill_process+0x239/0x480
[  260.304116]  ? oom_badness+0xeb/0x160
[  260.304118]  out_of_memory+0x10f/0x480
[  260.304120]  __alloc_pages_slowpath+0xcdd/0xdb0
[  260.304123]  ? __update_load_avg_se.isra.38+0x1c1/0x1d0
[  260.304126]  __alloc_pages_nodemask+0x246/0x280
[  260.304131]  iwl_pcie_rx_alloc_page+0x25/0x90 [iwlwifi]
[  260.304137]  iwl_pcie_rx_allocator_work+0x128/0x370 [iwlwifi]
[  260.304141]  process_one_work+0x147/0x3c0
[  260.304143]  worker_thread+0x4a/0x440
[  260.304145]  kthread+0xf8/0x130
[  260.304147]  ? rescuer_thread+0x360/0x360
[  260.304148]  ? kthread_associate_blkcg+0x90/0x90
[  260.304151]  ret_from_fork+0x35/0x40
[  260.304152] Mem-Info:
[  260.304157] active_anon:6190 inactive_anon:1909516 isolated_anon:448
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:3122 bounce:0
                free:27808 free_pcp:90 free_cma:0
[  260.304160] Node 0 active_anon:24760kB inactive_anon:7638064kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):1792kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
[  260.304161] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  260.304165] lowmem_reserve[]: 0 747 7758 7758 7758
[  260.304167] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767444kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  260.304171] lowmem_reserve[]: 0 0 7010 7010 7010
[  260.304173] Node 0 Normal free:60808kB min:60944kB low:76180kB high:91416kB active_anon:24500kB inactive_anon:6870480kB active_file:236kB inactive_file:240kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:12484kB bounce:0kB free_pcp:360kB local_pcp:360kB free_cma:0kB
[  260.304177] lowmem_reserve[]: 0 0 0 0 0
[  260.304179] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  260.304190] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  260.304200] Node 0 Normal: 568*4kB (UME) 299*8kB (UM) 149*16kB (UME) 123*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60840kB
[  260.304213] 1911494 total pagecache pages
[  260.304215] 836 pages in swap cache
[  260.304216] Swap cache stats: add 5093657, delete 5092313, find 110160/132281
[  260.304217] Free swap  = 7673432kB
[  260.304217] Total swap = 8000508kB
[  260.304218] 2056177 pages RAM
[  260.304218] 0 pages HighMem/MovableOnly
[  260.304219] 54740 pages reserved
[  260.304219] 0 pages cma reserved
[  260.304220] 0 pages hwpoisoned
[  260.304381] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  260.304397] Killed process 10617 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  281.828011] 1 and 32768 pages still available in the bound and unbound GPU page lists.
[  281.828093] kworker/u9:2 invoked oom-killer: gfp_mask=0x14002c0(GFP_KERNEL|__GFP_NOWARN), nodemask=(null), order=0, oom_score_adj=0
[  281.828097] CPU: 0 PID: 348 Comm: kworker/u9:2 Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  281.828098] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  281.828110] Workqueue: rb_allocator iwl_pcie_rx_allocator_work [iwlwifi]
[  281.828112] Call Trace:
[  281.828118]  dump_stack+0x5c/0x85
[  281.828121]  dump_header+0x6b/0x27c
[  281.828124]  oom_kill_process+0x239/0x480
[  281.828126]  ? oom_badness+0xeb/0x160
[  281.828128]  out_of_memory+0x10f/0x480
[  281.828131]  __alloc_pages_slowpath+0xcdd/0xdb0
[  281.828134]  ? __update_load_avg_se.isra.38+0x1c1/0x1d0
[  281.828136]  __alloc_pages_nodemask+0x246/0x280
[  281.828143]  iwl_pcie_rx_alloc_page+0x25/0x90 [iwlwifi]
[  281.828150]  iwl_pcie_rx_allocator_work+0x128/0x370 [iwlwifi]
[  281.828153]  process_one_work+0x147/0x3c0
[  281.828156]  worker_thread+0x4a/0x440
[  281.828158]  kthread+0xf8/0x130
[  281.828160]  ? rescuer_thread+0x360/0x360
[  281.828162]  ? kthread_associate_blkcg+0x90/0x90
[  281.828164]  ret_from_fork+0x35/0x40
[  281.828166] Mem-Info:
[  281.828171] active_anon:6176 inactive_anon:1909559 isolated_anon:416
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:3095 bounce:0
                free:27800 free_pcp:136 free_cma:0
[  281.828174] Node 0 active_anon:24704kB inactive_anon:7638236kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):1664kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
[  281.828175] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  281.828179] lowmem_reserve[]: 0 747 7758 7758 7758
[  281.828183] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767604kB active_file:0kB inactive_file:4kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  281.828186] lowmem_reserve[]: 0 0 7010 7010 7010
[  281.828189] Node 0 Normal free:60776kB min:60944kB low:76180kB high:91416kB active_anon:24444kB inactive_anon:6870424kB active_file:240kB inactive_file:236kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:12376kB bounce:0kB free_pcp:540kB local_pcp:0kB free_cma:0kB
[  281.828194] lowmem_reserve[]: 0 0 0 0 0
[  281.828196] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  281.828208] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  281.828220] Node 0 Normal: 568*4kB (UME) 299*8kB (UM) 149*16kB (UME) 121*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60776kB
[  281.828235] 1911494 total pagecache pages
[  281.828238] 836 pages in swap cache
[  281.828239] Swap cache stats: add 5093657, delete 5092313, find 110160/132281
[  281.828239] Free swap  = 7673432kB
[  281.828240] Total swap = 8000508kB
[  281.828241] 2056177 pages RAM
[  281.828241] 0 pages HighMem/MovableOnly
[  281.828242] 54740 pages reserved
[  281.828242] 0 pages cma reserved
[  281.828243] 0 pages hwpoisoned
[  281.828433] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  281.828453] Killed process 10618 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  297.168009] 1 and 65536 pages still available in the bound and unbound GPU page lists.
[  297.168089] irqbalance invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  297.168094] CPU: 0 PID: 756 Comm: irqbalance Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  297.168095] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  297.168096] Call Trace:
[  297.168104]  dump_stack+0x5c/0x85
[  297.168108]  dump_header+0x6b/0x27c
[  297.168111]  oom_kill_process+0x239/0x480
[  297.168113]  ? oom_badness+0xeb/0x160
[  297.168115]  out_of_memory+0x10f/0x480
[  297.168117]  __alloc_pages_slowpath+0xcdd/0xdb0
[  297.168121]  __alloc_pages_nodemask+0x246/0x280
[  297.168123]  filemap_fault+0x2e9/0x650
[  297.168125]  ? filemap_map_pages+0x188/0x370
[  297.168128]  ext4_filemap_fault+0x2c/0x3b
[  297.168131]  __do_fault+0x1f/0xb6
[  297.168133]  __handle_mm_fault+0xbfc/0x1130
[  297.168136]  handle_mm_fault+0xfa/0x200
[  297.168139]  __do_page_fault+0x257/0x4f0
[  297.168141]  ? page_fault+0x2f/0x50
[  297.168143]  page_fault+0x45/0x50
[  297.168144] RIP: 0002:          (null)
[  297.168146] RSP: 000a:00007fff6077fd38 EFLAGS: 7fff6077f9bc
[  297.168147] Mem-Info:
[  297.168152] active_anon:6162 inactive_anon:1909667 isolated_anon:320
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:3068 bounce:0
                free:27761 free_pcp:213 free_cma:0
[  297.168155] Node 0 active_anon:24648kB inactive_anon:7638668kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):1280kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
[  297.168156] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  297.168160] lowmem_reserve[]: 0 747 7758 7758 7758
[  297.168164] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767388kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  297.168167] lowmem_reserve[]: 0 0 7010 7010 7010
[  297.168170] Node 0 Normal free:60620kB min:60944kB low:76180kB high:91416kB active_anon:24388kB inactive_anon:6871068kB active_file:236kB inactive_file:240kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:12268kB bounce:0kB free_pcp:848kB local_pcp:308kB free_cma:0kB
[  297.168174] lowmem_reserve[]: 0 0 0 0 0
[  297.168177] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  297.168189] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  297.168202] Node 0 Normal: 553*4kB (ME) 293*8kB (M) 148*16kB (UME) 120*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60620kB
[  297.168217] 1911494 total pagecache pages
[  297.168219] 836 pages in swap cache
[  297.168220] Swap cache stats: add 5093657, delete 5092313, find 110160/132281
[  297.168221] Free swap  = 7673432kB
[  297.168222] Total swap = 8000508kB
[  297.168222] 2056177 pages RAM
[  297.168223] 0 pages HighMem/MovableOnly
[  297.168223] 54740 pages reserved
[  297.168224] 0 pages cma reserved
[  297.168224] 0 pages hwpoisoned
[  297.168409] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  297.168429] Killed process 10619 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  305.312012] 1 and 98304 pages still available in the bound and unbound GPU page lists.
[  305.312092] kworker/u9:2 invoked oom-killer: gfp_mask=0x14002c0(GFP_KERNEL|__GFP_NOWARN), nodemask=(null), order=0, oom_score_adj=0
[  305.312098] CPU: 3 PID: 348 Comm: kworker/u9:2 Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  305.312099] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  305.312111] Workqueue: rb_allocator iwl_pcie_rx_allocator_work [iwlwifi]
[  305.312112] Call Trace:
[  305.312120]  dump_stack+0x5c/0x85
[  305.312123]  dump_header+0x6b/0x27c
[  305.312126]  oom_kill_process+0x239/0x480
[  305.312128]  ? oom_badness+0xeb/0x160
[  305.312130]  out_of_memory+0x10f/0x480
[  305.312132]  __alloc_pages_slowpath+0xcdd/0xdb0
[  305.312135]  ? __update_load_avg_se.isra.38+0x1c1/0x1d0
[  305.312138]  __alloc_pages_nodemask+0x246/0x280
[  305.312145]  iwl_pcie_rx_alloc_page+0x25/0x90 [iwlwifi]
[  305.312151]  iwl_pcie_rx_allocator_work+0x128/0x370 [iwlwifi]
[  305.312155]  process_one_work+0x147/0x3c0
[  305.312157]  worker_thread+0x4a/0x440
[  305.312160]  kthread+0xf8/0x130
[  305.312162]  ? rescuer_thread+0x360/0x360
[  305.312164]  ? kthread_associate_blkcg+0x90/0x90
[  305.312166]  ret_from_fork+0x35/0x40
[  305.312168] Mem-Info:
[  305.312173] active_anon:6148 inactive_anon:1909356 isolated_anon:608
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:3041 bounce:0
                free:27761 free_pcp:259 free_cma:0
[  305.312177] Node 0 active_anon:24592kB inactive_anon:7637424kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):2432kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
[  305.312178] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  305.312182] lowmem_reserve[]: 0 747 7758 7758 7758
[  305.312185] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767264kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  305.312189] lowmem_reserve[]: 0 0 7010 7010 7010
[  305.312192] Node 0 Normal free:60620kB min:60944kB low:76180kB high:91416kB active_anon:24332kB inactive_anon:6869952kB active_file:236kB inactive_file:240kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:12160kB bounce:0kB free_pcp:1032kB local_pcp:0kB free_cma:0kB
[  305.312196] lowmem_reserve[]: 0 0 0 0 0
[  305.312199] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  305.312211] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  305.312223] Node 0 Normal: 553*4kB (ME) 293*8kB (M) 148*16kB (UME) 120*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60620kB
[  305.312238] 1911494 total pagecache pages
[  305.312240] 836 pages in swap cache
[  305.312241] Swap cache stats: add 5093657, delete 5092313, find 110160/132281
[  305.312242] Free swap  = 7673432kB
[  305.312242] Total swap = 8000508kB
[  305.312243] 2056177 pages RAM
[  305.312243] 0 pages HighMem/MovableOnly
[  305.312244] 54740 pages reserved
[  305.312244] 0 pages cma reserved
[  305.312245] 0 pages hwpoisoned
[  305.312428] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  305.312446] Killed process 10620 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  306.956010] 1 and 131072 pages still available in the bound and unbound GPU page lists.
[  306.956090] wpa_supplicant invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  306.956096] CPU: 0 PID: 874 Comm: wpa_supplicant Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  306.956097] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  306.956099] Call Trace:
[  306.956106]  dump_stack+0x5c/0x85
[  306.956110]  dump_header+0x6b/0x27c
[  306.956112]  oom_kill_process+0x239/0x480
[  306.956115]  ? oom_badness+0xeb/0x160
[  306.956117]  out_of_memory+0x10f/0x480
[  306.956119]  __alloc_pages_slowpath+0xcdd/0xdb0
[  306.956124]  ? compat_poll_select_copy_remaining+0x140/0x140
[  306.956127]  __alloc_pages_nodemask+0x246/0x280
[  306.956129]  filemap_fault+0x2e9/0x650
[  306.956131]  ? filemap_map_pages+0x188/0x370
[  306.956134]  ext4_filemap_fault+0x2c/0x3b
[  306.956137]  __do_fault+0x1f/0xb6
[  306.956139]  __handle_mm_fault+0xbfc/0x1130
[  306.956142]  handle_mm_fault+0xfa/0x200
[  306.956145]  __do_page_fault+0x257/0x4f0
[  306.956147]  ? page_fault+0x2f/0x50
[  306.956149]  page_fault+0x45/0x50
[  306.956152] RIP: e91f96e0:0x5611e91f9800
[  306.956153] RSP: 0000:00005611e921c740 EFLAGS: 5611e91f9770
[  306.956155] Mem-Info:
[  306.956160] active_anon:6134 inactive_anon:1909452 isolated_anon:480
                active_file:45 inactive_file:75 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:3014 bounce:0
                free:27730 free_pcp:336 free_cma:0
[  306.956164] Node 0 active_anon:24536kB inactive_anon:7637808kB active_file:180kB inactive_file:300kB unevictable:0kB isolated(anon):1920kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
[  306.956165] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  306.956169] lowmem_reserve[]: 0 747 7758 7758 7758
[  306.956173] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767592kB active_file:0kB inactive_file:4kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  306.956177] lowmem_reserve[]: 0 0 7010 7010 7010
[  306.956180] Node 0 Normal free:60496kB min:60944kB low:76180kB high:91416kB active_anon:24276kB inactive_anon:6870252kB active_file:180kB inactive_file:296kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:12052kB bounce:0kB free_pcp:1340kB local_pcp:308kB free_cma:0kB
[  306.956184] lowmem_reserve[]: 0 0 0 0 0
[  306.956187] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  306.956199] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  306.956212] Node 0 Normal: 554*4kB (UME) 293*8kB (M) 140*16kB (UME) 120*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60496kB
[  306.956228] 1911494 total pagecache pages
[  306.956230] 836 pages in swap cache
[  306.956231] Swap cache stats: add 5093657, delete 5092313, find 110160/132283
[  306.956232] Free swap  = 7673432kB
[  306.956233] Total swap = 8000508kB
[  306.956233] 2056177 pages RAM
[  306.956234] 0 pages HighMem/MovableOnly
[  306.956234] 54740 pages reserved
[  306.956235] 0 pages cma reserved
[  306.956236] 0 pages hwpoisoned
[  306.956424] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  306.956445] Killed process 10621 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  313.404009] 1 and 163840 pages still available in the bound and unbound GPU page lists.
[  316.388007] 1 and 163840 pages still available in the bound and unbound GPU page lists.
[  316.388084] systemd-timesyn invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  316.388089] CPU: 1 PID: 568 Comm: systemd-timesyn Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  316.388090] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  316.388091] Call Trace:
[  316.388098]  dump_stack+0x5c/0x85
[  316.388102]  dump_header+0x6b/0x27c
[  316.388104]  oom_kill_process+0x239/0x480
[  316.388106]  ? oom_badness+0xeb/0x160
[  316.388107]  out_of_memory+0x10f/0x480
[  316.388110]  __alloc_pages_slowpath+0xcdd/0xdb0
[  316.388113]  __alloc_pages_nodemask+0x246/0x280
[  316.388115]  filemap_fault+0x2e9/0x650
[  316.388117]  ? filemap_map_pages+0x266/0x370
[  316.388119]  ext4_filemap_fault+0x2c/0x3b
[  316.388122]  __do_fault+0x1f/0xb6
[  316.388124]  __handle_mm_fault+0xbfc/0x1130
[  316.388127]  handle_mm_fault+0xfa/0x200
[  316.388129]  __do_page_fault+0x257/0x4f0
[  316.388131]  ? page_fault+0x2f/0x50
[  316.388133]  page_fault+0x45/0x50
[  316.388134] RIP: ffffffff:          (null)
[  316.388135] RSP: 0004:0000000000000000 EFLAGS: 00000008
[  316.388136] Mem-Info:
[  316.388141] active_anon:6120 inactive_anon:1909431 isolated_anon:544
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:2987 bounce:0
                free:27722 free_pcp:390 free_cma:0
[  316.388144] Node 0 active_anon:24480kB inactive_anon:7637724kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):2176kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  316.388145] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  316.388148] lowmem_reserve[]: 0 747 7758 7758 7758
[  316.388151] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767516kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  316.388155] lowmem_reserve[]: 0 0 7010 7010 7010
[  316.388157] Node 0 Normal free:60464kB min:60944kB low:76180kB high:91416kB active_anon:24220kB inactive_anon:6870224kB active_file:236kB inactive_file:240kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4224kB pagetables:11944kB bounce:0kB free_pcp:1556kB local_pcp:308kB free_cma:0kB
[  316.388161] lowmem_reserve[]: 0 0 0 0 0
[  316.388163] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  316.388174] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  316.388184] Node 0 Normal: 554*4kB (UME) 293*8kB (M) 140*16kB (UME) 119*32kB (UM) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60464kB
[  316.388197] 1911494 total pagecache pages
[  316.388199] 836 pages in swap cache
[  316.388200] Swap cache stats: add 5093657, delete 5092313, find 110160/132283
[  316.388200] Free swap  = 7673432kB
[  316.388201] Total swap = 8000508kB
[  316.388201] 2056177 pages RAM
[  316.388202] 0 pages HighMem/MovableOnly
[  316.388202] 54740 pages reserved
[  316.388203] 0 pages cma reserved
[  316.388203] 0 pages hwpoisoned
[  316.388362] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  316.388379] Killed process 10622 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  317.712003] 1 and 196608 pages still available in the bound and unbound GPU page lists.
[  317.712079] cron invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  317.712084] CPU: 1 PID: 681 Comm: cron Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  317.712085] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  317.712086] Call Trace:
[  317.712093]  dump_stack+0x5c/0x85
[  317.712097]  dump_header+0x6b/0x27c
[  317.712099]  oom_kill_process+0x239/0x480
[  317.712101]  ? oom_badness+0xeb/0x160
[  317.712103]  out_of_memory+0x10f/0x480
[  317.712106]  __alloc_pages_slowpath+0xcdd/0xdb0
[  317.712109]  ? _cond_resched+0x16/0x40
[  317.712112]  __alloc_pages_nodemask+0x246/0x280
[  317.712114]  filemap_fault+0x2e9/0x650
[  317.712116]  ? filemap_map_pages+0x188/0x370
[  317.712119]  ext4_filemap_fault+0x2c/0x3b
[  317.712122]  __do_fault+0x1f/0xb6
[  317.712125]  __handle_mm_fault+0xbfc/0x1130
[  317.712127]  handle_mm_fault+0xfa/0x200
[  317.712130]  __do_page_fault+0x257/0x4f0
[  317.712132]  ? page_fault+0x2f/0x50
[  317.712134]  page_fault+0x45/0x50
[  317.712135] RIP: f7ddd4e0:          (null)
[  317.712137] RSP: fffffe98:0000000000000004 EFLAGS: 00000000
[  317.712138] Mem-Info:
[  317.712143] active_anon:6106 inactive_anon:1909592 isolated_anon:416
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1910538 pagetables:2960 bounce:0
                free:27753 free_pcp:413 free_cma:0
[  317.712147] Node 0 active_anon:24424kB inactive_anon:7638368kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):1664kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7642152kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  317.712148] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  317.712152] lowmem_reserve[]: 0 747 7758 7758 7758
[  317.712155] Node 0 DMA32 free:34540kB min:6500kB low:8124kB high:9748kB active_anon:260kB inactive_anon:767544kB active_file:0kB inactive_file:4kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:4kB local_pcp:0kB free_cma:0kB
[  317.712159] lowmem_reserve[]: 0 0 7010 7010 7010
[  317.712162] Node 0 Normal free:60588kB min:60944kB low:76180kB high:91416kB active_anon:24164kB inactive_anon:6870428kB active_file:240kB inactive_file:236kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4112kB pagetables:11836kB bounce:0kB free_pcp:1648kB local_pcp:524kB free_cma:0kB
[  317.712166] lowmem_reserve[]: 0 0 0 0 0
[  317.712168] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  317.712180] Node 0 DMA32: 15*4kB (UM) 22*8kB (UM) 24*16kB (UM) 26*32kB (UME) 21*64kB (UME) 16*128kB (UM) 18*256kB (UME) 17*512kB (UME) 4*1024kB (M) 6*2048kB (M) 0*4096kB = 34540kB
[  317.712192] Node 0 Normal: 561*4kB (UME) 297*8kB (UME) 142*16kB (UME) 120*32kB (UME) 187*64kB (UM) 128*128kB (UM) 54*256kB (UME) 3*512kB (UME) 0*1024kB 1*2048kB (E) 1*4096kB (E) = 60588kB
[  317.712207] 1911494 total pagecache pages
[  317.712209] 836 pages in swap cache
[  317.712211] Swap cache stats: add 5093657, delete 5092313, find 110160/132283
[  317.712211] Free swap  = 7673432kB
[  317.712212] Total swap = 8000508kB
[  317.712213] 2056177 pages RAM
[  317.712213] 0 pages HighMem/MovableOnly
[  317.712214] 54740 pages reserved
[  317.712214] 0 pages cma reserved
[  317.712215] 0 pages hwpoisoned
[  317.712394] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  317.712411] Killed process 10623 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  343.932002] 1 and 196608 pages still available in the bound and unbound GPU page lists.
[  343.932078] gmain invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  343.932083] CPU: 1 PID: 805 Comm: gmain Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  343.932084] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  343.932085] Call Trace:
[  343.932091]  dump_stack+0x5c/0x85
[  343.932095]  dump_header+0x6b/0x27c
[  343.932097]  oom_kill_process+0x239/0x480
[  343.932099]  ? oom_badness+0xeb/0x160
[  343.932100]  out_of_memory+0x10f/0x480
[  343.932103]  __alloc_pages_slowpath+0xcdd/0xdb0
[  343.932106]  __alloc_pages_nodemask+0x246/0x280
[  343.932108]  filemap_fault+0x2e9/0x650
[  343.932110]  ? filemap_map_pages+0x188/0x370
[  343.932113]  ext4_filemap_fault+0x2c/0x3b
[  343.932115]  __do_fault+0x1f/0xb6
[  343.932117]  __handle_mm_fault+0xbfc/0x1130
[  343.932120]  handle_mm_fault+0xfa/0x200
[  343.932122]  __do_page_fault+0x257/0x4f0
[  343.932126]  ? SyS_poll+0x6b/0x120
[  343.932128]  ? page_fault+0x2f/0x50
[  343.932129]  page_fault+0x45/0x50
[  343.932132] RIP: 90873960:0x55a39089ddf0
[  343.932133] RSP: 908fef20:000055a3908fef20 EFLAGS: 00000000
[  343.932134] Mem-Info:
[  343.932139] active_anon:6099 inactive_anon:1918269 isolated_anon:608
                active_file:60 inactive_file:60 isolated_file:0
                unevictable:0 dirty:4 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1919408 pagetables:2960 bounce:0
                free:19290 free_pcp:29 free_cma:0
[  343.932142] Node 0 active_anon:24396kB inactive_anon:7673076kB active_file:240kB inactive_file:240kB unevictable:0kB isolated(anon):2432kB isolated(file):0kB mapped:2172kB dirty:16kB writeback:0kB shmem:7677632kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  343.932143] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  343.932146] lowmem_reserve[]: 0 747 7758 7758 7758
[  343.932149] Node 0 DMA32 free:31164kB min:6500kB low:8124kB high:9748kB active_anon:288kB inactive_anon:770732kB active_file:0kB inactive_file:4kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  343.932152] lowmem_reserve[]: 0 0 7010 7010 7010
[  343.932155] Node 0 Normal free:30112kB min:60944kB low:76180kB high:91416kB active_anon:24108kB inactive_anon:6902044kB active_file:240kB inactive_file:236kB unevictable:0kB writepending:16kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4144kB pagetables:11836kB bounce:0kB free_pcp:116kB local_pcp:0kB free_cma:0kB
[  343.932158] lowmem_reserve[]: 0 0 0 0 0
[  343.932161] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  343.932171] Node 0 DMA32: 19*4kB (UME) 24*8kB (UME) 21*16kB (UM) 25*32kB (UM) 21*64kB (UME) 16*128kB (UM) 17*256kB (UM) 17*512kB (UME) 5*1024kB (ME) 4*2048kB (M) 0*4096kB = 31164kB
[  343.932182] Node 0 Normal: 370*4kB (UME) 197*8kB (UM) 108*16kB (UM) 80*32kB (UME) 110*64kB (UME) 70*128kB (ME) 26*256kB (ME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 30000kB
[  343.932194] 1920367 total pagecache pages
[  343.932196] 839 pages in swap cache
[  343.932197] Swap cache stats: add 5093675, delete 5092328, find 110167/132300
[  343.932197] Free swap  = 7673432kB
[  343.932198] Total swap = 8000508kB
[  343.932198] 2056177 pages RAM
[  343.932199] 0 pages HighMem/MovableOnly
[  343.932199] 54740 pages reserved
[  343.932200] 0 pages cma reserved
[  343.932200] 0 pages hwpoisoned
[  343.932354] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  343.932371] Killed process 10624 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  363.488021] INFO: task python:855 blocked for more than 120 seconds.
[  363.488027]       Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  363.488030] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  363.488036] Call Trace:
[  363.488045]  ? __schedule+0x3d5/0x8c0
[  363.488047]  schedule+0x32/0x80
[  363.488050]  schedule_preempt_disabled+0xa/0x10
[  363.488052]  __mutex_lock.isra.2+0x2ae/0x4e0
[  363.488086]  ? i915_gem_shrink+0x3ff/0x500 [i915]
[  363.488115]  i915_gem_shrink+0x3ff/0x500 [i915]
[  363.488120]  ? wake_up_q+0x2d/0x60
[  363.488149]  ? i915_gem_shrinker_scan+0xb6/0x110 [i915]
[  363.488177]  i915_gem_shrinker_scan+0xb6/0x110 [i915]
[  363.488181]  shrink_slab.part.48+0x1c5/0x3f0
[  363.488184]  shrink_node+0x338/0x350
[  363.488186]  do_try_to_free_pages+0xeb/0x360
[  363.488189]  try_to_free_pages+0xf7/0x1d0
[  363.488192]  __alloc_pages_slowpath+0x3ad/0xdb0
[  363.488194]  ? pagecache_get_page+0x185/0x220
[  363.488197]  ? _cond_resched+0x16/0x40
[  363.488199]  ? dput+0x2f/0x1f0
[  363.488202]  __alloc_pages_nodemask+0x246/0x280
[  363.488205]  __do_page_cache_readahead+0x110/0x290
[  363.488208]  ? terminate_walk+0xe4/0x100
[  363.488210]  ? path_openat+0x3ce/0x1380
[  363.488212]  ? ondemand_readahead+0x171/0x2b0
[  363.488214]  ondemand_readahead+0x171/0x2b0
[  363.488216]  ? pagecache_get_page+0x27/0x220
[  363.488218]  generic_file_read_iter+0x71b/0x9b0
[  363.488221]  ? _copy_to_user+0x22/0x30
[  363.488223]  ? cp_new_stat+0x154/0x190
[  363.488226]  __vfs_read+0xfd/0x170
[  363.488228]  vfs_read+0x8e/0x130
[  363.488230]  SyS_read+0x52/0xc0
[  363.488233]  do_syscall_64+0x6e/0x120
[  363.488235]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[  363.488238] RIP: 0033:0x7fe763b09021
[  363.488239] RSP: 002b:00007ffca6345258 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
[  363.488241] RAX: ffffffffffffffda RBX: 0000559f1ec4ada0 RCX: 00007fe763b09021
[  363.488242] RDX: 0000000000001000 RSI: 0000559f1eca8260 RDI: 0000000000000007
[  363.488243] RBP: 0000000000000d68 R08: 0000000000000000 R09: 0000559f1eca8260
[  363.488244] R10: ffffffffffffffb0 R11: 0000000000000246 R12: 00007fe763ddc3e0
[  363.488245] R13: 00007fe763ddb8a0 R14: 0000559f1ec9f174 R15: 00007fe763ddb8a0
[  383.796008] 1 and 229376 pages still available in the bound and unbound GPU page lists.
[  383.796084] bash invoked oom-killer: gfp_mask=0x15080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=0, oom_score_adj=0
[  383.796090] CPU: 3 PID: 10741 Comm: bash Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  383.796091] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  383.796092] Call Trace:
[  383.796099]  dump_stack+0x5c/0x85
[  383.796102]  dump_header+0x6b/0x27c
[  383.796105]  oom_kill_process+0x239/0x480
[  383.796107]  ? oom_badness+0xeb/0x160
[  383.796109]  out_of_memory+0x10f/0x480
[  383.796112]  __alloc_pages_slowpath+0xcdd/0xdb0
[  383.796115]  __alloc_pages_nodemask+0x246/0x280
[  383.796118]  pte_alloc_one+0x13/0x40
[  383.796121]  __handle_mm_fault+0xb2a/0x1130
[  383.796124]  handle_mm_fault+0xfa/0x200
[  383.796126]  __do_page_fault+0x257/0x4f0
[  383.796128]  ? page_fault+0x2f/0x50
[  383.796130]  page_fault+0x45/0x50
[  383.796132] RIP: 4cd15e:0x2384801
[  383.796134] RSP: 0001:00007ffd46762d80 EFLAGS: 7ffd46762e00
[  383.796135] Mem-Info:
[  383.796140] active_anon:6085 inactive_anon:1918280 isolated_anon:544
                active_file:61 inactive_file:57 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1919408 pagetables:2933 bounce:0
                free:19312 free_pcp:20 free_cma:0
[  383.796144] Node 0 active_anon:24340kB inactive_anon:7673120kB active_file:244kB inactive_file:228kB unevictable:0kB isolated(anon):2176kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7677632kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  383.796145] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  383.796149] lowmem_reserve[]: 0 747 7758 7758 7758
[  383.796152] Node 0 DMA32 free:31164kB min:6500kB low:8124kB high:9748kB active_anon:288kB inactive_anon:770796kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  383.796156] lowmem_reserve[]: 0 0 7010 7010 7010
[  383.796159] Node 0 Normal free:30200kB min:60944kB low:76180kB high:91416kB active_anon:24052kB inactive_anon:6902332kB active_file:240kB inactive_file:228kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4144kB pagetables:11728kB bounce:0kB free_pcp:80kB local_pcp:0kB free_cma:0kB
[  383.796162] lowmem_reserve[]: 0 0 0 0 0
[  383.796165] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  383.796177] Node 0 DMA32: 19*4kB (UME) 24*8kB (UME) 21*16kB (UM) 25*32kB (UM) 21*64kB (UME) 16*128kB (UM) 17*256kB (UM) 17*512kB (UME) 5*1024kB (ME) 4*2048kB (M) 0*4096kB = 31164kB
[  383.796189] Node 0 Normal: 393*4kB (UME) 213*8kB (UME) 108*16kB (UM) 80*32kB (UME) 110*64kB (UME) 70*128kB (ME) 26*256kB (ME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 30220kB
[  383.796203] 1920365 total pagecache pages
[  383.796205] 839 pages in swap cache
[  383.796206] Swap cache stats: add 5093675, delete 5092328, find 110167/132300
[  383.796207] Free swap  = 7673432kB
[  383.796207] Total swap = 8000508kB
[  383.796208] 2056177 pages RAM
[  383.796208] 0 pages HighMem/MovableOnly
[  383.796209] 54740 pages reserved
[  383.796209] 0 pages cma reserved
[  383.796210] 0 pages hwpoisoned
[  383.796383] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  383.796400] Killed process 10625 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  387.872016] 1 and 262144 pages still available in the bound and unbound GPU page lists.
[  387.872096] in:imklog invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0
[  387.872101] CPU: 1 PID: 697 Comm: in:imklog Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  387.872102] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  387.872103] Call Trace:
[  387.872110]  dump_stack+0x5c/0x85
[  387.872114]  dump_header+0x6b/0x27c
[  387.872116]  oom_kill_process+0x239/0x480
[  387.872118]  ? oom_badness+0xeb/0x160
[  387.872120]  out_of_memory+0x10f/0x480
[  387.872123]  __alloc_pages_slowpath+0xcdd/0xdb0
[  387.872127]  __alloc_pages_nodemask+0x246/0x280
[  387.872129]  filemap_fault+0x2e9/0x650
[  387.872131]  ? filemap_map_pages+0x188/0x370
[  387.872134]  ext4_filemap_fault+0x2c/0x3b
[  387.872137]  __do_fault+0x1f/0xb6
[  387.872140]  __handle_mm_fault+0xbfc/0x1130
[  387.872143]  handle_mm_fault+0xfa/0x200
[  387.872145]  __do_page_fault+0x257/0x4f0
[  387.872148]  ? page_fault+0x2f/0x50
[  387.872150]  page_fault+0x45/0x50
[  387.872152] RIP: 1fa0:0x1f9f
[  387.872153] RSP: 0004:00007f5b8187cd90 EFLAGS: 00001fa0
[  387.872155] Mem-Info:
[  387.872160] active_anon:6071 inactive_anon:1918515 isolated_anon:288
                active_file:61 inactive_file:57 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25610
                mapped:543 shmem:1919408 pagetables:2906 bounce:0
                free:19312 free_pcp:71 free_cma:0
[  387.872163] Node 0 active_anon:24284kB inactive_anon:7674060kB active_file:244kB inactive_file:228kB unevictable:0kB isolated(anon):1152kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7677632kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  387.872164] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  387.872168] lowmem_reserve[]: 0 747 7758 7758 7758
[  387.872172] Node 0 DMA32 free:31164kB min:6500kB low:8124kB high:9748kB active_anon:288kB inactive_anon:770860kB active_file:4kB inactive_file:0kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  387.872176] lowmem_reserve[]: 0 0 7010 7010 7010
[  387.872179] Node 0 Normal free:30200kB min:60944kB low:76180kB high:91416kB active_anon:23996kB inactive_anon:6902684kB active_file:240kB inactive_file:228kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4144kB pagetables:11620kB bounce:0kB free_pcp:284kB local_pcp:0kB free_cma:0kB
[  387.872183] lowmem_reserve[]: 0 0 0 0 0
[  387.872186] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  387.872199] Node 0 DMA32: 19*4kB (UME) 24*8kB (UME) 21*16kB (UM) 25*32kB (UM) 21*64kB (UME) 16*128kB (UM) 17*256kB (UM) 17*512kB (UME) 5*1024kB (ME) 4*2048kB (M) 0*4096kB = 31164kB
[  387.872213] Node 0 Normal: 388*4kB (UME) 213*8kB (UME) 108*16kB (UM) 80*32kB (UME) 110*64kB (UME) 70*128kB (ME) 26*256kB (ME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 30200kB
[  387.872228] 1920365 total pagecache pages
[  387.872230] 839 pages in swap cache
[  387.872231] Swap cache stats: add 5093675, delete 5092328, find 110167/132300
[  387.872231] Free swap  = 7673432kB
[  387.872232] Total swap = 8000508kB
[  387.872233] 2056177 pages RAM
[  387.872233] 0 pages HighMem/MovableOnly
[  387.872234] 54740 pages reserved
[  387.872234] 0 pages cma reserved
[  387.872235] 0 pages hwpoisoned
[  387.872428] Out of memory: Kill process 10614 (gem_shrink) score 999 or sacrifice child
[  387.872448] Killed process 10626 (gem_shrink) total-vm:51648kB, anon-rss:396kB, file-rss:0kB, shmem-rss:0kB
[  394.296014] gem_shrink: page allocation failure: order:0, mode:0x14204d2(GFP_HIGHUSER|__GFP_RETRY_MAYFAIL|__GFP_RECLAIMABLE), nodemask=(null)
[  394.296021] CPU: 2 PID: 10628 Comm: gem_shrink Not tainted 4.16.0-rc6-drm-intel-qa-ww12-commit-4db112a+ #1
[  394.296022] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X124.B02.1802051422 02/05/2018
[  394.296023] Call Trace:
[  394.296030]  dump_stack+0x5c/0x85
[  394.296034]  warn_alloc+0x100/0x180
[  394.296037]  ? unreserve_highatomic_pageblock+0x111/0x180
[  394.296039]  __alloc_pages_slowpath+0xda9/0xdb0
[  394.296042]  __alloc_pages_nodemask+0x246/0x280
[  394.296046]  alloc_pages_vma+0x7c/0x1e0
[  394.296048]  shmem_alloc_page+0x78/0xc0
[  394.296050]  ? __radix_tree_create+0x168/0x1f0
[  394.296053]  ? __update_load_avg_se.isra.38+0x1c1/0x1d0
[  394.296055]  ? __update_load_avg_se.isra.38+0x1c1/0x1d0
[  394.296058]  shmem_alloc_and_acct_page+0x7a/0x1d0
[  394.296060]  shmem_getpage_gfp+0x194/0xcf0
[  394.296063]  ? __schedule+0x3dd/0x8c0
[  394.296066]  shmem_read_mapping_page_gfp+0x42/0x80
[  394.296068]  ? _cond_resched+0x2d/0x40
[  394.296100]  i915_gem_object_get_pages_gtt+0x1b2/0x520 [i915]
[  394.296128]  __i915_gem_object_get_pages+0x52/0x60 [i915]
[  394.296156]  i915_gem_pread_ioctl+0x266/0x5a0 [i915]
[  394.296183]  ? i915_gem_object_get_page+0x70/0x70 [i915]
[  394.296186]  drm_ioctl_kernel+0x67/0xb0
[  394.296188]  drm_ioctl+0x2d4/0x3c0
[  394.296214]  ? i915_gem_object_get_page+0x70/0x70 [i915]
[  394.296216]  ? set_next_entity+0x92/0x1b0
[  394.296218]  ? pick_next_task_fair+0x287/0x5d0
[  394.296221]  ? __switch_to+0x12f/0x460
[  394.296224]  do_vfs_ioctl+0xa2/0x610
[  394.296228]  ? __schedule+0x3dd/0x8c0
[  394.296230]  SyS_ioctl+0x74/0x80
[  394.296233]  ? exit_to_usermode_loop+0x61/0xc0
[  394.296235]  do_syscall_64+0x6e/0x120
[  394.296237]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[  394.296239] RIP: 0033:0x7fa69a483ef7
[  394.296241] RSP: 002b:00007ffe21883a78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[  394.296243] RAX: ffffffffffffffda RBX: 0000000000008000 RCX: 00007fa69a483ef7
[  394.296244] RDX: 00007ffe21883ab0 RSI: 000000004020645c RDI: 0000000000000004
[  394.296245] RBP: 00007ffe21883ab0 R08: 0000000000000004 R09: 0000000000000043
[  394.296246] R10: 0000000000000073 R11: 0000000000000246 R12: 000000004020645c
[  394.296247] R13: 0000000000000004 R14: 0000000000000004 R15: 0000000008000000
[  394.296248] Mem-Info:
[  394.296254] active_anon:6057 inactive_anon:1918238 isolated_anon:608
                active_file:57 inactive_file:61 isolated_file:0
                unevictable:0 dirty:0 writeback:0 unstable:0
                slab_reclaimable:9750 slab_unreclaimable:25582
                mapped:543 shmem:1919408 pagetables:2879 bounce:0
                free:19314 free_pcp:140 free_cma:0
[  394.296257] Node 0 active_anon:24228kB inactive_anon:7672952kB active_file:228kB inactive_file:244kB unevictable:0kB isolated(anon):2432kB isolated(file):0kB mapped:2172kB dirty:0kB writeback:0kB shmem:7677632kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[  394.296258] Node 0 DMA free:15884kB min:132kB low:164kB high:196kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15884kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  394.296262] lowmem_reserve[]: 0 747 7758 7758 7758
[  394.296266] Node 0 DMA32 free:31164kB min:6500kB low:8124kB high:9748kB active_anon:288kB inactive_anon:771032kB active_file:0kB inactive_file:4kB unevictable:0kB writepending:0kB present:872780kB managed:807024kB mlocked:0kB kernel_stack:16kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[  394.296270] lowmem_reserve[]: 0 0 7010 7010 7010
[  394.296273] Node 0 Normal free:30208kB min:60944kB low:76180kB high:91416kB active_anon:23940kB inactive_anon:6901932kB active_file:228kB inactive_file:240kB unevictable:0kB writepending:0kB present:7335936kB managed:7182840kB mlocked:0kB kernel_stack:4144kB pagetables:11512kB bounce:0kB free_pcp:560kB local_pcp:80kB free_cma:0kB
[  394.296277] lowmem_reserve[]: 0 0 0 0 0
[  394.296280] Node 0 DMA: 1*4kB (U) 1*8kB (U) 2*16kB (U) 1*32kB (U) 1*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
[  394.296292] Node 0 DMA32: 19*4kB (UME) 24*8kB (UME) 21*16kB (UM) 25*32kB (UM) 21*64kB (UME) 16*128kB (UM) 17*256kB (UM) 17*512kB (UME) 5*1024kB (ME) 4*2048kB (M) 0*4096kB = 31164kB
[  394.296305] Node 0 Normal: 393*4kB (UME) 213*8kB (UME) 108*16kB (UM) 80*32kB (UME) 110*64kB (UME) 70*128kB (ME) 26*256kB (ME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 30220kB
[  394.296319] 1920365 total pagecache pages
[  394.296321] 839 pages in swap cache
[  394.296322] Swap cache stats: add 5093675, delete 5092328, find 110167/132300
[  394.296323] Free swap  = 7673432kB
[  394.296324] Total swap = 8000508kB
[  394.296324] 2056177 pages RAM
[  394.296325] 0 pages HighMem/MovableOnly
[  394.296325] 54740 pages reserved
[  394.296326] 0 pages cma reserved
[  394.296326] 0 pages hwpoisoned
[  394.904700] systemd[1]: systemd-journald.service: Main process exited, code=dumped, status=6/ABRT
[  394.905939] systemd[1]: systemd-journald.service: Unit entered failed state.
[  394.907498] systemd[1]: systemd-journald.service: Failed with result 'watchdog'.
[  394.958886] systemd-journald[10792]: File /run/log/journal/f67bf632faf24157a4676ab8a79ac726/system.journal corrupted or uncleanly shut down, renaming and replacing.
Comment 1 Chris Wilson 2018-04-05 20:36:19 UTC
The test isn't expected to PASS in the traditional sense, the test itself is expected to crash and burn. The only thing we want is for it to not take the kernel with it, i.e. failure here is an oops or system lockup.
Comment 2 Lakshmi 2018-08-23 14:25:13 UTC
Closing as not a bug.


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.