igt@xe_eudebug_online@set-breakpoint@drm_xe_engine_class_compute0 on bat-lnl-2@xkb-pr-main-259-472-bdfb513933c9e46b47cce1b2e6673956abb62fcb Test details

Detail	Value
Duration	0.35 seconds
Igt-Version	IGT-Version: 2.3-g105262d67 (x86_64) (Linux: 6.17.13-lgci-xe-xkb-pr-main-259-472-bdfb5+ x86_64)
Out	Using IGT_SRANDOM=1770723975 for randomisation Opened device: /dev/dri/card0 Using IGT_SRANDOM=1770723975 for randomisation Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 client running with pid 27503 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.350s) Subtest set-breakpoint: FAIL (0.355s)
Err	Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 (xe_eudebug_online:27501) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27501) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27501) CRITICAL: error: 1024 != 512 Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed. ** DEBUG (xe_eudebug_online:27501) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) \|\| !xe_supports_faults(fd) (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger: 27501 waiting for token 'client pid' (xe_eudebug_online:27501) xe/xe_eudebug-INFO: client running with pid 27503 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a680 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a6b0 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a6e0 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a710 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a740 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a770 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger connected to 27503 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: 27501 signalling token 'client run' with value '27503' (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger: 27501 waiting for token 'client fini' (xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: Using simple allocator (xe_eudebug_online:27501) [thread:27504] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27501) [thread:27504] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27501) [thread:27504] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[12]: stopped (xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[14]: resume (xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[16]: stopped (xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: <ial: 0x738070000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: <ial: 0x738070000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[18]: resume (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes): (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=1, handle=1 (xe_eudebug_online:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (7) vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2 (xe_eudebug_online:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27501) 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:27501) 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:27501) 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:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (20) vm(3):destroy: client_handle=1, handle=1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (21) metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (22) metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (23) client(2):destroy: handle=1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes): (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=7 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=7, handle=1 (xe_eudebug_online:27501) 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:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (8) vm(3):destroy: client_handle=7, handle=1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (9) metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (10) metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (11) client(2):destroy: handle=7 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: client: 7 -> 1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: client: 1 -> 7 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10 (xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11 (xe_eudebug_online:27501) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27501) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27501) CRITICAL: error: 1024 != 512 (xe_eudebug_online:27501) igt_core-INFO: Stack trace: (xe_eudebug_online:27501) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:27501) igt_core-INFO: #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check() (xe_eudebug_online:27501) igt_core-INFO: #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online() (xe_eudebug_online:27501) igt_core-INFO: #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671() (xe_eudebug_online:27501) igt_core-INFO: #4 ../tests/intel/xe_eudebug_online.c:2671 main() (xe_eudebug_online:27501) igt_core-INFO: #5 [__libc_init_first+0x8a] (xe_eudebug_online:27501) igt_core-INFO: #6 [__libc_start_main+0x8b] (xe_eudebug_online:27501) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.350s) Subtest set-breakpoint: FAIL (0.355s)
Dmesg	<6> [268.985167] [IGT] xe_eudebug_online: executing <6> [268.989019] [IGT] xe_eudebug_online: starting subtest set-breakpoint <6> [268.989158] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 <7> [268.993525] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3280:0: (27501/27501) -> (27503/27503): "connected session 3280" <7> [268.993677] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3280:0: (8899/8899) -> (27503/27503): "Discovery start for 3280\n" <7> [268.993813] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3280:0: (8899/8899) -> (27503/27503): "Discovery end for 3280\n" <7> [268.994125] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:1: (27504/27501) -> (27503/27503): "event read=0: type=2, flags=0x1, seqno=1" <7> [268.994570] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:2: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x1, seqno=2" <7> [268.994886] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "read metadata: client_handle=1, metadata_handle=1, flags=0x0" <7> [268.994990] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "ioctl cmd=READ_METADATA ret=0\n" <7> [268.995087] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x1, seqno=3" <7> [268.995179] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "read metadata: client_handle=1, metadata_handle=2, flags=0x0" <7> [268.995270] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "ioctl cmd=READ_METADATA ret=0\n" <7> [268.995924] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "event read=0: type=3, flags=0x1, seqno=4" <7> [268.996070] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10" <7> [268.996168] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "ioctl cmd=VM_OPEN ret=10\n" <7> [268.997002] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [268.997090] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [268.997249] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:6: (27504/27501) -> (27503/27503): "event read=0: type=4, flags=0x1, seqno=5" <7> [268.997351] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:6: (27504/27501) -> (27503/27503): "event read=0: type=13, flags=0x1, seqno=6" <7> [268.998605] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:9: (27504/27501) -> (27503/27503): "event read=0: type=6, flags=0x4, seqno=7" <7> [268.998649] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3280:10: (8899/8899) -> (27503/27503): "ACK: seqno=10: tracking started" <7> [268.998713] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=7, flags=0x1, seqno=8" <7> [268.998806] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=7, flags=0x1, seqno=9" <7> [268.998895] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=8, flags=0x9, seqno=10" <7> [268.999145] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n" <7> [268.999446] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "ACK: seqno=10: signalled by 10 (debugger) (held 798us)" <7> [268.999544] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "ioctl cmd=EVENT_ACK ret=0\n" <7> [269.095717] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.096238] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.096739] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.097191] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.097883] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.097912] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:11: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=11" <7> [269.098318] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.098367] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:11: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [269.098766] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.098864] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.099190] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.099285] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.099675] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.099721] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.100096] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.100130] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.100512] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.100745] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:12: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [269.100951] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.101159] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:12: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n" <7> [269.101602] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [269.102038] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.102399] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.102789] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.103148] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.103546] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [269.103934] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [269.104304] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n" <7> [269.104686] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n" <7> [269.105043] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n" <7> [269.105366] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n" <7> [269.105716] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n" <7> [269.106017] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n" <7> [269.106310] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n" <7> [269.106600] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n" <7> [269.106899] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n" <7> [269.107175] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n" <7> [269.107438] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n" <7> [269.107697] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n" <7> [269.107956] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [269.108199] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n" <7> [269.108453] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=13" <7> [269.207720] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.208177] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.208560] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.208950] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.209538] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:15: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=15" <7> [269.209523] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.209904] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.209917] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:15: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [269.210254] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.210285] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.210589] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.210601] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.210943] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.210987] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.211271] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.211324] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.211666] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.211768] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:16: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [269.211989] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.212088] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:16: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n" <7> [269.212447] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [269.212816] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [269.213137] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [269.213456] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [269.213793] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [269.214152] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [269.214447] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [269.214784] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [269.215090] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n" <7> [269.215396] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=17" <7> [269.215731] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "event read=0: type=4, flags=0x2, seqno=19" <7> [269.216051] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "event read=0: type=3, flags=0x2, seqno=20" <7> [269.216370] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "vm_release: client_handle=1, vm_handle=1, flags=0x0" <7> [269.217677] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:21: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x2, seqno=21" <7> [269.218000] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:22: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x2, seqno=22" <7> [269.218387] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:23: (27504/27501) -> (27503/27503): "event read=0: type=2, flags=0x2, seqno=23" <6> [269.338970] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_COMPUTE0, FAIL <6> [269.344145] [IGT] xe_eudebug_online: finished subtest set-breakpoint, FAIL <7> [269.346547] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [269.346757] [IGT] xe_eudebug_online: exiting, ret=98 <7> [269.351404] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3280:23:disconnected (27501/27501) -> (27503/27503): "session 3280 detached with 0" <7> [269.351543] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3280:23:disconnected (27501/27501) -> (27503/27503): "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-pr-main-259-472-bdfb5+ x86_64)

