igt@xe_eudebug_online@set-breakpoint@drm_xe_engine_class_compute0 on bat-lnl-2@xkb-213-9ac3ff8c8f27e85d83108ec4a536246b55a7edf4 Test details

Detail	Value
Duration	0.35 seconds
Igt-Version	IGT-Version: 2.3-g105262d67 (x86_64) (Linux: 6.17.13-lgci-xe-xkb-213-9ac3ff8c8f27e85d8+ x86_64)
Out	Using IGT_SRANDOM=1769775191 for randomisation Opened device: /dev/dri/card0 Using IGT_SRANDOM=1769775191 for randomisation Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 client running with pid 27515 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check() #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online() #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671() #4 ../tests/intel/xe_eudebug_online.c:2671 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.348s) Subtest set-breakpoint: FAIL (0.354s)
Err	Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 (xe_eudebug_online:27513) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27513) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27513) CRITICAL: error: 1024 != 512 Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed. ** DEBUG (xe_eudebug_online:27513) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) \|\| !xe_supports_faults(fd) (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger: 27513 waiting for token 'client pid' (xe_eudebug_online:27513) xe/xe_eudebug-INFO: client running with pid 27515 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d680 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d6b0 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d6e0 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d710 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d740 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d770 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger connected to 27515 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: 27513 signalling token 'client run' with value '27515' (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger: 27513 waiting for token 'client fini' (xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: Using simple allocator (xe_eudebug_online:27513) [thread:27516] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27513) [thread:27516] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27513) [thread:27516] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[12]: stopped (xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[14]: resume (xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[16]: stopped (xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[18]: resume (xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: <ial: 0x7bb1bc000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: <ial: 0x7bb1bc000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes): (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=1, handle=1 (xe_eudebug_online:27513) 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:27513) 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:27513) xe/xe_eudebug-DEBUG: (7) vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2 (xe_eudebug_online:27513) 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:27513) xe/xe_eudebug-DEBUG: (9) vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001a000000, range=8192 num_extensions=0 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (11) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (13) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56 (xe_eudebug_online:27513) 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:27513) xe/xe_eudebug-DEBUG: (17) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (19) exec_queue(4):destroy: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (20) vm(3):destroy: client_handle=1, handle=1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (21) metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (22) metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (23) client(2):destroy: handle=1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes): (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=7 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=7, handle=1 (xe_eudebug_online:27513) 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:27513) 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:27513) 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:27513) xe/xe_eudebug-DEBUG: (8) vm(3):destroy: client_handle=7, handle=1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (9) metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (10) metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (11) client(2):destroy: handle=7 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: client: 7 -> 1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: client: 1 -> 7 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10 (xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11 (xe_eudebug_online:27513) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27513) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27513) CRITICAL: error: 1024 != 512 (xe_eudebug_online:27513) igt_core-INFO: Stack trace: (xe_eudebug_online:27513) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:27513) igt_core-INFO: #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check() (xe_eudebug_online:27513) igt_core-INFO: #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online() (xe_eudebug_online:27513) igt_core-INFO: #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671() (xe_eudebug_online:27513) igt_core-INFO: #4 ../tests/intel/xe_eudebug_online.c:2671 main() (xe_eudebug_online:27513) igt_core-INFO: #5 [__libc_init_first+0x8a] (xe_eudebug_online:27513) igt_core-INFO: #6 [__libc_start_main+0x8b] (xe_eudebug_online:27513) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.348s) Subtest set-breakpoint: FAIL (0.354s)
Dmesg	<6> [232.374097] [IGT] xe_eudebug_online: executing <6> [232.378054] [IGT] xe_eudebug_online: starting subtest set-breakpoint <6> [232.378200] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 <7> [232.381713] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3282:0: (27513/27513) -> (27515/27515): "connected session 3282" <7> [232.381851] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3282:0: (7990/7990) -> (27515/27515): "Discovery start for 3282\n" <7> [232.381968] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3282:0: (7990/7990) -> (27515/27515): "Discovery end for 3282\n" <7> [232.382604] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:1: (27516/27513) -> (27515/27515): "event read=0: type=2, flags=0x1, seqno=1" <7> [232.382999] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:2: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x1, seqno=2" <7> [232.383312] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "read metadata: client_handle=1, metadata_handle=1, flags=0x0" <7> [232.383415] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "ioctl cmd=READ_METADATA ret=0\n" <7> [232.383513] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x1, seqno=3" <7> [232.383626] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "read metadata: client_handle=1, metadata_handle=2, flags=0x0" <7> [232.383732] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "ioctl cmd=READ_METADATA ret=0\n" <7> [232.384246] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "event read=0: type=3, flags=0x1, seqno=4" <7> [232.384375] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10" <7> [232.384468] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "ioctl cmd=VM_OPEN ret=10\n" <7> [232.385491] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [232.385597] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [232.385766] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:6: (27516/27513) -> (27515/27515): "event read=0: type=4, flags=0x1, seqno=5" <7> [232.385862] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:6: (27516/27513) -> (27515/27515): "event read=0: type=13, flags=0x1, seqno=6" <7> [232.387211] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:9: (27516/27513) -> (27515/27515): "event read=0: type=6, flags=0x4, seqno=7" <7> [232.387258] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3282:10: (7990/7990) -> (27515/27515): "ACK: seqno=10: tracking started" <7> [232.387313] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=7, flags=0x1, seqno=8" <7> [232.387405] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=7, flags=0x1, seqno=9" <7> [232.387493] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=8, flags=0x9, seqno=10" <7> [232.387749] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n" <7> [232.388213] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "ACK: seqno=10: signalled by 10 (debugger) (held 955us)" <7> [232.388311] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "ioctl cmd=EVENT_ACK ret=0\n" <7> [232.485694] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.486356] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.486972] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.487518] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.488333] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.488361] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:11: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=11" <7> [232.488879] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.488916] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:11: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [232.489316] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.489386] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.489767] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.489823] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.490234] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.490243] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.490667] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.490684] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.491102] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.491261] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:12: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [232.491519] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.491692] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:12: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n" <7> [232.492166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [232.492638] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.493051] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.493459] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.493893] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.494344] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [232.494785] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [232.495157] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n" <7> [232.495524] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n" <7> [232.495905] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n" <7> [232.496237] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n" <7> [232.496580] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n" <7> [232.496907] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n" <7> [232.497198] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n" <7> [232.497488] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n" <7> [232.497805] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n" <7> [232.498083] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n" <7> [232.498348] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n" <7> [232.498624] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n" <7> [232.498899] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [232.499141] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n" <7> [232.499391] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=13" <7> [232.597687] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.598084] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.598417] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.598788] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.599348] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:15: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=15" <7> [232.599324] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.599681] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:15: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [232.599672] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.599986] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.599979] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.600259] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.600278] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.600522] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.600634] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.600818] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.600964] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.601244] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [232.601279] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.601512] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n" <7> [232.601608] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.601874] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [232.602198] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [232.602473] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [232.602758] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [232.603031] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [232.603343] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:17: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [232.603640] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:17: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [232.603936] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [232.604214] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n" <7> [232.604509] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=17" <7> [232.604945] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:19: (27516/27513) -> (27515/27515): "event read=0: type=4, flags=0x2, seqno=19" <7> [232.605240] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:20: (27516/27513) -> (27515/27515): "event read=0: type=3, flags=0x2, seqno=20" <7> [232.605527] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3282:20: (27516/27513) -> (27515/27515): "vm_release: client_handle=1, vm_handle=1, flags=0x0" <7> [232.607143] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:21: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x2, seqno=21" <7> [232.607460] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:22: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x2, seqno=22" <7> [232.608170] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:23: (27516/27513) -> (27515/27515): "event read=0: type=2, flags=0x2, seqno=23" <6> [232.726276] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_COMPUTE0, FAIL <6> [232.732356] [IGT] xe_eudebug_online: finished subtest set-breakpoint, FAIL <7> [232.734656] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [232.734857] [IGT] xe_eudebug_online: exiting, ret=98 <7> [232.739977] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3282:23:disconnected (27513/27513) -> (27515/27515): "session 3282 detached with 0" <7> [232.740117] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3282:23:disconnected (27513/27513) -> (27515/27515): "Session closed (0)"

