igt@i915_selftest@live@gt_engines - timeout - i915/live_engine_pm_selftests: live_engine_busy_stats failed with error -16
Showing all locks held in the system:
<4> [303.764467] 1 lock held by in:imklog/414:
<4> [303.764468] #0: ffff888128001788 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x3e/0x60
<4> [303.764478] 3 locks held by dmesg/974:
<4> [303.764479] 3 locks held by igt_runner/1007:
<4> [303.764481] #0: ffff88810c6493e8 (sb_writers#4){.+.+}-{0:0}, at: ksys_write+0x64/0xe0
<4> [303.764488] #1: ffffffff827397c0 (rcu_read_lock){....}-{1:2}, at: __handle_sysrq+0x3b/0x290
<4> [303.764493] #2: ffffffff827397c0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x36/0x1c0
<4> [303.764499] 1 lock held by i915_selftest/5720:
<4> [303.764500] #0: ffff8881025941a8 (&dev->mutex){....}-{3:3}, at: __driver_attach+0xab/0x180
<4> [303.764506]
<4> [303.764507] =============================================
<6> [303.764508] Showing busy workqueues and worker pools:
<6> [303.764564] sysrq: Show Memory
<4> [303.764568] Mem-Info:
<4> [303.764570] active_anon:70 inactive_anon:64574 isolated_anon:0
active_file:81507 inactive_file:40462 isolated_file:0
unevictable:3158 dirty:385 writeback:0
slab_reclaimable:7997 slab_unreclaimable:29786
mapped:37134 shmem:3902 pagetables:1411
sec_pagetables:0 bounce:0
kernel_misc_reclaimable:0
free:7879345 free_pcp:13588 free_cma:0
<4> [303.764574] Node 0 active_anon:280kB inactive_anon:258296kB active_file:326028kB inactive_file:161848kB unevictable:12632kB isolated(anon):0kB isolated(file):0kB mapped:148536kB dirty:1540kB writeback:0kB shmem:15608kB shmem_thp:12288kB shmem_pmdmapped:0kB anon_thp:120832kB writeback_tmp:0kB kernel_stack:7152kB pagetables:5644kB sec_pagetables:0kB all_unreclaimable? no
<4> [303.764577] DMA free:15360kB boost:0kB min:28kB low:40kB high:52kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15360kB mlocked:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
<4> [303.764580] lowmem_reserve[]: 0 943 31850 31850
<4> [303.764585] DMA32 free:968520kB boost:0kB min:2000kB low:2964kB high:3928kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:1085696kB managed:969564kB mlocked:0kB bounce:0kB free_pcp:1040kB local_pcp:248kB free_cma:0kB
<4> [303.764588] lowmem_reserve[]: 0 0 30907 30907
<4> [303.764593] Normal free:30533500kB boost:0kB min:65548kB low:97196kB high:128844kB reserved_highatomic:0KB active_anon:280kB inactive_anon:258296kB active_file:326028kB inactive_file:161848kB unevictable:12632kB writepending:1540kB present:32239616kB managed:31648808kB mlocked:0kB bounce:0kB free_pcp:53312kB local_pcp:4856kB free_cma:0kB
<4> [303.764596] lowmem_reserve[]: 0 0 0 0
<4> [303.764600] DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15360kB
<4> [303.764623] DMA32: 10*4kB (UM) 8*8kB (M) 10*16kB (UM) 8*32kB (M) 9*64kB (M) 6*128kB (M) 6*256kB (UM) 5*512kB (M) 6*1024kB (UM) 5*2048kB (UM) 231*4096kB (M) = 968520kB
<4> [303.764643] Normal: 1335*4kB (UME) 1531*8kB (UME) 1117*16kB (UME) 576*32kB (UME) 544*64kB (UME) 384*128kB (UME) 220*256kB (UME) 132*512kB (UME) 46*1024kB (UME) 32*2048kB (UME) 7363*4096kB (UME) = 30533252kB
<4> [303.764662] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB
<4> [303.764663] 125887 total pagecache pages
<4> [303.764665] 0 pages in swap cache
<4> [303.764666] Free swap = 2097148kB
<4> [303.764667] Total swap = 2097148kB
<4> [303.764668] 8335326 pages RAM
<4> [303.764669] 0 pages HighMem/MovableOnly
<4> [303.764670] 176893 pages reserved
<3> [423.957291] i915/live_engine_pm_selftests: live_engine_busy_stats failed with error -16
<7> [423.957395] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [423.958792] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [423.960894] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_2
<7> [423.961707] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_3
<7> [423.962602] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_4
<7> [423.962879] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling PW_5
<7> [423.987864] intel_gt_set_wedged called from intel_gt_set_wedged_on_fini+0xd/0x30 [i915]
<7> [424.040087] i915 0000:00:02.0: [drm:drm_client_release] drm_fb_helper
<4> [424.086652] i915: probe of 0000:00:02.0 failed with error -16