igt@xe_exec_reset@long-spin-many-preempt-threads on shard-bmg@xe-5059-848634197d2738329d56c588df7cd8f21c0f7568 Test details

Detail	Value
Duration	11.22 seconds
Hostname	shard-bmg-10
Igt-Version	IGT-Version: 2.4-ge68d82b44 (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-5059-848634197d2738329-debug+ x86_64)
Out	Using IGT_SRANDOM=1778782740 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-many-preempt-threads [thread:5504] Stack trace: [thread:5504] #0 ../lib/igt_core.c:2074 __igt_fail_assert() [thread:5504] #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [thread:5504] #2 ../tests/intel/xe_exec_reset.c:793 thread() [thread:5504] #3 [pthread_condattr_setpshared+0x684] [thread:5504] #4 [__clone+0x24c] Subtest long-spin-many-preempt-threads: FAIL (11.221s)
Err	Starting subtest: long-spin-many-preempt-threads [223.667666] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [223.667752] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [223.667783] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [228.387363] (xe_exec_reset:5503) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-many-preempt-threads failed. ** DEBUG [223.667666] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291: [223.667752] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee [223.667783] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: error: 0 != 12648430 [223.684894] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: Stack trace: [223.701923] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: #0 ../lib/igt_core.c:2074 __igt_fail_assert() [223.702431] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode() [223.703112] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: #2 ../tests/intel/xe_exec_reset.c:793 thread() [223.707529] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: #3 [pthread_condattr_setpshared+0x684] [223.708388] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: #4 [__clone+0x24c] [228.387363] (xe_exec_reset:5503) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-many-preempt-threads: FAIL (11.221s)
Dmesg	<6> [218.750783] Console: switching to colour dummy device 80x25 <6> [218.751055] [IGT] xe_exec_reset: executing <6> [218.769270] [IGT] xe_exec_reset: starting subtest long-spin-many-preempt-threads <6> [222.534508] xe 0000:03:00.0: [drm] PL2 disabled for channel 0, val 0x00000000 <7> [222.537767] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x28262324 <7> [222.537916] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x26272726 <7> [224.186959] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [224.187644] 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=583, timeout_ms=5000, diff=0x00a2fa3d <7> [224.187735] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.188449] 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=538, timeout_ms=5000, diff=0x009668bb <7> [224.188467] 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=2823, timeout_ms=5000, diff=0x03140708 <7> [224.188979] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [224.189077] 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=2830, timeout_ms=5000, diff=0x03160069 <7> [224.189518] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.189682] 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=2827, timeout_ms=5000, diff=0x03153775 <7> [224.189952] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [224.189935] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.190039] 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=2254, timeout_ms=5000, diff=0x0275272d <7> [224.190085] 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=2827, timeout_ms=5000, diff=0x031520ae <7> [224.190140] 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=2832, timeout_ms=5000, diff=0x03169f45 <7> [224.190339] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.190481] 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=2826, timeout_ms=5000, diff=0x0314d6a7 <7> [224.190712] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.190850] 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=2825, timeout_ms=5000, diff=0x031484e6 <7> [224.190916] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [224.191012] 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=234880, timeout_ms=5000, diff=0xffffffa1 <7> [224.191064] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [224.191197] 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=2829, timeout_ms=5000, diff=0x0315ba5a <5> [224.191314] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=8, flags=0x0 in xe_exec_reset [5503] <7> [224.191354] 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=2827, timeout_ms=5000, diff=0x031531ab <7> [224.191571] 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=2828, timeout_ms=5000, diff=0x0315613f <6> [224.370772] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [224.370796] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <7> [229.302261] 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=2765, timeout_ms=5000, diff=0x0303d2ac <7> [229.302806] 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=2819, timeout_ms=5000, diff=0x0312c906 <6> [229.991993] [IGT] xe_exec_reset: finished subtest long-spin-many-preempt-threads, FAIL <6> [229.994408] [IGT] xe_exec_reset: exiting, ret=98 <6> [229.996758] Console: switching to colour frame buffer device 240x67 <7> [230.018315] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

11.22 seconds

Hostname

shard-bmg-10

Igt-Version

IGT-Version: 2.4-ge68d82b44 (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-5059-848634197d2738329-debug+ x86_64)

Out

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

Err

Starting subtest: long-spin-many-preempt-threads
[223.667666] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[223.667752] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[223.667783] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[228.387363] (xe_exec_reset:5503) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-many-preempt-threads failed.
**** DEBUG ****
[223.667666] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Test assertion failure function xe_legacy_test_mode, file ../lib/xe/xe_legacy.c:291:
[223.667752] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: Failed assertion: data[i].data == 0xc0ffee
[223.667783] (xe_exec_reset:5503) [thread:5504] xe/xe_legacy-CRITICAL: error: 0 != 12648430
[223.684894] (xe_exec_reset:5503) [thread:5504] igt_core-INFO: Stack trace:
[223.701923] (xe_exec_reset:5503) [thread:5504] igt_core-INFO:   #0 ../lib/igt_core.c:2074 __igt_fail_assert()
[223.702431] (xe_exec_reset:5503) [thread:5504] igt_core-INFO:   #1 ../lib/xe/xe_legacy.c:304 xe_legacy_test_mode()
[223.703112] (xe_exec_reset:5503) [thread:5504] igt_core-INFO:   #2 ../tests/intel/xe_exec_reset.c:793 thread()
[223.707529] (xe_exec_reset:5503) [thread:5504] igt_core-INFO:   #3 [pthread_condattr_setpshared+0x684]
[223.708388] (xe_exec_reset:5503) [thread:5504] igt_core-INFO:   #4 [__clone+0x24c]
[228.387363] (xe_exec_reset:5503) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-many-preempt-threads: FAIL (11.221s)

Dmesg

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

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

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

<6> [222.534508] xe 0000:03:00.0: [drm] PL2 disabled for channel 0, val 0x00000000

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

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

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

<7> [224.187644] 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=583, timeout_ms=5000, diff=0x00a2fa3d

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

<7> [224.188449] 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=538, timeout_ms=5000, diff=0x009668bb

<7> [224.188467] 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=2823, timeout_ms=5000, diff=0x03140708

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

<7> [224.189077] 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=2830, timeout_ms=5000, diff=0x03160069

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

<7> [224.189682] 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=2827, timeout_ms=5000, diff=0x03153775

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

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

<7> [224.190039] 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=2254, timeout_ms=5000, diff=0x0275272d

<7> [224.190085] 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=2827, timeout_ms=5000, diff=0x031520ae

<7> [224.190140] 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=2832, timeout_ms=5000, diff=0x03169f45

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

<7> [224.190481] 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=2826, timeout_ms=5000, diff=0x0314d6a7

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

<7> [224.190850] 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=2825, timeout_ms=5000, diff=0x031484e6

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

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

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

<7> [224.191197] 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=2829, timeout_ms=5000, diff=0x0315ba5a

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

<7> [224.191354] 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=2827, timeout_ms=5000, diff=0x031531ab

<7> [224.191571] 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=2828, timeout_ms=5000, diff=0x0315613f

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

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

<7> [229.302261] 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=2765, timeout_ms=5000, diff=0x0303d2ac

<7> [229.302806] 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=2819, timeout_ms=5000, diff=0x0312c906

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

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

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

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

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