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

Detail	Value
Duration	0.39 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=1770724087 for randomisation Opened device: /dev/dri/card0 Using IGT_SRANDOM=1770724087 for randomisation Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 client running with pid 27983 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 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main() #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34() #7 [_start+0x25] Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.390s) Subtest set-breakpoint: FAIL (0.394s)
Err	Starting subtest: set-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0 (xe_eudebug_online:27981) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27981) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27981) CRITICAL: error: 1024 != 512 Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed. ** DEBUG (xe_eudebug_online:27981) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) \|\| !xe_supports_faults(fd) (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger: 27981 waiting for token 'client pid' (xe_eudebug_online:27981) xe/xe_eudebug-INFO: client running with pid 27983 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4680 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c46b0 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c46e0 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4710 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4740 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4770 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger connected to 27983 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: 27981 signalling token 'client run' with value '27983' (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger: 27981 waiting for token 'client fini' (xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: Using simple allocator (xe_eudebug_online:27981) [thread:27984] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27981) [thread:27984] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER (xe_eudebug_online:27981) [thread:27984] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[12]: stopped (xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[14]: resume (xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[16]: stopped (xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[18]: resume (xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: <ial: 0x753358000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: <ial: 0x753358000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes): (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=1, handle=1 (xe_eudebug_online:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (7) vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2 (xe_eudebug_online:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:27981) 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:27981) 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:27981) 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:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (20) vm(3):destroy: client_handle=1, handle=1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (21) metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (22) metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (23) client(2):destroy: handle=1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes): (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=7 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=7, handle=1 (xe_eudebug_online:27981) 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:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (8) vm(3):destroy: client_handle=7, handle=1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (9) metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (10) metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (11) client(2):destroy: handle=7 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: client: 7 -> 1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: client: 1 -> 7 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10 (xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11 (xe_eudebug_online:27981) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:27981) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:27981) CRITICAL: error: 1024 != 512 (xe_eudebug_online:27981) igt_core-INFO: Stack trace: (xe_eudebug_online:27981) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:27981) igt_core-INFO: #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check() (xe_eudebug_online:27981) igt_core-INFO: #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online() (xe_eudebug_online:27981) igt_core-INFO: #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671() (xe_eudebug_online:27981) igt_core-INFO: #4 ../tests/intel/xe_eudebug_online.c:2671 main() (xe_eudebug_online:27981) igt_core-INFO: #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main() (xe_eudebug_online:27981) igt_core-INFO: #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34() (xe_eudebug_online:27981) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.390s) Subtest set-breakpoint: FAIL (0.394s)
Dmesg	<6> [371.887248] Console: switching to colour dummy device 80x25 <6> [371.887532] [IGT] xe_eudebug_online: executing <6> [371.891651] [IGT] xe_eudebug_online: starting subtest set-breakpoint <6> [371.892009] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 <7> [371.896028] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3281:0: (27981/27981) -> (27983/27983): "connected session 3281" <7> [371.896142] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3281:0: (8417/8417) -> (27983/27983): "Discovery start for 3281\n" <7> [371.896424] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3281:0: (8417/8417) -> (27983/27983): "Discovery end for 3281\n" <7> [371.896662] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:1: (27984/27981) -> (27983/27983): "event read=0: type=2, flags=0x1, seqno=1" <7> [371.897138] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x1, seqno=2" <7> [371.897438] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "read metadata: client_handle=1, metadata_handle=1, flags=0x0" <7> [371.897542] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "ioctl cmd=READ_METADATA ret=0\n" <7> [371.897632] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x1, seqno=3" <7> [371.897729] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "read metadata: client_handle=1, metadata_handle=2, flags=0x0" <7> [371.897821] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "ioctl cmd=READ_METADATA ret=0\n" <7> [371.898470] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "event read=0: type=3, flags=0x1, seqno=4" <7> [371.898621] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10" <7> [371.898699] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "ioctl cmd=VM_OPEN ret=10\n" <7> [371.899444] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [371.899546] xe 0000:00:02.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff00c8 <7> [371.899745] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:6: (27984/27981) -> (27983/27983): "event read=0: type=4, flags=0x1, seqno=5" <7> [371.899826] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:6: (27984/27981) -> (27983/27983): "event read=0: type=13, flags=0x1, seqno=6" <7> [371.901189] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=6, flags=0x4, seqno=7" <7> [371.901196] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3281:10: (8417/8417) -> (27983/27983): "ACK: seqno=10: tracking started" <7> [371.901289] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=7, flags=0x1, seqno=8" <7> [371.901390] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=7, flags=0x1, seqno=9" <7> [371.901481] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=8, flags=0x9, seqno=10" <7> [371.901705] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n" <7> [371.902002] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "ACK: seqno=10: signalled by 10 (debugger) (held 808us)" <7> [371.902096] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "ioctl cmd=EVENT_ACK ret=0\n" <7> [371.997301] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [371.997698] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [371.998024] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [371.998381] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [371.998885] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [371.998930] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:11: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=11" <7> [371.999171] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [371.999381] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:11: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [371.999527] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [371.999764] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [371.999808] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.000077] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.000176] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.000425] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.000534] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.000720] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.000808] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.001075] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.001202] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:12: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [372.001490] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n" <7> [372.001833] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [372.002141] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.002518] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.002794] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.003116] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.003466] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [372.003738] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [372.004003] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n" <7> [372.004317] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n" <7> [372.004631] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n" <7> [372.004897] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n" <7> [372.005158] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n" <7> [372.005482] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n" <7> [372.005754] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n" <7> [372.006054] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n" <7> [372.006403] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n" <7> [372.006724] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n" <7> [372.007034] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n" <7> [372.007378] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n" <7> [372.007672] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [372.007942] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n" <7> [372.008240] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=13" <7> [372.109291] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.109664] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.109987] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.110351] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.110878] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.111212] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.111528] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.111835] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.112043] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:15: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=15" <7> [372.112254] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.112536] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:15: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [372.112554] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.112878] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.112951] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.113170] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.113335] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.113675] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.114004] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.114577] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [372.114932] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n" <7> [372.115332] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n" <7> [372.115684] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00002800 <7> [372.115987] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=inactive, context=inactive <7> [372.116319] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=active, context=active <7> [372.116618] xe 0000:00:02.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine ccs0 found <7> [372.116952] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n" <7> [372.117265] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n" <7> [372.117574] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n" <7> [372.117882] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n" <7> [372.118233] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=17" <7> [372.118819] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "event read=0: type=4, flags=0x2, seqno=19" <7> [372.119319] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "event read=0: type=3, flags=0x2, seqno=20" <7> [372.119811] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "vm_release: client_handle=1, vm_handle=1, flags=0x0" <7> [372.120908] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:22: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x2, seqno=21" <7> [372.121388] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:22: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x2, seqno=22" <7> [372.121772] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:23: (27984/27981) -> (27983/27983): "event read=0: type=2, flags=0x2, seqno=23" <6> [372.282544] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_COMPUTE0, FAIL <6> [372.285818] [IGT] xe_eudebug_online: finished subtest set-breakpoint, FAIL <7> [372.287795] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [372.288538] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [372.305830] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [372.306291] [IGT] xe_eudebug_online: exiting, ret=98 <6> [372.322676] Console: switching to colour frame buffer device 180x56 <7> [372.350372] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3281:23:disconnected (27981/27981) -> (27983/27983): "session 3281 detached with 0" <7> [372.350603] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3281:23:disconnected (27981/27981) -> (27983/27983): "Session closed (0)"

