igt@xe_eudebug_online@basic-breakpoint@drm_xe_engine_class_render0 on bat-bmg-1@xkb-pr-main-259-472-bdfb513933c9e46b47cce1b2e6673956abb62fcb Test details

Detail	Value
Duration	0.26 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=1770724149 for randomisation Opened device: /dev/dri/card0 Using IGT_SRANDOM=1770724149 for randomisation Starting subtest: basic-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_RENDER0 client running with pid 32766 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:1560 test_basic_online() #3 ../tests/intel/xe_eudebug_online.c:2686 __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_RENDER0: FAIL (0.264s) Subtest basic-breakpoint: FAIL (0.268s) Test requirement not met in function xe_eudebug_enable, file ../lib/xe/xe_eudebug.c:1971: Test requirement: !(ret) Last errno: 16, Device or resource busy
Err	Starting subtest: basic-breakpoint Starting dynamic subtest: DRM_XE_ENGINE_CLASS_RENDER0 (xe_eudebug_online:32764) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:32764) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:32764) CRITICAL: error: 1024 != 512 Dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0 failed. ** DEBUG (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger: 32764 waiting for token 'client pid' (xe_eudebug_online:32764) xe/xe_eudebug-INFO: client running with pid 32766 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b01593957e0 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b0159395810 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b01593958a0 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger connected to 32766 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: 32764 signalling token 'client run' with value '32766' (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger: 32764 waiting for token 'client fini' (xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: Using simple allocator (xe_eudebug_online:32764) [thread:32767] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:32764) [thread:32767] DEBUG: EVENT[11] eu-attenttion; threads=512 client[1], exec_queue[1], lrc[1], bitmask_size[160] (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[0] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[1] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[2] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[3] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[4] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[5] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[6] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[7] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[8] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[9] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[10] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[11] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[12] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[13] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[14] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[15] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[16] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[17] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[18] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[19] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: EU CONTROL[12]: stopped (xe_eudebug_online:32764) [thread:32767] DEBUG: EU CONTROL[14]: resume (xe_eudebug_online:32764) [thread:32767] DEBUG: EVENT[13] eu-attenttion; threads=512 client[1], exec_queue[1], lrc[1], bitmask_size[160] (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[0] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[1] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[2] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[3] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[4] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[5] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[6] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[7] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[8] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[9] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[10] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[11] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[12] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[13] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[14] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[15] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[16] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[17] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[18] = 0x1313133313131333 (xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[19] = 0x1313131313131333 (xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: <ial: 0x79c4e0000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: <ial: 0x79c4e0000c20, fd: 7> objects: 0, reserved_areas: 1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: event log 'debugger' (1192 bytes): (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=1, handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (5) exec_queue(4):create: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1 (xe_eudebug_online:32764) 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=[rcs0 pad0] (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (7) vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2 (xe_eudebug_online:32764) 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:32764) 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:32764) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create\|ack: vm_bind_ref_seqno=7 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (11) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=160 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (13) attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=160 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (15) exec_queue(4):destroy: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (16) vm(3):destroy: client_handle=1, handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (17) metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (18) metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (19) client(2):destroy: handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes): (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (1) client(2):create: handle=7 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (2) metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (3) metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (4) vm(3):create: client_handle=7, handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (5) exec_queue(4):create: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1 (xe_eudebug_online:32764) 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=[rcs0 pad0] (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (7) exec_queue(4):destroy: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (8) vm(3):destroy: client_handle=7, handle=1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (9) metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (10) metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (11) client(2):destroy: handle=7 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: client: 7 -> 1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 15 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 16 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 17 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 18 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 19 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: client: 1 -> 7 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 15 vs client 7 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 16 vs client 8 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 17 vs client 9 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 18 vs client 10 (xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 11 (xe_eudebug_online:32764) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381: (xe_eudebug_online:32764) CRITICAL: Failed assertion: sum == data->thread_hit_count (xe_eudebug_online:32764) CRITICAL: error: 1024 != 512 (xe_eudebug_online:32764) igt_core-INFO: Stack trace: (xe_eudebug_online:32764) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_eudebug_online:32764) igt_core-INFO: #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check() (xe_eudebug_online:32764) igt_core-INFO: #2 ../tests/intel/xe_eudebug_online.c:1560 test_basic_online() (xe_eudebug_online:32764) igt_core-INFO: #3 ../tests/intel/xe_eudebug_online.c:2686 __igt_unique____real_main2671() (xe_eudebug_online:32764) igt_core-INFO: #4 ../tests/intel/xe_eudebug_online.c:2671 main() (xe_eudebug_online:32764) igt_core-INFO: #5 [__libc_init_first+0x8a] (xe_eudebug_online:32764) igt_core-INFO: #6 [__libc_start_main+0x8b] (xe_eudebug_online:32764) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0: FAIL (0.264s) Subtest basic-breakpoint: FAIL (0.268s)
Dmesg	<6> [422.659277] Console: switching to colour dummy device 80x25 <6> [422.659646] [IGT] xe_eudebug_online: executing <6> [422.667039] xe 0000:03:00.0: [drm] Tile0: GT0: trying reset from xe_eudebug_enable [xe] <6> [422.667207] xe 0000:03:00.0: [drm] Tile0: GT0: reset queued <6> [422.667357] xe 0000:03:00.0: [drm] Tile0: GT0: reset started <7> [422.667905] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped <7> [422.668142] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs <7> [422.668267] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000 <7> [422.668407] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000 <7> [422.668521] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb0c8] = 0x55555440 <7> [422.668644] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440 <7> [422.668748] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000 <7> [422.668857] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f <7> [422.668962] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K <7> [422.669091] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K) <7> [422.669257] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled <7> [422.670406] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 45056) <7> [422.680321] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: GuC load: init took 9ms, freq = 2150MHz (req = 2133MHz), before = 2150MHz, status = 0x8002F034 <7> [422.680711] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel enabled <7> [422.682352] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: flag:0x1 <7> [422.682566] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: mocs entries: 16 <7> [422.682770] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[0] 0x4000 0xc <7> [422.682971] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[1] 0x4004 0x10c <7> [422.683170] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[2] 0x4008 0x130 <7> [422.683386] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[3] 0x400c 0x13c <7> [422.683587] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[4] 0x4010 0x100 <7> [422.683792] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[5] 0x4014 0x100 <7> [422.683998] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[6] 0x4018 0x100 <7> [422.684207] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[7] 0x401c 0x100 <7> [422.684493] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[8] 0x4020 0x100 <7> [422.684701] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[9] 0x4024 0x100 <7> [422.684906] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[10] 0x4028 0x100 <7> [422.685109] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[11] 0x402c 0x100 <7> [422.685331] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[12] 0x4030 0x100 <7> [422.685556] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[13] 0x4034 0x100 <7> [422.685778] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[14] 0x4038 0x100 <7> [422.686002] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[15] 0x403c 0x100 <7> [422.686220] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying rcs0 save-restore MMIOs <7> [422.686500] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x2050] = 0x10001000 <7> [422.686748] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20c4] = 0x3f7e0306 <7> [422.686985] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20d4] = 0xc080c080 <7> [422.687222] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d0] = 0x1000dafc <7> [422.687474] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d4] = 0x1000db01 <7> [422.687709] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d8] = 0x0000db1c <7> [422.687969] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x7044] = 0x04200420 <7> [422.688239] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe194] = 0x00400040 <7> [422.688530] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe400] = 0x00000095 <7> [422.688788] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe48c] = 0x02000200 <7> [422.689038] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe49c] = 0x40004000 <7> [422.689291] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4c4] = 0x10401040 <7> [422.689563] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4f0] = 0x00020002 <7> [422.689800] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7c8] = 0x04002000 <7> [422.690032] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00009000 <7> [422.690265] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x14800] = 0x00020002 <7> [422.690514] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs0 save-restore MMIOs <7> [422.690727] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x22050] = 0x10001000 <7> [422.690939] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220c4] = 0x3f7e0306 <7> [422.691142] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220d4] = 0xc080c080 <7> [422.691348] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs8 save-restore MMIOs <7> [422.691547] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee050] = 0x10001000 <7> [422.691743] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0c4] = 0x3f7e0306 <7> [422.691929] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0d4] = 0xc080c080 <7> [422.692120] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs0 save-restore MMIOs <7> [422.692302] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a050] = 0x10001000 <7> [422.692516] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0c4] = 0x3f7e0308 <7> [422.692695] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0d4] = 0xc080c080 <7> [422.692867] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d0] = 0x1000dafc <7> [422.693028] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d4] = 0x1000db01 <7> [422.693183] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d8] = 0x0000db1c <7> [422.693356] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs1 save-restore MMIOs <7> [422.693516] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c050] = 0x10001000 <7> [422.693677] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0c4] = 0x3f7e0308 <7> [422.693827] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0d4] = 0xc080c080 <7> [422.693978] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d0] = 0x1000dafc <7> [422.694126] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d4] = 0x1000db01 <7> [422.694267] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d8] = 0x0000db1c <7> [422.694431] xe 0000:03:00.0: [drm:xe_gt_apply_ccs_mode [xe]] Tile0: GT0: CCS_MODE=fff0fc0 config:00400000, num_engines:1, num_slices:2 <6> [422.694617] xe 0000:03:00.0: [drm] Tile0: GT0: reset done <6> [422.694639] xe 0000:03:00.0: [drm] Tile0: GT1: trying reset from xe_eudebug_enable [xe] <6> [422.694931] xe 0000:03:00.0: [drm] Tile0: GT1: reset queued <6> [422.695710] xe 0000:03:00.0: [drm] Tile0: GT1: reset started <7> [422.695983] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel stopped <7> [422.696164] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying GT save-restore MMIOs <7> [422.696341] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x4148] = 0x00000000 <7> [422.696486] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c3f08] = 0x00000020 <7> [422.696604] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c3f1c] = 0x00800008 <7> [422.696723] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d3f08] = 0x00000020 <7> [422.696835] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d3f1c] = 0x00800008 <7> [422.696948] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K <7> [422.697090] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [5136K, 832K) <7> [422.697268] xe 0000:03:00.0: [drm:xe_gt_sriov_pf_config_restart [xe]] PF: Tile0: GT0: pushed 0 skip 24 of 24 VFs configurations <7> [422.697332] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel disabled <7> [422.697492] xe 0000:03:00.0: [drm:pf_worker_restart_func [xe]] PF: Tile0: GT0: restart completed <7> [422.698464] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT1: Updated ADS capture size 20480 (was 45056) <7> [422.709231] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT1: GuC load: init took 10ms, freq = 1500MHz (req = 1500MHz), before = 1500MHz, status = 0x8002F034 <7> [422.709568] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel enabled <7> [422.710467] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: flag:0x1 <7> [422.710598] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: mocs entries: 16 <7> [422.710720] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[0] 0x4000 0xc <7> [422.710836] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[1] 0x4004 0x10c <7> [422.710951] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[2] 0x4008 0x130 <7> [422.711059] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[3] 0x400c 0x13c <7> [422.711166] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[4] 0x4010 0x100 <7> [422.711272] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[5] 0x4014 0x100 <7> [422.711398] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[6] 0x4018 0x100 <7> [422.711502] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[7] 0x401c 0x100 <7> [422.711603] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[8] 0x4020 0x100 <7> [422.711703] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[9] 0x4024 0x100 <7> [422.711803] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[10] 0x4028 0x100 <7> [422.711903] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[11] 0x402c 0x100 <7> [422.712000] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[12] 0x4030 0x100 <7> [422.712098] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[13] 0x4034 0x100 <7> [422.712188] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[14] 0x4038 0x100 <7> [422.712279] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[15] 0x403c 0x100 <7> [422.712386] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vcs0 save-restore MMIOs <7> [422.712492] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c0050] = 0x10001000 <7> [422.712596] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c00d4] = 0xc000c000 <7> [422.712705] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vcs2 save-restore MMIOs <7> [422.712804] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d0050] = 0x10001000 <7> [422.712900] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d00d4] = 0xc000c000 <7> [422.713000] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vecs0 save-restore MMIOs <7> [422.713092] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c8050] = 0x10001000 <7> [422.713180] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c80d4] = 0xc000c000 <7> [422.713278] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vecs1 save-restore MMIOs <7> [422.713378] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d8050] = 0x10001000 <7> [422.713464] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d80d4] = 0xc000c000 <6> [422.713577] xe 0000:03:00.0: [drm] Tile0: GT1: reset done <6> [422.714728] [IGT] xe_eudebug_online: starting subtest basic-breakpoint <7> [422.714712] xe 0000:03:00.0: [drm:xe_gt_sriov_pf_config_restart [xe]] PF: Tile0: GT1: pushed 0 skip 24 of 24 VFs configurations <7> [422.714822] xe 0000:03:00.0: [drm:pf_worker_restart_func [xe]] PF: Tile0: GT1: restart completed <6> [422.715173] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0 <7> [422.719042] xe 0000:03:00.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3268:0: (32764/32764) -> (32766/32766): "connected session 3268" <7> [422.719226] xe 0000:03:00.0: [drm:discovery_work_fn [xe]] eudbg: 3268:0: (12300/12300) -> (32766/32766): "Discovery start for 3268\n" <7> [422.719338] xe 0000:03:00.0: [drm:discovery_work_fn [xe]] eudbg: 3268:0: (12300/12300) -> (32766/32766): "Discovery end for 3268\n" <7> [422.719851] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:1: (32767/32764) -> (32766/32766): "event read=0: type=2, flags=0x1, seqno=1" <7> [422.720177] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:3: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x1, seqno=2" <7> [422.720392] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:3: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x1, seqno=3" <7> [422.721066] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:4: (32767/32764) -> (32766/32766): "event read=0: type=3, flags=0x1, seqno=4" <7> [422.721906] xe 0000:03:00.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff0088 <7> [422.722000] xe 0000:03:00.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff0088 <7> [422.722142] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:6: (32767/32764) -> (32766/32766): "event read=0: type=4, flags=0x1, seqno=5" <7> [422.722237] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:6: (32767/32764) -> (32766/32766): "event read=0: type=13, flags=0x1, seqno=6" <7> [422.724811] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:9: (32767/32764) -> (32766/32766): "event read=0: type=6, flags=0x4, seqno=7" <7> [422.724828] xe 0000:03:00.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3268:10: (12292/12292) -> (32766/32766): "ACK: seqno=10: tracking started" <7> [422.724909] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=7, flags=0x1, seqno=8" <7> [422.725006] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=7, flags=0x1, seqno=9" <7> [422.725106] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=8, flags=0x9, seqno=10" <7> [422.725293] xe 0000:03:00.0: [drm:handle_ack [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "ACK: seqno=10: signalled by 10 (debugger) (held 465us)" <7> [422.725417] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "ioctl cmd=EVENT_ACK ret=0\n" <7> [422.824741] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280 <7> [422.825291] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active <7> [422.825815] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found <7> [422.826364] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive <7> [422.826858] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive <7> [422.828590] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280 <7> [422.828689] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:11: (32767/32764) -> (32766/32766): "event read=0: type=5, flags=0x4, seqno=11" <7> [422.828997] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active <7> [422.829415] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found <7> [422.829500] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:11: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=160\n" <7> [422.829879] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive <7> [422.830266] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive <7> [422.830309] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280 <7> [422.830385] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280 <7> [422.830401] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active <7> [422.830479] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active <7> [422.830482] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found <7> [422.830547] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found <7> [422.830556] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive <7> [422.830614] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive <7> [422.830628] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive <7> [422.830681] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive <7> [422.830948] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=160 ret=0\n" <7> [422.831030] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "ioctl cmd=EU_CONTROL ret=0\n" <7> [422.831139] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=160\n" <7> [422.831231] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280 <7> [422.831338] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active <7> [422.831415] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found <7> [422.831489] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive <7> [422.831560] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive <7> [422.831649] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:0:0:0): 0x13131333\n" <7> [422.831722] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:0:0:1): 0x13131333\n" <7> [422.831794] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:1:0:0): 0x13131333\n" <7> [422.831866] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:1:0:1): 0x13131333\n" <7> [422.831938] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:2:0:0): 0x13131333\n" <7> [422.832009] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:2:0:1): 0x13131333\n" <7> [422.832082] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:3:0:0): 0x13131313\n" <7> [422.832153] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:3:0:1): 0x13131333\n" <7> [422.832225] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:0:0:0): 0x13131333\n" <7> [422.832305] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:0:0:1): 0x13131333\n" <7> [422.832388] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:1:0:0): 0x13131313\n" <7> [422.832469] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:1:0:1): 0x13131333\n" <7> [422.832541] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:2:0:0): 0x13131333\n" <7> [422.832612] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:2:0:1): 0x13131333\n" <7> [422.832683] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:3:0:0): 0x13131313\n" <7> [422.832755] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:3:0:1): 0x13131333\n" <7> [422.832826] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:0:0:0): 0x13131333\n" <7> [422.832898] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:0:0:1): 0x13131333\n" <7> [422.832969] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:1:0:0): 0x13131313\n" <7> [422.833040] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:1:0:1): 0x13131333\n" <7> [422.833111] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:2:0:0): 0x13131333\n" <7> [422.833180] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:2:0:1): 0x13131333\n" <7> [422.833250] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:3:0:0): 0x13131333\n" <7> [422.833326] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:3:0:1): 0x13131333\n" <7> [422.833405] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:0:0:0): 0x13131333\n" <7> [422.833480] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:0:0:1): 0x13131333\n" <7> [422.833550] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:1:0:0): 0x13131313\n" <7> [422.833619] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:1:0:1): 0x13131333\n" <7> [422.833691] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:2:0:0): 0x13131333\n" <7> [422.833760] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:2:0:1): 0x13131333\n" <7> [422.833832] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:3:0:0): 0x13131313\n" <7> [422.833904] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:3:0:1): 0x13131333\n" <7> [422.833975] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:0:0:0): 0x13131333\n" <7> [422.834046] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:0:0:1): 0x13131333\n" <7> [422.834119] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:1:0:0): 0x13131313\n" <7> [422.834190] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:1:0:1): 0x13131333\n" <7> [422.834260] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:2:0:0): 0x13131333\n" <7> [422.834345] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:2:0:1): 0x13131333\n" <7> [422.834426] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:3:0:0): 0x13131313\n" <7> [422.834507] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:3:0:1): 0x13131333\n" <7> [422.834594] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=160 ret=0\n" <7> [422.834672] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "ioctl cmd=EU_CONTROL ret=0\n" <7> [422.834752] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "event read=0: type=5, flags=0x4, seqno=13" <7> [422.836001] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:16: (32767/32764) -> (32766/32766): "event read=0: type=4, flags=0x2, seqno=15" <7> [422.836112] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:16: (32767/32764) -> (32766/32766): "event read=0: type=3, flags=0x2, seqno=16" <7> [422.836547] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:18: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x2, seqno=17" <7> [422.836663] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:19: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x2, seqno=18" <7> [422.836761] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:19: (32767/32764) -> (32766/32766): "event read=0: type=2, flags=0x2, seqno=19" <6> [422.979808] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_RENDER0, FAIL <6> [422.983116] [IGT] xe_eudebug_online: finished subtest basic-breakpoint, FAIL <6> [422.983964] [IGT] xe_eudebug_online: exiting, ret=98 <6> [422.985056] Console: switching to colour frame buffer device 240x67 <7> [422.992095] xe 0000:03:00.0: [drm:xe_eudebug_detach [xe]] eudbg: 3268:19:disconnected (32765/32764) -> (32766/32766): "session 3268 detached with 0" <7> [422.992225] xe 0000:03:00.0: [drm:xe_eudebug_release [xe]] eudbg: 3268:19:disconnected (32765/32764) -> (32766/32766): "Session closed (0)" <7> [423.002180] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

