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

Detail	Value
Duration	12.05 seconds
Hostname	shard-bmg-3
Igt-Version	IGT-Version: 2.4-g8b0b513dc (x86_64) (Linux: 7.1.0-rc5-lgci-xe-xe-pw-167456v1-debug+ x86_64)
Out	Using IGT_SRANDOM=1779987515 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-sys-reuse-many-preempt-threads [thread:11820] Stack trace: [thread:11820] #0 ../lib/igt_core.c:2106 __igt_fail_assert() [thread:11820] #1 [xe_exec+0x48] [thread:11820] #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [thread:11820] #3 ../tests/intel/xe_exec_reset.c:793 thread() [thread:11820] #4 [pthread_condattr_setpshared+0x684] [thread:11820] #5 [__clone+0x24c] Subtest long-spin-sys-reuse-many-preempt-threads: FAIL (12.049s)
Err	Starting subtest: long-spin-sys-reuse-many-preempt-threads [346.720783] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [346.720890] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [346.720935] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: error: -125 != 0 [353.157695] (xe_exec_reset:11813) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-sys-reuse-many-preempt-threads failed. ** DEBUG [346.720783] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [346.720890] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [346.720935] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: error: -125 != 0 [346.724515] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: Stack trace: [346.725853] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #0 ../lib/igt_core.c:2106 __igt_fail_assert() [346.735056] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #1 [xe_exec+0x48] [346.735523] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [346.736587] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #3 ../tests/intel/xe_exec_reset.c:793 thread() [346.739766] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #4 [pthread_condattr_setpshared+0x684] [346.741056] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: #5 [__clone+0x24c] [353.157695] (xe_exec_reset:11813) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-sys-reuse-many-preempt-threads: FAIL (12.049s)
Dmesg	<6> [342.638996] Console: switching to colour dummy device 80x25 <6> [342.639298] [IGT] xe_exec_reset: executing <6> [342.678981] [IGT] xe_exec_reset: starting subtest long-spin-sys-reuse-many-preempt-threads <7> [343.311489] xe 0000:03:00.0: [drm:intel_power_well_enable [xe]] enabling AUX_TC2 <7> [343.415451] xe 0000:03:00.0: [drm:intel_power_well_disable [xe]] disabling AUX_TC2 <7> [343.881363] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x2f2f2d2d <7> [343.881539] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x31303030 <7> [347.860694] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [347.860739] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [347.860811] 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=2707, timeout_ms=5000, diff=0x02f39d08 <7> [347.860868] 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=2701, timeout_ms=5000, diff=0x02f1e1f7 <7> [347.861621] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [347.861747] 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=2701, timeout_ms=5000, diff=0x02f20f92 <7> [347.861884] 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=234880, timeout_ms=5000, diff=0xffffffbc <7> [347.862115] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [347.862221] 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=513, timeout_ms=5000, diff=0x008f7046 <5> [347.862504] xe 0000:03:00.0: [drm] Tile0: GT1: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=7, flags=0x0 in xe_exec_reset [11813] <7> [347.862564] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [347.862653] 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=2709, timeout_ms=5000, diff=0x02f3e35d <7> [347.862735] 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=557, timeout_ms=5000, diff=0x009bdb22 <7> [347.862997] 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=2157, timeout_ms=5000, diff=0x025a3849 <7> [347.863079] 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=2184, timeout_ms=5000, diff=0x02618eef <6> [348.028542] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [348.028570] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <7> [348.028637] 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=2788, timeout_ms=5000, diff=0x030a511b <7> [348.028764] 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=2790, timeout_ms=5000, diff=0x030ae0b4 <7> [348.028873] 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=2790, timeout_ms=5000, diff=0x030ab77a <7> [348.028971] 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=2790, timeout_ms=5000, diff=0x030ae128 <7> [348.029068] 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=2791, timeout_ms=5000, diff=0x030b1283 <7> [348.289772] 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> [352.975464] 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=2268, timeout_ms=5000, diff=0x0278e465 <7> [352.975995] 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=2200, timeout_ms=5000, diff=0x02661789 <6> [354.729802] [IGT] xe_exec_reset: finished subtest long-spin-sys-reuse-many-preempt-threads, FAIL <6> [354.733432] [IGT] xe_exec_reset: exiting, ret=98 <6> [354.733901] Console: switching to colour frame buffer device 240x67 <7> [354.762132] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

12.05 seconds

Hostname

shard-bmg-3

Igt-Version

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

Out

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

Err

Starting subtest: long-spin-sys-reuse-many-preempt-threads
[346.720783] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[346.720890] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[346.720935] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: error: -125 != 0
[353.157695] (xe_exec_reset:11813) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-sys-reuse-many-preempt-threads failed.
**** DEBUG ****
[346.720783] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[346.720890] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[346.720935] (xe_exec_reset:11813) [thread:11820] xe/xe_ioctl-CRITICAL: error: -125 != 0
[346.724515] (xe_exec_reset:11813) [thread:11820] igt_core-INFO: Stack trace:
[346.725853] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #0 ../lib/igt_core.c:2106 __igt_fail_assert()
[346.735056] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #1 [xe_exec+0x48]
[346.735523] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode()
[346.736587] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #3 ../tests/intel/xe_exec_reset.c:793 thread()
[346.739766] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #4 [pthread_condattr_setpshared+0x684]
[346.741056] (xe_exec_reset:11813) [thread:11820] igt_core-INFO:   #5 [__clone+0x24c]
[353.157695] (xe_exec_reset:11813) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-sys-reuse-many-preempt-threads: FAIL (12.049s)

Dmesg

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

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

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

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

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

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

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

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

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

<7> [347.860811] 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=2707, timeout_ms=5000, diff=0x02f39d08

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

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

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

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

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

<7> [347.862221] 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=513, timeout_ms=5000, diff=0x008f7046

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

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

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

<7> [347.862735] 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=557, timeout_ms=5000, diff=0x009bdb22

<7> [347.862997] 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=2157, timeout_ms=5000, diff=0x025a3849

<7> [347.863079] 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=2184, timeout_ms=5000, diff=0x02618eef

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

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

<7> [348.028637] 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=2788, timeout_ms=5000, diff=0x030a511b

<7> [348.028764] 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=2790, timeout_ms=5000, diff=0x030ae0b4

<7> [348.028873] 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=2790, timeout_ms=5000, diff=0x030ab77a

<7> [348.028971] 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=2790, timeout_ms=5000, diff=0x030ae128

<7> [348.029068] 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=2791, timeout_ms=5000, diff=0x030b1283

<7> [348.289772] 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> [352.975464] 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=2268, timeout_ms=5000, diff=0x0278e465

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

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

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

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

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

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