Detail

Value

Duration

0.39 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=1770724087 for randomisation
Opened device: /dev/dri/card0
Using IGT_SRANDOM=1770724087 for randomisation
Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
client running with pid 27983
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 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main()
  #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34()
  #7 [_start+0x25]
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.390s)
Subtest set-breakpoint: FAIL (0.394s)

Err

Starting subtest: set-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_COMPUTE0
(xe_eudebug_online:27981) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27981) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27981) CRITICAL: error: 1024 != 512
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0 failed.
**** DEBUG ****
(xe_eudebug_online:27981) DEBUG: Test requirement passed: !(flags & FAULTABLE_VM) || !xe_supports_faults(fd)
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger: 27981 waiting for token 'client pid'
(xe_eudebug_online:27981) xe/xe_eudebug-INFO: client running with pid 27983
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4680
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c46b0
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c46e0
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4710
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4740
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: added trigger 0x575b196c4770
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger connected to 27983
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: 27981 signalling token 'client run' with value '27983'
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: debugger: 27981 waiting for token 'client fini'
(xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: Using simple allocator
(xe_eudebug_online:27981) [thread:27984] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27981) [thread:27984] gpgpu_shader-DEBUG: Test requirement passed: shdr->gen_ver >= SUPPORTED_GEN_VER
(xe_eudebug_online:27981) [thread:27984] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[12]: stopped
(xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[14]: resume
(xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[16]: stopped
(xe_eudebug_online:27981) [thread:27984] DEBUG: EU CONTROL[18]: resume
(xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: <ial: 0x753358000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27981) [thread:27982] intel_allocator_simple-DEBUG: <ial: 0x753358000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: event log 'debugger' (1208 bytes):
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=1, handle=1
(xe_eudebug_online:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (7)      vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2
(xe_eudebug_online:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:27981) 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:27981) 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:27981) 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:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (20)           vm(3):destroy: client_handle=1, handle=1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (21)     metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (22)     metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (23)       client(2):destroy: handle=1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes):
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=7
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=7, handle=1
(xe_eudebug_online:27981) 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:27981) 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:27981) 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:27981) xe/xe_eudebug-DEBUG: (8)           vm(3):destroy: client_handle=7, handle=1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (9)     metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (10)     metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: (11)       client(2):destroy: handle=7
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: client: 7 -> 1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 19
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 20
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 21
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 22
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 23
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: client: 1 -> 7
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 7
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 20 vs client 8
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 21 vs client 9
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 22 vs client 10
(xe_eudebug_online:27981) xe/xe_eudebug-DEBUG: comparing debugger 23 vs client 11
(xe_eudebug_online:27981) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:27981) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:27981) CRITICAL: error: 1024 != 512
(xe_eudebug_online:27981) igt_core-INFO: Stack trace:
(xe_eudebug_online:27981) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:27981) igt_core-INFO:   #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check()
(xe_eudebug_online:27981) igt_core-INFO:   #2 ../tests/intel/xe_eudebug_online.c:1600 test_set_breakpoint_online()
(xe_eudebug_online:27981) igt_core-INFO:   #3 ../tests/intel/xe_eudebug_online.c:2692 __igt_unique____real_main2671()
(xe_eudebug_online:27981) igt_core-INFO:   #4 ../tests/intel/xe_eudebug_online.c:2671 main()
(xe_eudebug_online:27981) igt_core-INFO:   #5 ../sysdeps/nptl/libc_start_call_main.h:74 __libc_start_call_main()
(xe_eudebug_online:27981) igt_core-INFO:   #6 ../csu/libc-start.c:128 __libc_start_main@@GLIBC_2.34()
(xe_eudebug_online:27981) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest DRM_XE_ENGINE_CLASS_COMPUTE0: FAIL (0.390s)
Subtest set-breakpoint: FAIL (0.394s)

