<html>
    <head>
      <base href="https://bugs.freedesktop.org/">
    </head>
    <body>
      <p>
        <div>
            <b><a class="bz_bug_link 
          bz_status_NEW "
   title="NEW - [CI] igt@gem_tiled_swapping@non-threaded - cause incompletes on following tests"
   href="https://bugs.freedesktop.org/show_bug.cgi?id=104218#c4">Comment # 4</a>
              on <a class="bz_bug_link 
          bz_status_NEW "
   title="NEW - [CI] igt@gem_tiled_swapping@non-threaded - cause incompletes on following tests"
   href="https://bugs.freedesktop.org/show_bug.cgi?id=104218">bug 104218</a>
              from <span class="vcard"><a class="email" href="mailto:marta.lofstedt@intel.com" title="Marta Löfstedt <marta.lofstedt@intel.com>"> <span class="fn">Marta Löfstedt</span></a>
</span></b>
        <pre><a href="https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4063/shard-hsw7/igt@gem_tiled_pread_basic.html">https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4063/shard-hsw7/igt@gem_tiled_pread_basic.html</a>

from pstore:
<14>[   56.825306] [IGT] gem_tiled_swapping: exiting, ret=0
<14>[   57.631391] [IGT] gem_tiled_pread_basic: executing
<3>[  123.820940] INFO: task kswapd0:80 blocked for more than 60 seconds.
<3>[  123.820963]       Tainted: G     U           4.15.0-rc3-CI-CI_DRM_3513+
#1
<3>[  123.820983] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables
this message.
<6>[  123.821006] kswapd0         D    0    80      2 0x80000000
<4>[  123.821011] Call Trace:
<4>[  123.821019]  ? __schedule+0x3c3/0xaf0
<4>[  123.821027]  schedule+0x37/0x90
<4>[  123.821031]  io_schedule+0xd/0x30
<4>[  123.821034]  __lock_page+0x107/0x130
<4>[  123.821039]  ? add_to_page_cache_lru+0xc0/0xc0
<4>[  123.821046]  deferred_split_scan+0x25a/0x2b0
<4>[  123.821053]  shrink_slab.part.17+0x201/0x5d0
<4>[  123.821065]  shrink_node+0x2fd/0x310
<4>[  123.821073]  kswapd+0x31c/0x910
<4>[  123.821085]  kthread+0x173/0x1b0
<4>[  123.821088]  ? mem_cgroup_shrink_node+0x300/0x300
<4>[  123.821090]  ? _kthread_create_on_node+0x30/0x30
<4>[  123.821095]  ret_from_fork+0x24/0x30
<4>[  123.821105] 
<4>[  123.821105] Showing all locks held in the system:
<4>[  123.821113] 2 locks held by khungtaskd/67:
<4>[  123.821116]  #0:  (rcu_read_lock){....}, at: [<00000000899df8e4>]
watchdog+0x9b/0x5e0
<4>[  123.821127]  #1:  (tasklist_lock){.+.+}, at: [<00000000bcdb3c63>]
debug_show_all_locks+0x37/0x190
<4>[  123.821139] 1 lock held by kswapd0/80:
<4>[  123.821141]  #0:  (shrinker_rwsem){++++}, at: [<000000008a60ca11>]
shrink_slab.part.17+0x46/0x5d0
<4>[  123.821157] 1 lock held by in:imklog/593:
<4>[  123.821159]  #0:  (&f->f_pos_lock){+.+.}, at: [<00000000109958e5>]
__fdget_pos+0x40/0x50
<4>[  123.821172] 2 locks held by systemd-hostnam/767:
<4>[  123.821174]  #0:  (&type->s_umount_key#29){++++}, at:
[<000000005dafd8e5>] deactivate_super+0x3e/0x50
<4>[  123.821185]  #1:  (shrinker_rwsem){++++}, at: [<00000000771ee75f>]
unregister_shrinker+0x10/0x60
<4>[  123.821198] 1 lock held by dmesg/1079:
<4>[  123.821200]  #0:  (&user->lock){+.+.}, at: [<00000000eb7fbce0>]
devkmsg_read+0x35/0x2f0
<4>[  123.821213] 1 lock held by gem_tiled_pread/1526:
<4>[  123.821214]  #0:  (&type->s_umount_key#29){++++}, at:
[<00000000c0065d2f>] iterate_supers+0x8d/0xf0

