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

Result: Fail

Detail	Value
Duration	12.05 seconds
Hostname	shard-bmg-9
Igt-Version	IGT-Version: 2.4-g0e365bfe5 (x86_64) (Linux: 7.1.0-rc5-lgci-xe-xe-pw-167480v1-debug+ x86_64)
Out	Using IGT_SRANDOM=1780017965 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-comp-reuse-many-preempt-threads [thread:4463] Stack trace: [thread:4463] #0 ../lib/igt_core.c:2106 __igt_fail_assert() [thread:4463] #1 [xe_exec+0x48] [thread:4463] #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [thread:4463] #3 ../tests/intel/xe_exec_reset.c:793 thread() [thread:4463] #4 [pthread_condattr_setpshared+0x684] [thread:4463] #5 [__clone+0x24c] Subtest long-spin-comp-reuse-many-preempt-threads: FAIL (12.048s)
Err	Starting subtest: long-spin-comp-reuse-many-preempt-threads [311.715925] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [311.716061] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [311.716116] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: error: -125 != 0 [317.979923] (xe_exec_reset:4458) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-comp-reuse-many-preempt-threads failed. ** DEBUG [305.934409] (xe_exec_reset:4458) [thread:4462] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.934882] (xe_exec_reset:4458) [thread:4465] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.934906] (xe_exec_reset:4458) [thread:4459] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.934961] (xe_exec_reset:4458) [thread:4461] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.934981] (xe_exec_reset:4458) [thread:4464] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.935015] (xe_exec_reset:4458) [thread:4460] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [305.935156] (xe_exec_reset:4458) [thread:4463] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20 [311.715925] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [311.716061] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [311.716116] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: error: -125 != 0 [311.721460] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: Stack trace: [311.736133] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #0 ../lib/igt_core.c:2106 __igt_fail_assert() [311.738395] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #1 [xe_exec+0x48] [311.738619] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [311.739201] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #3 ../tests/intel/xe_exec_reset.c:793 thread() [311.742250] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #4 [pthread_condattr_setpshared+0x684] [311.743371] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: #5 [__clone+0x24c] [317.979923] (xe_exec_reset:4458) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-comp-reuse-many-preempt-threads: FAIL (12.048s)
Dmesg	<6> [307.485853] Console: switching to colour dummy device 80x25 <6> [307.486113] [IGT] xe_exec_reset: executing <6> [307.503936] [IGT] xe_exec_reset: starting subtest long-spin-comp-reuse-many-preempt-threads <7> [313.009690] 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=2873, timeout_ms=5000, diff=0x0321ef59 <7> [313.009771] 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=2879, timeout_ms=5000, diff=0x03236176 <7> [313.010548] 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=2870, timeout_ms=5000, diff=0x0320fe8f <7> [313.010904] 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=546, timeout_ms=5000, diff=0x00987410 <7> [313.011061] 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=2870, timeout_ms=5000, diff=0x032134e3 <7> [313.011463] 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=2322, timeout_ms=5000, diff=0x02883519 <7> [313.011507] 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=234880, timeout_ms=5000, diff=0xffffffaa <5> [313.012114] xe 0000:03:00.0: [drm] Tile0: GT1: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=3, flags=0x0 in xe_exec_reset [4458] <7> [313.011929] 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=2878, timeout_ms=5000, diff=0x03234be0 <7> [313.012131] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken <7> [313.012502] 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=593, timeout_ms=5000, diff=0x00a594dc <7> [313.012679] 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=2870, timeout_ms=5000, diff=0x032140f5 <7> [313.012918] 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=2292, timeout_ms=5000, diff=0x027fc01a <7> [313.013107] 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=2870, timeout_ms=5000, diff=0x0321228a <7> [313.013517] 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=2873, timeout_ms=5000, diff=0x0322194c <7> [313.013938] 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=2877, timeout_ms=5000, diff=0x0322c426 <7> [313.277662] xe 0000:03:00.0: [drm:xe_exec_ioctl [xe]] Ioctl argument check failed at drivers/gpu/drm/xe/xe_exec.c:153: q->ops->reset_status(q) <7> [316.063745] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x28282525 <7> [316.064033] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x28292929 <7> [318.128199] 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=2439, timeout_ms=5000, diff=0x02a8d019 <7> [318.128801] 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=2373, timeout_ms=5000, diff=0x0296434a <6> [319.553767] [IGT] xe_exec_reset: finished subtest long-spin-comp-reuse-many-preempt-threads, FAIL <6> [319.557400] [IGT] xe_exec_reset: exiting, ret=98 <6> [319.559754] Console: switching to colour frame buffer device 240x67 <7> [319.583759] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