0.26 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=1770724149 for randomisation
Opened device: /dev/dri/card0
Using IGT_SRANDOM=1770724149 for randomisation
Starting subtest: basic-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_RENDER0
client running with pid 32766
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:1560 test_basic_online()
  #3 ../tests/intel/xe_eudebug_online.c:2686 __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_RENDER0: FAIL (0.264s)
Subtest basic-breakpoint: FAIL (0.268s)
Test requirement not met in function xe_eudebug_enable, file ../lib/xe/xe_eudebug.c:1971:
Test requirement: !(ret)
Last errno: 16, Device or resource busy

Err

Starting subtest: basic-breakpoint
Starting dynamic subtest: DRM_XE_ENGINE_CLASS_RENDER0
(xe_eudebug_online:32764) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:32764) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:32764) CRITICAL: error: 1024 != 512
Dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0 failed.
**** DEBUG ****
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger: 32764 waiting for token 'client pid'
(xe_eudebug_online:32764) xe/xe_eudebug-INFO: client running with pid 32766
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b01593957e0
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b0159395810
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: added trigger 0x5b01593958a0
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger connected to 32766
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: 32764 signalling token 'client run' with value '32766'
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: debugger: 32764 waiting for token 'client fini'
(xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: Using simple allocator
(xe_eudebug_online:32764) [thread:32767] xe/xe_eudebug-DEBUG: delivering ack for event: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:32764) [thread:32767] DEBUG: EVENT[11] eu-attenttion; threads=512 client[1], exec_queue[1], lrc[1], bitmask_size[160]
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[0] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[1] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[2] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[3] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[4] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[5] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[6] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[7] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[8] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[9] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[10] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[11] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[12] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[13] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[14] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[15] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[16] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[17] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[18] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[19] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: EU CONTROL[12]: stopped
(xe_eudebug_online:32764) [thread:32767] DEBUG: EU CONTROL[14]: resume
(xe_eudebug_online:32764) [thread:32767] DEBUG: EVENT[13] eu-attenttion; threads=512 client[1], exec_queue[1], lrc[1], bitmask_size[160]
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[0] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[1] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[2] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[3] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[4] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[5] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[6] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[7] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[8] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[9] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[10] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[11] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[12] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[13] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[14] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[15] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[16] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[17] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[18] = 0x1313133313131333
(xe_eudebug_online:32764) [thread:32767] DEBUG: bitmask[19] = 0x1313131313131333
(xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: <ial: 0x79c4e0000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:32764) [thread:32765] intel_allocator_simple-DEBUG: <ial: 0x79c4e0000c20, fd: 7> objects: 0, reserved_areas: 1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: event log 'debugger' (1192 bytes):
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=1, handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (5)   exec_queue(4):create: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1
(xe_eudebug_online:32764) 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=[rcs0 pad0] 
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (7)      vm_bind(6):state-change: client_handle=1, vm_handle=1, flags=0x1, num_binds=2
(xe_eudebug_online:32764) 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:32764) 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:32764) xe/xe_eudebug-DEBUG: (10) vm_bind_ufence(8):create|ack: vm_bind_ref_seqno=7
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (11)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=160
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (13)    attention(5):state-change: client_handle=1, exec_queue_handle=1, lrc_handle=1, bitmask_size=160
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (15)   exec_queue(4):destroy: client_handle=1, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (16)           vm(3):destroy: client_handle=1, handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (17)     metadata(9):destroy: client_handle=1, metadata_handle=1, type=0, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (18)     metadata(9):destroy: client_handle=1, metadata_handle=2, type=1, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (19)       client(2):destroy: handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: event log 'client' (552 bytes):
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (1)       client(2):create: handle=7
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (2)     metadata(9):create: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (3)     metadata(9):create: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (4)           vm(3):create: client_handle=7, handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (5)   exec_queue(4):create: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1
(xe_eudebug_online:32764) 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=[rcs0 pad0] 
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (7)   exec_queue(4):destroy: client_handle=7, vm_handle=1, exec_queue_handle=1, engine_class=0, exec_queue_width=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (8)           vm(3):destroy: client_handle=7, handle=1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (9)     metadata(9):destroy: client_handle=7, metadata_handle=1, type=0, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (10)     metadata(9):destroy: client_handle=7, metadata_handle=2, type=1, len=16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: (11)       client(2):destroy: handle=7
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: client: 7 -> 1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 1 vs debugger 1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 2 vs debugger 2
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 3 vs debugger 3
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 4 vs debugger 4
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 5 vs debugger 5
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 6 vs debugger 6
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 7 vs debugger 15
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 8 vs debugger 16
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 9 vs debugger 17
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 10 vs debugger 18
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing client 11 vs debugger 19
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: client: 1 -> 7
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 1 vs client 1
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 2 vs client 2
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 3 vs client 3
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 4 vs client 4
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 5 vs client 5
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 6 vs client 6
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 15 vs client 7
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 16 vs client 8
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 17 vs client 9
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 18 vs client 10
(xe_eudebug_online:32764) xe/xe_eudebug-DEBUG: comparing debugger 19 vs client 11
(xe_eudebug_online:32764) CRITICAL: Test assertion failure function online_session_check, file ../tests/intel/xe_eudebug_online.c:1381:
(xe_eudebug_online:32764) CRITICAL: Failed assertion: sum == data->thread_hit_count
(xe_eudebug_online:32764) CRITICAL: error: 1024 != 512
(xe_eudebug_online:32764) igt_core-INFO: Stack trace:
(xe_eudebug_online:32764) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_eudebug_online:32764) igt_core-INFO:   #1 ../tests/intel/xe_eudebug_online.c:1386 online_session_check()
(xe_eudebug_online:32764) igt_core-INFO:   #2 ../tests/intel/xe_eudebug_online.c:1560 test_basic_online()
(xe_eudebug_online:32764) igt_core-INFO:   #3 ../tests/intel/xe_eudebug_online.c:2686 __igt_unique____real_main2671()
(xe_eudebug_online:32764) igt_core-INFO:   #4 ../tests/intel/xe_eudebug_online.c:2671 main()
(xe_eudebug_online:32764) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(xe_eudebug_online:32764) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(xe_eudebug_online:32764) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0: FAIL (0.264s)
Subtest basic-breakpoint: FAIL (0.268s)

