[58.343161] Initializing watchdogs
[58.343218]   /dev/watchdog0
[58.360885] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d67 Intel Meteorlake (Gen12) 
[58.370265] [001/162] (960s left) i915_module_load (load)
[58.425606] Starting subtest: load
[61.110900] Subtest load: SUCCESS (2.695s)
[61.148954] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.150232] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[61.156570] [002/162] (957s left) core_auth (basic-auth)
[62.222750] Starting subtest: basic-auth
[62.228402] Subtest basic-auth: SUCCESS (0.002s)
[62.368578] [003/162] (956s left) core_debugfs (read-all-entries)
[62.426073] Starting subtest: read-all-entries
[62.494903] Subtest read-all-entries: SUCCESS (0.073s)
[62.601178] [004/162] (956s left) core_sysfs (read-all-entries)
[62.658081] Starting subtest: read-all-entries
[62.663470] Subtest read-all-entries: SUCCESS (0.003s)
[62.750723] [005/162] (956s left) fbdev (eof)
[62.796560] Starting subtest: eof
[62.801892] Subtest eof: SUCCESS (0.000s)
[62.902264] [006/162] (956s left) fbdev (info)
[62.951968] Starting subtest: info
[62.957187] Subtest info: SUCCESS (0.000s)
[63.015314] [007/162] (956s left) fbdev (nullptr)
[63.064938] Starting subtest: nullptr
[63.070873] Subtest nullptr: SUCCESS (0.000s)
[63.132587] [008/162] (956s left) fbdev (read)
[63.182351] Starting subtest: read
[63.916963] Subtest read: SUCCESS (0.730s)
[63.974793] [009/162] (955s left) fbdev (write)
[64.029069] Starting subtest: write
[64.550966] Subtest write: SUCCESS (0.514s)
[64.608511] [010/162] (954s left) gem_basic (bad-close)
[64.668982] Starting subtest: bad-close
[64.679638] Subtest bad-close: SUCCESS (0.000s)
[64.768914] [011/162] (954s left) gem_basic (create-close)
[64.820849] Starting subtest: create-close
[64.831534] Subtest create-close: SUCCESS (0.000s)
[64.919467] [012/162] (954s left) gem_basic (create-fd-close)
[64.976683] Starting subtest: create-fd-close
[64.987528] Subtest create-fd-close: SUCCESS (0.000s)
[65.068183] [013/162] (954s left) gem_busy (busy@all-engines)
[65.133047] Starting subtest: busy
[65.138695] Starting dynamic subtest: all-engines
[65.167912] Dynamic subtest all-engines: SUCCESS (0.035s)
[65.173122] Subtest busy: SUCCESS (0.035s)
[67.321167] [014/162] (952s left) gem_close_race (basic-process)
[67.394940] Starting subtest: basic-process
[67.433787] Subtest basic-process: SUCCESS (0.040s)
[67.619226] [015/162] (951s left) gem_close_race (basic-threads)
[67.692125] Starting subtest: basic-threads
[69.194406] Subtest basic-threads: SUCCESS (1.494s)
[69.424703] [016/162] (950s left) gem_ctx_create (basic)
[69.516968] Starting subtest: basic
[69.524193] Subtest basic: SUCCESS (0.000s)
[69.713464] [017/162] (949s left) gem_ctx_create (basic-files)
[69.853748] Starting subtest: basic-files
[71.861260] Subtest basic-files: SUCCESS (2.008s)
[73.322695] [018/162] (946s left) gem_ctx_exec (basic)
[73.381445] Starting subtest: basic
[73.392241] Subtest basic: SUCCESS (0.007s)
[73.535761] [019/162] (946s left) gem_exec_basic (basic)
[73.601865] Starting subtest: basic
[73.607151] Starting dynamic subtest: rcs0-smem
[73.612539] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[73.623634] Starting dynamic subtest: bcs0-smem
[73.629046] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[73.640043] Starting dynamic subtest: vcs0-smem
[73.645545] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[73.656422] Starting dynamic subtest: vcs1-smem
[73.661757] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[73.672474] Starting dynamic subtest: vecs0-smem
[73.677914] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[73.688748] Starting dynamic subtest: ccs0-smem
[73.694039] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[73.699762] Subtest basic: SUCCESS (0.012s)
[75.289277] [020/162] (944s left) gem_exec_create (basic)
[75.360862] Starting subtest: basic
[75.366489] Starting dynamic subtest: smem
[78.314195] Dynamic subtest smem: SUCCESS (2.944s)
[78.320577] Subtest basic: SUCCESS (2.945s)
[78.496554] [021/162] (941s left) gem_exec_fence (basic-busy)
[78.680435] Starting subtest: basic-busy
[78.685899] Starting dynamic subtest: rcs0
[78.756905] Dynamic subtest rcs0: SUCCESS (0.076s)
[78.768129] Starting dynamic subtest: bcs0
[78.804913] Dynamic subtest bcs0: SUCCESS (0.047s)
[78.816231] Starting dynamic subtest: vcs0
[78.852790] Dynamic subtest vcs0: SUCCESS (0.047s)
[78.863635] Starting dynamic subtest: vcs1
[78.900633] Dynamic subtest vcs1: SUCCESS (0.047s)
[78.911362] Starting dynamic subtest: vecs0
[78.951649] Dynamic subtest vecs0: SUCCESS (0.050s)
[78.961965] Starting dynamic subtest: ccs0
[79.000947] Dynamic subtest ccs0: SUCCESS (0.049s)
[79.006779] Subtest basic-busy: SUCCESS (0.321s)
[81.322623] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[81.328937] [022/162] (938s left) gem_exec_fence (basic-wait)
[81.511200] Starting subtest: basic-wait
[81.516705] Starting dynamic subtest: rcs0
[81.563408] Dynamic subtest rcs0: SUCCESS (0.057s)
[81.574688] Starting dynamic subtest: bcs0
[81.610503] Dynamic subtest bcs0: SUCCESS (0.046s)
[81.621974] Starting dynamic subtest: vcs0
[81.659125] Dynamic subtest vcs0: SUCCESS (0.048s)
[81.670602] Starting dynamic subtest: vcs1
[81.710096] Dynamic subtest vcs1: SUCCESS (0.050s)
[81.721608] Starting dynamic subtest: vecs0
[81.757101] Dynamic subtest vecs0: SUCCESS (0.046s)
[81.768332] Starting dynamic subtest: ccs0
[81.805244] Dynamic subtest ccs0: SUCCESS (0.047s)
[81.810900] Subtest basic-wait: SUCCESS (0.300s)
[83.314371] [023/162] (936s left) gem_exec_fence (basic-await)
[83.494044] Starting subtest: basic-await
[83.499547] Starting dynamic subtest: rcs0
[83.577665] Dynamic subtest rcs0: SUCCESS (0.084s)
[83.589269] Starting dynamic subtest: bcs0
[83.654871] Dynamic subtest bcs0: SUCCESS (0.076s)
[83.666242] Starting dynamic subtest: vcs0
[83.731742] Dynamic subtest vcs0: SUCCESS (0.076s)
[83.743336] Starting dynamic subtest: vcs1
[83.808748] Dynamic subtest vcs1: SUCCESS (0.076s)
[83.820134] Starting dynamic subtest: vecs0
[83.885563] Dynamic subtest vecs0: SUCCESS (0.076s)
[83.896953] Starting dynamic subtest: ccs0
[83.963291] Dynamic subtest ccs0: SUCCESS (0.077s)
[83.968889] Subtest basic-await: SUCCESS (0.471s)
[85.298166] [024/162] (934s left) gem_exec_fence (nb-await)
[85.475866] Starting subtest: nb-await
[85.481499] Starting dynamic subtest: rcs0
[85.544062] Dynamic subtest rcs0: SUCCESS (0.068s)
[85.555990] Starting dynamic subtest: bcs0
[85.604454] Dynamic subtest bcs0: SUCCESS (0.060s)
[85.616423] Starting dynamic subtest: vcs0
[85.664957] Dynamic subtest vcs0: SUCCESS (0.059s)
[85.676289] Starting dynamic subtest: vcs1
[85.724157] Dynamic subtest vcs1: SUCCESS (0.058s)
[85.735524] Starting dynamic subtest: vecs0
[85.783573] Dynamic subtest vecs0: SUCCESS (0.058s)
[85.795108] Starting dynamic subtest: ccs0
[85.842931] Dynamic subtest ccs0: SUCCESS (0.058s)
[85.848810] Subtest nb-await: SUCCESS (0.368s)
[87.348306] [025/162] (932s left) gem_exec_gttfill (basic)
[87.428979] Starting subtest: basic
[89.750546] Subtest basic: SUCCESS (2.331s)
[89.930967] [026/162] (930s left) gem_exec_parallel (engines)
[90.014586] Starting subtest: engines
[90.020164] Starting dynamic subtest: basic
[93.227834] Dynamic subtest basic: SUCCESS (3.204s)
[93.241407] Starting dynamic subtest: contexts
[95.531534] Dynamic subtest contexts: SUCCESS (2.303s)
[95.543877] Starting dynamic subtest: fds
[97.521578] Dynamic subtest fds: SUCCESS (1.989s)
[97.534191] Starting dynamic subtest: userptr
[99.241828] Dynamic subtest userptr: SUCCESS (1.720s)
[99.247738] Subtest engines: SUCCESS (9.219s)
[99.430538] [027/162] (920s left) gem_exec_store (basic)
[99.513042] Starting subtest: basic
[99.593039] Subtest basic: SUCCESS (0.090s)
[99.823560] [028/162] (920s left) gem_flink_basic (bad-flink)
[99.880368] Starting subtest: bad-flink
[99.887284] Subtest bad-flink: SUCCESS (0.000s)
[100.010102] [029/162] (920s left) gem_flink_basic (bad-open)
[100.069340] Starting subtest: bad-open
[100.074734] Subtest bad-open: SUCCESS (0.000s)
[100.175784] [030/162] (919s left) gem_flink_basic (basic)
[100.232037] Starting subtest: basic
[100.237512] Subtest basic: SUCCESS (0.000s)
[100.341870] [031/162] (919s left) gem_flink_basic (double-flink)
[100.398965] Starting subtest: double-flink
[100.404422] Subtest double-flink: SUCCESS (0.000s)
[100.508210] [032/162] (919s left) gem_flink_basic (flink-lifetime)
[100.564435] Starting subtest: flink-lifetime
[100.569743] Subtest flink-lifetime: SUCCESS (0.002s)
[100.674733] [033/162] (919s left) gem_huc_copy (huc-copy)
[100.737036] Starting subtest: huc-copy
[100.742523] Subtest huc-copy: SUCCESS (0.003s)
[100.859412] [034/162] (919s left) gem_linear_blits (basic)
[101.027175] Starting subtest: basic
[101.038464] Subtest basic: SUCCESS (0.011s)
[101.169775] [035/162] (919s left) gem_mmap (basic)
[101.256511] Subtest basic: SKIP (0.000s)
[101.312871] [036/162] (919s left) gem_mmap_gtt (basic)
[101.380734] Subtest basic: SKIP (0.000s)
[101.440905] [037/162] (919s left) gem_render_linear_blits (basic)
[101.504085] Starting subtest: basic
[101.536845] Subtest basic: SUCCESS (0.033s)
[101.624463] [038/162] (918s left) gem_render_tiled_blits (basic)
[101.694499] Subtest basic: SKIP (0.000s)
[101.750935] [039/162] (918s left) gem_ringfill (basic-all)
[107.247522] Starting subtest: basic-all
[108.405414] Subtest basic-all: SUCCESS (1.161s)
[108.542985] [040/162] (912s left) gem_softpin (allocator-basic)
[108.606120] Starting subtest: allocator-basic
[108.689089] Subtest allocator-basic: SUCCESS (0.088s)
[108.798041] [041/162] (911s left) gem_softpin (allocator-basic-reserve)
[108.863397] Starting subtest: allocator-basic-reserve
[108.935500] Subtest allocator-basic-reserve: SUCCESS (0.074s)
[109.064644] [042/162] (911s left) gem_softpin (safe-alignment)
[109.141241] Starting subtest: safe-alignment
[109.161719] Subtest safe-alignment: SUCCESS (0.023s)
[110.294239] [043/162] (910s left) gem_sync (basic-all)
[110.401921] Starting subtest: basic-all
[114.218929] Subtest basic-all: SUCCESS (3.848s)
[114.411672] [044/162] (906s left) gem_sync (basic-each)
[114.518120] Starting subtest: basic-each
[116.791393] Subtest basic-each: SUCCESS (2.311s)
[116.992937] [045/162] (903s left) gem_tiled_blits (basic)
[117.093740] Subtest basic: SKIP (0.000s)
[117.160045] [046/162] (903s left) gem_tiled_fence_blits (basic)
[117.233189] Subtest basic: SKIP (0.000s)
[117.292676] [047/162] (903s left) gem_tiled_pread_basic (basic)
[117.356804] Subtest basic: SKIP (0.000s)
[117.427424] [048/162] (903s left) gem_wait (busy@all-engines)
[117.496874] Starting subtest: busy
[117.502267] Starting dynamic subtest: all-engines
[119.274310] Dynamic subtest all-engines: SUCCESS (1.768s)
[119.280632] Subtest busy: SUCCESS (1.769s)
[119.467292] [049/162] (901s left) gem_wait (wait@all-engines)
[119.532410] Starting subtest: wait
[119.538413] Starting dynamic subtest: all-engines
[121.257345] Dynamic subtest all-engines: SUCCESS (1.717s)
[121.263354] Subtest wait: SUCCESS (1.717s)
[121.460575] [050/162] (899s left) i915_getparams_basic (basic-eu-total)
[121.519830] Starting subtest: basic-eu-total
[121.531045] Subtest basic-eu-total: SUCCESS (0.000s)
[121.603809] [051/162] (899s left) i915_getparams_basic (basic-subslice-total)
[121.670337] Starting subtest: basic-subslice-total
[121.681091] Subtest basic-subslice-total: SUCCESS (0.000s)
[121.759554] [052/162] (899s left) i915_hangman (error-state-basic)
[121.822655] Starting subtest: error-state-basic
[121.939370] Subtest error-state-basic: SUCCESS (0.114s)
[122.046376] [053/162] (899s left) i915_pciid
[122.210635] [054/162] (899s left) intel_hwmon (hwmon-read)
[122.272565] Subtest hwmon-read: SKIP (0.000s)
[122.326714] [055/162] (898s left) intel_hwmon (hwmon-write)
[122.384144] Subtest hwmon-write: SKIP (0.000s)
[122.460795] [056/162] (898s left) kms_addfb_basic (addfb25-4-tiled)
[122.581439] Starting subtest: addfb25-4-tiled
[122.586839] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[122.676314] [057/162] (898s left) kms_addfb_basic (addfb25-bad-modifier)
[122.788590] Starting subtest: addfb25-bad-modifier
[122.793852] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[122.892573] [058/162] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[123.010090] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[123.110663] [059/162] (898s left) kms_addfb_basic (addfb25-modifier-no-flag)
[123.222498] Starting subtest: addfb25-modifier-no-flag
[123.227774] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[123.342826] [060/162] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[123.463078] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[123.560394] [061/162] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[123.685482] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[123.776468] [062/162] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[123.902774] Starting subtest: addfb25-yf-tiled-legacy
[123.910976] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[123.999818] [063/162] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[124.121886] Starting subtest: addfb25-y-tiled-legacy
[124.127087] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[124.233712] [064/162] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[124.351667] Starting subtest: addfb25-y-tiled-small-legacy
[124.362380] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[124.447435] [065/162] (897s left) kms_addfb_basic (bad-pitch-0)
[124.507059] Starting subtest: bad-pitch-0
[124.514812] Subtest bad-pitch-0: SUCCESS (0.000s)
[124.661798] [066/162] (897s left) kms_addfb_basic (bad-pitch-1024)
[124.725869] Starting subtest: bad-pitch-1024
[124.731254] Subtest bad-pitch-1024: SUCCESS (0.000s)
[124.877418] [067/162] (896s left) kms_addfb_basic (bad-pitch-128)
[124.937767] Starting subtest: bad-pitch-128
[124.943131] Subtest bad-pitch-128: SUCCESS (0.000s)
[125.096850] [068/162] (896s left) kms_addfb_basic (bad-pitch-256)
[125.152612] Starting subtest: bad-pitch-256
[125.160976] Subtest bad-pitch-256: SUCCESS (0.000s)
[125.311585] [069/162] (896s left) kms_addfb_basic (bad-pitch-32)
[125.365055] Starting subtest: bad-pitch-32
[125.373915] Subtest bad-pitch-32: SUCCESS (0.000s)
[125.526415] [070/162] (896s left) kms_addfb_basic (bad-pitch-63)
[125.591997] Starting subtest: bad-pitch-63
[125.597342] Subtest bad-pitch-63: SUCCESS (0.000s)
[125.764475] [071/162] (896s left) kms_addfb_basic (bad-pitch-65536)
[125.829828] Starting subtest: bad-pitch-65536
[125.835240] Subtest bad-pitch-65536: SUCCESS (0.000s)
[125.983054] [072/162] (896s left) kms_addfb_basic (bad-pitch-999)
[126.038945] Starting subtest: bad-pitch-999
[126.048266] Subtest bad-pitch-999: SUCCESS (0.000s)
[126.212927] [073/162] (895s left) kms_addfb_basic (basic)
[126.283468] Starting subtest: basic
[126.288930] Subtest basic: SUCCESS (0.000s)
[126.442869] [074/162] (895s left) kms_addfb_basic (basic-x-tiled-legacy)
[126.502708] Starting subtest: basic-x-tiled-legacy
[126.513588] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[126.659606] [075/162] (895s left) kms_addfb_basic (basic-y-tiled-legacy)
[126.715410] Starting subtest: basic-y-tiled-legacy
[126.726190] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[126.876326] [076/162] (895s left) kms_addfb_basic (bo-too-small)
[126.988515] Starting subtest: bo-too-small
[126.993974] Subtest bo-too-small: SUCCESS (0.000s)
[127.092838] [077/162] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[127.203154] Starting subtest: bo-too-small-due-to-tiling
[127.213977] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[127.309978] [078/162] (895s left) kms_addfb_basic (clobberred-modifier)
[127.365366] Starting subtest: clobberred-modifier
[127.376287] Subtest clobberred-modifier: SKIP (0.000s)
[127.526858] [079/162] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[127.583095] Starting subtest: framebuffer-vs-set-tiling
[127.593982] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[127.743269] [080/162] (894s left) kms_addfb_basic (invalid-get-prop)
[127.798619] Starting subtest: invalid-get-prop
[127.807764] Subtest invalid-get-prop: SUCCESS (0.000s)
[127.959704] [081/162] (894s left) kms_addfb_basic (invalid-get-prop-any)
[128.015563] Starting subtest: invalid-get-prop-any
[128.020917] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[128.176224] [082/162] (894s left) kms_addfb_basic (invalid-set-prop)
[128.232115] Starting subtest: invalid-set-prop
[128.237533] Subtest invalid-set-prop: SUCCESS (0.000s)
[128.377654] [083/162] (894s left) kms_addfb_basic (invalid-set-prop-any)
[128.433407] Starting subtest: invalid-set-prop-any
[128.438719] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[128.627121] [084/162] (894s left) kms_addfb_basic (no-handle)
[128.683400] Starting subtest: no-handle
[128.688703] Subtest no-handle: SUCCESS (0.000s)
[128.860249] [085/162] (893s left) kms_addfb_basic (size-max)
[128.976712] Starting subtest: size-max
[128.982190] Subtest size-max: SUCCESS (0.000s)
[129.093389] [086/162] (893s left) kms_addfb_basic (small-bo)
[129.206898] Starting subtest: small-bo
[129.212509] Subtest small-bo: SUCCESS (0.000s)
[129.327608] [087/162] (893s left) kms_addfb_basic (tile-pitch-mismatch)
[129.383947] Starting subtest: tile-pitch-mismatch
[129.394566] Subtest tile-pitch-mismatch: SKIP (0.000s)
[129.543180] [088/162] (893s left) kms_addfb_basic (too-high)
[129.655092] Starting subtest: too-high
[129.660560] Subtest too-high: SUCCESS (0.001s)
[129.760307] [089/162] (893s left) kms_addfb_basic (too-wide)
[129.871881] Starting subtest: too-wide
[129.877253] Subtest too-wide: SUCCESS (0.000s)
[129.976680] [090/162] (892s left) kms_addfb_basic (unused-handle)
[130.032395] Starting subtest: unused-handle
[130.037759] Subtest unused-handle: SUCCESS (0.000s)
[130.193227] [091/162] (892s left) kms_addfb_basic (unused-modifier)
[130.248432] Starting subtest: unused-modifier
[130.253767] Subtest unused-modifier: SUCCESS (0.000s)
[130.410437] [092/162] (892s left) kms_addfb_basic (unused-offsets)
[130.466466] Starting subtest: unused-offsets
[130.471989] Subtest unused-offsets: SUCCESS (0.000s)
[130.626177] [093/162] (892s left) kms_addfb_basic (unused-pitches)
[130.683161] Starting subtest: unused-pitches
[130.688659] Subtest unused-pitches: SUCCESS (0.000s)
[130.843040] [094/162] (892s left) kms_busy (basic)
[130.964825] Starting subtest: basic
[130.970141] Starting dynamic subtest: flip
[131.530347] Dynamic subtest flip: SUCCESS (0.569s)
[131.543244] Starting dynamic subtest: modeset
[132.424174] Dynamic subtest modeset: SUCCESS (0.888s)
[132.429579] Subtest basic: SUCCESS (1.459s)
[132.639957] [095/162] (890s left) kms_prop_blob (basic)
[132.701077] Starting subtest: basic
[132.706558] Subtest basic: SUCCESS (0.000s)
[132.807802] [096/162] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[132.925637] Starting subtest: basic-busy-flip-before-cursor-atomic
[132.936475] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[133.005762] [097/162] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[133.119237] Starting subtest: basic-busy-flip-before-cursor-legacy
[133.129939] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[133.211223] [098/162] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[133.322919] Starting subtest: basic-flip-after-cursor-atomic
[134.331118] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.006s)
[134.529773] [099/162] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.649082] Starting subtest: basic-flip-after-cursor-legacy
[135.654377] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.003s)
[135.863369] [100/162] (887s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.982059] Starting subtest: basic-flip-after-cursor-varying-size
[136.999298] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.021s)
[137.229008] [101/162] (886s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[137.351003] Starting subtest: basic-flip-before-cursor-atomic
[138.349868] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.001s)
[138.575667] [102/162] (884s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.697012] Starting subtest: basic-flip-before-cursor-legacy
[139.700730] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.004s)
[139.902529] [103/162] (883s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.033941] Starting subtest: basic-flip-before-cursor-varying-size
[141.058911] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.022s)
[141.280643] [104/162] (882s left) kms_dsc (dsc-basic)
[141.405444] Starting subtest: dsc-basic
[141.445107] Subtest dsc-basic: SKIP (0.001s)
[141.497699] [105/162] (882s left) kms_flip (basic-flip-vs-dpms)
[141.618575] Starting subtest: basic-flip-vs-dpms
[141.623959] Starting dynamic subtest: A-DP3
[142.542294] Dynamic subtest A-DP3: SUCCESS (0.925s)
[142.554921] Starting dynamic subtest: B-DP3
[143.392671] Dynamic subtest B-DP3: SUCCESS (0.854s)
[143.405357] Starting dynamic subtest: C-DP3
[144.173435] Dynamic subtest C-DP3: SUCCESS (0.776s)
[144.186130] Starting dynamic subtest: D-DP3
[144.954728] Dynamic subtest D-DP3: SUCCESS (0.781s)
[144.962811] Subtest basic-flip-vs-dpms: SUCCESS (3.343s)
[145.187985] [106/162] (878s left) kms_flip (basic-flip-vs-modeset)
[145.320774] Starting subtest: basic-flip-vs-modeset
[145.328975] Starting dynamic subtest: A-DP3
[146.241283] Dynamic subtest A-DP3: SUCCESS (0.932s)
[146.252207] Starting dynamic subtest: B-DP3
[147.085436] Dynamic subtest B-DP3: SUCCESS (0.842s)
[147.096380] Starting dynamic subtest: C-DP3
[147.866183] Dynamic subtest C-DP3: SUCCESS (0.774s)
[147.877114] Starting dynamic subtest: D-DP3
[148.640436] Dynamic subtest D-DP3: SUCCESS (0.778s)
[148.645846] Subtest basic-flip-vs-modeset: SUCCESS (3.332s)
[148.848969] [107/162] (874s left) kms_flip (basic-flip-vs-wf_vblank)
[148.977402] Starting subtest: basic-flip-vs-wf_vblank
[148.983015] Starting dynamic subtest: A-DP3
[150.246525] Dynamic subtest A-DP3: SUCCESS (1.275s)
[150.260093] Starting dynamic subtest: B-DP3
[151.317311] Dynamic subtest B-DP3: SUCCESS (1.069s)
[151.331238] Starting dynamic subtest: C-DP3
[152.379544] Dynamic subtest C-DP3: SUCCESS (1.051s)
[152.395603] Starting dynamic subtest: D-DP3
[153.428917] Dynamic subtest D-DP3: SUCCESS (1.052s)
[153.436645] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.456s)
[153.698561] [108/162] (870s left) kms_flip (basic-plain-flip)
[153.820874] Starting subtest: basic-plain-flip
[153.826280] Starting dynamic subtest: A-DP3
[154.640183] Dynamic subtest A-DP3: SUCCESS (0.825s)
[154.653967] Starting dynamic subtest: B-DP3
[155.443511] Dynamic subtest B-DP3: SUCCESS (0.800s)
[155.456705] Starting dynamic subtest: C-DP3
[156.231375] Dynamic subtest C-DP3: SUCCESS (0.784s)
[156.244823] Starting dynamic subtest: D-DP3
[157.001268] Dynamic subtest D-DP3: SUCCESS (0.769s)
[157.007449] Subtest basic-plain-flip: SUCCESS (3.188s)
[157.268819] [109/162] (866s left) kms_force_connector_basic (force-connector-state)
[157.359864] Starting subtest: force-connector-state
[157.637089] Subtest force-connector-state: SUCCESS (0.279s)
[157.936443] [110/162] (865s left) kms_force_connector_basic (force-edid)
[158.019688] Starting subtest: force-edid
[158.065072] Subtest force-edid: SUCCESS (0.043s)
[158.255581] [111/162] (865s left) kms_force_connector_basic (force-load-detect)
[158.339401] Starting subtest: force-load-detect
[158.353171] Subtest force-load-detect: SKIP (0.000s)
[158.489986] [112/162] (865s left) kms_force_connector_basic (prune-stale-modes)
[158.583879] Starting subtest: prune-stale-modes
[158.618586] Subtest prune-stale-modes: SUCCESS (0.040s)
[158.822692] [113/162] (865s left) kms_frontbuffer_tracking (basic)
[158.951551] Starting subtest: basic
[162.394257] Subtest basic: SUCCESS (3.458s)
[162.514937] [114/162] (861s left) kms_hdmi_inject (inject-audio)
[162.657441] Starting subtest: inject-audio
[162.801634] Subtest inject-audio: SUCCESS (0.143s)
[163.070156] [115/162] (861s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[163.194035] Starting subtest: compare-crc-sanitycheck-xr24
[163.199362] Starting dynamic subtest: pipe-A-DP-3
[163.662192] Dynamic subtest pipe-A-DP-3: SUCCESS (0.472s)
[163.675152] Starting dynamic subtest: pipe-B-DP-3
[164.149803] Dynamic subtest pipe-B-DP-3: SUCCESS (0.483s)
[164.163010] Starting dynamic subtest: pipe-C-DP-3
[164.601047] Dynamic subtest pipe-C-DP-3: SUCCESS (0.449s)
[164.614358] Starting dynamic subtest: pipe-D-DP-3
[165.061437] Dynamic subtest pipe-D-DP-3: SUCCESS (0.452s)
[165.066756] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.864s)
[165.281541] [116/162] (858s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[165.400708] Starting subtest: compare-crc-sanitycheck-nv12
[165.406124] Starting dynamic subtest: pipe-A-DP-3
[165.955036] Dynamic subtest pipe-A-DP-3: SUCCESS (0.555s)
[165.968055] Starting dynamic subtest: pipe-B-DP-3
[166.473167] Dynamic subtest pipe-B-DP-3: SUCCESS (0.516s)
[166.485988] Starting dynamic subtest: pipe-C-DP-3
[166.969171] Dynamic subtest pipe-C-DP-3: SUCCESS (0.495s)
[166.982073] Starting dynamic subtest: pipe-D-DP-3
[167.467144] Dynamic subtest pipe-D-DP-3: SUCCESS (0.496s)
[167.472666] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.068s)
[167.714257] [117/162] (856s left) kms_pipe_crc_basic (hang-read-crc)
[167.831396] Starting subtest: hang-read-crc
[167.836790] Starting dynamic subtest: pipe-A-DP-3
[169.197471] Dynamic subtest pipe-A-DP-3: SUCCESS (1.367s)
[169.210164] Starting dynamic subtest: pipe-B-DP-3
[170.503678] Dynamic subtest pipe-B-DP-3: SUCCESS (1.304s)
[170.516651] Starting dynamic subtest: pipe-C-DP-3
[171.752635] Dynamic subtest pipe-C-DP-3: SUCCESS (1.248s)
[171.765358] Starting dynamic subtest: pipe-D-DP-3
[173.004624] Dynamic subtest pipe-D-DP-3: SUCCESS (1.250s)
[173.010095] Subtest hang-read-crc: SUCCESS (5.175s)
[173.203571] [118/162] (851s left) kms_pipe_crc_basic (nonblocking-crc)
[173.320026] Starting subtest: nonblocking-crc
[173.325528] Starting dynamic subtest: pipe-A-DP-3
[173.987053] Dynamic subtest pipe-A-DP-3: SUCCESS (0.667s)
[174.000580] Starting dynamic subtest: pipe-B-DP-3
[174.654958] Dynamic subtest pipe-B-DP-3: SUCCESS (0.668s)
[174.668391] Starting dynamic subtest: pipe-C-DP-3
[175.261923] Dynamic subtest pipe-C-DP-3: SUCCESS (0.604s)
[175.272850] Starting dynamic subtest: pipe-D-DP-3
[175.870289] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s)
[175.875730] Subtest nonblocking-crc: SUCCESS (2.553s)
[176.136346] [119/162] (848s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[176.258703] Starting subtest: nonblocking-crc-frame-sequence
[176.264137] Starting dynamic subtest: pipe-A-DP-3
[176.917622] Dynamic subtest pipe-A-DP-3: SUCCESS (0.659s)
[176.930518] Starting dynamic subtest: pipe-B-DP-3
[177.564575] Dynamic subtest pipe-B-DP-3: SUCCESS (0.647s)
[177.577528] Starting dynamic subtest: pipe-C-DP-3
[178.165153] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s)
[178.178192] Starting dynamic subtest: pipe-D-DP-3
[178.768600] Dynamic subtest pipe-D-DP-3: SUCCESS (0.602s)
[178.773919] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.512s)
[178.965709] [120/162] (845s left) kms_pipe_crc_basic (read-crc)
[179.086194] Starting subtest: read-crc
[179.091501] Starting dynamic subtest: pipe-A-DP-3
[179.684407] Dynamic subtest pipe-A-DP-3: SUCCESS (0.600s)
[179.697235] Starting dynamic subtest: pipe-B-DP-3
[180.293908] Dynamic subtest pipe-B-DP-3: SUCCESS (0.602s)
[180.306682] Starting dynamic subtest: pipe-C-DP-3
[180.831906] Dynamic subtest pipe-C-DP-3: SUCCESS (0.539s)
[180.844686] Starting dynamic subtest: pipe-D-DP-3
[181.375871] Dynamic subtest pipe-D-DP-3: SUCCESS (0.541s)
[181.383933] Subtest read-crc: SUCCESS (2.290s)
[181.597649] [121/162] (842s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[181.712717] Starting subtest: read-crc-frame-sequence
[181.718189] Starting dynamic subtest: pipe-A-DP-3
[182.312445] Dynamic subtest pipe-A-DP-3: SUCCESS (0.601s)
[182.325349] Starting dynamic subtest: pipe-B-DP-3
[182.917243] Dynamic subtest pipe-B-DP-3: SUCCESS (0.603s)
[182.933236] Starting dynamic subtest: pipe-C-DP-3
[183.464310] Dynamic subtest pipe-C-DP-3: SUCCESS (0.538s)
[183.476939] Starting dynamic subtest: pipe-D-DP-3
[184.020561] Dynamic subtest pipe-D-DP-3: SUCCESS (0.558s)
[184.028568] Subtest read-crc-frame-sequence: SUCCESS (2.308s)
[184.234964] [122/162] (840s left) kms_pm_backlight (basic-brightness)
[184.358544] Subtest basic-brightness: SKIP (0.000s)
[184.416665] [123/162] (840s left) kms_pm_rpm (basic-pci-d3-state)
[186.397229] Starting subtest: basic-pci-d3-state
[187.734447] Subtest basic-pci-d3-state: SUCCESS (1.341s)
[187.897978] [124/162] (836s left) kms_pm_rpm (basic-rte)
[187.948564] Starting subtest: basic-rte
[190.682851] Subtest basic-rte: SUCCESS (2.744s)
[192.160793] [125/162] (832s left) kms_psr (psr-primary-page-flip)
[192.289676] Subtest psr-primary-page-flip: SKIP (0.000s)
[192.348884] [126/162] (832s left) kms_psr (psr-cursor-plane-move)
[192.466088] Subtest psr-cursor-plane-move: SKIP (0.000s)
[192.509173] [127/162] (832s left) kms_psr (psr-sprite-plane-onoff)
[192.633177] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[192.694624] [128/162] (832s left) kms_psr (psr-primary-mmap-gtt)
[192.819776] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[192.874282] [129/162] (832s left) kms_setmode (basic-clone-single-crtc)
[192.935370] Starting subtest: basic-clone-single-crtc
[192.951988] Subtest basic-clone-single-crtc: SKIP (0.000s)
[193.045753] [130/162] (831s left) i915_pm_rps (basic-api)
[193.107108] Starting subtest: basic-api
[193.118159] Subtest basic-api: SKIP (0.001s)
[193.214626] [131/162] (831s left) prime_self_import (basic-llseek-bad)
[193.264075] Starting subtest: basic-llseek-bad
[193.278094] Subtest basic-llseek-bad: SUCCESS (0.015s)
[193.376254] [132/162] (831s left) prime_self_import (basic-llseek-size)
[193.433183] Starting subtest: basic-llseek-size
[193.444266] Subtest basic-llseek-size: SUCCESS (0.015s)
[193.542810] [133/162] (831s left) prime_self_import (basic-with_fd_dup)
[193.594155] Starting subtest: basic-with_fd_dup
[193.610994] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[193.729411] [134/162] (831s left) prime_self_import (basic-with_one_bo)
[193.788140] Starting subtest: basic-with_one_bo
[193.799090] Subtest basic-with_one_bo: SUCCESS (0.014s)
[193.949811] [135/162] (831s left) prime_self_import (basic-with_one_bo_two_files)
[194.007773] Starting subtest: basic-with_one_bo_two_files
[194.018644] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[194.127985] [136/162] (831s left) prime_self_import (basic-with_two_bos)
[194.189269] Starting subtest: basic-with_two_bos
[194.200367] Subtest basic-with_two_bos: SUCCESS (0.021s)
[194.311858] [137/162] (830s left) prime_vgem (basic-fence-flip)
[194.383889] Starting subtest: basic-fence-flip
[194.847824] Subtest basic-fence-flip: SUCCESS (0.464s)
[194.948985] [138/162] (830s left) prime_vgem (basic-fence-mmap)
[195.036222] Starting subtest: basic-fence-mmap
[195.047017] Subtest basic-fence-mmap: SKIP (0.000s)
[195.145994] [139/162] (830s left) prime_vgem (basic-fence-read)
[195.222190] Starting subtest: basic-fence-read
[195.235964] Subtest basic-fence-read: SKIP (0.013s)
[195.342939] [140/162] (830s left) prime_vgem (basic-gtt)
[195.420299] Starting subtest: basic-gtt
[195.431091] Subtest basic-gtt: SKIP (0.000s)
[195.546665] [141/162] (829s left) prime_vgem (basic-read)
[195.628596] Starting subtest: basic-read
[195.641700] Subtest basic-read: SKIP (0.012s)
[195.766436] [142/162] (829s left) prime_vgem (basic-write)
[195.838567] Starting subtest: basic-write
[195.853308] Subtest basic-write: SKIP (0.011s)
[195.952801] [143/162] (829s left) vgem_basic (setversion)
[196.023506] Starting subtest: setversion
[196.037627] Subtest setversion: SUCCESS (0.000s)
[196.088404] [144/162] (829s left) vgem_basic (create)
[196.159598] Starting subtest: create
[196.164987] Subtest create: SUCCESS (0.000s)
[196.245513] [145/162] (829s left) vgem_basic (debugfs)
[196.307076] Starting subtest: debugfs
[196.312610] Subtest debugfs: SUCCESS (0.000s)
[196.370065] [146/162] (829s left) vgem_basic (dmabuf-export)
[196.445894] Starting subtest: dmabuf-export
[196.456901] Subtest dmabuf-export: SUCCESS (0.019s)
[196.580846] [147/162] (829s left) vgem_basic (dmabuf-fence)
[196.637489] Starting subtest: dmabuf-fence
[196.643019] Subtest dmabuf-fence: SUCCESS (0.000s)
[196.711673] [148/162] (829s left) vgem_basic (dmabuf-fence-before)
[196.775057] Starting subtest: dmabuf-fence-before
[196.783796] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[196.844718] [149/162] (829s left) vgem_basic (dmabuf-mmap)
[196.907471] Starting subtest: dmabuf-mmap
[196.918902] Subtest dmabuf-mmap: SUCCESS (0.018s)
[196.996368] [150/162] (828s left) vgem_basic (mmap)
[197.054273] Starting subtest: mmap
[197.069240] Subtest mmap: SUCCESS (0.012s)
[197.124094] [151/162] (828s left) vgem_basic (second-client)
[197.190817] Starting subtest: second-client
[197.223105] Subtest second-client: SUCCESS (0.033s)
[197.296656] [152/162] (828s left) vgem_basic (sysfs)
[197.357269] Starting subtest: sysfs
[197.362685] Subtest sysfs: SUCCESS (0.000s)
[197.431450] [153/162] (828s left) core_hotunplug (unbind-rebind)
[197.534374] Starting subtest: unbind-rebind
[202.362134] Subtest unbind-rebind: SUCCESS (4.830s)
[202.413901] [154/162] (823s left) vgem_basic (unload)
[202.468480] Starting subtest: unload
[231.476729] Subtest unload: SUCCESS (29.009s)
[231.594930] [155/162] (794s left) i915_module_load (reload)
[231.649511] Starting subtest: reload
[235.221167] Subtest reload: SUCCESS (3.581s)
[235.262608] [156/162] (790s left) gem_lmem_swapping (basic)
[235.330751] Subtest basic: SKIP (0.000s)
[235.386573] [157/162] (790s left) gem_lmem_swapping (parallel-random-engines)
[235.448741] Subtest parallel-random-engines: SKIP (0.000s)
[235.507165] [158/162] (790s left) gem_lmem_swapping (random-engines)
[235.565338] Subtest random-engines: SKIP (0.000s)
[235.614472] [159/162] (790s left) gem_lmem_swapping (verify-random)
[235.677075] Subtest verify-random: SKIP (0.000s)
[235.726475] [160/162] (790s left) i915_pm_rpm (module-reload)
[247.278469] Starting subtest: module-reload
[279.195202] Subtest module-reload: SUCCESS (31.908s)
[279.231659] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[279.232278] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[279.240593] [161/162] (747s left) i915_selftest (live)