igt@xe_exec_system_allocator@evict-malloc on shard-bmg@xe-3814-d2f002c868da5926fabd73b1ba2ab7a2b66d81dc Test details

Results for igt@xe_exec_system_allocator@evict-malloc

Detail	Value
Duration	unknown
Hostname	shard-bmg-6
Igt-Version	IGT-Version: 2.1-g477154cba (x86_64) (Linux: 6.17.0-rc7-lgci-xe-xe-3814-d2f002c868da5926f+ x86_64)
Out	Using IGT_SRANDOM=1758626841 for randomisation Opened device: /dev/dri/card0 Starting subtest: evict-malloc FAIL EXEC_UFENCE_ADDR: 0x000077f16f713000 FAIL EXEC_UFENCE: EXPECTED=0xdeadbeefdeadbeef, ACTUAL=0x0505050505050505 FAIL BATCH_ADDR: 0x000077ef06800000 FAIL SDI_ADDR: 0x000077ef06800048 FAIL SDI_ADDR (in batch): 0x000077ef06800048 FAIL DATA: EXPECTED=0xc1f64000, ACTUAL=0xc1f64000 FAIL BATCH_ADDR: 0x000077ef06900000 FAIL SDI_ADDR: 0x000077ef06900048 FAIL SDI_ADDR (in batch): 0x000077ef06900048 FAIL DATA: EXPECTED=0x4a1c1001, ACTUAL=0x4a1c1001 FAIL BATCH_ADDR: 0x000077ef06a00000 FAIL SDI_ADDR: 0x000077ef06a00048 FAIL SDI_ADDR (in batch): 0x000077ef06a00048 FAIL DATA: EXPECTED=0x1244f002, ACTUAL=0x1244f002 FAIL BATCH_ADDR: 0x000077ef06b00000 FAIL SDI_ADDR: 0x000077ef06b00048 FAIL SDI_ADDR (in batch): 0x000077ef06b00048 FAIL DATA: EXPECTED=0x2ef15003, ACTUAL=0x2ef15003 FAIL BATCH_ADDR: 0x000077ef06c00000 FAIL SDI_ADDR: 0x000077ef06c00048 FAIL SDI_ADDR (in batch): 0x000077ef06c00048 FAIL DATA: EXPECTED=0x87fc0004, ACTUAL=0x87fc0004 FAIL BATCH_ADDR: 0x000077ef06d00000 FAIL SDI_ADDR: 0x000077ef06d00048 FAIL SDI_ADDR (in batch): 0x000077ef06d00048 FAIL DATA: EXPECTED=0x70a62005, ACTUAL=0x70a62005 FAIL BATCH_ADDR: 0x000077ef06e00000 FAIL SDI_ADDR: 0x000077ef06e00048 FAIL SDI_ADDR (in batch): 0x000077ef06e00048 FAIL DATA: EXPECTED=0x2d104006, ACTUAL=0x00000000 FAIL BATCH_ADDR: 0x000077ef06f00000 FAIL SDI_ADDR: 0x000077ef06f00048 FAIL SDI_ADDR (in batch): 0x000077ef06f00048 FAIL DATA: EXPECTED=0x302e5007, ACTUAL=0x00000000 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 [many_allocs+0xd73] #2 ../tests/intel/xe_exec_system_allocator.c:2541 __igt_unique____real_main2202() #3 ../tests/intel/xe_exec_system_allocator.c:2202 main() #4 [__libc_init_first+0x8a] #5 [__libc_start_main+0x8b] #6 [_start+0x25] Subtest evict-malloc: FAIL (5.084s) This test caused an abort condition: Kernel badly tainted (0x244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened.
Err	Starting subtest: evict-malloc (xe_exec_system_allocator:3432) CRITICAL: Test assertion failure function touch_all_pages, file ../tests/intel/xe_exec_system_allocator.c:370: (xe_exec_system_allocator:3432) CRITICAL: Failed assertion: ret == 0 (xe_exec_system_allocator:3432) CRITICAL: Last errno: 5, Input/output error (xe_exec_system_allocator:3432) CRITICAL: error: -5 != 0 Subtest evict-malloc failed. ** DEBUG (xe_exec_system_allocator:3432) INFO: FAIL EXEC_UFENCE_ADDR: 0x000077f16f713000 (xe_exec_system_allocator:3432) INFO: FAIL EXEC_UFENCE: EXPECTED=0xdeadbeefdeadbeef, ACTUAL=0x0505050505050505 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06800000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06800048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06800048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0xc1f64000, ACTUAL=0xc1f64000 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06900000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06900048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06900048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x4a1c1001, ACTUAL=0x4a1c1001 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06a00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06a00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06a00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x1244f002, ACTUAL=0x1244f002 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06b00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06b00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06b00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x2ef15003, ACTUAL=0x2ef15003 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06c00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06c00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06c00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x87fc0004, ACTUAL=0x87fc0004 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06d00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06d00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06d00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x70a62005, ACTUAL=0x70a62005 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06e00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06e00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06e00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x2d104006, ACTUAL=0x00000000 (xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06f00000 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06f00048 (xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06f00048 (xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x302e5007, ACTUAL=0x00000000 (xe_exec_system_allocator:3432) CRITICAL: Test assertion failure function touch_all_pages, file ../tests/intel/xe_exec_system_allocator.c:370: (xe_exec_system_allocator:3432) CRITICAL: Failed assertion: ret == 0 (xe_exec_system_allocator:3432) CRITICAL: Last errno: 5, Input/output error (xe_exec_system_allocator:3432) CRITICAL: error: -5 != 0 (xe_exec_system_allocator:3432) igt_core-INFO: Stack trace: (xe_exec_system_allocator:3432) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_exec_system_allocator:3432) igt_core-INFO: #1 [many_allocs+0xd73] (xe_exec_system_allocator:3432) igt_core-INFO: #2 ../tests/intel/xe_exec_system_allocator.c:2541 __igt_unique____real_main2202() (xe_exec_system_allocator:3432) igt_core-INFO: #3 ../tests/intel/xe_exec_system_allocator.c:2202 main() (xe_exec_system_allocator:3432) igt_core-INFO: #4 [__libc_init_first+0x8a] (xe_exec_system_allocator:3432) igt_core-INFO: #5 [__libc_start_main+0x8b] (xe_exec_system_allocator:3432) igt_core-INFO: #6 [_start+0x25] END ** Subtest evict-malloc: FAIL (5.084s)
Dmesg Scroll to first warning	<6> [125.894119] Console: switching to colour dummy device 80x25 <6> [125.894156] [IGT] xe_exec_system_allocator: executing <6> [125.921340] [IGT] xe_exec_system_allocator: starting subtest evict-malloc <7> [130.946325] xe 0000:03:00.0: [drm:pf_queue_work_func [xe]] Tile0: GT0: ASID: 0 VFID: 0 PDATA: 0x0592 Faulted Address: 0x000000000062d000 FaultType: 0 AccessType: 1 FaultLevel: 0 EngineClass: 3 bcs EngineInstance: 8 <7> [130.946448] xe 0000:03:00.0: [drm:pf_queue_work_func [xe]] Tile0: GT0: Fault response: Unsuccessful -EINVAL <7> [130.946619] xe 0000:03:00.0: [drm:xe_guc_exec_queue_memory_cat_error_handler [xe]] Tile0: GT0: Engine memory CAT error [18]: class=bcs, logical_mask: 0x2, guc_id=0 <7> [130.947109] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot <6> [130.947828] xe 0000:03:00.0: [drm] Tile0: GT0: Engine reset: engine_class=bcs, logical_mask: 0x2, guc_id=0 <5> [130.947855] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=11730, lrc_seqno=11730, guc_id=0, flags=0x53 in no process [-1] <6> [130.970903] xe 0000:03:00.0: [drm] Xe device coredump has been created <6> [130.970950] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data <4> [130.970952] ------------[ cut here ]------------ <4> [130.970953] xe 0000:03:00.0: [drm] Tile0: GT0: Kernel-submitted job timed out <4> [130.970971] WARNING: CPU: 10 PID: 3271 at drivers/gpu/drm/xe/xe_guc_submit.c:1366 guc_exec_queue_timedout_job+0x983/0xe40 [xe] <4> [130.971044] Modules linked in: pmt_crashlog snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc_proxy mtd_intel_dg mei_gsc xe drm_gpuvm drm_gpusvm_helper drm_ttm_helper ttm gpu_sched drm_suballoc_helper drm_exec drm_buddy drm_display_helper cec rc_core drm_kunit_helpers i2c_algo_bit kunit overlay intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling x86_pkg_temp_thermal intel_powerclamp cmdlinepart hid_generic coretemp eeepc_wmi spi_nor asus_wmi mei_pxp sparse_keymap mtd platform_profile mei_hdcp wmi_bmof kvm_intel kvm irqbypass usbhid snd_hda_intel polyval_clmulni hid snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel r8169 rapl snd_hda_core snd_hwdep video intel_cstate snd_pcm realtek binfmt_misc i2c_i801 snd_timer spi_intel_pci snd i2c_mux mei_me spi_intel i2c_smbus soundcore idma64 mei intel_pmc_core pmt_telemetry nls_iso8859_1 pmt_discovery pmt_class intel_pmc_ssram_telemetry wmi pinctrl_alderlake intel_vsec acpi_pad acpi_tad dm_multipath msr <4> [130.971126] nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [130.971142] CPU: 10 UID: 0 PID: 3271 Comm: kworker/u64:16 Tainted: G S U 6.17.0-rc7-lgci-xe-xe-3814-d2f002c868da5926f+ #1 PREEMPT(voluntary) <4> [130.971145] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER <4> [130.971146] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1656 04/18/2024 <4> [130.971147] Workqueue: gt-ordered-wq drm_sched_job_timedout [gpu_sched] <4> [130.971152] RIP: 0010:guc_exec_queue_timedout_job+0x983/0xe40 [xe] <4> [130.971219] Code: 8d 70 ff ff ff 44 89 45 88 e8 09 e8 56 e1 44 8b 45 88 4c 89 f2 8b 8d 70 ff ff ff 48 89 c6 48 c7 c7 b0 95 16 a1 e8 ad 86 76 e0 <0f> 0b 49 8b 44 24 58 e9 eb f9 ff ff 31 db e9 e2 f8 ff ff 41 b8 88 <4> [130.971221] RSP: 0018:ffffc9000595bcb8 EFLAGS: 00010246 <4> [130.971223] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000 <4> [130.971224] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 <4> [130.971225] RBP: ffffc9000595bda8 R08: 0000000000000000 R09: 0000000000000000 <4> [130.971226] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888169702c00 <4> [130.971227] R13: ffff888145bd31c0 R14: ffff888103881e90 R15: ffff888122d98028 <4> [130.971229] FS: 0000000000000000(0000) GS:ffff8888db1f7000(0000) knlGS:0000000000000000 <4> [130.971230] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [130.971231] CR2: 000077ef06f0004c CR3: 00000001289d1004 CR4: 0000000000f72ef0 <4> [130.971232] PKRU: 55555554 <4> [130.971233] Call Trace: <4> [130.971234] <TASK> <4> [130.971237] ? lock_acquire+0xc4/0x2e0 <4> [130.971243] ? __pfx_autoremove_wake_function+0x10/0x10 <4> [130.971248] drm_sched_job_timedout+0x91/0x1a0 [gpu_sched] <4> [130.971253] process_one_work+0x22b/0x6f0 <4> [130.971260] worker_thread+0x1e8/0x3d0 <4> [130.971263] ? __pfx_worker_thread+0x10/0x10 <4> [130.971265] kthread+0x11c/0x250 <4> [130.971268] ? __pfx_kthread+0x10/0x10 <4> [130.971271] ret_from_fork+0x2d7/0x310 <4> [130.971273] ? __pfx_kthread+0x10/0x10 <4> [130.971275] ret_from_fork_asm+0x1a/0x30 <4> [130.971283] </TASK> <4> [130.971284] irq event stamp: 285507 <4> [130.971285] hardirqs last enabled at (285513): [<ffffffff814a6da9>] __up_console_sem+0x79/0xa0 <4> [130.971287] hardirqs last disabled at (285518): [<ffffffff814a6d8e>] __up_console_sem+0x5e/0xa0 <4> [130.971289] softirqs last enabled at (285290): [<ffffffff813d4ddf>] __irq_exit_rcu+0x13f/0x160 <4> [130.971291] softirqs last disabled at (285283): [<ffffffff813d4ddf>] __irq_exit_rcu+0x13f/0x160 <4> [130.971292] ---[ end trace 0000000000000000 ]--- <6> [130.971294] xe 0000:03:00.0: [drm] Tile0: GT0: trying reset from guc_exec_queue_timedout_job [xe] <6> [130.971358] xe 0000:03:00.0: [drm] Tile0: GT0: reset queued <6> [130.971627] xe 0000:03:00.0: [drm] Tile0: GT0: reset started <7> [130.971933] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped <6> [130.972310] xe 0000:03:00.0: [drm] exec queue reset detected <7> [130.972648] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs <7> [130.972773] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000 <7> [130.972862] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000 <7> [130.972944] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb0c8] = 0x55555440 <7> [130.973026] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440 <7> [130.973106] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000 <7> [130.973204] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f <7> [130.973281] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] WOPCM: 4096K <7> [130.973368] xe 0000:03:00.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K) <7> [130.973474] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled <7> [130.974505] xe 0000:03:00.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 45056) <7> [130.975469] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: load still in progress, timeouts = 0, freq = 2150MHz (req 2133MHz), status = 0x00000072 [0x39/00] <7> [130.980137] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: load still in progress, timeouts = 0, freq = 2150MHz (req 2133MHz), status = 0x80000534 [0x1A/05] <7> [130.981512] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: init took 6ms, freq = 2150MHz (req = 2133MHz), before = 2150MHz, status = 0x8002F034, timeouts = 0 <7> [130.981767] xe 0000:03:00.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel enabled <7> [130.983378] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: flag:0x1 <7> [130.983453] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: mocs entries: 16 <7> [130.983523] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[0] 0x4000 0xc <7> [130.983593] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[1] 0x4004 0x10c <7> [130.983661] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[2] 0x4008 0x130 <7> [130.983728] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[3] 0x400c 0x13c <7> [130.983795] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[4] 0x4010 0x100 <7> [130.983861] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[5] 0x4014 0x100 <7> [130.983928] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[6] 0x4018 0x100 <7> [130.983997] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[7] 0x401c 0x100 <7> [130.984066] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[8] 0x4020 0x100 <7> [130.984140] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[9] 0x4024 0x100 <7> [130.984210] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[10] 0x4028 0x100 <7> [130.984277] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[11] 0x402c 0x100 <7> [130.984343] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[12] 0x4030 0x100 <7> [130.984409] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[13] 0x4034 0x100 <7> [130.984475] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[14] 0x4038 0x100 <7> [130.984541] xe 0000:03:00.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[15] 0x403c 0x100 <7> [130.984852] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying rcs0 save-restore MMIOs <7> [130.984930] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x2050] = 0x10001000 <7> [130.985110] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20c4] = 0x3f7e0306 <7> [130.985199] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20d4] = 0xc080c080 <7> [130.985270] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d0] = 0x1000dafc <7> [130.985341] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d4] = 0x1000db01 <7> [130.985410] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d8] = 0x0000db1c <7> [130.985482] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x7044] = 0x04200420 <7> [130.985556] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe194] = 0x00400040 <7> [130.985628] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe48c] = 0x02000200 <7> [130.985697] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe49c] = 0x40004000 <7> [130.985769] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4c4] = 0x10401040 <7> [130.985839] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4f0] = 0x00020002 <7> [130.985915] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe530] = 0x00000400 <7> [130.985991] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7c8] = 0x04002000 <7> [130.986067] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00009000 <7> [130.986144] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x14800] = 0x00020002 <7> [130.986218] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs0 save-restore MMIOs <7> [130.986289] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x22050] = 0x10001000 <7> [130.986429] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220c4] = 0x3f7e0306 <7> [130.986535] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220d4] = 0xc080c080 <7> [130.986606] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs8 save-restore MMIOs <7> [130.986676] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee050] = 0x10001000 <7> [130.986748] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0c4] = 0x3f7e0306 <7> [130.986821] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0d4] = 0xc080c080 <7> [130.986896] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs0 save-restore MMIOs <7> [130.986967] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a050] = 0x10001000 <7> [130.987037] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0c4] = 0x3f7e0308 <7> [130.987105] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0d4] = 0xc080c080 <7> [130.987187] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d0] = 0x1000dafc <7> [130.987255] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d4] = 0x1000db01 <7> [130.987324] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d8] = 0x0000db1c <7> [130.987394] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs1 save-restore MMIOs <7> [130.987473] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c050] = 0x10001000 <7> [130.987544] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0c4] = 0x3f7e0308 <7> [130.987612] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c0d4] = 0xc080c080 <7> [130.987682] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d0] = 0x1000dafc <7> [130.987749] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d4] = 0x1000db01 <7> [130.987817] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1c4d8] = 0x0000db1c <7> [130.987890] 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> [130.988238] xe 0000:03:00.0: [drm] Tile0: GT0: reset done <7> [130.988752] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken <4> [130.989347] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=11733, lrc_seqno=11733, guc_id=0, not started <7> [130.989375] xe 0000:03:00.0: [drm:xe_gt_sriov_pf_config_restart [xe]] Tile0: GT0: PF: pushed 0 skip 12 of 12 VFs configurations <7> [130.989473] xe 0000:03:00.0: [drm:pf_worker_restart_func [xe]] Tile0: GT0: PF: restart completed <4> [130.991475] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=11734, lrc_seqno=11734, guc_id=0, not started <7> [130.991874] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=11734, lrc_seqno=11734, guc_id=0, running_time_ms=1, timeout_ms=5000, diff=0x00000d45 <6> [131.005202] [IGT] xe_exec_system_allocator: finished subtest evict-malloc, FAIL <7> [131.043177] xe 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [131.043253] [IGT] xe_exec_system_allocator: exiting, ret=98 <6> [131.059947] Console: switching to colour frame buffer device 240x67

Detail

Value

Duration

unknown

Hostname

shard-bmg-6

Igt-Version

IGT-Version: 2.1-g477154cba (x86_64) (Linux: 6.17.0-rc7-lgci-xe-xe-3814-d2f002c868da5926f+ x86_64)

Out

Using IGT_SRANDOM=1758626841 for randomisation
Opened device: /dev/dri/card0
Starting subtest: evict-malloc
FAIL EXEC_UFENCE_ADDR: 0x000077f16f713000
FAIL EXEC_UFENCE: EXPECTED=0xdeadbeefdeadbeef, ACTUAL=0x0505050505050505
FAIL BATCH_ADDR: 0x000077ef06800000
FAIL SDI_ADDR: 0x000077ef06800048
FAIL SDI_ADDR (in batch): 0x000077ef06800048
FAIL DATA: EXPECTED=0xc1f64000, ACTUAL=0xc1f64000
FAIL BATCH_ADDR: 0x000077ef06900000
FAIL SDI_ADDR: 0x000077ef06900048
FAIL SDI_ADDR (in batch): 0x000077ef06900048
FAIL DATA: EXPECTED=0x4a1c1001, ACTUAL=0x4a1c1001
FAIL BATCH_ADDR: 0x000077ef06a00000
FAIL SDI_ADDR: 0x000077ef06a00048
FAIL SDI_ADDR (in batch): 0x000077ef06a00048
FAIL DATA: EXPECTED=0x1244f002, ACTUAL=0x1244f002
FAIL BATCH_ADDR: 0x000077ef06b00000
FAIL SDI_ADDR: 0x000077ef06b00048
FAIL SDI_ADDR (in batch): 0x000077ef06b00048
FAIL DATA: EXPECTED=0x2ef15003, ACTUAL=0x2ef15003
FAIL BATCH_ADDR: 0x000077ef06c00000
FAIL SDI_ADDR: 0x000077ef06c00048
FAIL SDI_ADDR (in batch): 0x000077ef06c00048
FAIL DATA: EXPECTED=0x87fc0004, ACTUAL=0x87fc0004
FAIL BATCH_ADDR: 0x000077ef06d00000
FAIL SDI_ADDR: 0x000077ef06d00048
FAIL SDI_ADDR (in batch): 0x000077ef06d00048
FAIL DATA: EXPECTED=0x70a62005, ACTUAL=0x70a62005
FAIL BATCH_ADDR: 0x000077ef06e00000
FAIL SDI_ADDR: 0x000077ef06e00048
FAIL SDI_ADDR (in batch): 0x000077ef06e00048
FAIL DATA: EXPECTED=0x2d104006, ACTUAL=0x00000000
FAIL BATCH_ADDR: 0x000077ef06f00000
FAIL SDI_ADDR: 0x000077ef06f00048
FAIL SDI_ADDR (in batch): 0x000077ef06f00048
FAIL DATA: EXPECTED=0x302e5007, ACTUAL=0x00000000
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 [many_allocs+0xd73]
  #2 ../tests/intel/xe_exec_system_allocator.c:2541 __igt_unique____real_main2202()
  #3 ../tests/intel/xe_exec_system_allocator.c:2202 main()
  #4 [__libc_init_first+0x8a]
  #5 [__libc_start_main+0x8b]
  #6 [_start+0x25]
Subtest evict-malloc: FAIL (5.084s)

This test caused an abort condition: Kernel badly tainted (0x244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

Err

Starting subtest: evict-malloc
(xe_exec_system_allocator:3432) CRITICAL: Test assertion failure function touch_all_pages, file ../tests/intel/xe_exec_system_allocator.c:370:
(xe_exec_system_allocator:3432) CRITICAL: Failed assertion: ret == 0
(xe_exec_system_allocator:3432) CRITICAL: Last errno: 5, Input/output error
(xe_exec_system_allocator:3432) CRITICAL: error: -5 != 0
Subtest evict-malloc failed.
**** DEBUG ****
(xe_exec_system_allocator:3432) INFO: FAIL EXEC_UFENCE_ADDR: 0x000077f16f713000
(xe_exec_system_allocator:3432) INFO: FAIL EXEC_UFENCE: EXPECTED=0xdeadbeefdeadbeef, ACTUAL=0x0505050505050505
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06800000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06800048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06800048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0xc1f64000, ACTUAL=0xc1f64000
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06900000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06900048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06900048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x4a1c1001, ACTUAL=0x4a1c1001
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06a00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06a00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06a00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x1244f002, ACTUAL=0x1244f002
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06b00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06b00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06b00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x2ef15003, ACTUAL=0x2ef15003
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06c00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06c00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06c00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x87fc0004, ACTUAL=0x87fc0004
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06d00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06d00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06d00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x70a62005, ACTUAL=0x70a62005
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06e00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06e00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06e00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x2d104006, ACTUAL=0x00000000
(xe_exec_system_allocator:3432) INFO: FAIL BATCH_ADDR: 0x000077ef06f00000
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR: 0x000077ef06f00048
(xe_exec_system_allocator:3432) INFO: FAIL SDI_ADDR (in batch): 0x000077ef06f00048
(xe_exec_system_allocator:3432) INFO: FAIL DATA: EXPECTED=0x302e5007, ACTUAL=0x00000000
(xe_exec_system_allocator:3432) CRITICAL: Test assertion failure function touch_all_pages, file ../tests/intel/xe_exec_system_allocator.c:370:
(xe_exec_system_allocator:3432) CRITICAL: Failed assertion: ret == 0
(xe_exec_system_allocator:3432) CRITICAL: Last errno: 5, Input/output error
(xe_exec_system_allocator:3432) CRITICAL: error: -5 != 0
(xe_exec_system_allocator:3432) igt_core-INFO: Stack trace:
(xe_exec_system_allocator:3432) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_exec_system_allocator:3432) igt_core-INFO:   #1 [many_allocs+0xd73]
(xe_exec_system_allocator:3432) igt_core-INFO:   #2 ../tests/intel/xe_exec_system_allocator.c:2541 __igt_unique____real_main2202()
(xe_exec_system_allocator:3432) igt_core-INFO:   #3 ../tests/intel/xe_exec_system_allocator.c:2202 main()
(xe_exec_system_allocator:3432) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(xe_exec_system_allocator:3432) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(xe_exec_system_allocator:3432) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Subtest evict-malloc: FAIL (5.084s)

Dmesg

Scroll to first warning

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

<6> [125.894156] [IGT] xe_exec_system_allocator: executing

<6> [125.921340] [IGT] xe_exec_system_allocator: starting subtest evict-malloc

<7> [130.946325] xe 0000:03:00.0: [drm:pf_queue_work_func [xe]] Tile0: GT0:

ASID: 0

VFID: 0

PDATA: 0x0592

Faulted Address: 0x000000000062d000

FaultType: 0

AccessType: 1

FaultLevel: 0

EngineClass: 3 bcs

EngineInstance: 8

<7> [130.946448] xe 0000:03:00.0: [drm:pf_queue_work_func [xe]] Tile0: GT0: Fault response: Unsuccessful -EINVAL

<7> [130.946619] xe 0000:03:00.0: [drm:xe_guc_exec_queue_memory_cat_error_handler [xe]] Tile0: GT0: Engine memory CAT error [18]: class=bcs, logical_mask: 0x2, guc_id=0

<7> [130.947109] xe 0000:03:00.0: [drm:xe_hw_engine_snapshot_capture [xe]] Tile0: GT0: Proceeding with manual engine snapshot

<6> [130.947828] xe 0000:03:00.0: [drm] Tile0: GT0: Engine reset: engine_class=bcs, logical_mask: 0x2, guc_id=0

<5> [130.947855] xe 0000:03:00.0: [drm] Tile0: GT0: Timedout job: seqno=11730, lrc_seqno=11730, guc_id=0, flags=0x53 in no process [-1]

<6> [130.970903] xe 0000:03:00.0: [drm] Xe device coredump has been created

<6> [130.970950] xe 0000:03:00.0: [drm] Check your /sys/class/drm/card0/device/devcoredump/data

<4> [130.970952] ------------[ cut here ]------------

<4> [130.970953] xe 0000:03:00.0: [drm] Tile0: GT0: Kernel-submitted job timed out

<4> [130.970971] WARNING: CPU: 10 PID: 3271 at drivers/gpu/drm/xe/xe_guc_submit.c:1366 guc_exec_queue_timedout_job+0x983/0xe40 [xe]

<4> [130.971044] Modules linked in: pmt_crashlog snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc_proxy mtd_intel_dg mei_gsc xe drm_gpuvm drm_gpusvm_helper drm_ttm_helper ttm gpu_sched drm_suballoc_helper drm_exec drm_buddy drm_display_helper cec rc_core drm_kunit_helpers i2c_algo_bit kunit overlay intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common intel_tcc_cooling x86_pkg_temp_thermal intel_powerclamp cmdlinepart hid_generic coretemp eeepc_wmi spi_nor asus_wmi mei_pxp sparse_keymap mtd platform_profile mei_hdcp wmi_bmof kvm_intel kvm irqbypass usbhid snd_hda_intel polyval_clmulni hid snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec aesni_intel r8169 rapl snd_hda_core snd_hwdep video intel_cstate snd_pcm realtek binfmt_misc i2c_i801 snd_timer spi_intel_pci snd i2c_mux mei_me spi_intel i2c_smbus soundcore idma64 mei intel_pmc_core pmt_telemetry nls_iso8859_1 pmt_discovery pmt_class intel_pmc_ssram_telemetry wmi pinctrl_alderlake intel_vsec acpi_pad acpi_tad dm_multipath msr

<4> [130.971126] nvme_fabrics fuse efi_pstore nfnetlink autofs4

<4> [130.971142] CPU: 10 UID: 0 PID: 3271 Comm: kworker/u64:16 Tainted: G S U 6.17.0-rc7-lgci-xe-xe-3814-d2f002c868da5926f+ #1 PREEMPT(voluntary)

<4> [130.971145] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER

<4> [130.971146] Hardware name: ASUS System Product Name/PRIME Z790-P WIFI, BIOS 1656 04/18/2024

<4> [130.971147] Workqueue: gt-ordered-wq drm_sched_job_timedout [gpu_sched]

<4> [130.971152] RIP: 0010:guc_exec_queue_timedout_job+0x983/0xe40 [xe]

<4> [130.971219] Code: 8d 70 ff ff ff 44 89 45 88 e8 09 e8 56 e1 44 8b 45 88 4c 89 f2 8b 8d 70 ff ff ff 48 89 c6 48 c7 c7 b0 95 16 a1 e8 ad 86 76 e0 <0f> 0b 49 8b 44 24 58 e9 eb f9 ff ff 31 db e9 e2 f8 ff ff 41 b8 88

<4> [130.971221] RSP: 0018:ffffc9000595bcb8 EFLAGS: 00010246

<4> [130.971223] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000

<4> [130.971224] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000

<4> [130.971225] RBP: ffffc9000595bda8 R08: 0000000000000000 R09: 0000000000000000

<4> [130.971226] R10: 0000000000000000 R11: 0000000000000000 R12: ffff888169702c00

<4> [130.971227] R13: ffff888145bd31c0 R14: ffff888103881e90 R15: ffff888122d98028

<4> [130.971229] FS: 0000000000000000(0000) GS:ffff8888db1f7000(0000) knlGS:0000000000000000

<4> [130.971230] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

<4> [130.971231] CR2: 000077ef06f0004c CR3: 00000001289d1004 CR4: 0000000000f72ef0

<4> [130.971232] PKRU: 55555554

<4> [130.971233] Call Trace:

<4> [130.971234] <TASK>

<4> [130.971237] ? lock_acquire+0xc4/0x2e0

<4> [130.971243] ? __pfx_autoremove_wake_function+0x10/0x10

<4> [130.971248] drm_sched_job_timedout+0x91/0x1a0 [gpu_sched]

<4> [130.971253] process_one_work+0x22b/0x6f0

<4> [130.971260] worker_thread+0x1e8/0x3d0

<4> [130.971263] ? __pfx_worker_thread+0x10/0x10

<4> [130.971265] kthread+0x11c/0x250

<4> [130.971268] ? __pfx_kthread+0x10/0x10

<4> [130.971271] ret_from_fork+0x2d7/0x310

<4> [130.971273] ? __pfx_kthread+0x10/0x10

<4> [130.971275] ret_from_fork_asm+0x1a/0x30

<4> [130.971283] </TASK>

<4> [130.971284] irq event stamp: 285507

<4> [130.971285] hardirqs last enabled at (285513): [<ffffffff814a6da9>] __up_console_sem+0x79/0xa0

<4> [130.971287] hardirqs last disabled at (285518): [<ffffffff814a6d8e>] __up_console_sem+0x5e/0xa0

<4> [130.971289] softirqs last enabled at (285290): [<ffffffff813d4ddf>] __irq_exit_rcu+0x13f/0x160

<4> [130.971291] softirqs last disabled at (285283): [<ffffffff813d4ddf>] __irq_exit_rcu+0x13f/0x160

<4> [130.971292] ---[ end trace 0000000000000000 ]---

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

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

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

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

<6> [130.972310] xe 0000:03:00.0: [drm] exec queue reset detected

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

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

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

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

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

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

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

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

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

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

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

<7> [130.975469] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: load still in progress, timeouts = 0, freq = 2150MHz (req 2133MHz), status = 0x00000072 [0x39/00]

<7> [130.980137] xe 0000:03:00.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: load still in progress, timeouts = 0, freq = 2150MHz (req 2133MHz), status = 0x80000534 [0x1A/05]

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [130.985915] xe 0000:03:00.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe530] = 0x00000400

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

<7> [130.987890] 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> [130.988238] xe 0000:03:00.0: [drm] Tile0: GT0: reset done

<7> [130.988752] xe 0000:03:00.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken

<4> [130.989347] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=11733, lrc_seqno=11733, guc_id=0, not started

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

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

<4> [130.991475] xe 0000:03:00.0: [drm] Tile0: GT0: Check job timeout: seqno=11734, lrc_seqno=11734, guc_id=0, not started

<7> [130.991874] xe 0000:03:00.0: [drm:guc_exec_queue_timedout_job [xe]] Tile0: GT0: Check job timeout: seqno=11734, lrc_seqno=11734, guc_id=0, running_time_ms=1, timeout_ms=5000, diff=0x00000d45

<6> [131.005202] [IGT] xe_exec_system_allocator: finished subtest evict-malloc, FAIL

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

<6> [131.043253] [IGT] xe_exec_system_allocator: exiting, ret=98

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

Created at 2025-09-23 11:37:38