Bug 110151 - [CI][SHARDS] igt@gem_tiled_swapping@non-threaded - fail - irqbalance invoked oom-killer
Summary: [CI][SHARDS] igt@gem_tiled_swapping@non-threaded - fail - irqbalance invoked ...
Status: RESOLVED DUPLICATE of bug 108686
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: DRI git
Hardware: Other All
: high normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
Depends on:
Blocks:
 
Reported: 2019-03-18 08:12 UTC by Lakshmi
Modified: 2019-03-19 09:44 UTC (History)
1 user (show)

See Also:
i915 platform: ICL
i915 features: GEM/Other


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Lakshmi 2019-03-18 08:12:59 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5763/shard-iclb1/igt@gem_tiled_swapping@non-threaded.html

<6> [3414.931167] Console: switching to colour dummy device 80x25
<6> [3414.931211] [IGT] gem_tiled_swapping: executing
<7> [3417.713083] [drm:edp_panel_vdd_off_sync [i915]] Turning eDP port A VDD off
<7> [3417.713243] [drm:edp_panel_vdd_off_sync [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [3417.713295] [drm:intel_power_well_disable [i915]] disabling DC off
<7> [3417.713329] [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [3417.713360] [drm:gen9_set_dc_state [i915]] Setting DC state from 00 to 02
<6> [3490.363187] perf: interrupt took too long (10198 > 10140), lowering kernel.perf_event_max_sample_rate to 19000
<4> [3508.399050] irqbalance invoked oom-killer: gfp_mask=0x100cca(GFP_HIGHUSER_MOVABLE), order=0, oom_score_adj=0
<4> [3508.399097] CPU: 3 PID: 501 Comm: irqbalance Tainted: G     U            5.1.0-rc1-CI-CI_DRM_5763+ #1
<4> [3508.399100] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3087.A00.1902250334 02/25/2019
<4> [3508.399103] Call Trace:
<4> [3508.399110]  dump_stack+0x67/0x9b
<4> [3508.399116]  dump_header+0x52/0x610
<4> [3508.399122]  ? _raw_spin_unlock_irqrestore+0x4e/0x60
<4> [3508.399129]  ? _raw_spin_unlock_irqrestore+0x39/0x60
<4> [3508.399136]  oom_kill_process+0x175/0x210
<4> [3508.399142]  out_of_memory+0x107/0x3a0
<4> [3508.399149]  __alloc_pages_nodemask+0xd0e/0x1120
<4> [3508.399168]  pagecache_get_page+0xdf/0x220
<4> [3508.399176]  filemap_fault+0x44d/0x820
<4> [3508.399186]  ext4_filemap_fault+0x27/0x40
<4> [3508.399191]  __do_fault+0x2c/0xb0
<4> [3508.399197]  __handle_mm_fault+0x9a6/0xfc0
<4> [3508.399211]  handle_mm_fault+0x196/0x3a0
<4> [3508.399218]  __do_page_fault+0x248/0x4f0
<4> [3508.399226]  ? page_fault+0x8/0x30
<4> [3508.399231]  page_fault+0x1e/0x30
<4> [3508.399235] RIP: 0033:0x7fac2cba7140
<4> [3508.399243] Code: Bad RIP value.
<4> [3508.399246] RSP: 002b:00007fff927fb1e8 EFLAGS: 00010246
<4> [3508.399251] RAX: 00007fff927fb230 RBX: 0000000000000000 RCX: 00007fac2cc19860
<4> [3508.399253] RDX: 000000000000000a RSI: 0000000000000000 RDI: 00005623faf05b70
<4> [3508.399256] RBP: 00005623faf05b70 R08: 0000000000000000 R09: 0000000000000001
<4> [3508.399258] R10: 0000000000000021 R11: 00007fac2cd11550 R12: 00007fff927fb228
<4> [3508.399261] R13: 00005623faee7290 R14: 00005623faf06460 R15: 00005623faf05b75
<4> [3508.399275] Mem-Info:
<4> [3508.399281] active_anon:3288686 inactive_anon:300035 isolated_anon:17408
 active_file:29 inactive_file:29 isolated_file:0
 unevictable:366598 dirty:0 writeback:0 unstable:0
 slab_reclaimable:7243 slab_unreclaimable:27399
 mapped:1 shmem:48 pagetables:9312 bounce:0
 free:35622 free_pcp:0 free_cma:0
<4> [3508.399287] Node 0 active_anon:13154744kB inactive_anon:1198092kB active_file:116kB inactive_file:116kB unevictable:1466392kB isolated(anon):69632kB isolated(file):0kB mapped:4kB dirty:0kB writeback:0kB shmem:192kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
<4> [3508.399292] DMA free:15876kB min:64kB low:80kB high:96kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15876kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.399295] lowmem_reserve[]: 0 964 15788 15788
<4> [3508.399304] DMA32 free:63304kB min:4124kB low:5152kB high:6180kB active_anon:991236kB inactive_anon:8kB active_file:0kB inactive_file:0kB unevictable:2180kB writepending:0kB present:1104624kB managed:1056916kB mlocked:2180kB kernel_stack:0kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.399306] lowmem_reserve[]: 0 0 14823 14823
<4> [3508.399314] Normal free:63308kB min:63392kB low:79240kB high:95088kB active_anon:12163508kB inactive_anon:1200132kB active_file:116kB inactive_file:116kB unevictable:1464212kB writepending:0kB present:15470592kB managed:15179776kB mlocked:1464020kB kernel_stack:4944kB pagetables:37244kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.399316] lowmem_reserve[]: 0 0 0 0
<4> [3508.399322] DMA: 1*4kB (U) 0*8kB 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) = 15876kB
<4> [3508.399358] DMA32: 0*4kB 0*8kB 2*16kB (U) 1*32kB (E) 2*64kB (UE) 4*128kB (UME) 11*256kB (UME) 9*512kB (UME) 8*1024kB (UME) 3*2048kB (UME) 10*4096kB (M) = 63424kB
<4> [3508.399375] Normal: 13*4kB (UE) 99*8kB (UME) 96*16kB (UME) 348*32kB (UME) 238*64kB (UME) 156*128kB (UME) 57*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 63308kB
<6> [3508.399392] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
<4> [3508.399394] 317551 total pagecache pages
<4> [3508.399400] 317445 pages in swap cache
<4> [3508.399404] Swap cache stats: add 3990718, delete 3672544, find 742/1092
<4> [3508.399406] Free swap  = 755196kB
<4> [3508.399409] Total swap = 2097148kB
<4> [3508.399411] 4147802 pages RAM
<4> [3508.399414] 0 pages HighMem/MovableOnly
<4> [3508.399416] 84660 pages reserved
<6> [3508.399419] Tasks state (memory values in pages):
<6> [3508.399421] [  pid  ]   uid  tgid total_vm      rss pgtables_bytes swapents oom_score_adj name
<6> [3508.399567] [    301]     0   301    35748       15   286720      189             0 systemd-journal
<6> [3508.399696] [    329]     0   329    11282        1   114688      697         -1000 systemd-udevd
<6> [3508.399702] [    498]   101   498    17653        3   176128      163             0 systemd-resolve
<6> [3508.399707] [    501]     0   501    27620       20   114688       77             0 irqbalance
<6> [3508.399713] [    517]     0   517    17648        1   180224      193             0 systemd-logind
<6> [3508.399718] [    521]     0   521     1137        0    53248       42             0 acpid
<6> [3508.399724] [    522]     0   522     2478        0    61440       32             0 rngd
<6> [3508.399729] [    544]   103   544    12572        0   143360      217          -900 dbus-daemon
<6> [3508.399735] [    546]   102   546    65758        0   159744      509             0 rsyslogd
<6> [3508.399741] [    547]     0   547    44724        1   241664     1981             0 networkd-dispat
<6> [3508.399746] [    583]     0   583   159639        0   458752      745             0 NetworkManager
<6> [3508.399751] [    675]     0   675    72218        0   208896      222             0 polkitd
<6> [3508.399756] [    676]     0   676     6414        1    94208      308             0 dhclient
<6> [3508.399761] [    746]     0   746    18073        1   184320      188         -1000 sshd
<6> [3508.399767] [    747]     0   747     6126        0    81920       37             0 agetty
<6> [3508.399773] [   1064]     0  1064    26430        1   249856      246             0 sshd
<6> [3508.399778] [   1069]  1000  1069    19154        1   188416      274             0 systemd
<6> [3508.399783] [   1072]  1000  1072    65337        0   270336      603             0 (sd-pam)
<6> [3508.399788] [   1110]  1000  1110    27112       21   253952      347             0 sshd
<6> [3508.399793] [   1146]  1000  1146  2237229        0   999424    48090             0 java
<6> [3508.399799] [   1260]     0  1260    18483        1   176128      119             0 sudo
<6> [3508.399805] [   1265]     0  1265     2478        0    65536       31             0 rngd
<6> [3508.399810] [   2131]     0  2131    18483        1   176128      119             0 sudo
<6> [3508.399815] [   2136]     0  2136     2478        0    65536       32             0 rngd
<6> [3508.399820] [   2740]     0  2740    18483        1   180224      119             0 sudo
<6> [3508.399826] [   2745]     0  2745     2478        0    61440       32             0 rngd
<6> [3508.399831] [   4642]     0  4642    18483        1   176128      119             0 sudo
<6> [3508.399837] [   4647]     0  4647     2478        0    61440       32             0 rngd
<6> [3508.399842] [   7361]     0  7361    18483        1   176128      118             0 sudo
<6> [3508.399847] [   7366]     0  7366     2478        0    65536       31             0 rngd
<6> [3508.399854] [   7976]     0  7976    18483        1   188416      119             0 sudo
<6> [3508.399859] [   7981]     0  7981     2478        0    57344       31             0 rngd
<6> [3508.399866] [  11238]  1000 11238     5302        1    81920       72             0 bash
<6> [3508.399871] [  11314]     0 11314    18483        1   180224      119             0 sudo
<6> [3508.399876] [  11319]     0 11319     2478        0    69632       32             0 rngd
<6> [3508.399881] [  11337]  1000 11337     6097        0    86016       42             0 dmesg
<6> [3508.399886] [  11340]     0 11340    18483        1   180224      120             0 sudo
<6> [3508.399892] [  11344]     0 11344    50695        0   405504      442             0 igt_runner
<6> [3508.399907] [  11707]     0 11707  3982071  3654584 31924224   277750          1000 gem_tiled_swapp
<6> [3508.399995] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),global_oom,task_memcg=/,task=gem_tiled_swapp,pid=11707,uid=0
<3> [3508.400492] Out of memory: Killed process 11707 (gem_tiled_swapp) total-vm:15928284kB, anon-rss:14618332kB, file-rss:4kB, shmem-rss:0kB
<6> [3508.402515] oom_reaper: reaped process 11707 (gem_tiled_swapp), now anon-rss:14618332kB, file-rss:0kB, shmem-rss:0kB
<4> [3508.645117] sshd invoked oom-killer: gfp_mask=0x100cca(GFP_HIGHUSER_MOVABLE), order=0, oom_score_adj=0
<4> [3508.645156] CPU: 5 PID: 1110 Comm: sshd Tainted: G     U            5.1.0-rc1-CI-CI_DRM_5763+ #1
<4> [3508.645159] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP TLC, BIOS ICLSFWR1.R00.3087.A00.1902250334 02/25/2019
<4> [3508.645162] Call Trace:
<4> [3508.645169]  dump_stack+0x67/0x9b
<4> [3508.645175]  dump_header+0x52/0x610
<4> [3508.645180]  ? _raw_spin_unlock_irqrestore+0x4c/0x60
<4> [3508.645185]  ? _raw_spin_unlock_irqrestore+0x4c/0x60
<4> [3508.645190]  ? lockdep_hardirqs_on+0xe3/0x1b0
<4> [3508.645194]  ? _raw_spin_unlock_irqrestore+0x39/0x60
<4> [3508.645201]  oom_kill_process+0x175/0x210
<4> [3508.645208]  out_of_memory+0x107/0x3a0
<4> [3508.645214]  __alloc_pages_nodemask+0xd0e/0x1120
<4> [3508.645236]  __read_swap_cache_async+0x131/0x1d0
<4> [3508.645244]  swapin_readahead+0x305/0x3f0
<4> [3508.645253]  ? 0xffffffff81000000
<4> [3508.645261]  ? do_swap_page+0x2f4/0x960
<4> [3508.645265]  do_swap_page+0x2f4/0x960
<4> [3508.645270]  ? __lock_acquire+0x4a0/0x1590
<4> [3508.645277]  __handle_mm_fault+0x676/0xfc0
<4> [3508.645292]  handle_mm_fault+0x196/0x3a0
<4> [3508.645299]  __do_page_fault+0x248/0x4f0
<4> [3508.645307]  ? page_fault+0x8/0x30
<4> [3508.645312]  page_fault+0x1e/0x30
<4> [3508.645316] RIP: 0033:0x7fc8fc55d950
<4> [3508.645324] Code: Bad RIP value.
<4> [3508.645327] RSP: 002b:00007ffd2ee9cab8 EFLAGS: 00010246
<4> [3508.645330] RAX: 0000000000000001 RBX: 00005654bdc61a90 RCX: 0000000000000010
<4> [3508.645333] RDX: 00005654bdc6b1a0 RSI: 00005654bdc4a0d0 RDI: 00005654bdc46d40
<4> [3508.645336] RBP: 00005654bdc6b1a0 R08: 0000000000000010 R09: 0000000000000000
<4> [3508.645339] R10: 0000000000000010 R11: 0000000000000000 R12: 0000000000000000
<4> [3508.645342] R13: 00005654bdc4a0d0 R14: 0000000000000000 R15: 0000000000000010
<4> [3508.645355] Mem-Info:
<4> [3508.645362] active_anon:3288686 inactive_anon:301571 isolated_anon:15360
 active_file:29 inactive_file:29 isolated_file:0
 unevictable:366598 dirty:0 writeback:0 unstable:0
 slab_reclaimable:7243 slab_unreclaimable:27399
 mapped:1 shmem:48 pagetables:9312 bounce:0
 free:35622 free_pcp:0 free_cma:0
