igt@xe_exec_system_allocator@twice-large-malloc-mlock on shard-lnl@IGTPW

Results for igt@xe_exec_system_allocator@twice-large-malloc-mlock

Detail	Value
Duration	unknown
Hostname	shard-lnl-2
Igt-Version	IGT-Version: 2.2-g11c5d8d9c (x86_64) (Linux: 6.18.0-rc6-lgci-xe-xe-4121-91fc6d984707c9bfd+ x86_64)
Out	Using IGT_SRANDOM=1763449640 for randomisation Opened device: /dev/dri/card0 Starting subtest: twice-large-malloc-mlock Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 [xe_wait_ufence+0x57] #2 ../tests/intel/xe_exec_system_allocator.c:1729 test_exec() #3 ../tests/intel/xe_exec_system_allocator.c:2423 __igt_unique____real_main2229() #4 ../tests/intel/xe_exec_system_allocator.c:2229 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Subtest twice-large-malloc-mlock: FAIL (5.326s) This test caused an abort condition: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened.
Err	Starting subtest: twice-large-malloc-mlock (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Test assertion failure function xe_wait_ufence, file ../lib/xe/xe_ioctl.c:685: (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Failed assertion: __xe_wait_ufence(fd, addr, value, exec_queue, &timeout) == 0 (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Last errno: 62, Timer expired (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: error: -62 != 0 Subtest twice-large-malloc-mlock failed. ** DEBUG (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Test assertion failure function xe_wait_ufence, file ../lib/xe/xe_ioctl.c:685: (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Failed assertion: __xe_wait_ufence(fd, addr, value, exec_queue, &timeout) == 0 (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Last errno: 62, Timer expired (xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: error: -62 != 0 (xe_exec_system_allocator:3932) igt_core-INFO: Stack trace: (xe_exec_system_allocator:3932) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (xe_exec_system_allocator:3932) igt_core-INFO: #1 [xe_wait_ufence+0x57] (xe_exec_system_allocator:3932) igt_core-INFO: #2 ../tests/intel/xe_exec_system_allocator.c:1729 test_exec() (xe_exec_system_allocator:3932) igt_core-INFO: #3 ../tests/intel/xe_exec_system_allocator.c:2423 __igt_unique____real_main2229() (xe_exec_system_allocator:3932) igt_core-INFO: #4 ../tests/intel/xe_exec_system_allocator.c:2229 main() (xe_exec_system_allocator:3932) igt_core-INFO: #5 [__libc_init_first+0x8a] (xe_exec_system_allocator:3932) igt_core-INFO: #6 [__libc_start_main+0x8b] (xe_exec_system_allocator:3932) igt_core-INFO: #7 [_start+0x25] END ** Subtest twice-large-malloc-mlock: FAIL (5.326s)
Dmesg Scroll to first warning	<6> [213.964205] Console: switching to colour dummy device 80x25 <6> [213.964475] [IGT] xe_exec_system_allocator: executing <6> [213.968314] [IGT] xe_exec_system_allocator: starting subtest twice-large-malloc-mlock <4> [219.269782] xe 0000:00:02.0: [drm] Tile0: GT0: Schedule disable failed to respond, guc_id=3 <7> [219.269823] xe 0000:00:02.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken <6> [219.270112] xe 0000:00:02.0: [drm] Tile0: GT0: trying reset from xe_guc_exec_queue_lr_cleanup [xe] <6> [219.270394] xe 0000:00:02.0: [drm] Tile0: GT0: reset queued <6> [219.270703] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=bcs, logical_mask: 0x1, guc_id=4 <6> [219.271144] xe 0000:00:02.0: [drm] Tile0: GT0: reset started <6> [219.272420] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=rcs, logical_mask: 0x1, guc_id=5 <6> [219.272447] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=ccs, logical_mask: 0x1, guc_id=3 <7> [219.273786] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped <7> [219.278014] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs <7> [219.279009] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000 <7> [219.279979] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000 <7> [219.280853] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440 <7> [219.281607] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000 <7> [219.282271] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb154] = 0x00020000 <7> [219.282944] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f <7> [219.283551] xe 0000:00:02.0: [drm:xe_wopcm_init [xe]] WOPCM: 2048K <7> [219.284181] xe 0000:00:02.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K) <7> [219.284784] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled <7> [219.287544] xe 0000:00:02.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 45056) <6> [219.295303] [IGT] xe_exec_system_allocator: finished subtest twice-large-malloc-mlock, FAIL <6> [219.296317] [IGT] xe_exec_system_allocator: exiting, ret=98 <6> [219.297148] Console: switching to colour frame buffer device 180x56 <4> [219.298993] ------------[ cut here ]------------ <4> [219.299027] WARNING: CPU: 0 PID: 3932 at drivers/gpu/drm/xe/xe_svm.c:254 xe_svm_invalidate+0x4f7/0x650 [xe] <4> [219.299134] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi 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 hid_sensor_custom hid_sensor_hub hid_generic intel_ishtp_hid hid cmdlinepart intel_uncore_frequency spi_nor intel_uncore_frequency_common x86_pkg_temp_thermal intel_powerclamp mtd ucsi_acpi mei_gsc_proxy typec_ucsi coretemp typec intel_rapl_msr wmi_bmof kvm_intel kvm irqbypass polyval_clmulni snd_hda_intel ghash_clmulni_intel aesni_intel snd_intel_dspcfg rapl snd_hda_codec processor_thermal_device_pci intel_cstate snd_hda_core processor_thermal_device snd_hwdep processor_thermal_wt_hint snd_pcm platform_temperature_control processor_thermal_soc_slider snd_timer platform_profile e1000e spi_intel_pci snd processor_thermal_rfim spi_intel idma64 processor_thermal_rapl soundcore mei_me mei intel_ish_ipc intel_rapl_common processor_thermal_wt_req processor_thermal_power_floor intel_ishtp <4> [219.299205] intel_vpu thunderbolt processor_thermal_mbox binfmt_misc intel_pmc_core video int3403_thermal intel_skl_int3472_tps68470 int340x_thermal_zone tps68470_regulator clk_tps68470 pmt_telemetry nls_iso8859_1 pmt_discovery wmi intel_hid pmt_class sparse_keymap acpi_pad intel_pmc_ssram_telemetry int3400_thermal intel_skl_int3472_discrete acpi_thermal_rel intel_skl_int3472_common acpi_tad pinctrl_intel_platform intel_vsec dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 <4> [219.299228] CPU: 0 UID: 0 PID: 3932 Comm: xe_exec_system_ Tainted: G U 6.18.0-rc6-lgci-xe-xe-4121-91fc6d984707c9bfd+ #1 PREEMPT(voluntary) <4> [219.299230] Tainted: [U]=USER <4> [219.299231] Hardware name: Intel Corporation Lunar Lake Client Platform/LNL-M LP5 RVP1, BIOS LNLMFWI1.R00.3223.D99.2508051732 08/05/2025 <4> [219.299233] RIP: 0010:xe_svm_invalidate+0x4f7/0x650 [xe] <4> [219.299327] Code: 45 a0 e8 8c 22 f3 ff 48 8b 7d a8 41 0f b6 ce 4c 89 e2 48 8b b5 78 ff ff ff e8 95 90 ff ff 4c 8b 45 a0 85 c0 0f 84 b5 fb ff ff <0f> 0b e9 ae fb ff ff 48 8b bd 58 ff ff ff 31 f6 48 89 4d a0 e8 e0 <4> [219.299329] RSP: 0018:ffffc9000c593a90 EFLAGS: 00010286 <4> [219.299330] RAX: 00000000ffffffed RBX: ffff88817a0dc190 RCX: 0000000000000000 <4> [219.299332] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 <4> [219.299332] RBP: ffffc9000c593b48 R08: ffff8881abf6f240 R09: 0000000000000000 <4> [219.299333] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffffffffff <4> [219.299334] R13: ffff888140cb8000 R14: 0000000000000001 R15: ffff8881abf6f240 <4> [219.299335] FS: 0000000000000000(0000) GS:ffff8888db2ea000(0000) knlGS:0000000000000000 <4> [219.299336] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [219.299337] CR2: 00007c32e1402a7c CR3: 00000001a7de9003 CR4: 0000000000f72ef0 <4> [219.299338] PKRU: 55555554 <4> [219.299338] Call Trace: <4> [219.299339] <TASK> <4> [219.299345] drm_gpusvm_notifier_invalidate+0x59/0x80 [drm_gpusvm_helper] <4> [219.299348] __mmu_notifier_release+0x1e6/0x260 <4> [219.299354] exit_mmap+0x45b/0x4a0 <4> [219.299359] ? __mutex_unlock_slowpath+0x40/0x350 <4> [219.299364] __mmput+0x43/0x160 <4> [219.299367] mmput+0x44/0x60 <4> [219.299369] do_exit+0x29d/0xb40 <4> [219.299372] do_group_exit+0x3a/0xb0 <4> [219.299374] __x64_sys_exit_group+0x18/0x20 <4> [219.299375] x64_sys_call+0x2694/0x26a0 <4> [219.299377] do_syscall_64+0x93/0xd30 <4> [219.299380] ? find_held_lock+0x31/0x90 <4> [219.299382] ? exc_page_fault+0x96/0x2c0 <4> [219.299385] ? lock_release+0xce/0x2a0 <4> [219.299388] ? do_user_addr_fault+0x5d1/0x8e0 <4> [219.299391] ? irqentry_exit_to_user_mode+0xf4/0x320 <4> [219.299393] ? irqentry_exit+0x77/0xb0 <4> [219.299395] ? exc_page_fault+0xbd/0x2c0 <4> [219.299397] entry_SYSCALL_64_after_hwframe+0x76/0x7e <4> [219.299399] RIP: 0033:0x7c32e32ee21d <4> [219.299400] Code: Unable to access opcode bytes at 0x7c32e32ee1f3. <4> [219.299401] RSP: 002b:00007ffee2196e58 EFLAGS: 00000206 ORIG_RAX: 00000000000000e7 <4> [219.299403] RAX: ffffffffffffffda RBX: 00007c32e3404fa8 RCX: 00007c32e32ee21d <4> [219.299404] RDX: 00000000000000e7 RSI: fffffffffffffee8 RDI: 0000000000000062 <4> [219.299405] RBP: 00007ffee2196eb0 R08: 00007ffee2196e00 R09: 0000000000000007 <4> [219.299405] R10: 0000624b578592a0 R11: 0000000000000206 R12: 0000000000000003 <4> [219.299406] R13: 0000000000000000 R14: 0000000000000062 R15: 00007c32e3404fc0 <4> [219.299411] </TASK> <4> [219.299412] irq event stamp: 74093 <4> [219.299412] hardirqs last enabled at (74099): [<ffffffff814a6959>] __up_console_sem+0x79/0xa0 <4> [219.299415] hardirqs last disabled at (74104): [<ffffffff814a693e>] __up_console_sem+0x5e/0xa0 <4> [219.299416] softirqs last enabled at (72456): [<ffffffff813d3d9f>] __irq_exit_rcu+0x13f/0x160 <4> [219.299417] softirqs last disabled at (72449): [<ffffffff813d3d9f>] __irq_exit_rcu+0x13f/0x160 <4> [219.299419] ---[ end trace 0000000000000000 ]--- <7> [219.299469] xe 0000:00:02.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: GuC load: init took 9ms, freq = 1850MHz (req = 1850MHz), before = 1850MHz, status = 0x8002F034 <7> [219.300216] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel enabled <7> [219.300434] xe 0000:00:02.0: [drm:xe_svm_garbage_collector [xe]] Skipping madvise reset for vma. <7> [219.302238] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: flag:0x1 <7> [219.302358] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: mocs entries: 16 <7> [219.302434] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[0] 0x4000 0xc <7> [219.302526] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[1] 0x4004 0x10c <7> [219.302605] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[2] 0x4008 0x130 <7> [219.302674] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[3] 0x400c 0x13c <7> [219.302743] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[4] 0x4010 0x100 <7> [219.302810] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[5] 0x4014 0x100 <7> [219.302877] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[6] 0x4018 0x100 <7> [219.302942] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[7] 0x401c 0x100 <7> [219.303050] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[8] 0x4020 0x100 <7> [219.303042] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off <7> [219.303115] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[9] 0x4024 0x100 <7> [219.303152] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00 <7> [219.303177] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[10] 0x4028 0x100 <7> [219.303240] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[11] 0x402c 0x100 <7> [219.303301] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[12] 0x4030 0x100 <7> [219.303364] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[13] 0x4034 0x100 <7> [219.303425] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[14] 0x4038 0x100 <7> [219.303499] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[15] 0x403c 0x100 <7> [219.303676] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying rcs0 save-restore MMIOs <7> [219.303760] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x2050] = 0x10001000 <7> [219.303848] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20c4] = 0x3f7e0306 <7> [219.303925] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20d4] = 0xc080c080 <7> [219.304010] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d0] = 0x1000dafc <7> [219.304086] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d4] = 0x1000db01 <7> [219.304165] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d8] = 0x0000db1c <7> [219.304263] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe194] = 0x00400040 <7> [219.304333] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe48c] = 0x02000200 <7> [219.304401] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe49c] = 0x40004000 <7> [219.304476] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4c4] = 0x08400840 <7> [219.304553] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4f0] = 0x00020002 <7> [219.304630] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe530] = 0x00000400 <7> [219.304696] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7c8] = 0x00002000 <7> [219.304762] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00009000 <7> [219.304825] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs0 save-restore MMIOs <7> [219.304887] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x22050] = 0x10001000 <7> [219.304949] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220c4] = 0x3f7e0306 <7> [219.305008] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220d4] = 0xc080c080 <7> [219.305069] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs8 save-restore MMIOs <7> [219.305129] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee050] = 0x10001000 <7> [219.305188] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0c4] = 0x3f7e0306 <7> [219.305246] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0d4] = 0xc080c080 <7> [219.305306] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs0 save-restore MMIOs <7> [219.305363] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a050] = 0x10001000 <7> [219.305420] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0c4] = 0x3f7e0306 <7> [219.305482] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0d4] = 0xc080c080 <7> [219.305540] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d0] = 0x1000dafc <7> [219.305611] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d4] = 0x1000db01 <7> [219.305681] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d8] = 0x0000db1c <6> [219.305750] xe 0000:00:02.0: [drm] Tile0: GT0: reset done <7> [219.319909] xe 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0

Detail

Value

Duration

unknown

Hostname

shard-lnl-2

Igt-Version

IGT-Version: 2.2-g11c5d8d9c (x86_64) (Linux: 6.18.0-rc6-lgci-xe-xe-4121-91fc6d984707c9bfd+ x86_64)

Out

Using IGT_SRANDOM=1763449640 for randomisation
Opened device: /dev/dri/card0
Starting subtest: twice-large-malloc-mlock
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 [xe_wait_ufence+0x57]
  #2 ../tests/intel/xe_exec_system_allocator.c:1729 test_exec()
  #3 ../tests/intel/xe_exec_system_allocator.c:2423 __igt_unique____real_main2229()
  #4 ../tests/intel/xe_exec_system_allocator.c:2229 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Subtest twice-large-malloc-mlock: FAIL (5.326s)

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

Err

Starting subtest: twice-large-malloc-mlock
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Test assertion failure function xe_wait_ufence, file ../lib/xe/xe_ioctl.c:685:
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Failed assertion: __xe_wait_ufence(fd, addr, value, exec_queue, &timeout) == 0
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Last errno: 62, Timer expired
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: error: -62 != 0
Subtest twice-large-malloc-mlock failed.
**** DEBUG ****
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Test assertion failure function xe_wait_ufence, file ../lib/xe/xe_ioctl.c:685:
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Failed assertion: __xe_wait_ufence(fd, addr, value, exec_queue, &timeout) == 0
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: Last errno: 62, Timer expired
(xe_exec_system_allocator:3932) xe/xe_ioctl-CRITICAL: error: -62 != 0
(xe_exec_system_allocator:3932) igt_core-INFO: Stack trace:
(xe_exec_system_allocator:3932) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(xe_exec_system_allocator:3932) igt_core-INFO:   #1 [xe_wait_ufence+0x57]
(xe_exec_system_allocator:3932) igt_core-INFO:   #2 ../tests/intel/xe_exec_system_allocator.c:1729 test_exec()
(xe_exec_system_allocator:3932) igt_core-INFO:   #3 ../tests/intel/xe_exec_system_allocator.c:2423 __igt_unique____real_main2229()
(xe_exec_system_allocator:3932) igt_core-INFO:   #4 ../tests/intel/xe_exec_system_allocator.c:2229 main()
(xe_exec_system_allocator:3932) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(xe_exec_system_allocator:3932) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(xe_exec_system_allocator:3932) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Subtest twice-large-malloc-mlock: FAIL (5.326s)

Dmesg

Scroll to first warning

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

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

<6> [213.968314] [IGT] xe_exec_system_allocator: starting subtest twice-large-malloc-mlock

<4> [219.269782] xe 0000:00:02.0: [drm] Tile0: GT0: Schedule disable failed to respond, guc_id=3

<7> [219.269823] xe 0000:00:02.0: [drm:xe_devcoredump [xe]] Multiple hangs are occurring, but only the first snapshot was taken

<6> [219.270112] xe 0000:00:02.0: [drm] Tile0: GT0: trying reset from xe_guc_exec_queue_lr_cleanup [xe]

<6> [219.270394] xe 0000:00:02.0: [drm] Tile0: GT0: reset queued

<6> [219.270703] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=bcs, logical_mask: 0x1, guc_id=4

<6> [219.271144] xe 0000:00:02.0: [drm] Tile0: GT0: reset started

<6> [219.272420] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=rcs, logical_mask: 0x1, guc_id=5

<6> [219.272447] xe 0000:00:02.0: [drm] Tile0: GT0: Engine reset: engine_class=ccs, logical_mask: 0x1, guc_id=3

<7> [219.273786] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel stopped

<7> [219.278014] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying GT save-restore MMIOs

<7> [219.279009] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x4148] = 0x00000000

<7> [219.279979] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x8828] = 0x00800000

<7> [219.280853] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb104] = 0x08104440

<7> [219.281607] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb108] = 0x30200000

<7> [219.282271] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb154] = 0x00020000

