Results for igt@xe_exec_fault_mode@invalid-va

Machine description: shard-lnl-5

Result: Fail

i915_display_info8 igt_runner8 results8.json results8-xe-load.json boot8 dmesg8

DetailValue
Duration 1.05 seconds
Hostname 
shard-lnl-5
Igt-Version 
IGT-Version: 1.30-gbfefe1665 (x86_64) (Linux: 6.14.0-rc5-xe+ x86_64)
Out 
Using IGT_SRANDOM=1741536868 for randomisation
Opened device: /dev/dri/card0
Starting subtest: invalid-va
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/intel/xe_exec_fault_mode.c:340 test_exec()
  #2 ../tests/intel/xe_exec_fault_mode.c:504 __igt_unique____real_main401()
  #3 ../tests/intel/xe_exec_fault_mode.c:401 main()
  #4 [__libc_init_first+0x8a]
  #5 [__libc_start_main+0x8b]
  #6 [_start+0x25]
Subtest invalid-va: FAIL (1.049s)
Err 
Starting subtest: invalid-va
(xe_exec_fault_mode:5845) CRITICAL: Test assertion failure function test_exec, file ../tests/intel/xe_exec_fault_mode.c:340:
(xe_exec_fault_mode:5845) CRITICAL: Failed assertion: __xe_wait_ufence(fd, &exec_sync[i], 0xdeadbeefdeadbeefull, exec_queues[i % n_exec_queues], &timeout) == -5
(xe_exec_fault_mode:5845) CRITICAL: Last errno: 62, Timer expired
(xe_exec_fault_mode:5845) CRITICAL: error: -62 != -5
Subtest invalid-va failed.
**** DEBUG ****
(xe_exec_fault_mode:5845) DEBUG: test_exec running on: DRM_XE_ENGINE_CLASS_RENDER
(xe_exec_fault_mode:5845) CRITICAL: Test assertion failure function test_exec, file ../tests/intel/xe_exec_fault_mode.c:340:
(xe_exec_fault_mode:5845) CRITICAL: Failed assertion: __xe_wait_ufence(fd, &exec_sync[i], 0xdeadbeefdeadbeefull, exec_queues[i % n_exec_queues], &timeout) == -5
(xe_exec_fault_mode:5845) CRITICAL: Last errno: 62, Timer expired
(xe_exec_fault_mode:5845) CRITICAL: error: -62 != -5
(xe_exec_fault_mode:5845) igt_core-INFO: Stack trace:
(xe_exec_fault_mode:5845) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(xe_exec_fault_mode:5845) igt_core-INFO:   #1 ../tests/intel/xe_exec_fault_mode.c:340 test_exec()
(xe_exec_fault_mode:5845) igt_core-INFO:   #2 ../tests/intel/xe_exec_fault_mode.c:504 __igt_unique____real_main401()
(xe_exec_fault_mode:5845) igt_core-INFO:   #3 ../tests/intel/xe_exec_fault_mode.c:401 main()
(xe_exec_fault_mode:5845) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(xe_exec_fault_mode:5845) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(xe_exec_fault_mode:5845) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Subtest invalid-va: FAIL (1.049s)
Dmesg
<6> [240.205217] Console: switching to colour dummy device 80x25
<6> [240.205514] [IGT] xe_exec_fault_mode: executing
<6> [240.208943] [IGT] xe_exec_fault_mode: starting subtest invalid-va
<7> [240.212607] xe 0000:00:02.0: [drm:pf_queue_work_func [xe]]
ASID: 122
VFID: 0
PDATA: 0x0490
Faulted Address: 0x0000fffffffff000
FaultType: 0
AccessType: 1
FaultLevel: 3
EngineClass: 0 rcs
EngineInstance: 0
<3> [240.212710] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:321
<3> [240.212738] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2141, name: kworker/u36:4
<3> [240.212746] preempt_count: 1, expected: 0
<3> [240.212750] RCU nest depth: 0, expected: 0
<4> [240.212754] 3 locks held by kworker/u36:4/2141:
<4> [240.212755] #0: ffff888128c89148 ((wq_completion)xe_gt_page_fault_work_queue){+.+.}-{0:0}, at: process_one_work+0x444/0x740
<4> [240.212763] #1: ffffc9000a2d3e20 ((work_completion)(&pf_queue->worker)){+.+.}-{0:0}, at: process_one_work+0x1da/0x740
<4> [240.212767] #2: ffff888164afc910 (&vm->pfs.lock){+.+.}-{2:2}, at: pf_queue_work_func+0x37d/0x550 [xe]
<4> [240.212814] CPU: 0 UID: 0 PID: 2141 Comm: kworker/u36:4 Tainted: G U 6.14.0-rc5-xe+ #1
<4> [240.212816] Tainted: [U]=USER
<4> [240.212816] Hardware name: Intel Corporation Lunar Lake Client Platform/LNL-M LP5 RVP1, BIOS LNLMFWI1.R00.3223.D86.2501240726 01/24/2025
<4> [240.212817] Workqueue: xe_gt_page_fault_work_queue pf_queue_work_func [xe]
<4> [240.212859] Call Trace:
<4> [240.212859] <TASK>
<4> [240.212860] dump_stack_lvl+0xc1/0xf0
<4> [240.212863] dump_stack+0x10/0x20
<4> [240.212864] __might_resched+0x181/0x2d0
<4> [240.212867] __might_sleep+0x58/0xa0
<4> [240.212869] __kmalloc_node_track_caller_noprof+0x3ae/0x680
<4> [240.212871] ? lock_release+0xd4/0x2b0
<4> [240.212874] ? pf_queue_work_func+0x390/0x550 [xe]
<4> [240.212915] kmemdup_noprof+0x20/0x50
<4> [240.212917] ? kmemdup_noprof+0x20/0x50
<4> [240.212918] pf_queue_work_func+0x390/0x550 [xe]
<4> [240.212960] process_one_work+0x21c/0x740
<4> [240.212965] worker_thread+0x1db/0x3c0
<4> [240.212967] ? __pfx_worker_thread+0x10/0x10
<4> [240.212969] kthread+0x10d/0x270
<4> [240.212971] ? __pfx_kthread+0x10/0x10
<4> [240.212973] ret_from_fork+0x44/0x70
<4> [240.212975] ? __pfx_kthread+0x10/0x10
<4> [240.212976] ret_from_fork_asm+0x1a/0x30
<4> [240.212983] </TASK>
<4> [240.213012]
<4> [240.213014] ============================================
<4> [240.213016] WARNING: possible recursive locking detected
<4> [240.213019] 6.14.0-rc5-xe+ #1 Tainted: G U W
<4> [240.213021] --------------------------------------------
<4> [240.213023] kworker/u36:4/2141 is trying to acquire lock:
<4> [240.213025] ffff888164afc910 (&vm->pfs.lock){+.+.}-{2:2}, at: xe_vm_add_pf_entry+0x79/0x240 [xe]
<4> [240.213115]
but task is already holding lock:
<4> [240.213118] ffff888164afc910 (&vm->pfs.lock){+.+.}-{2:2}, at: pf_queue_work_func+0x37d/0x550 [xe]
<4> [240.213174]
other info that might help us debug this:
<4> [240.213176] Possible unsafe locking scenario:
<4> [240.213179] CPU0
<4> [240.213180] ----
<4> [240.213181] lock(&vm->pfs.lock);
<4> [240.213184] lock(&vm->pfs.lock);
<4> [240.213186]
*** DEADLOCK ***
<4> [240.213188] May be due to missing lock nesting notation
<4> [240.213190] 3 locks held by kworker/u36:4/2141:
<4> [240.213192] #0: ffff888128c89148 ((wq_completion)xe_gt_page_fault_work_queue){+.+.}-{0:0}, at: process_one_work+0x444/0x740
<4> [240.213199] #1: ffffc9000a2d3e20 ((work_completion)(&pf_queue->worker)){+.+.}-{0:0}, at: process_one_work+0x1da/0x740
<4> [240.213204] #2: ffff888164afc910 (&vm->pfs.lock){+.+.}-{2:2}, at: pf_queue_work_func+0x37d/0x550 [xe]
<4> [240.213258]
stack backtrace:
<4> [240.213260] CPU: 0 UID: 0 PID: 2141 Comm: kworker/u36:4 Tainted: G U W 6.14.0-rc5-xe+ #1
<4> [240.213262] Tainted: [U]=USER, [W]=WARN
<4> [240.213262] Hardware name: Intel Corporation Lunar Lake Client Platform/LNL-M LP5 RVP1, BIOS LNLMFWI1.R00.3223.D86.2501240726 01/24/2025
<4> [240.213263] Workqueue: xe_gt_page_fault_work_queue pf_queue_work_func [xe]
<4> [240.213307] Call Trace:
<4> [240.213307] <TASK>
<4> [240.213307] dump_stack_lvl+0x91/0xf0
<4> [240.213308] dump_stack+0x10/0x20
<4> [240.213309] print_deadlock_bug+0x23f/0x320
<4> [240.213311] __lock_acquire+0x145f/0x2810
<4> [240.213313] ? mark_held_locks+0x46/0x90
<4> [240.213315] lock_acquire+0xc9/0x300
<4> [240.213316] ? xe_vm_add_pf_entry+0x79/0x240 [xe]
<4> [240.213380] ? __kmalloc_cache_noprof+0x350/0x490
<4> [240.213382] _raw_spin_lock+0x2f/0x60
<4> [240.213384] ? xe_vm_add_pf_entry+0x79/0x240 [xe]
<4> [240.213444] xe_vm_add_pf_entry+0x79/0x240 [xe]
<4> [240.213504] pf_queue_work_func+0x39b/0x550 [xe]
<4> [240.213543] process_one_work+0x21c/0x740
<4> [240.213545] worker_thread+0x1db/0x3c0
<4> [240.213547] ? __pfx_worker_thread+0x10/0x10
<4> [240.213548] kthread+0x10d/0x270
<4> [240.213549] ? __pfx_kthread+0x10/0x10
<4> [240.213549] ret_from_fork+0x44/0x70
<4> [240.213550] ? __pfx_kthread+0x10/0x10
<4> [240.213551] ret_from_fork_asm+0x1a/0x30
<4> [240.213553] </TASK>
<7> [240.857055] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [240.857059] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [240.857068] xe 0000:00:02.0: [drm:intel_tc_port_reset_mode [xe]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected)
<6> [241.257738] [IGT] xe_exec_fault_mode: finished subtest invalid-va, FAIL
<6> [241.257905] [IGT] xe_exec_fault_mode: exiting, ret=98
<6> [241.258222] Console: switching to colour frame buffer device 180x56
<6> [241.263237] xe 0000:00:02.0: [drm] GT0: Engine reset: engine_class=rcs, logical_mask: 0x1, guc_id=3
<7> [242.443840] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 turning VDD off
<7> [242.444039] xe 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [xe]] [ENCODER:188:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
Created at 2025-03-09 18:02:52