Result:
git-log-oneline i915_display_info17 igt_runner17 runtimes17 results17.json results17-i915-load.json guc_logs17.tar i915_display_info_post_exec17 boot17 dmesg17
| Detail | Value |
|---|---|
| Duration | 7.23 seconds |
| Hostname |
shard-mtlp-1 |
| Igt-Version |
IGT-Version: 2.3-g125335b90 (x86_64) (Linux: 7.0.0-rc5-CI_DRM_18207-g41579e12882a+ x86_64) |
| Out |
Using IGT_SRANDOM=1774450978 for randomisation Opened device: /dev/dri/card0 Starting subtest: reset gt0 gt1 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/i915_pm_rps.c:225 do_writeval.isra.0() #2 ../tests/intel/i915_pm_rps.c:677 waitboost() #3 ../tests/intel/i915_pm_rps.c:1278 __igt_unique____real_main1204() #4 ../tests/intel/i915_pm_rps.c:1204 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Subtest reset: FAIL (7.230s) Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 [load_helper_stop.part.0+0x2c] #2 [pm_rps_exit_handler+0x105] #3 ../lib/igt_core.c:2961 fatal_sig_handler() #4 [__sigaction+0x50] #5 [pthread_kill+0x11c] #6 [gsignal+0x1e] #7 [abort+0xdf] #8 [<unknown>+0xc5a2881b] #9 [__assert_fail+0x47] #10 ../lib/igt_core.c:2386 igt_exit() #11 [main+0x32] #12 [__libc_init_first+0x8a] #13 [__libc_start_main+0x8b] #14 [_start+0x25] Stack trace: #0 ../lib/igt_core.c:460 internal_assert() #1 ../lib/igt_core.c:1943 igt_fail() #2 ../lib/igt_core.c:2285 __igt_fail_assert() #3 [load_helper_stop.part.0+0x2c] #4 [pm_rps_exit_handler+0x105] #5 ../lib/igt_core.c:2961 fatal_sig_handler() #6 [__sigaction+0x50] #7 [pthread_kill+0x11c] #8 [gsignal+0x1e] #9 [abort+0xdf] #10 [<unknown>+0xc5a2881b] #11 [__assert_fail+0x47] #12 ../lib/igt_core.c:2386 igt_exit() #13 [main+0x32] #14 [__libc_init_first+0x8a] #15 [__libc_start_main+0x8b] #16 [_start+0x25] |
| Err |
Starting subtest: reset (i915_pm_rps:2610) CRITICAL: Test assertion failure function do_writeval, file ../tests/intel/i915_pm_rps.c:225: (i915_pm_rps:2610) CRITICAL: Failed assertion: 0 < ret (i915_pm_rps:2610) CRITICAL: Last errno: 22, Invalid argument (i915_pm_rps:2610) CRITICAL: error: 0 >= -1 Subtest reset failed. **** DEBUG **** (i915_pm_rps:2610) i915/gem_context-DEBUG: Test requirement passed: has_ban_period || has_bannable (i915_pm_rps:2610) igt_gt-DEBUG: Test requirement passed: igt_params_set(fd, "reset", "%d", allow_reset) (i915_pm_rps:2610) igt_gt-DEBUG: Test requirement passed: has_gpu_reset(fd) (i915_pm_rps:2610) INFO: gt0 (i915_pm_rps:2610) DEBUG: Test requirement passed: origfreqs[gt_id][RP0] > origfreqs[gt_id][RPn] (i915_pm_rps:2610) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) (i915_pm_rps:2610) i915/gem-DEBUG: Test requirement passed: dir >= 0 (i915_pm_rps:2610) i915/gem-DEBUG: Test requirement passed: err == 0 (i915_pm_rps:2610) DEBUG: Apply low load... (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=800 cur=800 min=800 max=2250 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=800 cur=800 min=800 max=2250 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) igt_debugfs-DEBUG: i915_rps_boost_info: RPS enabled? no RPS active? no GPU busy? yes Boosts outstanding? 0 Interactive? 136 Frequency requested 0, actual 800 min hard:0, soft:0; max soft:0, hard:0 idle:0, efficient:0, boost:0 Wait boosts: 0 (i915_pm_rps:2610) DEBUG: Waited 0 msec to stabilize cur (i915_pm_rps:2610) DEBUG: Reset gpu... (i915_pm_rps:2610) igt_gt-DEBUG: Triggering GPU reset (i915_pm_rps:2610) intel_ctx-DEBUG: Test requirement passed: gem_has_contexts(fd) || !gt (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70) (i915_pm_rps:2610) intel_allocator_reloc-DEBUG: Using reloc allocator (i915_pm_rps:2610) igt_dummyload-DEBUG: Test requirement passed: nengine (i915_pm_rps:2610) igt_dummyload-DEBUG: Test requirement passed: nengine (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=1750 cur=2250 min=800 max=1525 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) DEBUG: Apply low load again... (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=800 cur=800 min=800 max=2250 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=800 cur=800 min=800 max=2250 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) igt_debugfs-DEBUG: i915_rps_boost_info: RPS enabled? no RPS active? no GPU busy? yes Boosts outstanding? 0 Interactive? 136 Frequency requested 0, actual 800 min hard:0, soft:0; max soft:0, hard:0 idle:0, efficient:0, boost:0 Wait boosts: 0 (i915_pm_rps:2610) DEBUG: Waited 0 msec to stabilize cur (i915_pm_rps:2610) DEBUG: Removing load... (i915_pm_rps:2610) DEBUG: gt0 freq (MHz): act=0 cur=800 min=800 max=2250 RP0=2250 RP1=800 RPn=800 boost=2250 (i915_pm_rps:2610) igt_debugfs-DEBUG: i915_rps_boost_info: RPS enabled? no RPS active? no GPU busy? no Boosts outstanding? 0 Interactive? 136 Frequency requested 0, actual 800 min hard:0, soft:0; max soft:0, hard:0 idle:0, efficient:0, boost:0 Wait boosts: 0 (i915_pm_rps:2610) DEBUG: Required 0 msec to reach cur=idle (i915_pm_rps:2610) INFO: gt1 (i915_pm_rps:2610) DEBUG: Test requirement passed: origfreqs[gt_id][RP0] > origfreqs[gt_id][RPn] (i915_pm_rps:2610) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) (i915_pm_rps:2610) i915/gem-DEBUG: Test requirement passed: dir >= 0 (i915_pm_rps:2610) i915/gem-DEBUG: Test requirement passed: err == 0 (i915_pm_rps:2610) DEBUG: Apply low load... (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=0 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=700 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=800 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=700 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=700 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) igt_debugfs-DEBUG: i915_rps_boost_info: RPS enabled? no RPS active? no GPU busy? yes Boosts outstanding? 0 Interactive? 136 Frequency requested 0, actual 350 min hard:0, soft:0; max soft:0, hard:0 idle:0, efficient:0, boost:0 Wait boosts: 0 (i915_pm_rps:2610) DEBUG: Waited 750 msec to stabilize cur (i915_pm_rps:2610) DEBUG: Reset gpu... (i915_pm_rps:2610) igt_gt-DEBUG: Triggering GPU reset (i915_pm_rps:2610) DEBUG: gt1 freq (MHz): act=800 cur=800 min=800 max=1300 RP0=1300 RP1=100 RPn=100 boost=1300 (i915_pm_rps:2610) CRITICAL: Test assertion failure function do_writeval, file ../tests/intel/i915_pm_rps.c:225: (i915_pm_rps:2610) CRITICAL: Failed assertion: 0 < ret (i915_pm_rps:2610) CRITICAL: Last errno: 22, Invalid argument (i915_pm_rps:2610) CRITICAL: error: 0 >= -1 (i915_pm_rps:2610) igt_core-INFO: Stack trace: (i915_pm_rps:2610) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (i915_pm_rps:2610) igt_core-INFO: #1 ../tests/intel/i915_pm_rps.c:225 do_writeval.isra.0() (i915_pm_rps:2610) igt_core-INFO: #2 ../tests/intel/i915_pm_rps.c:677 waitboost() (i915_pm_rps:2610) igt_core-INFO: #3 ../tests/intel/i915_pm_rps.c:1278 __igt_unique____real_main1204() (i915_pm_rps:2610) igt_core-INFO: #4 ../tests/intel/i915_pm_rps.c:1204 main() (i915_pm_rps:2610) igt_core-INFO: #5 [__libc_init_first+0x8a] (i915_pm_rps:2610) igt_core-INFO: #6 [__libc_start_main+0x8b] (i915_pm_rps:2610) igt_core-INFO: #7 [_start+0x25] **** END **** Subtest reset: FAIL (7.230s) Received signal SIGABRT. Stack trace: #0 [fatal_sig_handler+0x17b] #1 [__sigaction+0x50] #2 [pthread_kill+0x11c] #3 [gsignal+0x1e] #4 [abort+0xdf] #5 [<unknown>+0xdf] #6 [__assert_fail+0x47] #7 [igt_exit+0x159] #8 [main+0x32] #9 [__libc_init_first+0x8a] #10 [__libc_start_main+0x8b] #11 [_start+0x25] (i915_pm_rps:2610) CRITICAL: Test assertion failure function load_helper_stop, file ../tests/intel/i915_pm_rps.c:415: (i915_pm_rps:2610) CRITICAL: Failed assertion: igt_wait_helper(&lh.igt_proc) == 0 (i915_pm_rps:2610) CRITICAL: Last errno: 10, No child processes Test i915_pm_rps failed. **** DEBUG **** (i915_pm_rps:2610) igt_core-DEBUG: Exiting with status code 98 (i915_pm_rps:2610) igt_sysfs-DEBUG: Condition fstat(device, &st) occurred in function igt_sysfs_gt_path, file ../lib/igt_sysfs.c:371 (i915_pm_rps:2610) CRITICAL: Test assertion failure function load_helper_stop, file ../tests/intel/i915_pm_rps.c:415: (i915_pm_rps:2610) CRITICAL: Failed assertion: igt_wait_helper(&lh.igt_proc) == 0 (i915_pm_rps:2610) CRITICAL: Last errno: 10, No child processes (i915_pm_rps:2610) igt_core-INFO: Stack trace: (i915_pm_rps:2610) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (i915_pm_rps:2610) igt_core-INFO: #1 [load_helper_stop.part.0+0x2c] (i915_pm_rps:2610) igt_core-INFO: #2 [pm_rps_exit_handler+0x105] (i915_pm_rps:2610) igt_core-INFO: #3 ../lib/igt_core.c:2961 fatal_sig_handler() (i915_pm_rps:2610) igt_core-INFO: #4 [__sigaction+0x50] (i915_pm_rps:2610) igt_core-INFO: #5 [pthread_kill+0x11c] (i915_pm_rps:2610) igt_core-INFO: #6 [gsignal+0x1e] (i915_pm_rps:2610) igt_core-INFO: #7 [abort+0xdf] (i915_pm_rps:2610) igt_core-INFO: #8 [<unknown>+0xc5a2881b] (i915_pm_rps:2610) igt_core-INFO: #9 [__assert_fail+0x47] (i915_pm_rps:2610) igt_core-INFO: #10 ../lib/igt_core.c:2386 igt_exit() (i915_pm_rps:2610) igt_core-INFO: #11 [main+0x32] (i915_pm_rps:2610) igt_core-INFO: #12 [__libc_init_first+0x8a] (i915_pm_rps:2610) igt_core-INFO: #13 [__libc_start_main+0x8b] (i915_pm_rps:2610) igt_core-INFO: #14 [_start+0x25] **** END **** |
| Dmesg |
<6> [409.497525] Console: switching to colour dummy device 80x25
<6> [409.497852] [IGT] i915_pm_rps: executing
<7> [409.501247] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [409.502318] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [409.514240] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [409.514959] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [409.520963] [IGT] i915_pm_rps: starting subtest reset
<7> [410.526508] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [410.537814] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [411.674020] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 turning VDD off
<7> [411.674320] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [411.674473] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [411.674643] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [411.674779] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [411.884047] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:0:00000000
<6> [411.884052] i915 0000:00:02.0: [drm] GPU error state saved to /sys/class/drm/card0/error
<5> [411.885598] i915 0000:00:02.0: [drm] GT0: Resetting chip for Manually reset engine mask to ffffffffffffffff
<6> [411.886625] i915 0000:00:02.0: [drm] GT0: GuC firmware i915/mtl_guc_70.bin version 70.53.0
<7> [411.900628] i915 0000:00:02.0: [drm:intel_guc_fw_upload [i915]] GT0: GUC: init took 11ms, freq = 1650MHz -> 1850MHz vs 2250MHz, status = 0x8002F034, count = 0, ret = 0
<7> [411.902618] i915 0000:00:02.0: [drm:guc_enable_communication [i915]] GT0: GUC: communication enabled
<6> [411.906022] i915 0000:00:02.0: [drm] GT0: GUC: submission enabled
<6> [411.906025] i915 0000:00:02.0: [drm] GT0: GUC: SLPC enabled
<6> [411.981502] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:0:00000000
<5> [411.983096] i915 0000:00:02.0: [drm] GT1: Resetting chip for Manually reset engine mask to ffffffffffffffff
<6> [411.983934] i915 0000:00:02.0: [drm] GT1: GuC firmware i915/mtl_guc_70.bin version 70.53.0
<6> [411.983938] i915 0000:00:02.0: [drm] GT1: HuC firmware i915/mtl_huc_gsc.bin version 8.5.4
<7> [411.999995] i915 0000:00:02.0: [drm:intel_guc_fw_upload [i915]] GT1: GUC: init took 14ms, freq = 1300MHz -> 1300MHz vs 1300MHz, status = 0x8002F034, count = 0, ret = 0
<7> [412.000591] i915 0000:00:02.0: [drm:guc_enable_communication [i915]] GT1: GUC: communication enabled
<6> [412.002420] i915 0000:00:02.0: [drm] GT1: GUC: submission enabled
<6> [412.002423] i915 0000:00:02.0: [drm] GT1: GUC: SLPC enabled
<7> [413.005587] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [414.270549] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000004 [0x00000004]
<7> [414.277154] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [414.285593] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [415.611935] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:0:00000000
<5> [415.612350] i915 0000:00:02.0: [drm] GT0: Resetting chip for Manually reset engine mask to ffffffffffffffff
<6> [415.612808] i915 0000:00:02.0: [drm] GT0: GuC firmware i915/mtl_guc_70.bin version 70.53.0
<7> [415.627482] i915 0000:00:02.0: [drm:intel_guc_fw_upload [i915]] GT0: GUC: init took 12ms, freq = 1400MHz -> 1850MHz vs 2250MHz, status = 0x8002F034, count = 0, ret = 0
<7> [415.628508] i915 0000:00:02.0: [drm:guc_enable_communication [i915]] GT0: GUC: communication enabled
<6> [415.631012] i915 0000:00:02.0: [drm] GT0: GUC: submission enabled
<6> [415.631014] i915 0000:00:02.0: [drm] GT0: GUC: SLPC enabled
<6> [415.707699] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:0:00000000
<5> [415.709151] i915 0000:00:02.0: [drm] GT1: Resetting chip for Manually reset engine mask to ffffffffffffffff
<6> [415.710165] i915 0000:00:02.0: [drm] GT1: GuC firmware i915/mtl_guc_70.bin version 70.53.0
<6> [415.710167] i915 0000:00:02.0: [drm] GT1: HuC firmware i915/mtl_huc_gsc.bin version 8.5.4
<7> [415.724918] i915 0000:00:02.0: [drm:intel_guc_fw_upload [i915]] GT1: GUC: init took 14ms, freq = 950MHz -> 1300MHz vs 1300MHz, status = 0x8002F034, count = 0, ret = 0
<7> [415.725187] i915 0000:00:02.0: [drm:guc_enable_communication [i915]] GT1: GUC: communication enabled
<6> [415.726300] i915 0000:00:02.0: [drm] GT1: GUC: submission enabled
<6> [415.726309] i915 0000:00:02.0: [drm] GT1: GUC: SLPC enabled
<6> [416.751759] [IGT] i915_pm_rps: finished subtest reset, FAIL
<6> [416.752551] [IGT] i915_pm_rps: exiting, ret=98
<7> [417.208943] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x00000004 [0x00000004]
<7> [417.698115] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [417.698897] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [417.710515] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<7> [417.727860] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [417.728400] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [417.728922] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
|