<7> [219.282944] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xb158] = 0x0000007f

<7> [219.283551] xe 0000:00:02.0: [drm:xe_wopcm_init [xe]] WOPCM: 2048K

<7> [219.284181] xe 0000:00:02.0: [drm:xe_wopcm_init [xe]] GuC WOPCM is already locked [6144K, 832K)

<7> [219.284784] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel disabled

<7> [219.287544] xe 0000:00:02.0: [drm:xe_guc_ads_populate [xe]] Tile0: GT0: Updated ADS capture size 20480 (was 45056)

<6> [219.295303] [IGT] xe_exec_system_allocator: finished subtest twice-large-malloc-mlock, FAIL

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

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

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

<4> [219.299027] WARNING: CPU: 0 PID: 3932 at drivers/gpu/drm/xe/xe_svm.c:254 xe_svm_invalidate+0x4f7/0x650 [xe]

<4> [219.299134] Modules linked in: snd_hda_codec_intelhdmi snd_hda_codec_hdmi 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 hid_sensor_custom hid_sensor_hub hid_generic intel_ishtp_hid hid cmdlinepart intel_uncore_frequency spi_nor intel_uncore_frequency_common x86_pkg_temp_thermal intel_powerclamp mtd ucsi_acpi mei_gsc_proxy typec_ucsi coretemp typec intel_rapl_msr wmi_bmof kvm_intel kvm irqbypass polyval_clmulni snd_hda_intel ghash_clmulni_intel aesni_intel snd_intel_dspcfg rapl snd_hda_codec processor_thermal_device_pci intel_cstate snd_hda_core processor_thermal_device snd_hwdep processor_thermal_wt_hint snd_pcm platform_temperature_control processor_thermal_soc_slider snd_timer platform_profile e1000e spi_intel_pci snd processor_thermal_rfim spi_intel idma64 processor_thermal_rapl soundcore mei_me mei intel_ish_ipc intel_rapl_common processor_thermal_wt_req processor_thermal_power_floor intel_ishtp

