igt@xe_eudebug_online@interrupt-all on bat-lnl-2@xkb-pr-main-261-467-c6fbff4eb06bc4f75f9e7a9720093e24a758a231 Test details

Detail	Value
Duration	0.14 seconds
Igt-Version	IGT-Version: 2.3-g105262d67 (x86_64) (Linux: 6.17.13-lgci-xe-xkb-pr-main-261-467-c6fbf+ x86_64)
Out	Using IGT_SRANDOM=1770125833 for randomisation Opened device: /dev/dri/card0 Using IGT_SRANDOM=1770125833 for randomisation Starting subtest: interrupt-all Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 client running with pid 27434 [thread:27435] Stack trace: [thread:27435] #0 ../lib/igt_core.c:2075 __igt_fail_assert() [thread:27435] #1 ../tests/intel/xe_eudebug_online.c:728 eu_attention_resume_trigger() [thread:27435] #2 ../lib/xe/xe_eudebug.c:1131 debugger_worker_loop() [thread:27435] #3 [pthread_condattr_setpshared+0x684] [thread:27435] #4 [__clone+0x24c] Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../lib/xe/xe_eudebug.c:835 compare_client() #2 ../lib/xe/xe_eudebug.c:1074 xe_eudebug_event_log_compare() #3 ../lib/xe/xe_eudebug.c:1781 xe_eudebug_session_check() #4 ../tests/intel/xe_eudebug_online.c:1352 online_session_check() #5 ../tests/intel/xe_eudebug_online.c:1958 test_interrupt_all() #6 ../tests/intel/xe_eudebug_online.c:2715 __igt_unique____real_main2671() #7 ../tests/intel/xe_eudebug_online.c:2671 main() #8 [__libc_init_first+0x8a] #9 [__libc_start_main+0x8b] #10 [_start+0x25] Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.141s) Subtest interrupt-all: FAIL (0.145s)
Err	Starting subtest: interrupt-all Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 (xe_eudebug_online:27432) [thread:27435] CRITICAL: Test assertion failure function eu_ctl, file ../tests/intel/xe_eudebug_online.c:395: (xe_eudebug_online:27432) [thread:27435] CRITICAL: Failed assertion: __eu_ctl(debugfd, client, exec_queue, lrc, bitmask, bitmask_size, cmd, &seqno) == 0 (xe_eudebug_online:27432) [thread:27435] CRITICAL: Last errno: 22, Invalid argument (xe_eudebug_online:27432) [thread:27435] CRITICAL: error: -22 != 0 (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Test assertion failure function compare_client, file ../lib/xe/xe_eudebug.c:835: (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Failed assertion: evptr2 (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: client (7): no matching event type 4 found for client 7 Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed. ** DEBUG (xe_eudebug_online:27432) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) \|\| !xe_supports_faults(fd) (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger: 27432 waiting for token 'client pid' (xe_eudebug_online:27432) xe/xe_eudebug-INFO: client running with pid 27434 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c680 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c6b0 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c6e0 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c710 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c740 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c770 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c7a0 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger connected to 27434 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: 27432 signalling token 'client run' with value '27434' (xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: Using simple allocator (xe_eudebug_online:27432) [thread:27435] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27432) DEBUG: EU CONTROL[11]: interrupt all (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger: 27432 waiting for token 'client fini' (xe_eudebug_online:27432) [thread:27435] DEBUG: EVENT[12] eu-attenttion; threads=448 client[1], exec_queue[1], lrc[1], bitmask_size[56] (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[0] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[1] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[2] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[3] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[4] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[5] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[6] = 0xffffffffffffffff (xe_eudebug_online:27432) [thread:27435] DEBUG: EU CONTROL[13]: stopped (xe_eudebug_online:27432) [thread:27435] DEBUG: EU CONTROL[14]: resume (xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: <ial: 0x75b3b0000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: <ial: 0x75b3b0000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27432) [thread:27435] DEBUG: EVENT[15] eu-attenttion; threads=0 client[1], exec_queue[1], lrc[1], bitmask_size[56] (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[0] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[1] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[2] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[3] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[4] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[5] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[6] = 0x0000000000000000 (xe_eudebug_online:27432) [thread:27435] CRITICAL: Test assertion failure function eu_ctl, file ../tests/intel/xe_eudebug_online.c:395: (xe_eudebug_online:27432) [thread:27435] CRITICAL: Failed assertion: __eu_ctl(debugfd, client, exec_queue, lrc, bitmask, bitmask_size, cmd, &seqno) == 0 (xe_eudebug_online:27432) [thread:27435] CRITICAL: Last errno: 22, Invalid argument (xe_eudebug_online:27432) [thread:27435] CRITICAL: error: -22 != 0 (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: Stack trace: (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: #1 ../tests/intel/xe_eudebug_online.c:728 eu_attention_resume_trigger() (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: #2 ../lib/xe/xe_eudebug.c:1131 debugger_worker_loop() (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: #3 [pthread_condattr_setpshared+0x684] (xe_eudebug_online:27432) [thread:27435] igt_core-INFO: #4 [__clone+0x24c] (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: event log 'debugger' (736 bytes): (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=1, handle=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (5) exec_queue(4):create: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (6) exec_queue_placements(13):create: client_handle=1, vm_handle=1, exec_queue_handle=1, lrc_handle=1, num_placements=1, gt_id=0, mask=[ccs0 pad0] (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (7) vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (8) vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001b000000, range=12288 num_extensions=0 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (9) vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001a000000, range=12288 num_extensions=0 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (12) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (15) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes): (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=7 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=7, handle=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (5) exec_queue(4):create: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (6) exec_queue_placements(13):create: client_handle=7, vm_handle=1, exec_queue_handle=1, lrc_handle=0, num_placements=1, gt_id=0, mask=[ccs0 pad0] (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (7) exec_queue(4):destroy: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (8) vm(3):destroy: client_handle=7, handle=1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (9) metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (10) metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (11) client(2):destroy: handle=7 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: client: 7 -> 1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5 (xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6 (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Test assertion failure function compare_client, file ../lib/xe/xe_eudebug.c:835: (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Failed assertion: evptr2 (xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: client (7): no matching event type 4 found for client 7 (xe_eudebug_online:27432) igt_core-INFO: Stack trace: (xe_eudebug_online:27432) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:27432) igt_core-INFO: #1 ../lib/xe/xe_eudebug.c:835 compare_client() (xe_eudebug_online:27432) igt_core-INFO: #2 ../lib/xe/xe_eudebug.c:1074 xe_eudebug_event_log_compare() (xe_eudebug_online:27432) igt_core-INFO: #3 ../lib/xe/xe_eudebug.c:1781 xe_eudebug_session_check() (xe_eudebug_online:27432) igt_core-INFO: #4 ../tests/intel/xe_eudebug_online.c:1352 online_session_check() (xe_eudebug_online:27432) igt_core-INFO: #5 ../tests/intel/xe_eudebug_online.c:1958 test_interrupt_all() (xe_eudebug_online:27432) igt_core-INFO: #6 ../tests/intel/xe_eudebug_online.c:2715 __igt_unique____real_main2671() (xe_eudebug_online:27432) igt_core-INFO: #7 ../tests/intel/xe_eudebug_online.c:2671 main() (xe_eudebug_online:27432) igt_core-INFO: #8 [__libc_init_first+0x8a] (xe_eudebug_online:27432) igt_core-INFO: #9 [__libc_start_main+0x8b] (xe_eudebug_online:27432) igt_core-INFO: #10 [_start+0x25] END ** Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.141s) (xe_eudebug_online:27432) igt_thread-CRITICAL: Failure in a thread! Subtest interrupt-all: FAIL (0.145s)
Dmesg	<6> [221.601107] [IGT] xe_eudebug_online: executing <6> [221.604726] [IGT] xe_eudebug_online: starting subtest interrupt-all <6> [221.604879] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 <7> [221.608389] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3270:0: (27432/27432) -> (27434/27434): "connected session 3270" <7> [221.608534] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3270:0: (7957/7957) -> (27434/27434): "Discovery start for 3270\n" <7> [221.608639] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3270:0: (7957/7957) -> (27434/27434): "Discovery end for 3270\n" <7> [221.609257] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:1: (27435/27432) -> (27434/27434): "event read=0: type=2, flags=0x1, seqno=1" <7> [221.609840] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:2: (27435/27432) -> (27434/27434): "event read=0: type=9, flags=0x1, seqno=2" <7> [221.610017] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "read metadata: client_handle=1, metadata_handle=1, flags=0x0" <7> [221.610110] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "ioctl cmd=READ_METADATA ret=0\n" <7> [221.610187] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "event read=0: type=9, flags=0x1, seqno=3" <7> [221.610268] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "read metadata: client_handle=1, metadata_handle=2, flags=0x0" <7> [221.610345] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "ioctl cmd=READ_METADATA ret=0\n" <7> [221.611127] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "event read=0: type=3, flags=0x1, seqno=4" <7> [221.611261] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10" <7> [221.611348] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "ioctl cmd=VM_OPEN ret=10\n" <7> [221.612160] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [221.612262] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [221.612428] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:6: (27435/27432) -> (27434/27434): "event read=0: type=4, flags=0x1, seqno=5" <7> [221.612505] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:6: (27435/27432) -> (27434/27434): "event read=0: type=13, flags=0x1, seqno=6" <7> [221.613786] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:9: (27435/27432) -> (27434/27434): "event read=0: type=6, flags=0x4, seqno=7" <7> [221.613866] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=7, flags=0x1, seqno=8" <7> [221.613867] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3270:10: (7957/7957) -> (27434/27434): "ACK: seqno=10: tracking started" <7> [221.613941] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=7, flags=0x1, seqno=9" <7> [221.614012] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=8, flags=0x9, seqno=10" <7> [221.614095] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "ACK: seqno=10: signalled by 10 (debugger) (held 228us)" <7> [221.614166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "ioctl cmd=EVENT_ACK ret=0\n" <7> [221.614589] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27432/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=0, flags=0x0, exec_queue_handle=1, bitmask_size=0\n" <7> [221.614717] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.614839] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.614930] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.615017] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.615880] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:11: (27432/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=0, flags=0x0, exec_queue_handle=1, bitmask_size=0 ret=0\n" <7> [221.615983] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:11: (27432/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n" <7> [221.712863] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.713404] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.713927] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.714379] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.715116] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:12: (27435/27432) -> (27434/27434): "event read=0: type=5, flags=0x4, seqno=12" <7> [221.715089] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.715516] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:12: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [221.715522] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.715881] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.715916] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.716116] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.716341] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.716284] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.716557] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.716699] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.716944] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [221.717088] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.717166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n" <7> [221.717453] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.717517] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n" <7> [221.717831] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.717929] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [221.718184] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [221.718411] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [221.718650] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [221.718938] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [221.719214] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [221.719526] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [221.719809] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n" <7> [221.720072] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n" <7> [221.720332] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n" <7> [221.720570] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n" <7> [221.720827] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n" <7> [221.721067] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n" <7> [221.721321] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n" <7> [221.721579] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n" <7> [221.721886] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n" <7> [221.722163] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n" <7> [221.722439] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n" <7> [221.722764] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n" <7> [221.723086] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [221.723352] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n" <7> [221.723630] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "event read=0: type=5, flags=0x4, seqno=15" <7> [221.723960] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:16: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [221.724241] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] Ioctl argument check failed at drivers/gpu/drm/xe/prelim/xe_eudebug.c:1118: !q <7> [221.724497] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:17: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=-22\n" <7> [221.724736] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:17: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=-22\n" <6> [221.745975] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_COMPUTE0, FAIL <6> [221.750426] [IGT] xe_eudebug_online: finished subtest interrupt-all, FAIL <7> [221.752572] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [221.752658] [IGT] xe_eudebug_online: exiting, ret=98 <7> [221.758847] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3270:20: (27432/27432) -> (27434/27434): "vm_release: client_handle=1, vm_handle=1, flags=0x0" <7> [221.759081] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3270:20:disconnected (27432/27432) -> (27434/27434): "session 3270 detached with 0" <7> [221.759180] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3270:20:disconnected (27432/27432) -> (27434/27434): "Session closed (0)"

Detail

Value

Duration

0.14 seconds

Igt-Version

IGT-Version: 2.3-g105262d67 (x86_64) (Linux: 6.17.13-lgci-xe-xkb-pr-main-261-467-c6fbf+ x86_64)

Out

Using IGT_SRANDOM=1770125833 for randomisation
Opened device: /dev/dri/card0
Using IGT_SRANDOM=1770125833 for randomisation
Starting subtest: interrupt-all
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
client running with pid 27434
[thread:27435] Stack trace:
[thread:27435]   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
[thread:27435]   #1 ../tests/intel/xe_eudebug_online.c:728 eu_attention_resume_trigger()
[thread:27435]   #2 ../lib/xe/xe_eudebug.c:1131 debugger_worker_loop()
[thread:27435]   #3 [pthread_condattr_setpshared+0x684]
[thread:27435]   #4 [__clone+0x24c]
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../lib/xe/xe_eudebug.c:835 compare_client()
  #2 ../lib/xe/xe_eudebug.c:1074 xe_eudebug_event_log_compare()
  #3 ../lib/xe/xe_eudebug.c:1781 xe_eudebug_session_check()
  #4 ../tests/intel/xe_eudebug_online.c:1352 online_session_check()
  #5 ../tests/intel/xe_eudebug_online.c:1958 test_interrupt_all()
  #6 ../tests/intel/xe_eudebug_online.c:2715 __igt_unique____real_main2671()
  #7 ../tests/intel/xe_eudebug_online.c:2671 main()
  #8 [__libc_init_first+0x8a]
  #9 [__libc_start_main+0x8b]
  #10 [_start+0x25]
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.141s)
Subtest interrupt-all: FAIL (0.145s)

Err

Starting subtest: interrupt-all
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Test assertion failure function eu_ctl, file ../tests/intel/xe_eudebug_online.c:395:
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Failed assertion: __eu_ctl(debugfd, client, exec_queue, lrc, bitmask, bitmask_size, cmd, &seqno) == 0
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Last errno: 22, Invalid argument
(xe_eudebug_online:27432) [thread:27435] CRITICAL: error: -22 != 0
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Test assertion failure function compare_client, file ../lib/xe/xe_eudebug.c:835:
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Failed assertion: evptr2
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: client (7): no matching event type 4 found for client 7
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed.
**** DEBUG ****
(xe_eudebug_online:27432) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) || !xe_supports_faults(fd)
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger: 27432 waiting for token 'client pid'
(xe_eudebug_online:27432) xe/xe_eudebug-INFO: client running with pid 27434
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c680
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c6b0
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c6e0
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c710
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c740
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c770
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: added trigger 0x57856806c7a0
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger connected to 27434
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: 27432 signalling token 'client run' with value '27434'
(xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: Using simple allocator
(xe_eudebug_online:27432) [thread:27435] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27432) DEBUG: EU CONTROL[11]: interrupt all
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: debugger: 27432 waiting for token 'client fini'
(xe_eudebug_online:27432) [thread:27435] DEBUG: EVENT[12] eu-attenttion; threads=448 client[1], exec_queue[1], lrc[1], bitmask_size[56]
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[0] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[1] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[2] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[3] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[4] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[5] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[6] = 0xffffffffffffffff
(xe_eudebug_online:27432) [thread:27435] DEBUG: EU CONTROL[13]: stopped
(xe_eudebug_online:27432) [thread:27435] DEBUG: EU CONTROL[14]: resume
(xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: <ial: 0x75b3b0000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27432) [thread:27433] intel_allocator_simple-DEBUG: <ial: 0x75b3b0000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27432) [thread:27435] DEBUG: EVENT[15] eu-attenttion; threads=0 client[1], exec_queue[1], lrc[1], bitmask_size[56]
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[0] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[1] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[2] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[3] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[4] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[5] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] DEBUG: bitmask[6] = 0x0000000000000000
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Test assertion failure function eu_ctl, file ../tests/intel/xe_eudebug_online.c:395:
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Failed assertion: __eu_ctl(debugfd, client, exec_queue, lrc, bitmask, bitmask_size, cmd, &seqno) == 0
(xe_eudebug_online:27432) [thread:27435] CRITICAL: Last errno: 22, Invalid argument
(xe_eudebug_online:27432) [thread:27435] CRITICAL: error: -22 != 0
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO: Stack trace:
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO:   #1 ../tests/intel/xe_eudebug_online.c:728 eu_attention_resume_trigger()
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO:   #2 ../lib/xe/xe_eudebug.c:1131 debugger_worker_loop()
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO:   #3 [pthread_condattr_setpshared+0x684]
(xe_eudebug_online:27432) [thread:27435] igt_core-INFO:   #4 [__clone+0x24c]
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: event log 'debugger' (736 bytes):
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=1, handle=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (5)   exec_queue(4):create: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (6) exec_queue_placements(13):create: client_handle=1, vm_handle=1, exec_queue_handle=1, lrc_handle=1, num_placements=1, gt_id=0, mask=[ccs0 pad0] 
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (7)      vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (8)   vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001b000000, range=12288 num_extensions=0
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (9)   vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001a000000, range=12288 num_extensions=0
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (12)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (15)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes):
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=7
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=7, handle=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (5)   exec_queue(4):create: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (6) exec_queue_placements(13):create: client_handle=7, vm_handle=1, exec_queue_handle=1, lrc_handle=0, num_placements=1, gt_id=0, mask=[ccs0 pad0] 
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (7)   exec_queue(4):destroy: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (8)           vm(3):destroy: client_handle=7, handle=1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (9)     metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (10)     metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: (11)       client(2):destroy: handle=7
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: client: 7 -> 1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5
(xe_eudebug_online:27432) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Test assertion failure function compare_client, file ../lib/xe/xe_eudebug.c:835:
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: Failed assertion: evptr2
(xe_eudebug_online:27432) xe/xe_eudebug-CRITICAL: client (7): no matching event type 4 found for client 7
(xe_eudebug_online:27432) igt_core-INFO: Stack trace:
(xe_eudebug_online:27432) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:27432) igt_core-INFO:   #1 ../lib/xe/xe_eudebug.c:835 compare_client()
(xe_eudebug_online:27432) igt_core-INFO:   #2 ../lib/xe/xe_eudebug.c:1074 xe_eudebug_event_log_compare()
(xe_eudebug_online:27432) igt_core-INFO:   #3 ../lib/xe/xe_eudebug.c:1781 xe_eudebug_session_check()
(xe_eudebug_online:27432) igt_core-INFO:   #4 ../tests/intel/xe_eudebug_online.c:1352 online_session_check()
(xe_eudebug_online:27432) igt_core-INFO:   #5 ../tests/intel/xe_eudebug_online.c:1958 test_interrupt_all()
(xe_eudebug_online:27432) igt_core-INFO:   #6 ../tests/intel/xe_eudebug_online.c:2715 __igt_unique____real_main2671()
(xe_eudebug_online:27432) igt_core-INFO:   #7 ../tests/intel/xe_eudebug_online.c:2671 main()
(xe_eudebug_online:27432) igt_core-INFO:   #8 [__libc_init_first+0x8a]
(xe_eudebug_online:27432) igt_core-INFO:   #9 [__libc_start_main+0x8b]
(xe_eudebug_online:27432) igt_core-INFO:   #10 [_start+0x25]
****  END  ****
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.141s)
(xe_eudebug_online:27432) igt_thread-CRITICAL: Failure in a thread!
Subtest interrupt-all: FAIL (0.145s)

Dmesg

<6> [221.601107] [IGT] xe_eudebug_online: executing

<6> [221.604726] [IGT] xe_eudebug_online: starting subtest interrupt-all

<6> [221.604879] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0

<7> [221.608389] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3270:0: (27432/27432) -> (27434/27434): "connected session 3270"

<7> [221.608534] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3270:0: (7957/7957) -> (27434/27434): "Discovery start for 3270\n"

<7> [221.608639] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3270:0: (7957/7957) -> (27434/27434): "Discovery end for 3270\n"

<7> [221.609257] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:1: (27435/27432) -> (27434/27434): "event read=0: type=2, flags=0x1, seqno=1"

<7> [221.609840] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:2: (27435/27432) -> (27434/27434): "event read=0: type=9, flags=0x1, seqno=2"

<7> [221.610017] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "read metadata: client_handle=1, metadata_handle=1, flags=0x0"

<7> [221.610110] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "ioctl cmd=READ_METADATA ret=0\n"

<7> [221.610187] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "event read=0: type=9, flags=0x1, seqno=3"

<7> [221.610268] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "read metadata: client_handle=1, metadata_handle=2, flags=0x0"

<7> [221.610345] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:3: (27435/27432) -> (27434/27434): "ioctl cmd=READ_METADATA ret=0\n"

<7> [221.611127] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "event read=0: type=3, flags=0x1, seqno=4"

<7> [221.611261] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10"

<7> [221.611348] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:4: (27435/27432) -> (27434/27434): "ioctl cmd=VM_OPEN ret=10\n"

<7> [221.612160] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff00c8

<7> [221.612262] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff00c8

<7> [221.612428] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:6: (27435/27432) -> (27434/27434): "event read=0: type=4, flags=0x1, seqno=5"

<7> [221.612505] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:6: (27435/27432) -> (27434/27434): "event read=0: type=13, flags=0x1, seqno=6"

<7> [221.613786] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:9: (27435/27432) -> (27434/27434): "event read=0: type=6, flags=0x4, seqno=7"

<7> [221.613866] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=7, flags=0x1, seqno=8"

<7> [221.613867] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3270:10: (7957/7957) -> (27434/27434): "ACK: seqno=10: tracking started"

<7> [221.613941] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=7, flags=0x1, seqno=9"

<7> [221.614012] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "event read=0: type=8, flags=0x9, seqno=10"

<7> [221.614095] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "ACK: seqno=10: signalled by 10 (debugger) (held 228us)"

<7> [221.614166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27435/27432) -> (27434/27434): "ioctl cmd=EVENT_ACK ret=0\n"

<7> [221.614589] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:10: (27432/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=0, flags=0x0, exec_queue_handle=1, bitmask_size=0\n"

<7> [221.614717] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.614839] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.614930] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.615017] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.615880] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:11: (27432/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=0, flags=0x0, exec_queue_handle=1, bitmask_size=0 ret=0\n"

<7> [221.615983] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:11: (27432/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [221.712863] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.713404] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.713927] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.714379] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.715116] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:12: (27435/27432) -> (27434/27434): "event read=0: type=5, flags=0x4, seqno=12"

