igt@xe_exec_reset@long-spin-reuse-many-preempt-threads on shard-bmg@IGT

Detail	Value
Duration	12.05 seconds
Hostname	shard-bmg-8
Igt-Version	IGT-Version: 2.4-gf29c30f54 (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-5061-3d32fac0aa7111d9e-debug+ x86_64)
Out	Using IGT_SRANDOM=1778801969 for randomisation Opened device: /dev/dri/card0 Starting subtest: long-spin-reuse-many-preempt-threads [thread:22129] Stack trace: [thread:22129] #0 ../lib/igt_core.c:2074 __igt_fail_assert() [thread:22129] #1 [xe_exec+0x48] [thread:22129] #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [thread:22129] #3 ../tests/intel/xe_exec_reset.c:793 thread() [thread:22129] #4 [pthread_condattr_setpshared+0x684] [thread:22129] #5 [__clone+0x24c] Subtest long-spin-reuse-many-preempt-threads: FAIL (12.048s)
Err	Starting subtest: long-spin-reuse-many-preempt-threads [541.165626] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [541.165730] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [541.165819] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: error: -125 != 0 [547.518811] (xe_exec_reset:22124) igt_thread-CRITICAL: Failure in a thread! Subtest long-spin-reuse-many-preempt-threads failed. ** DEBUG [541.165626] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652: [541.165730] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0 [541.165819] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: error: -125 != 0 [541.173447] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: Stack trace: [541.189823] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #0 ../lib/igt_core.c:2074 __igt_fail_assert() [541.192186] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #1 [xe_exec+0x48] [541.192385] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode() [541.192938] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #3 ../tests/intel/xe_exec_reset.c:793 thread() [541.195987] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #4 [pthread_condattr_setpshared+0x684] [541.196710] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: #5 [__clone+0x24c] [547.518811] (xe_exec_reset:22124) igt_thread-CRITICAL: Failure in a thread! END ** Subtest long-spin-reuse-many-preempt-threads: FAIL (12.048s)
Dmesg	<6> [537.016290] Console: switching to colour dummy device 80x25 <6> [537.016636] [IGT] xe_exec_reset: executing <6> [537.050328] [IGT] xe_exec_reset: starting subtest long-spin-reuse-many-preempt-threads <7> [538.226910] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 0 val 0x27262425 <7> [538.227063] xe 0000:03:00.0: [drm:xe_hwmon_read [xe]] thermal data for group 1 val 0x28282827 <7> [542.395283] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [542.395995] 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=530, timeout_ms=5000, diff=0x0094232d <7> [542.396572] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [542.397150] 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=574, timeout_ms=5000, diff=0x00a088a5 <7> [542.397151] 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=2789, timeout_ms=5000, diff=0x030a8072 <7> [542.397549] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [542.397696] 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=2787, timeout_ms=5000, diff=0x0309ed6d <7> [542.397852] 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=2790, timeout_ms=5000, diff=0x030abc3d <7> [542.398154] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [542.398114] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [542.398644] 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=2254, timeout_ms=5000, diff=0x02751038 <7> [542.399122] 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=2228, timeout_ms=5000, diff=0x026def0a <7> [542.399292] 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=2793, timeout_ms=5000, diff=0x030b4ce9 <7> [542.399407] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <7> [542.399497] 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=2795, timeout_ms=5000, diff=0x030c19e7 <7> [542.399795] 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=2797, timeout_ms=5000, diff=0x030c9dfe <7> [542.400025] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [542.400130] 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=2790, timeout_ms=5000, diff=0x030aba2b <7> [542.400256] 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=2789, timeout_ms=5000, diff=0x030ab0c4 <7> [542.400459] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT1: Proceeding with manual engine snapshot <7> [542.401044] 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=2791, timeout_ms=5000, diff=0x030b2d18 <7> [542.401546] 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=0xffffffbb <5> [542.403413] xe 0000:03:00.0: [drm] Tile0: GT1: Timedout job: seqno=4294967169, lrc_seqno=4294967169, guc_id=3, flags=0x0 in xe_exec_reset [22124] <6> [542.585370] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [542.585395] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <7> [542.743403] 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> [547.511171] 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=2354, timeout_ms=5000, diff=0x0290d85b <7> [547.511902] 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=2289, timeout_ms=5000, diff=0x027ec0c7 <6> [549.099756] [IGT] xe_exec_reset: finished subtest long-spin-reuse-many-preempt-threads, FAIL <6> [549.102313] [IGT] xe_exec_reset: exiting, ret=98 <6> [549.103403] Console: switching to colour frame buffer device 240x67 <7> [549.126519] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

12.05 seconds

Hostname

shard-bmg-8

Igt-Version

IGT-Version: 2.4-gf29c30f54 (x86_64) (Linux: 7.1.0-rc3-lgci-xe-xe-5061-3d32fac0aa7111d9e-debug+ x86_64)

Out

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

Err

Starting subtest: long-spin-reuse-many-preempt-threads
[541.165626] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[541.165730] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[541.165819] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: error: -125 != 0
[547.518811] (xe_exec_reset:22124) igt_thread-CRITICAL: Failure in a thread!
Subtest long-spin-reuse-many-preempt-threads failed.
**** DEBUG ****
[541.165626] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Test assertion failure function xe_exec, file ../lib/xe/xe_ioctl.c:652:
[541.165730] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: Failed assertion: __xe_exec(fd, exec) == 0
[541.165819] (xe_exec_reset:22124) [thread:22129] xe/xe_ioctl-CRITICAL: error: -125 != 0
[541.173447] (xe_exec_reset:22124) [thread:22129] igt_core-INFO: Stack trace:
[541.189823] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #0 ../lib/igt_core.c:2074 __igt_fail_assert()
[541.192186] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #1 [xe_exec+0x48]
[541.192385] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #2 ../lib/xe/xe_legacy.c:241 xe_legacy_test_mode()
[541.192938] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #3 ../tests/intel/xe_exec_reset.c:793 thread()
[541.195987] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #4 [pthread_condattr_setpshared+0x684]
[541.196710] (xe_exec_reset:22124) [thread:22129] igt_core-INFO:   #5 [__clone+0x24c]
[547.518811] (xe_exec_reset:22124) igt_thread-CRITICAL: Failure in a thread!
****  END  ****
Subtest long-spin-reuse-many-preempt-threads: FAIL (12.048s)

Dmesg

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

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

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

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

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

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

<7> [542.395995] 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=530, timeout_ms=5000, diff=0x0094232d

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

<7> [542.397150] 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=574, timeout_ms=5000, diff=0x00a088a5

<7> [542.397151] 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=2789, timeout_ms=5000, diff=0x030a8072

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

<7> [542.397696] 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=2787, timeout_ms=5000, diff=0x0309ed6d

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

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

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

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

<7> [542.399122] 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=2228, timeout_ms=5000, diff=0x026def0a

<7> [542.399292] 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=2793, timeout_ms=5000, diff=0x030b4ce9

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

<7> [542.399497] 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=2795, timeout_ms=5000, diff=0x030c19e7

<7> [542.399795] 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=2797, timeout_ms=5000, diff=0x030c9dfe

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

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

<7> [542.400256] 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=2789, timeout_ms=5000, diff=0x030ab0c4

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

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

<7> [542.401546] 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=0xffffffbb

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

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

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

<7> [542.743403] 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> [547.511171] 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=2354, timeout_ms=5000, diff=0x0290d85b

<7> [547.511902] 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=2289, timeout_ms=5000, diff=0x027ec0c7

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

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

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

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

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