https://bugs.freedesktop.org/show_bug.cgi?id=105913

Bug ID: 105913 Summary: [IGT] igt@gem_shrink@pread Test assertion failure function gem_read, file ioctl_wrappers.c Product: DRI Version: DRI git Hardware: x86-64 (AMD64) OS: Linux (All) Status: NEW Severity: normal Priority: medium Component: IGT Assignee: dri-devel@lists.freedesktop.org Reporter: ricardo.o.perez@intel.com

Created attachment 138639 --> https://bugs.freedesktop.org/attachment.cgi?id=138639&action=edit 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.