Dmesg

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

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

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

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

<7> [371.896028] xe 0000:00:02.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3281:0: (27981/27981) -> (27983/27983): "connected session 3281"

<7> [371.896142] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3281:0: (8417/8417) -> (27983/27983): "Discovery start for 3281\n"

<7> [371.896424] xe 0000:00:02.0: [drm:discovery_work_fn [xe]] eudbg: 3281:0: (8417/8417) -> (27983/27983): "Discovery end for 3281\n"

<7> [371.896662] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:1: (27984/27981) -> (27983/27983): "event read=0: type=2, flags=0x1, seqno=1"

<7> [371.897138] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x1, seqno=2"

<7> [371.897438] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "read metadata: client_handle=1, metadata_handle=1, flags=0x0"

<7> [371.897542] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "ioctl cmd=READ_METADATA ret=0\n"

<7> [371.897632] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x1, seqno=3"

<7> [371.897729] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "read metadata: client_handle=1, metadata_handle=2, flags=0x0"

<7> [371.897821] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:3: (27984/27981) -> (27983/27983): "ioctl cmd=READ_METADATA ret=0\n"

<7> [371.898470] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "event read=0: type=3, flags=0x1, seqno=4"

<7> [371.898621] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "vm_open: client_handle=1, handle=1, flags=0x0, fd=10"

<7> [371.898699] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:4: (27984/27981) -> (27983/27983): "ioctl cmd=VM_OPEN ret=10\n"

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

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

<7> [371.899745] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:6: (27984/27981) -> (27983/27983): "event read=0: type=4, flags=0x1, seqno=5"

<7> [371.899826] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:6: (27984/27981) -> (27983/27983): "event read=0: type=13, flags=0x1, seqno=6"