<4> [219.299205] intel_vpu thunderbolt processor_thermal_mbox binfmt_misc intel_pmc_core video int3403_thermal intel_skl_int3472_tps68470 int340x_thermal_zone tps68470_regulator clk_tps68470 pmt_telemetry nls_iso8859_1 pmt_discovery wmi intel_hid pmt_class sparse_keymap acpi_pad intel_pmc_ssram_telemetry int3400_thermal intel_skl_int3472_discrete acpi_thermal_rel intel_skl_int3472_common acpi_tad pinctrl_intel_platform intel_vsec dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4

<4> [219.299228] CPU: 0 UID: 0 PID: 3932 Comm: xe_exec_system_ Tainted: G U 6.18.0-rc6-lgci-xe-xe-4121-91fc6d984707c9bfd+ #1 PREEMPT(voluntary)

<4> [219.299230] Tainted: [U]=USER

<4> [219.299231] Hardware name: Intel Corporation Lunar Lake Client Platform/LNL-M LP5 RVP1, BIOS LNLMFWI1.R00.3223.D99.2508051732 08/05/2025

<4> [219.299233] RIP: 0010:xe_svm_invalidate+0x4f7/0x650 [xe]

<4> [219.299327] Code: 45 a0 e8 8c 22 f3 ff 48 8b 7d a8 41 0f b6 ce 4c 89 e2 48 8b b5 78 ff ff ff e8 95 90 ff ff 4c 8b 45 a0 85 c0 0f 84 b5 fb ff ff <0f> 0b e9 ae fb ff ff 48 8b bd 58 ff ff ff 31 f6 48 89 4d a0 e8 e0