<7> [221.715089] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.715516] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:12: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

<7> [221.715522] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.715881] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.715916] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.716116] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.716341] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.716284] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.716557] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.716699] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.716944] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [221.717088] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.717166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [221.717453] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.717517] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n"

<7> [221.717831] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.717929] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

<7> [221.718184] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800

<7> [221.718411] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive

<7> [221.718650] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active

<7> [221.718938] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found

<7> [221.719214] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [221.719526] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [221.719809] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n"

<7> [221.720072] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n"

<7> [221.720332] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n"

<7> [221.720570] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n"

<7> [221.720827] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n"

<7> [221.721067] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n"

<7> [221.721321] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n"

<7> [221.721579] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n"

<7> [221.721886] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n"

<7> [221.722163] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n"

<7> [221.722439] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n"

<7> [221.722764] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3270:13: (27435/27432) -> (27434/27434): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n"

<7> [221.723086] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [221.723352] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [221.723630] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:15: (27435/27432) -> (27434/27434): "event read=0: type=5, flags=0x4, seqno=15"

<7> [221.723960] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:16: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

<7> [221.724241] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] Ioctl argument check failed at drivers/gpu/drm/xe/prelim/xe_eudebug.c:1118: !q

<7> [221.724497] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:17: (27435/27432) -> (27434/27434): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=-22\n"

<7> [221.724736] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3270:17: (27435/27432) -> (27434/27434): "ioctl cmd=EU_CONTROL ret=-22\n"

<6> [221.745975] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_COMPUTE0, FAIL

<6> [221.750426] [IGT] xe_eudebug_online: finished subtest interrupt-all, FAIL

<7> [221.752572] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0

<6> [221.752658] [IGT] xe_eudebug_online: exiting, ret=98

<7> [221.758847] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3270:20: (27432/27432) -> (27434/27434): "vm_release: client_handle=1, vm_handle=1, flags=0x0"

<7> [221.759081] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3270:20:disconnected (27432/27432) -> (27434/27434): "session 3270 detached with 0"

<7> [221.759180] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3270:20:disconnected (27432/27432) -> (27434/27434): "Session closed (0)"

Results for igt@xe_eudebug_online@interrupt-all