Dmesg

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

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

<6> [422.667039] xe 0000:03:00.0: [drm] Tile0: GT0: trying reset from xe_eudebug_enable [xe]

<6> [422.667207] xe 0000:03:00.0: [drm] Tile0: GT0: reset queued

<6> [422.667357] xe 0000:03:00.0: [drm] Tile0: GT0: reset started

<7> [422.667905] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped

<7> [422.668142] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs

<7> [422.668267] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000

<7> [422.668407] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000

<7> [422.668521] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb0c8] = 0x55555440

<7> [422.668644] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440

<7> [422.668748] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000

<7> [422.668857] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f

<7> [422.668962] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K

<7> [422.669091] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K)

<7> [422.669257] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled

<7> [422.670406] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 45056)

<7> [422.680321] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: GuC load: init took 9ms, freq = 2150MHz (req = 2133MHz), before = 2150MHz, status = 0x8002F034

<7> [422.680711] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel enabled

<7> [422.682352] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: flag:0x1

<7> [422.682566] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: mocs entries: 16

<7> [422.682770] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[0] 0x4000 0xc

<7> [422.682971] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[1] 0x4004 0x10c

<7> [422.683170] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[2] 0x4008 0x130

<7> [422.683386] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[3] 0x400c 0x13c

<7> [422.683587] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[4] 0x4010 0x100

