igt@xe_exec_reset@long-spin-many-preempt-threads on shard-bmg@xe-pw-167227v2 Test details

Result: Fail

Detail	Value
Duration	12.06 seconds
Hostname	shard-bmg-9
Igt-Version	IGT-Version: 2.4-gd88ebc53b (x86_64) (Linux: 7.1.0-rc5-lgci-xe-xe-pw-167227v2-debug+ x86_64)
Out	Using IGT_SRANDOM=1779755512 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-many-preempt-threads [thread:19458] Stack trace: [thread:19458] #0 ../lib/igt_core.c:2106 __igt_fail_assert() [thread:19458] #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [thread:19458] #2 ../tests/intel/xe_exec_reset.c:793 thread() [thread:19458] #3 [pthread_condattr_setpshared+0x684] [thread:19458] #4 [__clone+0x24c] Subtest long-spin-many-preempt-threads: FAIL (12.057s)
Err	Starting subtest: long-spin-many-preempt-threads [530.221833] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [530.221934] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [530.221979] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [536.574073] (xe_exec_reset:19456) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-many-preempt-threads failed. ** DEBUG [530.221833] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [530.221934] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [530.221979] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [530.237046] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: Stack trace: [530.253882] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: #0 ../lib/igt_core.c:2106 __igt_fail_assert() [530.254403] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [530.255218] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: #2 ../tests/intel/xe_exec_reset.c:793 thread() [530.259725] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: #3 [pthread_condattr_setpshared+0x684] [530.260466] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: #4 [__clone+0x24c] [536.574073] (xe_exec_reset:19456) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-many-preempt-threads: FAIL (12.057s)
Dmesg	<6> [526.066876] Console: switching to colour dummy device 80x25 <6> [526.067220] [IGT] xe_exec_reset: executing <6> [526.093924] [IGT] xe_exec_reset: starting subtest long-spin-many-preempt-threads <7> [527.812180] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2 <7> [527.916050] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2 <7> [531.461828] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [531.463999] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=9, running_time_ms=234880, timeout_ms=5000, diff=0xffffffa9 <7> [531.465268] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [531.465522] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=7, running_time_ms=2795, timeout_ms=5000, diff=0x030c1518 <5> [531.466276] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=9, flags=0x0 in xe_exec_reset [19456] <7> [531.466224] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [531.466373] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=4, running_time_ms=2794, timeout_ms=5000, diff=0x030bcee6 <7> [531.466498] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=2, running_time_ms=2795, timeout_ms=5000, diff=0x030bf600 <7> [531.466633] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=0, running_time_ms=2797, timeout_ms=5000, diff=0x030c915f <7> [531.466765] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=6, running_time_ms=2795, timeout_ms=5000, diff=0x030be52e <7> [531.466927] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=5, running_time_ms=2796, timeout_ms=5000, diff=0x030c33d3 <7> [531.467052] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=3, running_time_ms=2798, timeout_ms=5000, diff=0x030cef62 <7> [531.467181] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=1, running_time_ms=2797, timeout_ms=5000, diff=0x030cbb2b <6> [531.644430] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [531.644453] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <7> [531.644804] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=11, running_time_ms=555, timeout_ms=5000, diff=0x009b2449 <7> [531.644954] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=12, running_time_ms=2990, timeout_ms=5000, diff=0x03429576 <7> [531.645061] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=8, running_time_ms=601, timeout_ms=5000, diff=0x00a829da <7> [531.645166] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=10, running_time_ms=2304, timeout_ms=5000, diff=0x028329c9 <7> [531.645259] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=13, running_time_ms=2326, timeout_ms=5000, diff=0x028946a5 <7> [531.947525] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x26262222 <7> [531.947682] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x26262626 <7> [537.092704] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=8, running_time_ms=2628, timeout_ms=5000, diff=0x02dd8525 <7> [537.093378] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=11, running_time_ms=2566, timeout_ms=5000, diff=0x02cc4eda <6> [538.153125] [IGT] xe_exec_reset: finished subtest long-spin-many-preempt-threads, FAIL <6> [538.155834] [IGT] xe_exec_reset: exiting, ret=98 <6> [538.158134] Console: switching to colour frame buffer device 240x67 <7> [538.179314] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

12.06 seconds

Hostname

shard-bmg-9

Igt-Version

IGT-Version: 2.4-gd88ebc53b (x86_64) (Linux: 7.1.0-rc5-lgci-xe-xe-pw-167227v2-debug+ x86_64)

Out

