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

Result: Fail

Detail	Value
Duration	12.05 seconds
Hostname	shard-bmg-10
Igt-Version	IGT-Version: 2.4-ge322bfd77 (x86_64) (Linux: 7.1.0-rc6-lgci-xe-xe-pw-167844v1-debug+ x86_64)
Out	Using IGT_SRANDOM=1780569568 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-many-preempt-threads [thread:5805] Stack trace: [thread:5805] #0 ../lib/igt_core.c:2106 __igt_fail_assert() [thread:5805] #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [thread:5805] #2 ../tests/intel/xe_exec_reset.c:793 thread() [thread:5805] #3 [pthread_condattr_setpshared+0x684] [thread:5805] #4 [__clone+0x24c] Subtest long-spin-many-preempt-threads: FAIL (12.054s)
Err	Starting subtest: long-spin-many-preempt-threads [244.694547] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [244.694649] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [244.694692] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [251.137044] (xe_exec_reset:5803) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-many-preempt-threads failed. ** DEBUG [244.694547] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [244.694649] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [244.694692] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [244.710246] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: Stack trace: [244.727341] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: #0 ../lib/igt_core.c:2106 __igt_fail_assert() [244.727807] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [244.728509] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: #2 ../tests/intel/xe_exec_reset.c:793 thread() [244.731733] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: #3 [pthread_condattr_setpshared+0x684] [244.732481] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: #4 [__clone+0x24c] [251.137044] (xe_exec_reset:5803) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-many-preempt-threads: FAIL (12.054s)
Dmesg	<6> [240.638042] Console: switching to colour dummy device 80x25 <6> [240.638334] [IGT] xe_exec_reset: executing <6> [240.663576] [IGT] xe_exec_reset: starting subtest long-spin-many-preempt-threads <7> [241.752761] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2 <7> [241.856678] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2 <7> [245.849998] 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=558, timeout_ms=5000, diff=0x009c0d8a <7> [245.850001] 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=2699, timeout_ms=5000, diff=0x02f170cc <7> [245.850862] 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=514, timeout_ms=5000, diff=0x008f945a <7> [245.851372] 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=2700, timeout_ms=5000, diff=0x02f1a5c6 <7> [245.851368] 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=2180, timeout_ms=5000, diff=0x0260c1a1 <7> [245.851991] 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=2701, timeout_ms=5000, diff=0x02f208e9 <7> [245.851989] 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=2156, timeout_ms=5000, diff=0x025a0612 <7> [245.852495] 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=2700, timeout_ms=5000, diff=0x02f1aa2d <7> [245.852550] 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=2709, timeout_ms=5000, diff=0x02f40097 <7> [245.853059] 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=2702, timeout_ms=5000, diff=0x02f23aeb <7> [245.853208] 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=234880, timeout_ms=5000, diff=0xffffffc5 <7> [245.853571] 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=2702, timeout_ms=5000, diff=0x02f2335e <5> [245.854054] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=10, flags=0x0 in xe_exec_reset [5803] <7> [245.854072] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken <7> [245.854088] 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=2704, timeout_ms=5000, diff=0x02f2f5ed <7> [245.856250] 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=2705, timeout_ms=5000, diff=0x02f34486 <7> [247.105341] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x27262323 <7> [247.105553] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x26262726 <7> [250.968839] 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=2200, timeout_ms=5000, diff=0x026641c5 <7> [250.969521] 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=2270, timeout_ms=5000, diff=0x02798da9 <6> [252.719517] [IGT] xe_exec_reset: finished subtest long-spin-many-preempt-threads, FAIL <6> [252.722034] [IGT] xe_exec_reset: exiting, ret=98 <6> [252.723170] Console: switching to colour frame buffer device 240x67 <7> [252.742960] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

12.05 seconds

Hostname

shard-bmg-10

Igt-Version

IGT-Version: 2.4-ge322bfd77 (x86_64) (Linux: 7.1.0-rc6-lgci-xe-xe-pw-167844v1-debug+ x86_64)

Out

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

Err

Starting subtest: long-spin-many-preempt-threads
[244.694547] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[244.694649] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[244.694692] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[251.137044] (xe_exec_reset:5803) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-many-preempt-threads failed.
**** DEBUG ****
[244.694547] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[244.694649] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[244.694692] (xe_exec_reset:5803) [thread:5805] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[244.710246] (xe_exec_reset:5803) [thread:5805] igt_core-INFO: Stack trace:
[244.727341] (xe_exec_reset:5803) [thread:5805] igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[244.727807] (xe_exec_reset:5803) [thread:5805] igt_core-INFO:   #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode()
[244.728509] (xe_exec_reset:5803) [thread:5805] igt_core-INFO:   #2 ../tests/intel/xe_exec_reset.c:793 thread()
[244.731733] (xe_exec_reset:5803) [thread:5805] igt_core-INFO:   #3 [pthread_condattr_setpshared+0x684]
[244.732481] (xe_exec_reset:5803) [thread:5805] igt_core-INFO:   #4 [__clone+0x24c]
[251.137044] (xe_exec_reset:5803) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-many-preempt-threads: FAIL (12.054s)

Dmesg

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

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

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

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

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

<7> [245.849998] 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=558, timeout_ms=5000, diff=0x009c0d8a

<7> [245.850001] 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=2699, timeout_ms=5000, diff=0x02f170cc

<7> [245.850862] 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=514, timeout_ms=5000, diff=0x008f945a

<7> [245.851372] 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=2700, timeout_ms=5000, diff=0x02f1a5c6

<7> [245.851368] 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=2180, timeout_ms=5000, diff=0x0260c1a1

<7> [245.851991] 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=2701, timeout_ms=5000, diff=0x02f208e9

<7> [245.851989] 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=2156, timeout_ms=5000, diff=0x025a0612

<7> [245.852495] 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=2700, timeout_ms=5000, diff=0x02f1aa2d

<7> [245.852550] 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=2709, timeout_ms=5000, diff=0x02f40097

<7> [245.853059] 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=2702, timeout_ms=5000, diff=0x02f23aeb

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

<7> [245.853571] 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=2702, timeout_ms=5000, diff=0x02f2335e

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

<7> [245.854072] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken

<7> [245.854088] 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=2704, timeout_ms=5000, diff=0x02f2f5ed

<7> [245.856250] 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=2705, timeout_ms=5000, diff=0x02f34486

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

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

<7> [250.968839] 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=2200, timeout_ms=5000, diff=0x026641c5

<7> [250.969521] 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=2270, timeout_ms=5000, diff=0x02798da9

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

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

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

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

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