<7> [422.683792] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[5] 0x4014 0x100

<7> [422.683998] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[6] 0x4018 0x100

<7> [422.684207] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[7] 0x401c 0x100

<7> [422.684493] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[8] 0x4020 0x100

<7> [422.684701] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[9] 0x4024 0x100

<7> [422.684906] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[10] 0x4028 0x100

<7> [422.685109] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[11] 0x402c 0x100

<7> [422.685331] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[12] 0x4030 0x100

<7> [422.685556] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[13] 0x4034 0x100

<7> [422.685778] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[14] 0x4038 0x100

<7> [422.686002] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[15] 0x403c 0x100

<7> [422.686220] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying rcs0 save-restore MMIOs

<7> [422.686500] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x2050] = 0x10001000

<7> [422.686748] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20c4] = 0x3f7e0306

<7> [422.686985] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20d4] = 0xc080c080

<7> [422.687222] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d0] = 0x1000dafc

<7> [422.687474] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d4] = 0x1000db01

<7> [422.687709] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d8] = 0x0000db1c

<7> [422.687969] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x7044] = 0x04200420

<7> [422.688239] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe194] = 0x00400040

<7> [422.688530] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe400] = 0x00000095

<7> [422.688788] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe48c] = 0x02000200

<7> [422.689038] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe49c] = 0x40004000