Detail

Value

Duration

0.35 seconds

Igt-Version

IGT-Version: 2.3-g105262d67 (x86_64) (Linux: 6.17.13-lgci-xe-xkb-213-9ac3ff8c8f27e85d8+ x86_64)

Out

Using IGT_SRANDOM=1769775191 for randomisation
Opened device: /dev/dri/card0
Using IGT_SRANDOM=1769775191 for randomisation
Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
client running with pid 27515
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check()
  #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online()
  #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671()
  #4 ../tests/intel/xe_eudebug_online.c:2671 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.348s)
Subtest set-breakpoint: FAIL (0.354s)

Err

Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
(xe_eudebug_online:27513) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27513) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27513) CRITICAL: error: 1024 != 512
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed.
**** DEBUG ****
(xe_eudebug_online:27513) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) || !xe_supports_faults(fd)
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger: 27513 waiting for token 'client pid'
(xe_eudebug_online:27513) xe/xe_eudebug-INFO: client running with pid 27515
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d680
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d6b0
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d6e0
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d710
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d740
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: added trigger 0x647ae889d770
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger connected to 27515
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: 27513 signalling token 'client run' with value '27515'
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: debugger: 27513 waiting for token 'client fini'
(xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: Using simple allocator
(xe_eudebug_online:27513) [thread:27516] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27513) [thread:27516] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27513) [thread:27516] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[12]: stopped
(xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[14]: resume
(xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[16]: stopped
(xe_eudebug_online:27513) [thread:27516] DEBUG: EU CONTROL[18]: resume
(xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: <ial: 0x7bb1bc000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27513) [thread:27514] intel_allocator_simple-DEBUG: <ial: 0x7bb1bc000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes):
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=1, handle=1
(xe_eudebug_online:27513) 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:27513) 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:27513) xe/xe_eudebug-DEBUG: (7)      vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2
(xe_eudebug_online:27513) 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:27513) xe/xe_eudebug-DEBUG: (9)   vm_bind_op(7):create: vm_bind_ref_seqno=7, addr=000000001a000000, range=8192 num_extensions=0
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (11)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (13)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56
(xe_eudebug_online:27513) 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:27513) xe/xe_eudebug-DEBUG: (17)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=56
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (19)   exec_queue(4):destroy: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=4, exec_queue_width=1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (20)           vm(3):destroy: client_handle=1, handle=1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (21)     metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (22)     metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (23)       client(2):destroy: handle=1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes):
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=7
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=7, handle=1
(xe_eudebug_online:27513) 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:27513) 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:27513) 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:27513) xe/xe_eudebug-DEBUG: (8)           vm(3):destroy: client_handle=7, handle=1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (9)     metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (10)     metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: (11)       client(2):destroy: handle=7
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: client: 7 -> 1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: client: 1 -> 7
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10
(xe_eudebug_online:27513) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11
(xe_eudebug_online:27513) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27513) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27513) CRITICAL: error: 1024 != 512
(xe_eudebug_online:27513) igt_core-INFO: Stack trace:
(xe_eudebug_online:27513) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:27513) igt_core-INFO:   #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check()
(xe_eudebug_online:27513) igt_core-INFO:   #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online()
(xe_eudebug_online:27513) igt_core-INFO:   #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671()
(xe_eudebug_online:27513) igt_core-INFO:   #4 ../tests/intel/xe_eudebug_online.c:2671 main()
(xe_eudebug_online:27513) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(xe_eudebug_online:27513) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(xe_eudebug_online:27513) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.348s)
Subtest set-breakpoint: FAIL (0.354s)