but igt@gem_tiled_swapping@non-threaded is last in run.log and we appear to run
out of mem:
<7>[   22.506021] [IGT] gem_tiled_swapping: executing
<6>[   22.531591] gem_tiled_swapp (1433): drop_caches: 4
<7>[   24.044626] [IGT] gem_tiled_swapping: starting subtest non-threaded
<5>[   24.206026] random: crng init done
<6>[   38.088325] Purging GPU memory, 51712 pages freed, 935 pages still
pinned.
<6>[   41.465720] Purging GPU memory, 52224 pages freed, 935 pages still
pinned.
<6>[   44.272472] Purging GPU memory, 51968 pages freed, 935 pages still
pinned.
<4>[   47.709105] gem_tiled_swapp: page allocation failure: order:0,
mode:0x14204d2(GFP_HIGHUSER|__GFP_RETRY_MAYFAIL|__GFP_RECLAIMABLE),
nodemask=(null)
<4>[   47.709131] CPU: 5 PID: 1433 Comm: gem_tiled_swapp Tainted: G     U      
    4.15.0-rc3-CI-CI_DRM_3513+ #1
<4>[   47.709133] Hardware name: MSI MS-7924/Z97M-G43(MS-7924), BIOS V1.12
02/15/2016
<4>[   47.709135] Call Trace:
<4>[   47.709141]  dump_stack+0x5f/0x86
<4>[   47.709146]  warn_alloc+0xad/0x130
<4>[   47.709153]  ? __mutex_unlock_slowpath+0x38/0x270
<4>[   47.709159]  __alloc_pages_nodemask+0xeb5/0x11d0
<4>[   47.709175]  __read_swap_cache_async+0x146/0x250
<4>[   47.709180]  swapin_readahead+0x14b/0x230
<4>[   47.709191]  ? shmem_swapin+0x40/0x50
<4>[   47.709194]  shmem_swapin+0x40/0x50
<4>[   47.709198]  ? find_get_entry+0x160/0x210
<4>[   47.709202]  ? pagecache_get_page+0x2b/0x230
<4>[   47.709207]  ? lookup_swap_cache+0x46/0x100
<4>[   47.709211]  shmem_getpage_gfp.isra.9+0x925/0xc90
<4>[   47.709222]  shmem_read_mapping_page_gfp+0x2e/0x50
<4>[   47.709251]  i915_gem_object_get_pages_gtt+0x13b/0x660 [i915]
<4>[   47.709278]  ? i915_gem_obj_prepare_shmem_write+0x190/0x220 [i915]
<4>[   47.709299]  ____i915_gem_object_get_pages+0x17/0x70 [i915]
<4>[   47.709318]  __i915_gem_object_get_pages+0x59/0x80 [i915]
<4>[   47.709339]  i915_gem_set_domain_ioctl+0x377/0x3e0 [i915]
<4>[   47.709359]  ? i915_gem_obj_prepare_shmem_write+0x220/0x220 [i915]
<4>[   47.709363]  drm_ioctl_kernel+0x60/0xa0
<4>[   47.709367]  drm_ioctl+0x290/0x330
<4>[   47.709387]  ? i915_gem_obj_prepare_shmem_write+0x220/0x220 [i915]
<4>[   47.709392]  ? vm_mmap_pgoff+0xa1/0xd0
<4>[   47.709401]  do_vfs_ioctl+0x8a/0x680
<4>[   47.709404]  ? entry_SYSCALL_64_fastpath+0x5/0x89
<4>[   47.709408]  ? trace_hardirqs_on_caller+0xde/0x1c0
<4>[   47.709413]  SyS_ioctl+0x36/0x70
<4>[   47.709417]  entry_SYSCALL_64_fastpath+0x1c/0x89
<4>[   47.709420] RIP: 0033:0x7f4ed426a587
<4>[   47.709422] RSP: 002b:00007fffba7f6cc8 EFLAGS: 00000246 ORIG_RAX:
0000000000000010
<4>[   47.709425] RAX: ffffffffffffffda RBX: 0000000000000026 RCX:
00007f4ed426a587
<4>[   47.709427] RDX: 00007fffba7f6d0c RSI: 00000000400c645f RDI:
0000000000000003
<4>[   47.709429] RBP: 0000000000000098 R08: 0000000000000003 R09:
000000010fa00000
<4>[   47.709431] R10: 0000000000000001 R11: 0000000000000246 R12:
000055a474724240
<4>[   47.709433] R13: 00007f4ed5c5d000 R14: 0000000000000003 R15:
000000000000025f
<4>[   47.709461] Mem-Info:
<4>[   47.709465] active_anon:2810 inactive_anon:53101 isolated_anon:32
                   active_file:79 inactive_file:76 isolated_file:0
                   unevictable:3836673 dirty:5 writeback:0 unstable:0
                   slab_reclaimable:7694 slab_unreclaimable:16315
                   mapped:1000 shmem:53120 pagetables:8816 bounce:0
                   free:33343 free_pcp:30 free_cma:0
