[22.476377] Initializing watchdogs
[22.476532]   /dev/watchdog0
[22.496572] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4682 Intel Alderlake_s (Gen12) Alder Lake-S GT1 [UHD Graphics 730]
[22.515324] [001/162] (960s left) i915_module_load (load)
[22.607505] Starting subtest: load
[23.761575] Subtest load: SUCCESS (1.188s)
[23.804648] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[23.805437] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[23.812582] [002/162] (959s left) core_auth (basic-auth)
[23.876222] Starting subtest: basic-auth
[23.882744] Subtest basic-auth: SUCCESS (0.001s)
[23.984105] [003/162] (959s left) core_debugfs (read-all-entries)
[24.035309] Starting subtest: read-all-entries
[24.119206] Subtest read-all-entries: SUCCESS (0.085s)
[24.297052] [004/162] (958s left) core_sysfs (read-all-entries)
[24.376576] Starting subtest: read-all-entries
[24.383469] Subtest read-all-entries: SUCCESS (0.003s)
[24.492900] [005/162] (958s left) fbdev (eof)
[24.563732] Starting subtest: eof
[24.580378] Subtest eof: SUCCESS (0.001s)
[24.735097] [006/162] (958s left) fbdev (info)
[24.827284] Starting subtest: info
[24.833821] Subtest info: SUCCESS (0.000s)
[24.949360] [007/162] (958s left) fbdev (nullptr)
[25.018533] Starting subtest: nullptr
[25.026131] Subtest nullptr: SUCCESS (0.000s)
[25.139222] [008/162] (958s left) fbdev (read)
[25.208437] Starting subtest: read
[26.824998] Subtest read: SUCCESS (1.619s)
[26.943890] [009/162] (956s left) fbdev (write)
[27.015508] Starting subtest: write
[28.133189] Subtest write: SUCCESS (1.102s)
[28.240863] [010/162] (955s left) gem_basic (bad-close)
[28.312473] Starting subtest: bad-close
[28.325815] Subtest bad-close: SUCCESS (0.000s)
[28.434615] [011/162] (955s left) gem_basic (create-close)
[28.487883] Starting subtest: create-close
[28.501216] Subtest create-close: SUCCESS (0.000s)
[28.668926] [012/162] (954s left) gem_basic (create-fd-close)
[28.719700] Starting subtest: create-fd-close
[28.732497] Subtest create-fd-close: SUCCESS (0.000s)
[28.859672] [013/162] (954s left) gem_busy (busy@all-engines)
[28.927891] Starting subtest: busy
[28.934091] Starting dynamic subtest: all-engines
[28.940359] Dynamic subtest all-engines: SUCCESS (0.019s)
[28.946576] Subtest busy: SUCCESS (0.019s)
[29.381120] [014/162] (954s left) gem_close_race (basic-process)
[29.458260] Starting subtest: basic-process
[29.497760] Subtest basic-process: SUCCESS (0.049s)
[29.743389] [015/162] (954s left) gem_close_race (basic-threads)
[29.820141] Starting subtest: basic-threads
[31.065027] Subtest basic-threads: SUCCESS (1.247s)
[31.304304] [016/162] (952s left) gem_ctx_create (basic)
[31.396460] Starting subtest: basic
[31.402969] Subtest basic: SUCCESS (0.000s)
[31.634698] [017/162] (952s left) gem_ctx_create (basic-files)
[31.705854] Starting subtest: basic-files
[33.728438] Subtest basic-files: SUCCESS (2.008s)
[33.958755] [018/162] (950s left) gem_ctx_exec (basic)
[34.033606] Starting subtest: basic
[34.050203] Subtest basic: SUCCESS (0.002s)
[34.194332] [019/162] (949s left) gem_exec_basic (basic)
[34.239050] Starting subtest: basic
[34.245328] Starting dynamic subtest: rcs0-smem
[34.251811] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[34.274194] Starting dynamic subtest: bcs0-smem
[34.280765] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[34.299951] Starting dynamic subtest: vcs0-smem
[34.306532] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[34.323439] Starting dynamic subtest: vecs0-smem
[34.329912] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[34.336632] Subtest basic: SUCCESS (0.002s)
[34.475546] [020/162] (949s left) gem_exec_create (basic)
[34.530175] Starting subtest: basic
[34.536337] Starting dynamic subtest: smem
[36.603337] Dynamic subtest smem: SUCCESS (2.075s)
[36.609677] Subtest basic: SUCCESS (2.076s)
[36.851537] [021/162] (947s left) gem_exec_fence (basic-busy)
[37.047614] Starting subtest: basic-busy
[37.062202] Starting dynamic subtest: rcs0
[37.137087] Dynamic subtest rcs0: SUCCESS (0.083s)
[37.159101] Starting dynamic subtest: bcs0
[37.182291] Dynamic subtest bcs0: SUCCESS (0.043s)
[37.211848] Starting dynamic subtest: vcs0
[37.234984] Dynamic subtest vcs0: SUCCESS (0.054s)
[37.264547] Starting dynamic subtest: vecs0
[37.287794] Dynamic subtest vecs0: SUCCESS (0.052s)
[37.297512] Subtest basic-busy: SUCCESS (0.236s)
[37.806910] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[37.818869] [022/162] (946s left) gem_exec_fence (basic-wait)
[38.005956] Starting subtest: basic-wait
[38.022340] Starting dynamic subtest: rcs0
[38.081088] Dynamic subtest rcs0: SUCCESS (0.075s)
[38.101940] Starting dynamic subtest: bcs0
[38.125170] Dynamic subtest bcs0: SUCCESS (0.040s)
[38.152673] Starting dynamic subtest: vcs0
[38.173059] Dynamic subtest vcs0: SUCCESS (0.049s)
[38.204799] Starting dynamic subtest: vecs0
[38.213557] Dynamic subtest vecs0: SUCCESS (0.039s)
[38.226733] Subtest basic-wait: SUCCESS (0.207s)
[38.719893] [023/162] (945s left) gem_exec_fence (basic-await)
[38.907417] Starting subtest: basic-await
[38.916116] Starting dynamic subtest: rcs0
[38.977904] Dynamic subtest rcs0: SUCCESS (0.073s)
[38.994132] Starting dynamic subtest: bcs0
[39.046539] Dynamic subtest bcs0: SUCCESS (0.074s)
[39.062409] Starting dynamic subtest: vcs0
[39.120899] Dynamic subtest vcs0: SUCCESS (0.075s)
[39.144563] Starting dynamic subtest: vecs0
[39.210659] Dynamic subtest vecs0: SUCCESS (0.080s)
[39.217593] Subtest basic-await: SUCCESS (0.307s)
[39.712970] [024/162] (944s left) gem_exec_fence (nb-await)
[39.900354] Starting subtest: nb-await
[39.909197] Starting dynamic subtest: rcs0
[39.959993] Dynamic subtest rcs0: SUCCESS (0.062s)
[39.982263] Starting dynamic subtest: bcs0
[40.019994] Dynamic subtest bcs0: SUCCESS (0.062s)
[40.055162] Starting dynamic subtest: vcs0
[40.078945] Dynamic subtest vcs0: SUCCESS (0.063s)
[40.111075] Starting dynamic subtest: vecs0
[40.148299] Dynamic subtest vecs0: SUCCESS (0.063s)
[40.154929] Subtest nb-await: SUCCESS (0.255s)
[40.652400] [025/162] (943s left) gem_exec_gttfill (basic)
[40.739943] Starting subtest: basic
[43.061916] Subtest basic: SUCCESS (2.328s)
[43.315397] [026/162] (941s left) gem_exec_parallel (engines)
[43.428577] Starting subtest: engines
[43.444478] Starting dynamic subtest: basic
[44.752905] Dynamic subtest basic: SUCCESS (1.376s)
[44.778680] Starting dynamic subtest: contexts
[46.440120] Dynamic subtest contexts: SUCCESS (1.720s)
[46.459573] Starting dynamic subtest: fds
[48.044984] Dynamic subtest fds: SUCCESS (1.648s)
[48.065498] Starting dynamic subtest: userptr
[49.371176] Dynamic subtest userptr: SUCCESS (1.354s)
[49.384495] Subtest engines: SUCCESS (6.101s)
[49.637158] [027/162] (934s left) gem_exec_store (basic)
[49.736526] Starting subtest: basic
[49.780049] Subtest basic: SUCCESS (0.069s)
[50.010946] [028/162] (934s left) gem_flink_basic (bad-flink)
[50.081858] Starting subtest: bad-flink
[50.098127] Subtest bad-flink: SUCCESS (0.000s)
[50.200330] [029/162] (934s left) gem_flink_basic (bad-open)
[50.286776] Starting subtest: bad-open
[50.293281] Subtest bad-open: SUCCESS (0.000s)
[50.409782] [030/162] (934s left) gem_flink_basic (basic)
[50.477268] Starting subtest: basic
[50.490387] Subtest basic: SUCCESS (0.000s)
[50.629138] [031/162] (934s left) gem_flink_basic (double-flink)
[50.718950] Starting subtest: double-flink
[50.727556] Subtest double-flink: SUCCESS (0.000s)
[50.867577] [032/162] (934s left) gem_flink_basic (flink-lifetime)
[50.955771] Starting subtest: flink-lifetime
[50.962252] Subtest flink-lifetime: SUCCESS (0.002s)
[51.104379] [033/162] (933s left) gem_huc_copy (huc-copy)
[51.183083] Starting subtest: huc-copy
[51.191647] Subtest huc-copy: SUCCESS (0.002s)
[51.357237] [034/162] (933s left) gem_linear_blits (basic)
[51.479644] Starting subtest: basic
[51.485746] Subtest basic: SUCCESS (0.004s)
[51.647815] [035/162] (933s left) gem_mmap (basic)
[51.747428] Starting subtest: basic
[51.804193] Subtest basic: SUCCESS (0.001s)
[51.915065] [036/162] (933s left) gem_mmap_gtt (basic)
[52.007239] Starting subtest: basic
[52.013730] Subtest basic: SUCCESS (0.001s)
[52.137751] [037/162] (933s left) gem_render_linear_blits (basic)
[52.210426] Starting subtest: basic
[52.271426] Subtest basic: SUCCESS (0.023s)
[52.340125] [038/162] (932s left) gem_render_tiled_blits (basic)
[52.421206] Starting subtest: basic
[52.488728] Subtest basic: SUCCESS (0.021s)
[52.564152] [039/162] (932s left) gem_ringfill (basic-all)
[52.787915] Starting subtest: basic-all
[53.887083] Subtest basic-all: SUCCESS (1.102s)
[54.095552] [040/162] (931s left) gem_softpin (allocator-basic)
[54.163396] Starting subtest: allocator-basic
[54.218721] Subtest allocator-basic: SUCCESS (0.055s)
[54.410604] [041/162] (931s left) gem_softpin (allocator-basic-reserve)
[54.496213] Starting subtest: allocator-basic-reserve
[54.542294] Subtest allocator-basic-reserve: SUCCESS (0.058s)
[54.713742] [042/162] (930s left) gem_softpin (safe-alignment)
[54.786080] Starting subtest: safe-alignment
[54.802474] Subtest safe-alignment: SUCCESS (0.008s)
[54.988217] [043/162] (930s left) gem_sync (basic-all)