Using IGT_SRANDOM=1779755512 for randomisation
Opened device: /dev/dri/card0
Starting subtest: long-spin-many-preempt-threads
[thread:19458] Stack trace:
[thread:19458]   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[thread:19458]   #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode()
[thread:19458]   #2 ../tests/intel/xe_exec_reset.c:793 thread()
[thread:19458]   #3 [pthread_condattr_setpshared+0x684]
[thread:19458]   #4 [__clone+0x24c]
Subtest long-spin-many-preempt-threads: FAIL (12.057s)

Err

Starting subtest: long-spin-many-preempt-threads
[530.221833] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[530.221934] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[530.221979] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[536.574073] (xe_exec_reset:19456) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-many-preempt-threads failed.
**** DEBUG ****
[530.221833] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[530.221934] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[530.221979] (xe_exec_reset:19456) [thread:19458] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[530.237046] (xe_exec_reset:19456) [thread:19458] igt_core-INFO: Stack trace:
[530.253882] (xe_exec_reset:19456) [thread:19458] igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[530.254403] (xe_exec_reset:19456) [thread:19458] igt_core-INFO:   #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode()
[530.255218] (xe_exec_reset:19456) [thread:19458] igt_core-INFO:   #2 ../tests/intel/xe_exec_reset.c:793 thread()
[530.259725] (xe_exec_reset:19456) [thread:19458] igt_core-INFO:   #3 [pthread_condattr_setpshared+0x684]
[530.260466] (xe_exec_reset:19456) [thread:19458] igt_core-INFO:   #4 [__clone+0x24c]
[536.574073] (xe_exec_reset:19456) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-many-preempt-threads: FAIL (12.057s)

Dmesg

<6> [526.066876] Console: switching to colour dummy device 80x25

<6> [526.067220] [IGT] xe_exec_reset: executing

<6> [526.093924] [IGT] xe_exec_reset: starting subtest long-spin-many-preempt-threads

<7> [527.812180] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2

<7> [527.916050] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2

<7> [531.461828] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot

<7> [531.463999] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=9, running_time_ms=234880, timeout_ms=5000, diff=0xffffffa9

<7> [531.465268] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot

<7> [531.465522] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=7, running_time_ms=2795, timeout_ms=5000, diff=0x030c1518

<5> [531.466276] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=9, flags=0x0 in xe_exec_reset [19456]

<7> [531.466224] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot

<7> [531.466373] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=4, running_time_ms=2794, timeout_ms=5000, diff=0x030bcee6

<7> [531.466498] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=2, running_time_ms=2795, timeout_ms=5000, diff=0x030bf600

<7> [531.466633] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=0, running_time_ms=2797, timeout_ms=5000, diff=0x030c915f

<7> [531.466765] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=6, running_time_ms=2795, timeout_ms=5000, diff=0x030be52e

<7> [531.466927] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=5, running_time_ms=2796, timeout_ms=5000, diff=0x030c33d3

<7> [531.467052] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=3, running_time_ms=2798, timeout_ms=5000, diff=0x030cef62

<7> [531.467181] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT1: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=1, running_time_ms=2797, timeout_ms=5000, diff=0x030cbb2b

<6> [531.644430] xe 0000:03:00.0: [drm] Xe device coredump has been created

<6> [531.644453] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data

<7> [531.644804] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=11, running_time_ms=555, timeout_ms=5000, diff=0x009b2449

<7> [531.644954] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=12, running_time_ms=2990, timeout_ms=5000, diff=0x03429576

<7> [531.645061] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=8, running_time_ms=601, timeout_ms=5000, diff=0x00a829da

<7> [531.645166] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=10, running_time_ms=2304, timeout_ms=5000, diff=0x028329c9

<7> [531.645259] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=13, running_time_ms=2326, timeout_ms=5000, diff=0x028946a5

<7> [531.947525] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x26262222

<7> [531.947682] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x26262626

<7> [537.092704] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=8, running_time_ms=2628, timeout_ms=5000, diff=0x02dd8525

<7> [537.093378] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=4294967169, lrc_seqno=4294967169, guc_id=11, running_time_ms=2566, timeout_ms=5000, diff=0x02cc4eda

<6> [538.153125] [IGT] xe_exec_reset: finished subtest long-spin-many-preempt-threads, FAIL

<6> [538.155834] [IGT] xe_exec_reset: exiting, ret=98

<6> [538.158134] Console: switching to colour frame buffer device 240x67

<7> [538.179314] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Results for igt@xe_exec_reset@long-spin-many-preempt-threads