Dmesg

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

<6> [232.378054] [IGT] xe_eudebug_online: starting subtest set-breakpoint

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

<7> [232.381713] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3282:0: (27513/27513) -> (27515/27515): "connected session 3282"

<7> [232.381851] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3282:0: (7990/7990) -> (27515/27515): "Discovery start for 3282\n"

<7> [232.381968] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3282:0: (7990/7990) -> (27515/27515): "Discovery end for 3282\n"

<7> [232.382604] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:1: (27516/27513) -> (27515/27515): "event read=0: type=2, flags=0x1, seqno=1"

<7> [232.382999] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:2: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x1, seqno=2"

<7> [232.383312] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "read metadata: client_handle=1, metadata_handle=1, flags=0x0"

<7> [232.383415] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "ioctl cmd=READ_METADATA ret=0\n"

<7> [232.383513] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x1, seqno=3"

<7> [232.383626] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "read metadata: client_handle=1, metadata_handle=2, flags=0x0"

<7> [232.383732] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:3: (27516/27513) -> (27515/27515): "ioctl cmd=READ_METADATA ret=0\n"

<7> [232.384246] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "event read=0: type=3, flags=0x1, seqno=4"

<7> [232.384375] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10"

<7> [232.384468] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:4: (27516/27513) -> (27515/27515): "ioctl cmd=VM_OPEN ret=10\n"

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

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