Out

Using IGT_SRANDOM=1770723975 for randomisation
Opened device: /dev/dri/card0
Using IGT_SRANDOM=1770723975 for randomisation
Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
client running with pid 27503
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.350s)
Subtest set-breakpoint: FAIL (0.355s)

Err

Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
(xe_eudebug_online:27501) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27501) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27501) CRITICAL: error: 1024 != 512
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed.
**** DEBUG ****
(xe_eudebug_online:27501) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) || !xe_supports_faults(fd)
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger: 27501 waiting for token 'client pid'
(xe_eudebug_online:27501) xe/xe_eudebug-INFO: client running with pid 27503
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a680
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a6b0
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a6e0
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a710
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a740
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: added trigger 0x56120fd0a770
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger connected to 27503
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: 27501 signalling token 'client run' with value '27503'
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: debugger: 27501 waiting for token 'client fini'
(xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: Using simple allocator
(xe_eudebug_online:27501) [thread:27504] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27501) [thread:27504] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27501) [thread:27504] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[12]: stopped
(xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[14]: resume
(xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[16]: stopped
(xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: <ial: 0x738070000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27501) [thread:27502] intel_allocator_simple-DEBUG: <ial: 0x738070000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27501) [thread:27504] DEBUG: EU CONTROL[18]: resume
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes):
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=1, handle=1
(xe_eudebug_online:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (7)      vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2
(xe_eudebug_online:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27501) 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:27501) 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:27501) 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:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (20)           vm(3):destroy: client_handle=1, handle=1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (21)     metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (22)     metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (23)       client(2):destroy: handle=1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes):
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=7
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=7, handle=1
(xe_eudebug_online:27501) 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:27501) 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:27501) 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:27501) xe/xe_eudebug-DEBUG: (8)           vm(3):destroy: client_handle=7, handle=1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (9)     metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (10)     metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: (11)       client(2):destroy: handle=7
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: client: 7 -> 1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: client: 1 -> 7
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10
(xe_eudebug_online:27501) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11
(xe_eudebug_online:27501) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27501) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27501) CRITICAL: error: 1024 != 512
(xe_eudebug_online:27501) igt_core-INFO: Stack trace:
(xe_eudebug_online:27501) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:27501) igt_core-INFO:   #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check()
(xe_eudebug_online:27501) igt_core-INFO:   #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online()
(xe_eudebug_online:27501) igt_core-INFO:   #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671()
(xe_eudebug_online:27501) igt_core-INFO:   #4 ../tests/intel/xe_eudebug_online.c:2671 main()
(xe_eudebug_online:27501) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(xe_eudebug_online:27501) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(xe_eudebug_online:27501) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.350s)
Subtest set-breakpoint: FAIL (0.355s)