<4> [219.299329] RSP: 0018:ffffc9000c593a90 EFLAGS: 00010286

<4> [219.299330] RAX: 00000000ffffffed RBX: ffff88817a0dc190 RCX: 0000000000000000

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

<4> [219.299332] RBP: ffffc9000c593b48 R08: ffff8881abf6f240 R09: 0000000000000000

<4> [219.299333] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffffffffff

<4> [219.299334] R13: ffff888140cb8000 R14: 0000000000000001 R15: ffff8881abf6f240

<4> [219.299335] FS: 0000000000000000(0000) GS:ffff8888db2ea000(0000) knlGS:0000000000000000

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

<4> [219.299337] CR2: 00007c32e1402a7c CR3: 00000001a7de9003 CR4: 0000000000f72ef0

<4> [219.299338] PKRU: 55555554

<4> [219.299338] Call Trace:

<4> [219.299339] <TASK>

<4> [219.299345] drm_gpusvm_notifier_invalidate+0x59/0x80 [drm_gpusvm_helper]

<4> [219.299348] __mmu_notifier_release+0x1e6/0x260

<4> [219.299354] exit_mmap+0x45b/0x4a0

<4> [219.299359] ? __mutex_unlock_slowpath+0x40/0x350

<4> [219.299364] __mmput+0x43/0x160