<7> [371.901189] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=6, flags=0x4, seqno=7"

<7> [371.901196] xe 0000:00:02.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3281:10: (8417/8417) -> (27983/27983): "ACK: seqno=10: tracking started"

<7> [371.901289] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=7, flags=0x1, seqno=8"

<7> [371.901390] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=7, flags=0x1, seqno=9"

<7> [371.901481] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "event read=0: type=8, flags=0x9, seqno=10"

<7> [371.901705] xe 0000:00:02.0: [drm:xe_eudebug_vm_fsync [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "vm_fsync: client_handle=1, vm_handle=1, flags=0x0, start=0, end=9223372036854775807 datasync=0\n"

<7> [371.902002] xe 0000:00:02.0: [drm:handle_ack [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "ACK: seqno=10: signalled by 10 (debugger) (held 808us)"

<7> [371.902096] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:10: (27984/27981) -> (27983/27983): "ioctl cmd=EVENT_ACK ret=0\n"

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

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

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

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

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

<7> [371.998930] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:11: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=11"

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

<7> [371.999381] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:11: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

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

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

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

<7> [372.001202] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:12: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [372.001490] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [372.001833] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [372.003466] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [372.003738] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [372.004003] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:1:0:0): 0xffffffff\n"

<7> [372.004317] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:1:0:1): 0xffffffff\n"

<7> [372.004631] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:2:0:0): 0xffffffff\n"

<7> [372.004897] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:2:0:1): 0xffffffff\n"

<7> [372.005158] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:3:0:0): 0xffffffff\n"

<7> [372.005482] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:3:0:1): 0xffffffff\n"

<7> [372.005754] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:0:0:0): 0xffffffff\n"

<7> [372.006054] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:0:0:1): 0xffffffff\n"

<7> [372.006403] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:1:0:0): 0xffffffff\n"

<7> [372.006724] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:1:0:1): 0xffffffff\n"

<7> [372.007034] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:2:0:0): 0xffffffff\n"

<7> [372.007378] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:13: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (1:2:0:1): 0xffffffff\n"

<7> [372.007672] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [372.007942] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [372.008240] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:14: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=13"

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

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

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

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

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

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

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

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

<7> [372.112043] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:15: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=15"

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

<7> [372.112536] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:15: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

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

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

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

<7> [372.114577] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [372.114932] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [372.115332] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56\n"

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

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

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

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

<7> [372.116952] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:0): 0xffffffff\n"

<7> [372.117265] xe 0000:00:02.0: [drm:clear_attn_mcr [xe]] eudbg: 3281:17: (27984/27981) -> (27983/27983): "EU_ATT_CLR: (0:0:0:1): 0xffffffff\n"

<7> [372.117574] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=56 ret=0\n"

<7> [372.117882] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [372.118233] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:18: (27984/27981) -> (27983/27983): "event read=0: type=5, flags=0x4, seqno=17"

<7> [372.118819] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "event read=0: type=4, flags=0x2, seqno=19"

<7> [372.119319] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "event read=0: type=3, flags=0x2, seqno=20"

<7> [372.119811] xe 0000:00:02.0: [drm:xe_eudebug_vm_release [xe]] eudbg: 3281:20: (27984/27981) -> (27983/27983): "vm_release: client_handle=1, vm_handle=1, flags=0x0"

<7> [372.120908] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:22: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x2, seqno=21"

<7> [372.121388] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:22: (27984/27981) -> (27983/27983): "event read=0: type=9, flags=0x2, seqno=22"

<7> [372.121772] xe 0000:00:02.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3281:23: (27984/27981) -> (27983/27983): "event read=0: type=2, flags=0x2, seqno=23"

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

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

<7> [372.287795] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off

<7> [372.288538] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00

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

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

<6> [372.322676] Console: switching to colour frame buffer device 180x56

<7> [372.350372] xe 0000:00:02.0: [drm:xe_eudebug_detach [xe]] eudbg: 3281:23:disconnected (27981/27981) -> (27983/27983): "session 3281 detached with 0"

<7> [372.350603] xe 0000:00:02.0: [drm:xe_eudebug_release [xe]] eudbg: 3281:23:disconnected (27981/27981) -> (27983/27983): "Session closed (0)"

Results for igt@xe_eudebug_online@set-breakpoint@drm_xe_engine_class_compute0