<7> [422.689291] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4c4] = 0x10401040

<7> [422.689563] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4f0] = 0x00020002

<7> [422.689800] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7c8] = 0x04002000

<7> [422.690032] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00009000

<7> [422.690265] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x14800] = 0x00020002

<7> [422.690514] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs0 save-restore MMIOs

<7> [422.690727] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x22050] = 0x10001000

<7> [422.690939] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220c4] = 0x3f7e0306

<7> [422.691142] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220d4] = 0xc080c080

<7> [422.691348] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs8 save-restore MMIOs

<7> [422.691547] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee050] = 0x10001000

<7> [422.691743] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0c4] = 0x3f7e0306

<7> [422.691929] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0d4] = 0xc080c080

<7> [422.692120] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs0 save-restore MMIOs

<7> [422.692302] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a050] = 0x10001000

<7> [422.692516] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0c4] = 0x3f7e0308

<7> [422.692695] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0d4] = 0xc080c080

<7> [422.692867] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d0] = 0x1000dafc

<7> [422.693028] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d4] = 0x1000db01

<7> [422.693183] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d8] = 0x0000db1c

<7> [422.693356] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs1 save-restore MMIOs

<7> [422.693516] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c050] = 0x10001000

<7> [422.693677] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0c4] = 0x3f7e0308