<4> [219.299367] mmput+0x44/0x60

<4> [219.299369] do_exit+0x29d/0xb40

<4> [219.299372] do_group_exit+0x3a/0xb0

<4> [219.299374] __x64_sys_exit_group+0x18/0x20

<4> [219.299375] x64_sys_call+0x2694/0x26a0

<4> [219.299377] do_syscall_64+0x93/0xd30

<4> [219.299380] ? find_held_lock+0x31/0x90

<4> [219.299382] ? exc_page_fault+0x96/0x2c0

<4> [219.299385] ? lock_release+0xce/0x2a0

<4> [219.299388] ? do_user_addr_fault+0x5d1/0x8e0

<4> [219.299391] ? irqentry_exit_to_user_mode+0xf4/0x320

<4> [219.299393] ? irqentry_exit+0x77/0xb0

<4> [219.299395] ? exc_page_fault+0xbd/0x2c0

<4> [219.299397] entry_SYSCALL_64_after_hwframe+0x76/0x7e

<4> [219.299399] RIP: 0033:0x7c32e32ee21d

<4> [219.299400] Code: Unable to access opcode bytes at 0x7c32e32ee1f3.

<4> [219.299401] RSP: 002b:00007ffee2196e58 EFLAGS: 00000206 ORIG_RAX: 00000000000000e7

