[39.829206] Initializing watchdogs
[39.829264]   /dev/watchdog0
[39.844529] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[39.852925] [001/162] (960s left) i915_module_load (load)
[39.916235] Starting subtest: load
[42.915785] Subtest load: SUCCESS (3.021s)
[42.981882] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[42.984853] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[42.994094] [002/162] (957s left) core_auth (basic-auth)
[44.872423] Starting subtest: basic-auth
[44.879342] Subtest basic-auth: SUCCESS (0.002s)
[45.035972] [003/162] (955s left) core_debugfs (read-all-entries)
[45.138320] Starting subtest: read-all-entries
[45.297069] Subtest read-all-entries: SUCCESS (0.167s)
[45.456495] [004/162] (955s left) core_sysfs (read-all-entries)
[45.551799] Starting subtest: read-all-entries
[45.558463] Subtest read-all-entries: SUCCESS (0.011s)
[45.732870] [005/162] (954s left) fbdev (eof)
[45.830622] Starting subtest: eof
[45.837267] Subtest eof: SUCCESS (0.000s)
[46.020367] [006/162] (954s left) fbdev (info)
[46.115543] Starting subtest: info
[46.122455] Subtest info: SUCCESS (0.000s)
[46.280093] [007/162] (954s left) fbdev (nullptr)
[46.375001] Starting subtest: nullptr
[46.381965] Subtest nullptr: SUCCESS (0.000s)
[46.527662] [008/162] (954s left) fbdev (read)
[46.623047] Starting subtest: read
[48.145137] Subtest read: SUCCESS (1.472s)
[48.314011] [009/162] (952s left) fbdev (write)
[48.412389] Starting subtest: write
[49.145262] Subtest write: SUCCESS (0.714s)
[49.257549] [010/162] (951s left) gem_basic (bad-close)
[49.318830] Starting subtest: bad-close
[49.331830] Subtest bad-close: SUCCESS (0.000s)
[49.417639] [011/162] (951s left) gem_basic (create-close)
[49.466725] Starting subtest: create-close
[49.480436] Subtest create-close: SUCCESS (0.000s)
[49.645163] [012/162] (951s left) gem_basic (create-fd-close)
[49.702350] Starting subtest: create-fd-close
[49.715562] Subtest create-fd-close: SUCCESS (0.000s)
[49.848760] [013/162] (951s left) gem_busy (busy@all-engines)
[49.911793] Starting subtest: busy
[49.918290] Starting dynamic subtest: all-engines
[49.943604] Dynamic subtest all-engines: SUCCESS (0.037s)
[49.950127] Subtest busy: SUCCESS (0.037s)
[51.982978] [014/162] (949s left) gem_close_race (basic-process)
[52.075972] Starting subtest: basic-process
[52.138146] Subtest basic-process: SUCCESS (0.067s)
[52.390499] [015/162] (949s left) gem_close_race (basic-threads)
[52.455044] Starting subtest: basic-threads
[53.788460] Subtest basic-threads: SUCCESS (1.320s)
[54.024410] [016/162] (947s left) gem_ctx_create (basic)
[54.090332] Starting subtest: basic
[54.097657] Subtest basic: SUCCESS (0.000s)
[54.332956] [017/162] (947s left) gem_ctx_create (basic-files)
[54.402803] Starting subtest: basic-files
[56.408068] Subtest basic-files: SUCCESS (1.990s)
[57.913087] [018/162] (943s left) gem_ctx_exec (basic)
[57.966491] Starting subtest: basic
[57.972835] Subtest basic: SUCCESS (0.008s)
[58.136424] [019/162] (943s left) gem_exec_basic (basic)
[58.191942] Starting subtest: basic
[58.198595] Starting dynamic subtest: rcs0-smem
[58.205283] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[58.221041] Starting dynamic subtest: bcs0-smem
[58.227776] Dynamic subtest bcs0-smem: SUCCESS (0.006s)
[58.243284] Starting dynamic subtest: vcs0-smem
[58.250119] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[58.265459] Starting dynamic subtest: vcs1-smem
[58.271963] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[58.287121] Starting dynamic subtest: vecs0-smem
[58.293698] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[58.309140] Starting dynamic subtest: ccs0-smem
[58.315819] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[58.322667] Subtest basic: SUCCESS (0.023s)
[59.910364] [020/162] (941s left) gem_exec_create (basic)
[59.966427] Starting subtest: basic
[59.972681] Starting dynamic subtest: smem
[63.841313] Dynamic subtest smem: SUCCESS (3.853s)
[63.848232] Subtest basic: SUCCESS (3.854s)
[64.076778] [021/162] (937s left) gem_exec_fence (basic-busy)
[64.239407] Starting subtest: basic-busy
[64.245886] Starting dynamic subtest: rcs0
[64.350536] Dynamic subtest rcs0: SUCCESS (0.113s)
[64.381338] Starting dynamic subtest: bcs0
[64.424458] Dynamic subtest bcs0: SUCCESS (0.073s)
[64.454593] Starting dynamic subtest: vcs0
[64.490023] Dynamic subtest vcs0: SUCCESS (0.065s)
[64.520988] Starting dynamic subtest: vcs1
[64.558133] Dynamic subtest vcs1: SUCCESS (0.068s)
[64.589112] Starting dynamic subtest: vecs0
[64.625247] Dynamic subtest vecs0: SUCCESS (0.067s)
[64.654952] Starting dynamic subtest: ccs0
[64.693733] Dynamic subtest ccs0: SUCCESS (0.068s)
[64.700215] Subtest basic-busy: SUCCESS (0.455s)
[67.217467] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[67.230157] [022/162] (934s left) gem_exec_fence (basic-wait)
[67.458715] Starting subtest: basic-wait
[67.469112] Starting dynamic subtest: rcs0
[67.756258] Dynamic subtest rcs0: SUCCESS (0.294s)
[67.776384] Starting dynamic subtest: bcs0
[67.891861] Dynamic subtest bcs0: SUCCESS (0.132s)
[67.913985] Starting dynamic subtest: vcs0
[67.961823] Dynamic subtest vcs0: SUCCESS (0.068s)
[67.984394] Starting dynamic subtest: vcs1
[68.082952] Dynamic subtest vcs1: SUCCESS (0.124s)
[68.101764] Starting dynamic subtest: vecs0
[68.284065] Dynamic subtest vecs0: SUCCESS (0.191s)
[68.302129] Starting dynamic subtest: ccs0
[68.410737] Dynamic subtest ccs0: SUCCESS (0.138s)
[68.417377] Subtest basic-wait: SUCCESS (0.951s)
[70.004639] [023/162] (931s left) gem_exec_fence (basic-await)
[70.167428] Starting subtest: basic-await
[70.173687] Starting dynamic subtest: rcs0
[70.259684] Dynamic subtest rcs0: SUCCESS (0.094s)
[70.272017] Starting dynamic subtest: bcs0
[70.346356] Dynamic subtest bcs0: SUCCESS (0.087s)
[70.359044] Starting dynamic subtest: vcs0
[70.423721] Dynamic subtest vcs0: SUCCESS (0.077s)
[70.435641] Starting dynamic subtest: vcs1
[70.503087] Dynamic subtest vcs1: SUCCESS (0.079s)
[70.515879] Starting dynamic subtest: vecs0
[70.581850] Dynamic subtest vecs0: SUCCESS (0.079s)
[70.594240] Starting dynamic subtest: ccs0
[70.661838] Dynamic subtest ccs0: SUCCESS (0.080s)
[70.668118] Subtest basic-await: SUCCESS (0.496s)
[73.036636] [024/162] (928s left) gem_exec_fence (nb-await)
[73.198539] Starting subtest: nb-await
[73.204699] Starting dynamic subtest: rcs0
[73.276894] Dynamic subtest rcs0: SUCCESS (0.080s)
[73.288781] Starting dynamic subtest: bcs0
[73.340013] Dynamic subtest bcs0: SUCCESS (0.063s)
[73.351853] Starting dynamic subtest: vcs0
[73.404155] Dynamic subtest vcs0: SUCCESS (0.064s)
[73.415675] Starting dynamic subtest: vcs1
[73.468115] Dynamic subtest vcs1: SUCCESS (0.063s)
[73.479714] Starting dynamic subtest: vecs0
[73.530404] Dynamic subtest vecs0: SUCCESS (0.062s)
[73.541898] Starting dynamic subtest: ccs0
[73.592417] Dynamic subtest ccs0: SUCCESS (0.062s)
[73.598651] Subtest nb-await: SUCCESS (0.396s)
[75.019739] [025/162] (927s left) gem_exec_gttfill (basic)
[75.075154] Starting subtest: basic
[117.236101] Subtest basic: FAIL (41.672s)
[117.370984] [026/162] (884s left) gem_exec_parallel (engines)
[117.520934] Starting subtest: engines
[117.537352] Starting dynamic subtest: basic
[118.579371] Dynamic subtest basic: FAIL (0.487s)
[118.614048] Starting dynamic subtest: contexts
[119.482868] Dynamic subtest contexts: FAIL (0.142s)
[119.507711] Starting dynamic subtest: fds