<7> [422.693827] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0d4] = 0xc080c080

<7> [422.693978] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d0] = 0x1000dafc

<7> [422.694126] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d4] = 0x1000db01

<7> [422.694267] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d8] = 0x0000db1c

<7> [422.694431] xe 0000:03:00.0: [drm:xe_gt_apply_ccs_mode [xe]] Tile0: GT0: CCS_MODE=fff0fc0 config:00400000, num_engines:1, num_slices:2

<6> [422.694617] xe 0000:03:00.0: [drm] Tile0: GT0: reset done

<6> [422.694639] xe 0000:03:00.0: [drm] Tile0: GT1: trying reset from xe_eudebug_enable [xe]

<6> [422.694931] xe 0000:03:00.0: [drm] Tile0: GT1: reset queued

<6> [422.695710] xe 0000:03:00.0: [drm] Tile0: GT1: reset started

<7> [422.695983] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel stopped

<7> [422.696164] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying GT save-restore MMIOs

<7> [422.696341] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x4148] = 0x00000000

<7> [422.696486] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c3f08] = 0x00000020

<7> [422.696604] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c3f1c] = 0x00800008

<7> [422.696723] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d3f08] = 0x00000020

<7> [422.696835] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d3f1c] = 0x00800008

<7> [422.696948] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K

<7> [422.697090] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [5136K, 832K)

<7> [422.697268] xe 0000:03:00.0: [drm:xe_gt_sriov_pf_config_restart [xe]] PF: Tile0: GT0: pushed 0 skip 24 of 24 VFs configurations

<7> [422.697332] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel disabled

<7> [422.697492] xe 0000:03:00.0: [drm:pf_worker_restart_func [xe]] PF: Tile0: GT0: restart completed

<7> [422.698464] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT1: Updated ADS capture size 20480 (was 45056)

<7> [422.709231] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT1: GuC load: init took 10ms, freq = 1500MHz (req = 1500MHz), before = 1500MHz, status = 0x8002F034

<7> [422.709568] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT1: GuC CT communication channel enabled

<7> [422.710467] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: flag:0x1

<7> [422.710598] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: mocs entries: 16

<7> [422.710720] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[0] 0x4000 0xc

<7> [422.710836] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[1] 0x4004 0x10c