<4> [219.299403] RAX: ffffffffffffffda RBX: 00007c32e3404fa8 RCX: 00007c32e32ee21d

<4> [219.299404] RDX: 00000000000000e7 RSI: fffffffffffffee8 RDI: 0000000000000062

<4> [219.299405] RBP: 00007ffee2196eb0 R08: 00007ffee2196e00 R09: 0000000000000007

<4> [219.299405] R10: 0000624b578592a0 R11: 0000000000000206 R12: 0000000000000003

<4> [219.299406] R13: 0000000000000000 R14: 0000000000000062 R15: 00007c32e3404fc0

<4> [219.299411] </TASK>

<4> [219.299412] irq event stamp: 74093

<4> [219.299412] hardirqs last enabled at (74099): [<ffffffff814a6959>] __up_console_sem+0x79/0xa0

<4> [219.299415] hardirqs last disabled at (74104): [<ffffffff814a693e>] __up_console_sem+0x5e/0xa0

<4> [219.299416] softirqs last enabled at (72456): [<ffffffff813d3d9f>] __irq_exit_rcu+0x13f/0x160

<4> [219.299417] softirqs last disabled at (72449): [<ffffffff813d3d9f>] __irq_exit_rcu+0x13f/0x160

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

<7> [219.299469] xe 0000:00:02.0: [drm:guc_wait_ucode [xe]] Tile0: GT0: GuC load: init took 9ms, freq = 1850MHz (req = 1850MHz), before = 1850MHz, status = 0x8002F034