<4>[   47.709469] Node 0 active_anon:11240kB inactive_anon:212404kB
active_file:316kB inactive_file:304kB unevictable:15346692kB
isolated(anon):128kB isolated(file):0kB mapped:4000kB dirty:20kB writeback:0kB
shmem:212480kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 14948352kB
writeback_tmp:0kB unstable:0kB all_unreclaimable? no
<4>[   47.709472] DMA free:15884kB min:64kB low:80kB high:96kB active_anon:0kB
inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB
writepending:0kB present:15988kB managed:15884kB mlocked:0kB kernel_stack:0kB
pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4>[   47.709474] lowmem_reserve[]: 0 2894 15416 15416
<4>[   47.709485] DMA32 free:62488kB min:12676kB low:15844kB high:19012kB
active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB
unevictable:2970008kB writepending:0kB present:3077188kB managed:3032508kB
mlocked:2970008kB kernel_stack:0kB pagetables:8kB bounce:0kB free_pcp:0kB
local_pcp:0kB free_cma:0kB
<4>[   47.709487] lowmem_reserve[]: 0 0 12522 12522
<4>[   47.709498] Normal free:55000kB min:54836kB low:68544kB high:82252kB
active_anon:11240kB inactive_anon:212404kB active_file:316kB
inactive_file:304kB unevictable:12376684kB writepending:20kB present:13105152kB
managed:12823268kB mlocked:12376684kB kernel_stack:3760kB pagetables:35256kB
bounce:0kB free_pcp:120kB local_pcp:0kB free_cma:0kB
<4>[   47.709500] lowmem_reserve[]: 0 0 0 0
<4>[   47.709509] DMA: 3*4kB (U) 2*8kB (U) 3*16kB (U) 0*32kB 3*64kB (U) 2*128kB
(U) 0*256kB 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15884kB
<4>[   47.709544] DMA32: 4*4kB (UM) 3*8kB (U) 3*16kB (U) 4*32kB (UM) 1*64kB (U)
0*128kB 9*256kB (UM) 9*512kB (UM) 6*1024kB (UM) 2*2048kB (UM) 11*4096kB (M) =
62488kB
<4>[   47.709582] Normal: 2436*4kB (UME) 1167*8kB (UME) 633*16kB (UM) 250*32kB
(UM) 100*64kB (UME) 53*128kB (UME) 16*256kB (M) 1*512kB (M) 0*1024kB 0*2048kB
0*4096kB = 55000kB
<6>[   47.709617] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0
hugepages_size=2048kB
<4>[   47.709618] 54774 total pagecache pages
<4>[   47.709669] 1490 pages in swap cache
<4>[   47.709671] Swap cache stats: add 852548, delete 851079, find
285364/336301
<4>[   47.709672] Free swap  = 1349884kB
<4>[   47.709674] Total swap = 2097148kB
<4>[   47.709676] 4049582 pages RAM
<4>[   47.709677] 0 pages HighMem/MovableOnly
<4>[   47.709679] 81667 pages reserved
<6>[   47.740907] Purging GPU memory, 51968 pages freed, 935 pages still
pinned.
<6>[   51.532571] Purging GPU memory, 51968 pages freed, 935 pages still
pinned.
<6>[   54.663518] Purging GPU memory, 51968 pages freed, 935 pages still
pinned.</pre>
        </div>
      </p>


      <hr>
      <span>You are receiving this mail because:</span>

      <ul>
          <li>You are the QA Contact for the bug.</li>
          <li>You are the assignee for the bug.</li>
          <li>You are on the CC list for the bug.</li>
      </ul>
    </body>
</html>