<7> [232.385766] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:6: (27516/27513) -> (27515/27515): "event read=0: type=4, flags=0x1, seqno=5"

<7> [232.385862] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:6: (27516/27513) -> (27515/27515): "event read=0: type=13, flags=0x1, seqno=6"

<7> [232.387211] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:9: (27516/27513) -> (27515/27515): "event read=0: type=6, flags=0x4, seqno=7"

<7> [232.387258] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3282:10: (7990/7990) -> (27515/27515): "ACK: seqno=10: tracking started"

<7> [232.387313] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=7, flags=0x1, seqno=8"

<7> [232.387405] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=7, flags=0x1, seqno=9"

<7> [232.387493] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "event read=0: type=8, flags=0x9, seqno=10"

<7> [232.387749] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n"

<7> [232.388213] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "ACK: seqno=10: signalled by 10 (debugger) (held 955us)"

<7> [232.388311] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:10: (27516/27513) -> (27515/27515): "ioctl cmd=EVENT_ACK ret=0\n"

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

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

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

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

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

<7> [232.488361] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:11: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=11"

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

<7> [232.488916] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:11: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

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

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

<7> [232.491261] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:12: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

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

<7> [232.491692] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:12: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [232.492166] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [232.494344] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [232.494785] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [232.495157] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n"

<7> [232.495524] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n"

<7> [232.495905] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n"

<7> [232.496237] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n"

<7> [232.496580] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n"

<7> [232.496907] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n"

<7> [232.497198] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n"

<7> [232.497488] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n"

<7> [232.497805] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n"

<7> [232.498083] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n"

<7> [232.498348] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n"

<7> [232.498624] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:13: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n"

<7> [232.498899] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [232.499141] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [232.499391] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:14: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=13"

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

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

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

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

<7> [232.599348] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:15: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=15"

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

<7> [232.599681] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:15: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

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

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

<7> [232.601244] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

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

<7> [232.601512] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n"

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

<7> [232.601874] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:16: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [232.603343] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:17: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [232.603640] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3282:17: (27516/27513) -> (27515/27515): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [232.603936] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [232.604214] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [232.604509] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:18: (27516/27513) -> (27515/27515): "event read=0: type=5, flags=0x4, seqno=17"

<7> [232.604945] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:19: (27516/27513) -> (27515/27515): "event read=0: type=4, flags=0x2, seqno=19"

<7> [232.605240] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:20: (27516/27513) -> (27515/27515): "event read=0: type=3, flags=0x2, seqno=20"

<7> [232.605527] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3282:20: (27516/27513) -> (27515/27515): "vm_release: client_handle=1, vm_handle=1, flags=0x0"

<7> [232.607143] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:21: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x2, seqno=21"

<7> [232.607460] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:22: (27516/27513) -> (27515/27515): "event read=0: type=9, flags=0x2, seqno=22"

<7> [232.608170] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3282:23: (27516/27513) -> (27515/27515): "event read=0: type=2, flags=0x2, seqno=23"

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

<6> [232.732356] [IGT] xe_eudebug_online: finished subtest set-breakpoint, FAIL

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

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

<7> [232.739977] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3282:23:disconnected (27513/27513) -> (27515/27515): "session 3282 detached with 0"

<7> [232.740117] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3282:23:disconnected (27513/27513) -> (27515/27515): "Session closed (0)"

Results for igt@xe_eudebug_online@set-breakpoint@drm_xe_engine_class_compute0