<7> [219.300216] xe 0000:00:02.0: [drm:guc_ct_change_state [xe]] Tile0: GT0: GuC CT communication channel enabled

<7> [219.300434] xe 0000:00:02.0: [drm:xe_svm_garbage_collector [xe]] Skipping madvise reset for vma.

<7> [219.302238] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: flag:0x1

<7> [219.302358] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: mocs entries: 16

<7> [219.302434] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[0] 0x4000 0xc

<7> [219.302526] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[1] 0x4004 0x10c

<7> [219.302605] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[2] 0x4008 0x130

<7> [219.302674] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[3] 0x400c 0x13c

<7> [219.302743] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[4] 0x4010 0x100

<7> [219.302810] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[5] 0x4014 0x100

<7> [219.302877] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[6] 0x4018 0x100

<7> [219.302942] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[7] 0x401c 0x100

<7> [219.303050] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[8] 0x4020 0x100

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

<7> [219.303115] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[9] 0x4024 0x100

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

<7> [219.303177] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[10] 0x4028 0x100

<7> [219.303240] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[11] 0x402c 0x100

<7> [219.303301] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[12] 0x4030 0x100

<7> [219.303364] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[13] 0x4034 0x100

<7> [219.303425] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[14] 0x4038 0x100

<7> [219.303499] xe 0000:00:02.0: [drm:xe_mocs_init [xe]] Tile0: GT0: GLOB_MOCS[15] 0x403c 0x100

<7> [219.303676] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying rcs0 save-restore MMIOs

<7> [219.303760] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x2050] = 0x10001000

<7> [219.303848] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20c4] = 0x3f7e0306

<7> [219.303925] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x20d4] = 0xc080c080

<7> [219.304010] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d0] = 0x1000dafc

<7> [219.304086] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d4] = 0x1000db01

<7> [219.304165] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x24d8] = 0x0000db1c

<7> [219.304263] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe194] = 0x00400040

<7> [219.304333] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe48c] = 0x02000200

<7> [219.304401] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe49c] = 0x40004000

<7> [219.304476] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4c4] = 0x08400840

<7> [219.304553] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe4f0] = 0x00020002

<7> [219.304630] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe530] = 0x00000400

<7> [219.304696] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7c8] = 0x00002000

<7> [219.304762] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0xe7cc] = 0x00009000

<7> [219.304825] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs0 save-restore MMIOs

<7> [219.304887] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x22050] = 0x10001000

<7> [219.304949] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220c4] = 0x3f7e0306

<7> [219.305008] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x220d4] = 0xc080c080

<7> [219.305069] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying bcs8 save-restore MMIOs

<7> [219.305129] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee050] = 0x10001000

<7> [219.305188] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0c4] = 0x3f7e0306

<7> [219.305246] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x3ee0d4] = 0xc080c080

<7> [219.305306] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: Applying ccs0 save-restore MMIOs

<7> [219.305363] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a050] = 0x10001000

<7> [219.305420] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0c4] = 0x3f7e0306

<7> [219.305482] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a0d4] = 0xc080c080

<7> [219.305540] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d0] = 0x1000dafc

<7> [219.305611] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d4] = 0x1000db01

<7> [219.305681] xe 0000:00:02.0: [drm:xe_reg_sr_apply_mmio [xe]] Tile0: GT0: REG[0x1a4d8] = 0x0000db1c

<6> [219.305750] xe 0000:00:02.0: [drm] Tile0: GT0: reset done

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

Created at 2025-11-18 07:26:28