<7> [422.710951] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[2] 0x4008 0x130

<7> [422.711059] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[3] 0x400c 0x13c

<7> [422.711166] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[4] 0x4010 0x100

<7> [422.711272] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[5] 0x4014 0x100

<7> [422.711398] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[6] 0x4018 0x100

<7> [422.711502] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[7] 0x401c 0x100

<7> [422.711603] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[8] 0x4020 0x100

<7> [422.711703] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[9] 0x4024 0x100

<7> [422.711803] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[10] 0x4028 0x100

<7> [422.711903] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[11] 0x402c 0x100

<7> [422.712000] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[12] 0x4030 0x100

<7> [422.712098] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[13] 0x4034 0x100

<7> [422.712188] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[14] 0x4038 0x100

<7> [422.712279] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT1: GLOB_MOCS[15] 0x403c 0x100

<7> [422.712386] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vcs0 save-restore MMIOs

<7> [422.712492] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c0050] = 0x10001000

<7> [422.712596] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c00d4] = 0xc000c000

<7> [422.712705] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vcs2 save-restore MMIOs

<7> [422.712804] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d0050] = 0x10001000

<7> [422.712900] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d00d4] = 0xc000c000

<7> [422.713000] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vecs0 save-restore MMIOs

<7> [422.713092] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c8050] = 0x10001000

<7> [422.713180] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1c80d4] = 0xc000c000

<7> [422.713278] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: Applying vecs1 save-restore MMIOs

<7> [422.713378] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d8050] = 0x10001000

<7> [422.713464] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT1: REG[0x1d80d4] = 0xc000c000

<6> [422.713577] xe 0000:03:00.0: [drm] Tile0: GT1: reset done

<6> [422.714728] [IGT] xe_eudebug_online: starting subtest basic-breakpoint

<7> [422.714712] xe 0000:03:00.0: [drm:xe_gt_sriov_pf_config_restart [xe]] PF: Tile0: GT1: pushed 0 skip 24 of 24 VFs configurations

<7> [422.714822] xe 0000:03:00.0: [drm:pf_worker_restart_func [xe]] PF: Tile0: GT1: restart completed

<6> [422.715173] [IGT] xe_eudebug_online: starting dynamic subtest DRM_XE_ENGINE_CLASS_RENDER0

<7> [422.719042] xe 0000:03:00.0: [drm:prelim_xe_eudebug_connect_ioctl [xe]] eudbg: 3268:0: (32764/32764) -> (32766/32766): "connected session 3268"

<7> [422.719226] xe 0000:03:00.0: [drm:discovery_work_fn [xe]] eudbg: 3268:0: (12300/12300) -> (32766/32766): "Discovery start for 3268\n"

<7> [422.719338] xe 0000:03:00.0: [drm:discovery_work_fn [xe]] eudbg: 3268:0: (12300/12300) -> (32766/32766): "Discovery end for 3268\n"

<7> [422.719851] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:1: (32767/32764) -> (32766/32766): "event read=0: type=2, flags=0x1, seqno=1"

<7> [422.720177] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:3: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x1, seqno=2"

<7> [422.720392] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:3: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x1, seqno=3"

<7> [422.721066] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:4: (32767/32764) -> (32766/32766): "event read=0: type=3, flags=0x1, seqno=4"

<7> [422.721906] xe 0000:03:00.0: [drm:xe_lrc_create [xe]] read CTX_CONTEXT_CONTROL: 0xffff0088

<7> [422.722000] xe 0000:03:00.0: [drm:xe_lrc_create [xe]] written CTX_CONTEXT_CONTROL: 0xffff0088

<7> [422.722142] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:6: (32767/32764) -> (32766/32766): "event read=0: type=4, flags=0x1, seqno=5"

<7> [422.722237] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:6: (32767/32764) -> (32766/32766): "event read=0: type=13, flags=0x1, seqno=6"

<7> [422.724811] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:9: (32767/32764) -> (32766/32766): "event read=0: type=6, flags=0x4, seqno=7"

<7> [422.724828] xe 0000:03:00.0: [drm:prelim_xe_eudebug_vm_bind_ufence [xe]] eudbg: 3268:10: (12292/12292) -> (32766/32766): "ACK: seqno=10: tracking started"

<7> [422.724909] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=7, flags=0x1, seqno=8"

<7> [422.725006] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=7, flags=0x1, seqno=9"

<7> [422.725106] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "event read=0: type=8, flags=0x9, seqno=10"

<7> [422.725293] xe 0000:03:00.0: [drm:handle_ack [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "ACK: seqno=10: signalled by 10 (debugger) (held 465us)"

<7> [422.725417] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:10: (32767/32764) -> (32766/32766): "ioctl cmd=EVENT_ACK ret=0\n"

<7> [422.824741] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280

<7> [422.825291] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active

<7> [422.825815] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found

<7> [422.826364] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive

<7> [422.826858] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive

<7> [422.828590] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280

<7> [422.828689] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:11: (32767/32764) -> (32766/32766): "event read=0: type=5, flags=0x4, seqno=11"

<7> [422.828997] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active

<7> [422.829415] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found

<7> [422.829500] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:11: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=160\n"

<7> [422.829879] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive

<7> [422.830266] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive

<7> [422.830309] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280

<7> [422.830385] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280

<7> [422.830401] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active

<7> [422.830479] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active

<7> [422.830482] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found

<7> [422.830547] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found

<7> [422.830556] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive

<7> [422.830614] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive

<7> [422.830628] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive

<7> [422.830681] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive

<7> [422.830948] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=1, flags=0x0, exec_queue_handle=1, bitmask_size=160 ret=0\n"

<7> [422.831030] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [422.831139] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=160\n"

<7> [422.831231] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone RCU_DEBUG_1 = 0x00000280

<7> [422.831338] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine rcs0: runalone=active, context=active

<7> [422.831415] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: runalone engine rcs0 found

<7> [422.831489] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs0: runalone=inactive, context=inactive

<7> [422.831560] xe 0000:03:00.0: [drm:get_runalone_active_hw_engine [xe]] eudbg: engine ccs1: runalone=inactive, context=inactive

<7> [422.831649] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:0:0:0): 0x13131333\n"

<7> [422.831722] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:0:0:1): 0x13131333\n"