<4> [3508.645367] Node 0 active_anon:13154744kB inactive_anon:1208332kB active_file:116kB inactive_file:116kB unevictable:1466392kB isolated(anon):59392kB isolated(file):0kB mapped:4kB dirty:0kB writeback:0kB shmem:192kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes
<4> [3508.645372] DMA free:15876kB min:64kB low:80kB high:96kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15876kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.645375] lowmem_reserve[]: 0 964 15788 15788
<4> [3508.645383] DMA32 free:63304kB min:4124kB low:5152kB high:6180kB active_anon:991236kB inactive_anon:8kB active_file:0kB inactive_file:0kB unevictable:2180kB writepending:0kB present:1104624kB managed:1056916kB mlocked:2180kB kernel_stack:0kB pagetables:4kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.645386] lowmem_reserve[]: 0 0 14823 14823
<4> [3508.645394] Normal free:63308kB min:63392kB low:79240kB high:95088kB active_anon:12163508kB inactive_anon:1208324kB active_file:116kB inactive_file:116kB unevictable:1464212kB writepending:0kB present:15470592kB managed:15179776kB mlocked:1464020kB kernel_stack:4944kB pagetables:37244kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [3508.645397] lowmem_reserve[]: 0 0 0 0
<4> [3508.645402] DMA: 1*4kB (U) 0*8kB 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) = 15876kB
<4> [3508.645441] DMA32: 0*4kB 0*8kB 2*16kB (U) 1*32kB (E) 2*64kB (UE) 4*128kB (UME) 11*256kB (UME) 9*512kB (UME) 8*1024kB (UME) 3*2048kB (UME) 10*4096kB (M) = 63424kB
<4> [3508.645458] Normal: 13*4kB (UE) 99*8kB (UME) 96*16kB (UME) 348*32kB (UME) 238*64kB (UME) 156*128kB (UME) 57*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 63308kB
<6> [3508.645475] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
<4> [3508.645478] 317551 total pagecache pages
<4> [3508.645483] 317445 pages in swap cache
<4> [3508.645487] Swap cache stats: add 3990718, delete 3672544, find 742/1092
<4> [3508.645489] Free swap  = 756988kB
<4> [3508.645491] Total swap = 2097148kB
<4> [3508.645494] 4147802 pages RAM
<4> [3508.645496] 0 pages HighMem/MovableOnly
<4> [3508.645499] 84660 pages reserved
<6> [3508.645502] Tasks state (memory values in pages):
<6> [3508.645504] [  pid  ]   uid  tgid total_vm      rss pgtables_bytes swapents oom_score_adj name
<6> [3508.645653] [    301]     0   301    35748       15   286720      189             0 systemd-journal
<6> [3508.645775] [    329]     0   329    11282        1   114688      697         -1000 systemd-udevd
<6> [3508.645780] [    498]   101   498    17653        3   176128      163             0 systemd-resolve
<6> [3508.645785] [    501]     0   501    27620       20   114688       77             0 irqbalance
<6> [3508.645791] [    517]     0   517    17648        1   180224      193             0 systemd-logind
<6> [3508.645797] [    521]     0   521     1137        0    53248       42             0 acpid
<6> [3508.645802] [    522]     0   522     2478        0    61440       32             0 rngd
<6> [3508.645808] [    544]   103   544    12572        0   143360      217          -900 dbus-daemon
<6> [3508.645813] [    546]   102   546    65758        0   159744      509             0 rsyslogd
<6> [3508.645817] [    547]     0   547    44724        1   241664     1981             0 networkd-dispat
<6> [3508.645823] [    583]     0   583   159639        0   458752      745             0 NetworkManager
<6> [3508.645828] [    675]     0   675    72218        0   208896      222             0 polkitd
<6> [3508.645833] [    676]     0   676     6414        1    94208      308             0 dhclient
<6> [3508.645838] [    746]     0   746    18073        1   184320      188         -1000 sshd
<6> [3508.645843] [    747]     0   747     6126        0    81920       37             0 agetty
<6> [3508.645849] [   1064]     0  1064    26430        1   249856      246             0 sshd
<6> [3508.645854] [   1069]  1000  1069    19154        1   188416      274             0 systemd
<6> [3508.645859] [   1072]  1000  1072    65337        0   270336      603             0 (sd-pam)
<6> [3508.645864] [   1110]  1000  1110    27112       21   253952      347             0 sshd
<6> [3508.645869] [   1146]  1000  1146  2237229        0   999424    48090             0 java
<6> [3508.645875] [   1260]     0  1260    18483        1   176128      119             0 sudo
<6> [3508.645880] [   1265]     0  1265     2478        0    65536       31             0 rngd
<6> [3508.645886] [   2131]     0  2131    18483        1   176128      119             0 sudo
<6> [3508.645891] [   2136]     0  2136     2478        0    65536       32             0 rngd
<6> [3508.645897] [   2740]     0  2740    18483        1   180224      119             0 sudo
<6> [3508.645903] [   2745]     0  2745     2478        0    61440       32             0 rngd
<6> [3508.645908] [   4642]     0  4642    18483        1   176128      119             0 sudo
<6> [3508.645996] [   4647]     0  4647     2478        0    61440       32             0 rngd
<6> [3508.646002] [   7361]     0  7361    18483        1   176128      118             0 sudo
<6> [3508.646007] [   7366]     0  7366     2478        0    65536       31             0 rngd
<6> [3508.646014] [   7976]     0  7976    18483        1   188416      119             0 sudo
<6> [3508.646018] [   7981]     0  7981     2478        0    57344       31             0 rngd
<6> [3508.646025] [  11238]  1000 11238     5302        1    81920       72             0 bash
<6> [3508.646029] [  11314]     0 11314    18483        1   180224      119             0 sudo
<6> [3508.646034] [  11319]     0 11319     2478        0    69632       32             0 rngd
<6> [3508.646041] [  11337]  1000 11337     6097        0    86016       42             0 dmesg
<6> [3508.646046] [  11340]     0 11340    18483        1   180224      120             0 sudo
<6> [3508.646051] [  11344]     0 11344    50695        0   405504      442             0 igt_runner
<6> [3508.646067] [  11707]     0 11707  3982071  3654583 31924224   277321          1000 gem_tiled_swapp
<6> [3508.646071] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),global_oom,task_memcg=/,task=java,pid=1146,uid=1000
<3> [3508.646752] Out of memory: Killed process 1146 (java) total-vm:8948916kB, anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
<6> [3508.736801] oom_reaper: reaped process 1146 (java), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB
Comment 1 CI Bug Log 2019-03-18 08:14:23 UTC
The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* ICL: igt@gem_tiled_swapping@non-threaded - fail - irqbalance invoked oom-killer
  - https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5763/shard-iclb1/igt@gem_tiled_swapping@non-threaded.html
Comment 2 Chris Wilson 2019-03-18 09:25:39 UTC

*** This bug has been marked as a duplicate of bug 108686 ***
Comment 3 CI Bug Log 2019-03-19 09:44:24 UTC
The CI Bug Log issue associated to this bug has been archived.

New failures matching the above filters will not be associated to this bug anymore.


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.