Dmesg

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

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

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

<7> [268.993525] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3280:0: (27501/27501) -> (27503/27503): "connected session 3280"

<7> [268.993677] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3280:0: (8899/8899) -> (27503/27503): "Discovery start for 3280\n"

<7> [268.993813] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3280:0: (8899/8899) -> (27503/27503): "Discovery end for 3280\n"

<7> [268.994125] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:1: (27504/27501) -> (27503/27503): "event read=0: type=2, flags=0x1, seqno=1"

<7> [268.994570] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:2: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x1, seqno=2"

<7> [268.994886] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "read metadata: client_handle=1, metadata_handle=1, flags=0x0"

<7> [268.994990] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "ioctl cmd=READ_METADATA ret=0\n"

<7> [268.995087] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x1, seqno=3"

<7> [268.995179] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "read metadata: client_handle=1, metadata_handle=2, flags=0x0"

<7> [268.995270] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:3: (27504/27501) -> (27503/27503): "ioctl cmd=READ_METADATA ret=0\n"

<7> [268.995924] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "event read=0: type=3, flags=0x1, seqno=4"

<7> [268.996070] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10"

<7> [268.996168] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:4: (27504/27501) -> (27503/27503): "ioctl cmd=VM_OPEN ret=10\n"

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

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

<7> [268.997249] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:6: (27504/27501) -> (27503/27503): "event read=0: type=4, flags=0x1, seqno=5"

<7> [268.997351] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:6: (27504/27501) -> (27503/27503): "event read=0: type=13, flags=0x1, seqno=6"

<7> [268.998605] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:9: (27504/27501) -> (27503/27503): "event read=0: type=6, flags=0x4, seqno=7"

<7> [268.998649] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3280:10: (8899/8899) -> (27503/27503): "ACK: seqno=10: tracking started"

<7> [268.998713] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=7, flags=0x1, seqno=8"

<7> [268.998806] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=7, flags=0x1, seqno=9"

<7> [268.998895] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "event read=0: type=8, flags=0x9, seqno=10"

<7> [268.999145] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n"

<7> [268.999446] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "ACK: seqno=10: signalled by 10 (debugger) (held 798us)"

<7> [268.999544] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:10: (27504/27501) -> (27503/27503): "ioctl cmd=EVENT_ACK ret=0\n"

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

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

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

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

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

<7> [269.097912] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:11: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=11"

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

<7> [269.098367] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:11: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

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

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

<7> [269.100745] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:12: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

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

<7> [269.101159] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:12: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [269.101602] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [269.103546] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [269.103934] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [269.104304] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n"

<7> [269.104686] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n"

<7> [269.105043] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n"

<7> [269.105366] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n"

<7> [269.105716] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n"

<7> [269.106017] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n"

<7> [269.106310] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n"

<7> [269.106600] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n"

<7> [269.106899] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n"

<7> [269.107175] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n"

<7> [269.107438] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n"

<7> [269.107697] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:13: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n"

<7> [269.107956] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [269.108199] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [269.108453] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:14: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=13"

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

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

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

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

<7> [269.209538] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:15: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=15"

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

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

<7> [269.209917] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:15: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

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

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

<7> [269.211768] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:16: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

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

<7> [269.212088] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:16: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [269.212447] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [269.214152] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [269.214447] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3280:17: (27504/27501) -> (27503/27503): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [269.214784] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [269.215090] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [269.215396] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:18: (27504/27501) -> (27503/27503): "event read=0: type=5, flags=0x4, seqno=17"

<7> [269.215731] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "event read=0: type=4, flags=0x2, seqno=19"

<7> [269.216051] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "event read=0: type=3, flags=0x2, seqno=20"

<7> [269.216370] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3280:20: (27504/27501) -> (27503/27503): "vm_release: client_handle=1, vm_handle=1, flags=0x0"

<7> [269.217677] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:21: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x2, seqno=21"

<7> [269.218000] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:22: (27504/27501) -> (27503/27503): "event read=0: type=9, flags=0x2, seqno=22"

<7> [269.218387] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3280:23: (27504/27501) -> (27503/27503): "event read=0: type=2, flags=0x2, seqno=23"

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

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

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

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

<7> [269.351404] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3280:23:disconnected (27501/27501) -> (27503/27503): "session 3280 detached with 0"

<7> [269.351543] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3280:23:disconnected (27501/27501) -> (27503/27503): "Session closed (0)"

Results for igt@xe_eudebug_online@set-breakpoint@drm_xe_engine_class_compute0