<7> [422.831794] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:1:0:0): 0x13131333\n"

<7> [422.831866] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:1:0:1): 0x13131333\n"

<7> [422.831938] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:2:0:0): 0x13131333\n"

<7> [422.832009] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:2:0:1): 0x13131333\n"

<7> [422.832082] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:3:0:0): 0x13131313\n"

<7> [422.832153] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (0:3:0:1): 0x13131333\n"

<7> [422.832225] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:0:0:0): 0x13131333\n"

<7> [422.832305] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:0:0:1): 0x13131333\n"

<7> [422.832388] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:1:0:0): 0x13131313\n"

<7> [422.832469] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:1:0:1): 0x13131333\n"

<7> [422.832541] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:2:0:0): 0x13131333\n"

<7> [422.832612] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:2:0:1): 0x13131333\n"

<7> [422.832683] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:3:0:0): 0x13131313\n"

<7> [422.832755] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (1:3:0:1): 0x13131333\n"

<7> [422.832826] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:0:0:0): 0x13131333\n"

<7> [422.832898] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:0:0:1): 0x13131333\n"

<7> [422.832969] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:1:0:0): 0x13131313\n"

<7> [422.833040] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:1:0:1): 0x13131333\n"

<7> [422.833111] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:2:0:0): 0x13131333\n"

<7> [422.833180] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:2:0:1): 0x13131333\n"

<7> [422.833250] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:3:0:0): 0x13131333\n"

<7> [422.833326] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (2:3:0:1): 0x13131333\n"

<7> [422.833405] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:0:0:0): 0x13131333\n"

<7> [422.833480] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:0:0:1): 0x13131333\n"

<7> [422.833550] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:1:0:0): 0x13131313\n"

<7> [422.833619] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:1:0:1): 0x13131333\n"

<7> [422.833691] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:2:0:0): 0x13131333\n"

<7> [422.833760] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:2:0:1): 0x13131333\n"

<7> [422.833832] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:3:0:0): 0x13131313\n"

<7> [422.833904] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (3:3:0:1): 0x13131333\n"

<7> [422.833975] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:0:0:0): 0x13131333\n"

<7> [422.834046] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:0:0:1): 0x13131333\n"

<7> [422.834119] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:1:0:0): 0x13131313\n"

<7> [422.834190] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:1:0:1): 0x13131333\n"

<7> [422.834260] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:2:0:0): 0x13131333\n"

<7> [422.834345] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:2:0:1): 0x13131333\n"

<7> [422.834426] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:3:0:0): 0x13131313\n"

<7> [422.834507] xe 0000:03:00.0: [drm:clear_attn_mcr [xe]] eudbg: 3268:13: (32767/32764) -> (32766/32766): "EU_ATT_CLR: (4:3:0:1): 0x13131333\n"

<7> [422.834594] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "eu_control: client_handle=1, cmd=2, flags=0x0, exec_queue_handle=1, bitmask_size=160 ret=0\n"

<7> [422.834672] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "ioctl cmd=EU_CONTROL ret=0\n"

<7> [422.834752] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:14: (32767/32764) -> (32766/32766): "event read=0: type=5, flags=0x4, seqno=13"

<7> [422.836001] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:16: (32767/32764) -> (32766/32766): "event read=0: type=4, flags=0x2, seqno=15"

<7> [422.836112] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:16: (32767/32764) -> (32766/32766): "event read=0: type=3, flags=0x2, seqno=16"

<7> [422.836547] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:18: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x2, seqno=17"

<7> [422.836663] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:19: (32767/32764) -> (32766/32766): "event read=0: type=9, flags=0x2, seqno=18"

<7> [422.836761] xe 0000:03:00.0: [drm:xe_eudebug_ioctl [xe]] eudbg: 3268:19: (32767/32764) -> (32766/32766): "event read=0: type=2, flags=0x2, seqno=19"

<6> [422.979808] [IGT] xe_eudebug_online: finished subtest DRM_XE_ENGINE_CLASS_RENDER0, FAIL

<6> [422.983116] [IGT] xe_eudebug_online: finished subtest basic-breakpoint, FAIL

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

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

<7> [422.992095] xe 0000:03:00.0: [drm:xe_eudebug_detach [xe]] eudbg: 3268:19:disconnected (32765/32764) -> (32766/32766): "session 3268 detached with 0"

<7> [422.992225] xe 0000:03:00.0: [drm:xe_eudebug_release [xe]] eudbg: 3268:19:disconnected (32765/32764) -> (32766/32766): "Session closed (0)"

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

Results for igt@xe_eudebug_online@basic-breakpoint@drm_xe_engine_class_render0