12.05 seconds

Hostname

shard-bmg-9

Igt-Version

IGT-Version: 2.4-g0e365bfe5 (x86_64) (Linux: 7.1.0-rc5-lgci-xe-xe-pw-167480v1-debug+ x86_64)

Out

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

Err

Starting subtest: long-spin-comp-reuse-many-preempt-threads
[311.715925] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[311.716061] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[311.716116] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: error: -125 != 0
[317.979923] (xe_exec_reset:4458) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-comp-reuse-many-preempt-threads failed.
**** DEBUG ****
[305.934409] (xe_exec_reset:4458) [thread:4462] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.934882] (xe_exec_reset:4458) [thread:4465] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.934906] (xe_exec_reset:4458) [thread:4459] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.934961] (xe_exec_reset:4458) [thread:4461] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.934981] (xe_exec_reset:4458) [thread:4464] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.935015] (xe_exec_reset:4458) [thread:4460] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[305.935156] (xe_exec_reset:4458) [thread:4463] xe/xe_legacy-DEBUG: Test requirement passed: intel_gen(intel_get_drm_devid(fd)) >= 20
[311.715925] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[311.716061] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[311.716116] (xe_exec_reset:4458) [thread:4463] xe/xe_ioctl-CRITICAL: error: -125 != 0
[311.721460] (xe_exec_reset:4458) [thread:4463] igt_core-INFO: Stack trace:
[311.736133] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[311.738395] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #1 [xe_exec+0x48]
[311.738619] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode()
[311.739201] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #3 ../tests/intel/xe_exec_reset.c:793 thread()
[311.742250] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #4 [pthread_condattr_setpshared+0x684]
[311.743371] (xe_exec_reset:4458) [thread:4463] igt_core-INFO:   #5 [__clone+0x24c]
[317.979923] (xe_exec_reset:4458) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-comp-reuse-many-preempt-threads: FAIL (12.048s)

Dmesg

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

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

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

<7> [313.009690] 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=2873, timeout_ms=5000, diff=0x0321ef59

<7> [313.009771] 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=2879, timeout_ms=5000, diff=0x03236176

<7> [313.010548] 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=2870, timeout_ms=5000, diff=0x0320fe8f

<7> [313.010904] 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=546, timeout_ms=5000, diff=0x00987410

<7> [313.011061] 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=2870, timeout_ms=5000, diff=0x032134e3

<7> [313.011463] 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=2322, timeout_ms=5000, diff=0x02883519

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

<5> [313.012114] xe 0000:03:00.0: [drm] Tile0: GT1: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=3, flags=0x0 in xe_exec_reset [4458]

<7> [313.011929] 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=2878, timeout_ms=5000, diff=0x03234be0

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

<7> [313.012502] 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=593, timeout_ms=5000, diff=0x00a594dc

<7> [313.012679] 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=2870, timeout_ms=5000, diff=0x032140f5

<7> [313.012918] 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=2292, timeout_ms=5000, diff=0x027fc01a

<7> [313.013107] 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=2870, timeout_ms=5000, diff=0x0321228a

<7> [313.013517] 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=2873, timeout_ms=5000, diff=0x0322194c

<7> [313.013938] 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=2877, timeout_ms=5000, diff=0x0322c426

<7> [313.277662] xe 0000:03:00.0: [drm:xe_exec_ioctl [xe]] Ioctl argument check failed at drivers/gpu/drm/xe/xe_exec.c:153: q->ops->reset_status(q)

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

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

<7> [318.128199] 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=2439, timeout_ms=5000, diff=0x02a8d019

<7> [318.128801] 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=2373, timeout_ms=5000, diff=0x0296434a

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

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

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

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

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