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

Result: Fail

Detail	Value
Duration	9.62 seconds
Hostname	shard-bmg-9
Igt-Version	IGT-Version: 2.4-g07cadbb0b (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-pw-165914v3-debug+ x86_64)
Out	Using IGT_SRANDOM=1778628489 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-many-preempt-threads [thread:10241] Stack trace: [thread:10241] #0 ../lib/igt_core.c:2075 __igt_fail_assert() [thread:10241] #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [thread:10241] #2 ../tests/intel/xe_exec_reset.c:793 thread() [thread:10241] #3 [pthread_condattr_setpshared+0x684] [thread:10241] #4 [__clone+0x24c] Subtest long-spin-many-preempt-threads: FAIL (9.618s)
Err	Starting subtest: long-spin-many-preempt-threads (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: error: 0 != 12648430 (xe_exec_reset:10238) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-many-preempt-threads failed. ** DEBUG (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee (xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: error: 0 != 12648430 (xe_exec_reset:10238) [thread:10241] igt_core-INFO: Stack trace: (xe_exec_reset:10238) [thread:10241] igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_exec_reset:10238) [thread:10241] igt_core-INFO: #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() (xe_exec_reset:10238) [thread:10241] igt_core-INFO: #2 ../tests/intel/xe_exec_reset.c:793 thread() (xe_exec_reset:10238) [thread:10241] igt_core-INFO: #3 [pthread_condattr_setpshared+0x684] (xe_exec_reset:10238) [thread:10241] igt_core-INFO: #4 [__clone+0x24c] (xe_exec_reset:10238) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-many-preempt-threads: FAIL (9.618s)
Dmesg	<6> [437.391520] Console: switching to colour dummy device 80x25 <6> [437.391866] [IGT] xe_exec_reset: executing <6> [437.414267] [IGT] xe_exec_reset: starting subtest long-spin-many-preempt-threads <7> [438.969041] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2 <7> [439.081039] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2 <7> [441.803652] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x24242020 <7> [441.803801] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x23242424 <7> [442.621229] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [442.622086] 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=2710, timeout_ms=5000, diff=0x02f44ffe <7> [442.622065] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [442.622784] 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=517, timeout_ms=5000, diff=0x00907d8e <7> [442.622895] 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=2714, timeout_ms=5000, diff=0x02f56b67 <7> [442.623645] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [442.623665] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [442.623747] 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=2721, timeout_ms=5000, diff=0x02f78382 <7> [442.623764] 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=2712, timeout_ms=5000, diff=0x02f4d49d <7> [442.623852] 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=234880, timeout_ms=5000, diff=0xffffffeb <7> [442.623881] 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=2714, timeout_ms=5000, diff=0x02f56f9c <7> [442.624057] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [442.624149] 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=2713, timeout_ms=5000, diff=0x02f521f8 <5> [442.624254] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=11, flags=0x0 in xe_exec_reset [10238] <7> [442.624264] 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=2711, timeout_ms=5000, diff=0x02f48165 <7> [442.624344] 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=2715, timeout_ms=5000, diff=0x02f5e71a <7> [442.624430] 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=2714, timeout_ms=5000, diff=0x02f57868 <6> [442.804390] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [442.804412] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <7> [442.804486] 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=2815, timeout_ms=5000, diff=0x0311b881 <7> [442.804650] 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=2261, timeout_ms=5000, diff=0x02772870 <7> [442.804774] 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=2237, timeout_ms=5000, diff=0x027079e9 <6> [447.032932] [IGT] xe_exec_reset: finished subtest long-spin-many-preempt-threads, FAIL <6> [447.033569] [IGT] xe_exec_reset: exiting, ret=98 <6> [447.034191] Console: switching to colour frame buffer device 240x67 <7> [447.057827] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

9.62 seconds

Hostname

shard-bmg-9

Igt-Version

IGT-Version: 2.4-g07cadbb0b (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-pw-165914v3-debug+ x86_64)

Out

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

Err

Starting subtest: long-spin-many-preempt-threads
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: error: 0 != 12648430
(xe_exec_reset:10238) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-many-preempt-threads failed.
**** DEBUG ****
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
(xe_exec_reset:10238) [thread:10241] xe/xe_legacy-CRITICAL: error: 0 != 12648430
(xe_exec_reset:10238) [thread:10241] igt_core-INFO: Stack trace:
(xe_exec_reset:10238) [thread:10241] igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_exec_reset:10238) [thread:10241] igt_core-INFO:   #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode()
(xe_exec_reset:10238) [thread:10241] igt_core-INFO:   #2 ../tests/intel/xe_exec_reset.c:793 thread()
(xe_exec_reset:10238) [thread:10241] igt_core-INFO:   #3 [pthread_condattr_setpshared+0x684]
(xe_exec_reset:10238) [thread:10241] igt_core-INFO:   #4 [__clone+0x24c]
(xe_exec_reset:10238) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-many-preempt-threads: FAIL (9.618s)

Dmesg

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

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

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

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

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

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

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

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

<7> [442.622086] 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=2710, timeout_ms=5000, diff=0x02f44ffe

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

<7> [442.622784] 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=517, timeout_ms=5000, diff=0x00907d8e

<7> [442.622895] 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=2714, timeout_ms=5000, diff=0x02f56b67

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

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

<7> [442.623747] 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=2721, timeout_ms=5000, diff=0x02f78382

<7> [442.623764] 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=2712, timeout_ms=5000, diff=0x02f4d49d

<7> [442.623852] 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=234880, timeout_ms=5000, diff=0xffffffeb

<7> [442.623881] 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=2714, timeout_ms=5000, diff=0x02f56f9c

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

<7> [442.624149] 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=2713, timeout_ms=5000, diff=0x02f521f8

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

<7> [442.624264] 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=2711, timeout_ms=5000, diff=0x02f48165

<7> [442.624344] 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=2715, timeout_ms=5000, diff=0x02f5e71a

<7> [442.624430] 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=2714, timeout_ms=5000, diff=0x02f57868

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

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

<7> [442.804486] 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=2815, timeout_ms=5000, diff=0x0311b881

<7> [442.804650] 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=2261, timeout_ms=5000, diff=0x02772870

<7> [442.804774] 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=2237, timeout_ms=5000, diff=0x027079e9

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

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

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

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

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