[19.587644] Initializing watchdogs
[19.587781]   /dev/watchdog0
[19.614482] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d67 Intel Meteorlake (Gen12) 
[19.622423] [001/162] (960s left) i915_module_load (load)
[19.674719] Starting subtest: load
[23.051941] Subtest load: SUCCESS (3.381s)
[23.088049] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[23.088870] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[23.095665] [002/162] (957s left) core_auth (basic-auth)
[24.809557] Starting subtest: basic-auth
[24.815467] Subtest basic-auth: SUCCESS (0.002s)
[24.980704] [003/162] (955s left) core_debugfs (read-all-entries)
[25.048738] Starting subtest: read-all-entries
[25.133181] Subtest read-all-entries: SUCCESS (0.085s)
[25.258698] [004/162] (954s left) core_sysfs (read-all-entries)
[25.331290] Starting subtest: read-all-entries
[25.337033] Subtest read-all-entries: SUCCESS (0.003s)
[25.465701] [005/162] (954s left) fbdev (eof)
[25.520603] Starting subtest: eof
[25.526293] Subtest eof: SUCCESS (0.000s)
[25.643809] [006/162] (954s left) fbdev (info)
[25.698290] Starting subtest: info
[25.705727] Subtest info: SUCCESS (0.000s)
[25.804414] [007/162] (954s left) fbdev (nullptr)
[25.865671] Starting subtest: nullptr
[25.871309] Subtest nullptr: SUCCESS (0.000s)
[25.979587] [008/162] (954s left) fbdev (read)
[26.035166] Starting subtest: read
[26.771612] Subtest read: SUCCESS (0.727s)
[26.841838] [009/162] (953s left) fbdev (write)
[26.899889] Starting subtest: write
[27.434410] Subtest write: SUCCESS (0.527s)
[27.545464] [010/162] (953s left) gem_basic (bad-close)
[27.617208] Starting subtest: bad-close
[27.628208] Subtest bad-close: SUCCESS (0.000s)
[27.758681] [011/162] (952s left) gem_basic (create-close)
[27.833220] Starting subtest: create-close
[27.844199] Subtest create-close: SUCCESS (0.000s)
[27.992375] [012/162] (952s left) gem_basic (create-fd-close)
[28.055691] Starting subtest: create-fd-close
[28.071672] Subtest create-fd-close: SUCCESS (0.000s)
[28.194766] [013/162] (952s left) gem_busy (busy@all-engines)
[28.266372] Starting subtest: busy
[28.271877] Starting dynamic subtest: all-engines
[28.329165] Dynamic subtest all-engines: SUCCESS (0.063s)
[28.334673] Subtest busy: SUCCESS (0.063s)
[29.895541] [014/162] (950s left) gem_close_race (basic-process)
[29.981503] Starting subtest: basic-process
[30.026322] Subtest basic-process: SUCCESS (0.048s)
[30.259677] [015/162] (950s left) gem_close_race (basic-threads)
[30.344395] Starting subtest: basic-threads
[31.759998] Subtest basic-threads: SUCCESS (1.416s)
[31.992890] [016/162] (948s left) gem_ctx_create (basic)
[32.069521] Starting subtest: basic
[32.075023] Subtest basic: SUCCESS (0.000s)
[32.276148] [017/162] (948s left) gem_ctx_create (basic-files)
[32.352960] Starting subtest: basic-files
[34.364996] Subtest basic-files: SUCCESS (2.008s)
[35.993805] [018/162] (944s left) gem_ctx_exec (basic)
[36.072877] Starting subtest: basic
[36.078373] Subtest basic: SUCCESS (0.008s)
[36.276270] [019/162] (944s left) gem_exec_basic (basic)
[36.356725] Starting subtest: basic
[36.362043] Starting dynamic subtest: rcs0-smem
[36.367259] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[36.380172] Starting dynamic subtest: bcs0-smem
[36.385554] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[36.395953] Starting dynamic subtest: vcs0-smem
[36.401385] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[36.411762] Starting dynamic subtest: vcs1-smem
[36.417154] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[36.427442] Starting dynamic subtest: vecs0-smem
[36.432781] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[36.443069] Starting dynamic subtest: ccs0-smem
[36.448546] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[36.453831] Subtest basic: SUCCESS (0.012s)
[37.944463] [020/162] (943s left) gem_exec_create (basic)
[38.022172] Starting subtest: basic
[38.027494] Starting dynamic subtest: smem
[41.856329] Dynamic subtest smem: SUCCESS (3.827s)
[41.862611] Subtest basic: SUCCESS (3.828s)
[42.078285] [021/162] (938s left) gem_exec_fence (basic-busy)
[42.269157] Starting subtest: basic-busy
[42.274749] Starting dynamic subtest: rcs0
[42.370307] Dynamic subtest rcs0: SUCCESS (0.101s)
[42.384322] Starting dynamic subtest: bcs0
[42.435225] Dynamic subtest bcs0: SUCCESS (0.064s)
[42.448852] Starting dynamic subtest: vcs0
[42.500972] Dynamic subtest vcs0: SUCCESS (0.065s)
[42.514719] Starting dynamic subtest: vcs1
[42.559030] Dynamic subtest vcs1: SUCCESS (0.057s)
[42.572340] Starting dynamic subtest: vecs0
[42.622039] Dynamic subtest vecs0: SUCCESS (0.062s)
[42.635307] Starting dynamic subtest: ccs0
[42.688509] Dynamic subtest ccs0: SUCCESS (0.066s)
[42.694104] Subtest basic-busy: SUCCESS (0.420s)
[44.963638] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[44.969904] [022/162] (936s left) gem_exec_fence (basic-wait)
[45.168639] Starting subtest: basic-wait
[45.173954] Starting dynamic subtest: rcs0
[45.256018] Dynamic subtest rcs0: SUCCESS (0.095s)
[45.269794] Starting dynamic subtest: bcs0
[45.316099] Dynamic subtest bcs0: SUCCESS (0.061s)
[45.329362] Starting dynamic subtest: vcs0
[45.385085] Dynamic subtest vcs0: SUCCESS (0.070s)
[45.398468] Starting dynamic subtest: vcs1
[45.442945] Dynamic subtest vcs1: SUCCESS (0.059s)
[45.456434] Starting dynamic subtest: vecs0
[45.504098] Dynamic subtest vecs0: SUCCESS (0.062s)
[45.517765] Starting dynamic subtest: ccs0
[45.561127] Dynamic subtest ccs0: SUCCESS (0.058s)
[45.566562] Subtest basic-wait: SUCCESS (0.410s)
[46.962328] [023/162] (934s left) gem_exec_fence (basic-await)
[47.163694] Starting subtest: basic-await
[47.169163] Starting dynamic subtest: rcs0
[47.245279] Dynamic subtest rcs0: SUCCESS (0.084s)
[47.256115] Starting dynamic subtest: bcs0
[47.321384] Dynamic subtest bcs0: SUCCESS (0.077s)
[47.331880] Starting dynamic subtest: vcs0
[47.396434] Dynamic subtest vcs0: SUCCESS (0.076s)
[47.407323] Starting dynamic subtest: vcs1
[47.471910] Dynamic subtest vcs1: SUCCESS (0.076s)
[47.482949] Starting dynamic subtest: vecs0
[47.547159] Dynamic subtest vecs0: SUCCESS (0.076s)
[47.558033] Starting dynamic subtest: ccs0
[47.621351] Dynamic subtest ccs0: SUCCESS (0.075s)
[47.626750] Subtest basic-await: SUCCESS (0.469s)
[49.984294] [024/162] (931s left) gem_exec_fence (nb-await)
[50.175792] Starting subtest: nb-await
[50.181100] Starting dynamic subtest: rcs0
[50.238999] Dynamic subtest rcs0: SUCCESS (0.069s)
[50.251224] Starting dynamic subtest: bcs0
[50.297718] Dynamic subtest bcs0: SUCCESS (0.058s)
[50.310050] Starting dynamic subtest: vcs0
[50.356622] Dynamic subtest vcs0: SUCCESS (0.059s)
[50.368827] Starting dynamic subtest: vcs1
[50.415283] Dynamic subtest vcs1: SUCCESS (0.059s)
[50.427319] Starting dynamic subtest: vecs0
[50.473804] Dynamic subtest vecs0: SUCCESS (0.059s)
[50.485061] Starting dynamic subtest: ccs0
[50.533286] Dynamic subtest ccs0: SUCCESS (0.059s)
[50.538901] Subtest nb-await: SUCCESS (0.369s)
[51.922417] [025/162] (929s left) gem_exec_gttfill (basic)
[52.005579] Starting subtest: basic
[54.275490] Subtest basic: SUCCESS (2.298s)
[54.482591] [026/162] (926s left) gem_exec_parallel (engines)
[54.581063] Starting subtest: engines
[54.586438] Starting dynamic subtest: basic
[57.854444] Dynamic subtest basic: SUCCESS (3.291s)
[57.867961] Starting dynamic subtest: contexts
[60.237965] Dynamic subtest contexts: SUCCESS (2.390s)
[60.254824] Starting dynamic subtest: fds
[62.187426] Dynamic subtest fds: SUCCESS (1.959s)
[62.201036] Starting dynamic subtest: userptr
[63.871155] Dynamic subtest userptr: SUCCESS (1.688s)
[63.879877] Subtest engines: SUCCESS (9.333s)
[64.116664] [027/162] (917s left) gem_exec_store (basic)
[64.216445] Starting subtest: basic
[64.296281] Subtest basic: SUCCESS (0.099s)
[64.540168] [028/162] (916s left) gem_flink_basic (bad-flink)
[64.601943] Starting subtest: bad-flink
[64.607629] Subtest bad-flink: SUCCESS (0.000s)
[64.755187] [029/162] (916s left) gem_flink_basic (bad-open)
[64.817157] Starting subtest: bad-open
[64.822690] Subtest bad-open: SUCCESS (0.000s)
[64.972783] [030/162] (916s left) gem_flink_basic (basic)
[65.039489] Starting subtest: basic
[65.045207] Subtest basic: SUCCESS (0.000s)
[65.169204] [031/162] (916s left) gem_flink_basic (double-flink)
[65.233574] Starting subtest: double-flink
[65.239128] Subtest double-flink: SUCCESS (0.000s)
[65.383085] [032/162] (916s left) gem_flink_basic (flink-lifetime)
[65.443044] Starting subtest: flink-lifetime
[65.448787] Subtest flink-lifetime: SUCCESS (0.002s)
[65.599993] [033/162] (916s left) gem_huc_copy (huc-copy)
[65.681990] Starting subtest: huc-copy
[65.689533] Subtest huc-copy: SUCCESS (0.005s)
[65.868054] [034/162] (915s left) gem_linear_blits (basic)
[66.107535] Starting subtest: basic
[66.121539] Subtest basic: SUCCESS (0.009s)
[66.275313] [035/162] (915s left) gem_mmap (basic)
[66.376587] Subtest basic: SKIP (0.000s)
[66.461055] [036/162] (915s left) gem_mmap_gtt (basic)
[66.541090] Subtest basic: SKIP (0.000s)
[66.603102] [037/162] (915s left) gem_render_linear_blits (basic)
[66.745111] Starting subtest: basic
[66.778061] Subtest basic: SUCCESS (0.033s)
[66.942446] [038/162] (914s left) gem_render_tiled_blits (basic)
[67.181732] Subtest basic: SKIP (0.000s)
[67.419667] [039/162] (914s left) gem_ringfill (basic-all)
[72.899876] Starting subtest: basic-all
[74.054057] Subtest basic-all: SUCCESS (1.158s)
[74.238604] [040/162] (907s left) gem_softpin (allocator-basic)
[74.308625] Starting subtest: allocator-basic
[74.384588] Subtest allocator-basic: SUCCESS (0.074s)
[74.584659] [041/162] (907s left) gem_softpin (allocator-basic-reserve)
[74.658697] Starting subtest: allocator-basic-reserve
[74.736322] Subtest allocator-basic-reserve: SUCCESS (0.078s)
[74.882316] [042/162] (907s left) gem_softpin (safe-alignment)
[74.948896] Starting subtest: safe-alignment
[74.974218] Subtest safe-alignment: SUCCESS (0.022s)
[76.923010] [043/162] (905s left) gem_sync (basic-all)
[77.066151] Starting subtest: basic-all
[80.894961] Subtest basic-all: SUCCESS (3.870s)
[81.117549] [044/162] (901s left) gem_sync (basic-each)
[81.243396] Starting subtest: basic-each
[83.458032] Subtest basic-each: SUCCESS (2.259s)
[83.666650] [045/162] (898s left) gem_tiled_blits (basic)
[83.746344] Subtest basic: SKIP (0.000s)
[83.838572] [046/162] (898s left) gem_tiled_fence_blits (basic)
[83.927339] Subtest basic: SKIP (0.000s)
[84.023991] [047/162] (898s left) gem_tiled_pread_basic (basic)
[84.111393] Subtest basic: SKIP (0.000s)
[84.187237] [048/162] (898s left) gem_wait (busy@all-engines)
[84.272996] Starting subtest: busy
[84.278698] Starting dynamic subtest: all-engines
[85.822796] Dynamic subtest all-engines: SUCCESS (1.541s)
[85.831517] Subtest busy: SUCCESS (1.542s)
[86.051062] [049/162] (896s left) gem_wait (wait@all-engines)
[86.141231] Starting subtest: wait
[86.146817] Starting dynamic subtest: all-engines
[87.864406] Dynamic subtest all-engines: SUCCESS (1.721s)
[87.870172] Subtest wait: SUCCESS (1.722s)
[88.094120] [050/162] (894s left) i915_getparams_basic (basic-eu-total)
[88.157458] Starting subtest: basic-eu-total
[88.168644] Subtest basic-eu-total: SUCCESS (0.000s)
[88.272472] [051/162] (894s left) i915_getparams_basic (basic-subslice-total)
[88.344389] Starting subtest: basic-subslice-total
[88.355121] Subtest basic-subslice-total: SUCCESS (0.000s)
[88.472605] [052/162] (894s left) i915_hangman (error-state-basic)
[88.563855] Starting subtest: error-state-basic
[88.674291] Subtest error-state-basic: SUCCESS (0.111s)
[88.769254] [053/162] (893s left) i915_pciid
[88.986758] [054/162] (893s left) intel_hwmon (hwmon-read)
[89.071921] Subtest hwmon-read: SKIP (0.000s)
[89.155040] [055/162] (893s left) intel_hwmon (hwmon-write)
[89.238820] Subtest hwmon-write: SKIP (0.000s)
[89.321252] [056/162] (893s left) kms_addfb_basic (addfb25-4-tiled)
[89.460635] Starting subtest: addfb25-4-tiled
[89.466159] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[89.605789] [057/162] (893s left) kms_addfb_basic (addfb25-bad-modifier)
[89.721095] Starting subtest: addfb25-bad-modifier
[89.726543] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[89.873731] [058/162] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[90.004406] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[90.139346] [059/162] (892s left) kms_addfb_basic (addfb25-modifier-no-flag)
[90.272796] Starting subtest: addfb25-modifier-no-flag
[90.278413] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[90.380398] [060/162] (892s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[90.518421] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[90.638809] [061/162] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[90.780012] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[90.956535] [062/162] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[91.101249] Starting subtest: addfb25-yf-tiled-legacy
[91.106729] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[91.256072] [063/162] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[91.395689] Starting subtest: addfb25-y-tiled-legacy
[91.401280] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[91.540778] [064/162] (891s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[91.675618] Starting subtest: addfb25-y-tiled-small-legacy
[91.686675] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[91.806797] [065/162] (891s left) kms_addfb_basic (bad-pitch-0)
[91.885215] Starting subtest: bad-pitch-0
[91.890811] Subtest bad-pitch-0: SUCCESS (0.000s)
[92.107379] [066/162] (891s left) kms_addfb_basic (bad-pitch-1024)
[92.182314] Starting subtest: bad-pitch-1024
[92.187961] Subtest bad-pitch-1024: SUCCESS (0.000s)
[92.390249] [067/162] (890s left) kms_addfb_basic (bad-pitch-128)
[92.467254] Starting subtest: bad-pitch-128
[92.472835] Subtest bad-pitch-128: SUCCESS (0.000s)
[92.675119] [068/162] (890s left) kms_addfb_basic (bad-pitch-256)
[92.752083] Starting subtest: bad-pitch-256
[92.757678] Subtest bad-pitch-256: SUCCESS (0.000s)
[92.940141] [069/162] (890s left) kms_addfb_basic (bad-pitch-32)
[93.015878] Starting subtest: bad-pitch-32
[93.021392] Subtest bad-pitch-32: SUCCESS (0.000s)
[93.205868] [070/162] (890s left) kms_addfb_basic (bad-pitch-63)
[93.285136] Starting subtest: bad-pitch-63
[93.290622] Subtest bad-pitch-63: SUCCESS (0.000s)
[93.475692] [071/162] (890s left) kms_addfb_basic (bad-pitch-65536)
[93.547223] Starting subtest: bad-pitch-65536
[93.552818] Subtest bad-pitch-65536: SUCCESS (0.000s)
[93.723822] [072/162] (889s left) kms_addfb_basic (bad-pitch-999)
[93.794824] Starting subtest: bad-pitch-999
[93.800223] Subtest bad-pitch-999: SUCCESS (0.000s)
[93.990629] [073/162] (889s left) kms_addfb_basic (basic)
[94.064390] Starting subtest: basic
[94.069890] Subtest basic: SUCCESS (0.000s)
[94.274099] [074/162] (889s left) kms_addfb_basic (basic-x-tiled-legacy)
[94.342995] Starting subtest: basic-x-tiled-legacy
[94.354397] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[94.532251] [075/162] (889s left) kms_addfb_basic (basic-y-tiled-legacy)
[94.607303] Starting subtest: basic-y-tiled-legacy
[94.618621] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[94.807114] [076/162] (888s left) kms_addfb_basic (bo-too-small)
[94.938245] Starting subtest: bo-too-small
[94.943811] Subtest bo-too-small: SUCCESS (0.000s)
[95.107421] [077/162] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[95.239245] Starting subtest: bo-too-small-due-to-tiling
[95.250363] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[95.390630] [078/162] (888s left) kms_addfb_basic (clobberred-modifier)
[95.457447] Starting subtest: clobberred-modifier
[95.468576] Subtest clobberred-modifier: SKIP (0.000s)
[95.657089] [079/162] (888s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[95.731563] Starting subtest: framebuffer-vs-set-tiling
[95.742651] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[95.940702] [080/162] (888s left) kms_addfb_basic (invalid-get-prop)
[96.009880] Starting subtest: invalid-get-prop
[96.015482] Subtest invalid-get-prop: SUCCESS (0.000s)
[96.198354] [081/162] (887s left) kms_addfb_basic (invalid-get-prop-any)
[96.258707] Starting subtest: invalid-get-prop-any
[96.264298] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[96.441281] [082/162] (887s left) kms_addfb_basic (invalid-set-prop)
[96.512199] Starting subtest: invalid-set-prop
[96.517816] Subtest invalid-set-prop: SUCCESS (0.000s)
[96.710261] [083/162] (887s left) kms_addfb_basic (invalid-set-prop-any)
[96.790290] Starting subtest: invalid-set-prop-any
[96.795945] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[96.986625] [084/162] (887s left) kms_addfb_basic (no-handle)
[97.065524] Starting subtest: no-handle
[97.074223] Subtest no-handle: SUCCESS (0.000s)
[97.244678] [085/162] (886s left) kms_addfb_basic (size-max)
[97.383199] Starting subtest: size-max
[97.388621] Subtest size-max: SUCCESS (0.000s)
[97.547512] [086/162] (886s left) kms_addfb_basic (small-bo)
[97.681556] Starting subtest: small-bo
[97.688966] Subtest small-bo: SUCCESS (0.000s)
[97.836313] [087/162] (886s left) kms_addfb_basic (tile-pitch-mismatch)
[97.906837] Starting subtest: tile-pitch-mismatch
[97.920758] Subtest tile-pitch-mismatch: SKIP (0.000s)
[98.090286] [088/162] (886s left) kms_addfb_basic (too-high)
[98.213914] Starting subtest: too-high
[98.222703] Subtest too-high: SUCCESS (0.001s)
[98.345239] [089/162] (886s left) kms_addfb_basic (too-wide)
[98.479405] Starting subtest: too-wide
[98.484800] Subtest too-wide: SUCCESS (0.000s)
[98.629776] [090/162] (885s left) kms_addfb_basic (unused-handle)
[98.712431] Starting subtest: unused-handle
[98.718048] Subtest unused-handle: SUCCESS (0.000s)
[98.946859] [091/162] (885s left) kms_addfb_basic (unused-modifier)
[99.025813] Starting subtest: unused-modifier
[99.031444] Subtest unused-modifier: SUCCESS (0.000s)
[99.222517] [092/162] (885s left) kms_addfb_basic (unused-offsets)
[99.305727] Starting subtest: unused-offsets
[99.311548] Subtest unused-offsets: SUCCESS (0.000s)
[99.492195] [093/162] (885s left) kms_addfb_basic (unused-pitches)
[99.567526] Starting subtest: unused-pitches
[99.576333] Subtest unused-pitches: SUCCESS (0.000s)
[99.758570] [094/162] (884s left) kms_busy (basic)
[99.899129] Starting subtest: basic
[99.904622] Starting dynamic subtest: flip
[100.481902] Dynamic subtest flip: SUCCESS (0.579s)
[100.497251] Starting dynamic subtest: modeset
[101.381339] Dynamic subtest modeset: SUCCESS (0.905s)
[101.386835] Subtest basic: SUCCESS (1.486s)
[101.636107] [095/162] (883s left) kms_prop_blob (basic)
[101.719432] Starting subtest: basic
[101.724932] Subtest basic: SUCCESS (0.000s)
[101.878581] [096/162] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[101.993258] Starting subtest: basic-busy-flip-before-cursor-atomic
[102.004143] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[102.095798] [097/162] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[102.229932] Starting subtest: basic-busy-flip-before-cursor-legacy
[102.240619] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[102.328644] [098/162] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[102.459250] Starting subtest: basic-flip-after-cursor-atomic
[103.469330] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.007s)
[103.746110] [099/162] (881s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[103.881031] Starting subtest: basic-flip-after-cursor-legacy
[104.897422] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.017s)
[105.156283] [100/162] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[105.281165] Starting subtest: basic-flip-after-cursor-varying-size
[106.294063] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.016s)
[106.578678] [101/162] (878s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[106.715184] Starting subtest: basic-flip-before-cursor-atomic
[107.722270] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.006s)
[107.973335] [102/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[108.107943] Starting subtest: basic-flip-before-cursor-legacy
[109.111769] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.005s)
[109.383800] [103/162] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[109.514517] Starting subtest: basic-flip-before-cursor-varying-size
[110.525806] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.011s)
[110.814337] [104/162] (874s left) kms_dsc (dsc-basic)
[110.946890] Starting subtest: dsc-basic
[110.982146] Subtest dsc-basic: SKIP (0.001s)
[111.063328] [105/162] (874s left) kms_flip (basic-flip-vs-dpms)
[111.195951] Starting subtest: basic-flip-vs-dpms
[111.201453] Starting dynamic subtest: A-DP3
[112.118989] Dynamic subtest A-DP3: SUCCESS (0.924s)
[112.133779] Starting dynamic subtest: B-DP3
[112.985837] Dynamic subtest B-DP3: SUCCESS (0.857s)
[112.997963] Starting dynamic subtest: C-DP3
[113.742167] Dynamic subtest C-DP3: SUCCESS (0.768s)
[113.758092] Starting dynamic subtest: D-DP3
[114.493962] Dynamic subtest D-DP3: SUCCESS (0.752s)
[114.499388] Subtest basic-flip-vs-dpms: SUCCESS (3.308s)
[114.759322] [106/162] (870s left) kms_flip (basic-flip-vs-modeset)
[114.887368] Starting subtest: basic-flip-vs-modeset
[114.894994] Starting dynamic subtest: A-DP3
[115.835215] Dynamic subtest A-DP3: SUCCESS (0.953s)
[115.848932] Starting dynamic subtest: B-DP3
[116.702489] Dynamic subtest B-DP3: SUCCESS (0.865s)
[116.716028] Starting dynamic subtest: C-DP3
[117.496596] Dynamic subtest C-DP3: SUCCESS (0.793s)
[117.509934] Starting dynamic subtest: D-DP3
[118.288442] Dynamic subtest D-DP3: SUCCESS (0.792s)
[118.293978] Subtest basic-flip-vs-modeset: SUCCESS (3.410s)
[118.556661] [107/162] (866s left) kms_flip (basic-flip-vs-wf_vblank)
[118.684879] Starting subtest: basic-flip-vs-wf_vblank
[118.690380] Starting dynamic subtest: A-DP3
[119.948467] Dynamic subtest A-DP3: SUCCESS (1.270s)
[119.963215] Starting dynamic subtest: B-DP3
[121.205175] Dynamic subtest B-DP3: SUCCESS (1.254s)
[121.219674] Starting dynamic subtest: C-DP3
[122.284148] Dynamic subtest C-DP3: SUCCESS (1.068s)
[122.299721] Starting dynamic subtest: D-DP3
[123.356118] Dynamic subtest D-DP3: SUCCESS (1.069s)
[123.361771] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.674s)
[123.683404] [108/162] (861s left) kms_flip (basic-plain-flip)
[123.812650] Starting subtest: basic-plain-flip
[123.818044] Starting dynamic subtest: A-DP3
[124.628285] Dynamic subtest A-DP3: SUCCESS (0.824s)
[124.644232] Starting dynamic subtest: B-DP3
[125.450250] Dynamic subtest B-DP3: SUCCESS (0.819s)
[125.466098] Starting dynamic subtest: C-DP3
[126.244048] Dynamic subtest C-DP3: SUCCESS (0.784s)
[126.257369] Starting dynamic subtest: D-DP3
[127.030023] Dynamic subtest D-DP3: SUCCESS (0.785s)
[127.035518] Subtest basic-plain-flip: SUCCESS (3.222s)
[127.375309] [109/162] (858s left) kms_force_connector_basic (force-connector-state)
[127.478928] Starting subtest: force-connector-state
[127.763049] Subtest force-connector-state: SUCCESS (0.283s)
[128.085103] [110/162] (857s left) kms_force_connector_basic (force-edid)
[128.189445] Starting subtest: force-edid
[128.225050] Subtest force-edid: SUCCESS (0.040s)
[128.455312] [111/162] (857s left) kms_force_connector_basic (force-load-detect)
[128.560277] Starting subtest: force-load-detect
[128.574751] Subtest force-load-detect: SKIP (0.000s)
[128.710597] [112/162] (856s left) kms_force_connector_basic (prune-stale-modes)
[128.817905] Starting subtest: prune-stale-modes
[128.856492] Subtest prune-stale-modes: SUCCESS (0.043s)
[129.086492] [113/162] (856s left) kms_frontbuffer_tracking (basic)
[129.242222] Starting subtest: basic
[132.818134] Subtest basic: SUCCESS (3.594s)
[133.006269] [114/162] (852s left) kms_hdmi_inject (inject-audio)
[133.170969] Starting subtest: inject-audio
[133.316874] Subtest inject-audio: SUCCESS (0.148s)
[133.606305] [115/162] (852s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[133.741830] Starting subtest: compare-crc-sanitycheck-xr24
[133.747367] Starting dynamic subtest: pipe-A-DP-3
[134.224742] Dynamic subtest pipe-A-DP-3: SUCCESS (0.483s)
[134.240143] Starting dynamic subtest: pipe-B-DP-3
[134.711637] Dynamic subtest pipe-B-DP-3: SUCCESS (0.485s)
[134.726934] Starting dynamic subtest: pipe-C-DP-3
[135.168007] Dynamic subtest pipe-C-DP-3: SUCCESS (0.453s)
[135.183076] Starting dynamic subtest: pipe-D-DP-3
[135.623775] Dynamic subtest pipe-D-DP-3: SUCCESS (0.454s)
[135.629355] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.883s)
[135.876743] [116/162] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[135.999465] Starting subtest: compare-crc-sanitycheck-nv12
[136.004978] Starting dynamic subtest: pipe-A-DP-3
[136.571446] Dynamic subtest pipe-A-DP-3: SUCCESS (0.571s)
[136.586745] Starting dynamic subtest: pipe-B-DP-3
[137.087541] Dynamic subtest pipe-B-DP-3: SUCCESS (0.516s)
[137.102840] Starting dynamic subtest: pipe-C-DP-3
[137.583568] Dynamic subtest pipe-C-DP-3: SUCCESS (0.498s)
[137.599461] Starting dynamic subtest: pipe-D-DP-3
[138.081444] Dynamic subtest pipe-D-DP-3: SUCCESS (0.494s)
[138.087115] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.084s)
[138.359490] [117/162] (847s left) kms_pipe_crc_basic (hang-read-crc)
[138.484914] Starting subtest: hang-read-crc
[138.490440] Starting dynamic subtest: pipe-A-DP-3
[139.892427] Dynamic subtest pipe-A-DP-3: SUCCESS (1.408s)
[139.907711] Starting dynamic subtest: pipe-B-DP-3
[141.274639] Dynamic subtest pipe-B-DP-3: SUCCESS (1.380s)
[141.289874] Starting dynamic subtest: pipe-C-DP-3
[142.523293] Dynamic subtest pipe-C-DP-3: SUCCESS (1.248s)
[142.538307] Starting dynamic subtest: pipe-D-DP-3
[143.745593] Dynamic subtest pipe-D-DP-3: SUCCESS (1.221s)
[143.754673] Subtest hang-read-crc: SUCCESS (5.263s)
[144.060794] [118/162] (841s left) kms_pipe_crc_basic (nonblocking-crc)
[144.195867] Starting subtest: nonblocking-crc
[144.204250] Starting dynamic subtest: pipe-A-DP-3
[144.864733] Dynamic subtest pipe-A-DP-3: SUCCESS (0.664s)
[144.883597] Starting dynamic subtest: pipe-B-DP-3
[145.533632] Dynamic subtest pipe-B-DP-3: SUCCESS (0.667s)
[145.552359] Starting dynamic subtest: pipe-C-DP-3
[146.158247] Dynamic subtest pipe-C-DP-3: SUCCESS (0.622s)
[146.173227] Starting dynamic subtest: pipe-D-DP-3
[146.785425] Dynamic subtest pipe-D-DP-3: SUCCESS (0.626s)
[146.791030] Subtest nonblocking-crc: SUCCESS (2.588s)
[147.051558] [119/162] (838s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[147.172544] Starting subtest: nonblocking-crc-frame-sequence
[147.177941] Starting dynamic subtest: pipe-A-DP-3
[147.834687] Dynamic subtest pipe-A-DP-3: SUCCESS (0.662s)
[147.850396] Starting dynamic subtest: pipe-B-DP-3
[148.518684] Dynamic subtest pipe-B-DP-3: SUCCESS (0.682s)
[148.533584] Starting dynamic subtest: pipe-C-DP-3
[149.142490] Dynamic subtest pipe-C-DP-3: SUCCESS (0.623s)
[149.157483] Starting dynamic subtest: pipe-D-DP-3
[149.768667] Dynamic subtest pipe-D-DP-3: SUCCESS (0.625s)
[149.774311] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.598s)
[150.044562] [120/162] (836s left) kms_pipe_crc_basic (read-crc)
[150.178570] Starting subtest: read-crc
[150.184057] Starting dynamic subtest: pipe-A-DP-3
[150.785946] Dynamic subtest pipe-A-DP-3: SUCCESS (0.607s)
[150.800903] Starting dynamic subtest: pipe-B-DP-3
[151.389866] Dynamic subtest pipe-B-DP-3: SUCCESS (0.603s)
[151.404630] Starting dynamic subtest: pipe-C-DP-3
[151.962783] Dynamic subtest pipe-C-DP-3: SUCCESS (0.571s)
[151.977776] Starting dynamic subtest: pipe-D-DP-3
[152.523891] Dynamic subtest pipe-D-DP-3: SUCCESS (0.559s)
[152.529524] Subtest read-crc: SUCCESS (2.347s)
[152.818050] [121/162] (833s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[152.951882] Starting subtest: read-crc-frame-sequence
[152.957363] Starting dynamic subtest: pipe-A-DP-3
[153.562887] Dynamic subtest pipe-A-DP-3: SUCCESS (0.603s)
[153.578748] Starting dynamic subtest: pipe-B-DP-3
[154.140975] Dynamic subtest pipe-B-DP-3: SUCCESS (0.578s)
[154.156101] Starting dynamic subtest: pipe-C-DP-3
[154.689945] Dynamic subtest pipe-C-DP-3: SUCCESS (0.547s)
[154.705225] Starting dynamic subtest: pipe-D-DP-3
[155.226365] Dynamic subtest pipe-D-DP-3: SUCCESS (0.533s)
[155.234757] Subtest read-crc-frame-sequence: SUCCESS (2.267s)
[155.499088] [122/162] (830s left) kms_pm_backlight (basic-brightness)
[155.638851] Subtest basic-brightness: SKIP (0.000s)
[155.690695] [123/162] (830s left) kms_pm_rpm (basic-pci-d3-state)
[157.983003] Starting subtest: basic-pci-d3-state
[159.315941] Subtest basic-pci-d3-state: SUCCESS (1.339s)
[159.523530] [124/162] (826s left) kms_pm_rpm (basic-rte)
[159.578900] Starting subtest: basic-rte
[162.401931] Subtest basic-rte: SUCCESS (2.828s)
[163.917120] [125/162] (822s left) kms_psr (psr-primary-page-flip)
[164.056043] Subtest psr-primary-page-flip: SKIP (0.000s)
[164.114119] [126/162] (822s left) kms_psr (psr-cursor-plane-move)
[164.240592] Subtest psr-cursor-plane-move: SKIP (0.000s)
[164.298042] [127/162] (822s left) kms_psr (psr-sprite-plane-onoff)
[164.442258] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[164.498648] [128/162] (822s left) kms_psr (psr-primary-mmap-gtt)
[164.629279] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[164.681112] [129/162] (821s left) kms_setmode (basic-clone-single-crtc)
[164.751249] Starting subtest: basic-clone-single-crtc
[164.767671] Subtest basic-clone-single-crtc: SKIP (0.000s)
[164.898622] [130/162] (821s left) i915_pm_rps (basic-api)
[164.986391] Starting subtest: basic-api
[164.997589] Subtest basic-api: SKIP (0.001s)
[165.149663] [131/162] (821s left) prime_self_import (basic-llseek-bad)
[165.200129] Starting subtest: basic-llseek-bad
[165.229055] Subtest basic-llseek-bad: SUCCESS (0.029s)
[165.399264] [132/162] (821s left) prime_self_import (basic-llseek-size)
[165.455226] Starting subtest: basic-llseek-size
[165.466706] Subtest basic-llseek-size: SUCCESS (0.019s)
[165.599183] [133/162] (821s left) prime_self_import (basic-with_fd_dup)
[165.650057] Starting subtest: basic-with_fd_dup
[165.677274] Subtest basic-with_fd_dup: SUCCESS (0.035s)
[165.825543] [134/162] (820s left) prime_self_import (basic-with_one_bo)
[165.880429] Starting subtest: basic-with_one_bo
[165.891495] Subtest basic-with_one_bo: SUCCESS (0.017s)
[166.049935] [135/162] (820s left) prime_self_import (basic-with_one_bo_two_files)
[166.106238] Starting subtest: basic-with_one_bo_two_files
[166.117444] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[166.272393] [136/162] (820s left) prime_self_import (basic-with_two_bos)
[166.321806] Starting subtest: basic-with_two_bos
[166.332886] Subtest basic-with_two_bos: SUCCESS (0.014s)
[166.465489] [137/162] (820s left) prime_vgem (basic-fence-flip)
[166.546241] Starting subtest: basic-fence-flip
[167.018472] Subtest basic-fence-flip: SUCCESS (0.473s)
[167.190480] [138/162] (819s left) prime_vgem (basic-fence-mmap)
[167.274992] Starting subtest: basic-fence-mmap
[167.285890] Subtest basic-fence-mmap: SKIP (0.000s)
[167.431717] [139/162] (819s left) prime_vgem (basic-fence-read)
[167.511721] Starting subtest: basic-fence-read
[167.528910] Subtest basic-fence-read: SKIP (0.012s)
[167.681885] [140/162] (819s left) prime_vgem (basic-gtt)
[167.755291] Starting subtest: basic-gtt
[167.766309] Subtest basic-gtt: SKIP (0.000s)
[167.914803] [141/162] (819s left) prime_vgem (basic-read)
[167.994623] Starting subtest: basic-read
[168.018028] Subtest basic-read: SKIP (0.011s)
[168.168024] [142/162] (819s left) prime_vgem (basic-write)
[168.258792] Starting subtest: basic-write
[168.275865] Subtest basic-write: SKIP (0.010s)
[168.419832] [143/162] (818s left) vgem_basic (setversion)
[168.476516] Starting subtest: setversion
[168.491160] Subtest setversion: SUCCESS (0.000s)
[168.567566] [144/162] (818s left) vgem_basic (create)
[168.633994] Starting subtest: create
[168.639642] Subtest create: SUCCESS (0.000s)
[168.718977] [145/162] (818s left) vgem_basic (debugfs)
[168.782648] Starting subtest: debugfs
[168.790496] Subtest debugfs: SUCCESS (0.000s)
[168.868513] [146/162] (818s left) vgem_basic (dmabuf-export)
[168.933848] Starting subtest: dmabuf-export
[168.972054] Subtest dmabuf-export: SUCCESS (0.051s)
[169.122785] [147/162] (818s left) vgem_basic (dmabuf-fence)
[169.178496] Starting subtest: dmabuf-fence
[169.184115] Subtest dmabuf-fence: SUCCESS (0.000s)
[169.281992] [148/162] (818s left) vgem_basic (dmabuf-fence-before)
[169.344551] Starting subtest: dmabuf-fence-before
[169.350038] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[169.435684] [149/162] (818s left) vgem_basic (dmabuf-mmap)
[169.491614] Starting subtest: dmabuf-mmap
[169.503713] Subtest dmabuf-mmap: SUCCESS (0.018s)
[169.600685] [150/162] (818s left) vgem_basic (mmap)
[169.661733] Starting subtest: mmap
[169.667176] Subtest mmap: SUCCESS (0.012s)
[169.772529] [151/162] (817s left) vgem_basic (second-client)
[169.835681] Starting subtest: second-client
[169.860070] Subtest second-client: SUCCESS (0.033s)
[169.954556] [152/162] (817s left) vgem_basic (sysfs)
[170.023142] Starting subtest: sysfs
[170.028710] Subtest sysfs: SUCCESS (0.000s)
[170.115802] [153/162] (817s left) core_hotunplug (unbind-rebind)
[170.226948] Starting subtest: unbind-rebind
[177.829981] Subtest unbind-rebind: SUCCESS (7.613s)
[177.885776] [154/162] (809s left) vgem_basic (unload)
[177.937124] Starting subtest: unload
[207.088889] Subtest unload: SUCCESS (29.147s)
[207.235373] [155/162] (780s left) i915_module_load (reload)
[207.293802] Starting subtest: reload
[213.660134] Subtest reload: SUCCESS (6.382s)
[213.705396] [156/162] (774s left) gem_lmem_swapping (basic)
[213.766958] Subtest basic: SKIP (0.000s)
[213.821199] [157/162] (774s left) gem_lmem_swapping (parallel-random-engines)
[213.890512] Subtest parallel-random-engines: SKIP (0.000s)
[213.948774] [158/162] (774s left) gem_lmem_swapping (random-engines)
[214.017938] Subtest random-engines: SKIP (0.000s)
[214.073011] [159/162] (774s left) gem_lmem_swapping (verify-random)
[214.135733] Subtest verify-random: SKIP (0.000s)
[214.203055] [160/162] (773s left) i915_pm_rpm (module-reload)
[225.755765] Starting subtest: module-reload
[259.528969] Subtest module-reload: SUCCESS (33.768s)
[259.561938] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[259.562540] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[259.568988] [161/162] (728s left) i915_selftest (live)
[259.623517] Starting subtest: live
[259.629110] Starting dynamic subtest: sanitycheck
[263.906489] Dynamic subtest sanitycheck: SUCCESS (4.282s)
[263.919462] Starting dynamic subtest: uncore
[270.148177] Dynamic subtest uncore: SUCCESS (6.240s)
[270.161166] Starting dynamic subtest: workarounds
[274.944375] Dynamic subtest workarounds: SUCCESS (4.794s)
[274.957173] Starting dynamic subtest: gt_engines
[281.561630] Dynamic subtest gt_engines: SUCCESS (6.615s)
[281.574049] Starting dynamic subtest: gt_timelines
[300.663668] Dynamic subtest gt_timelines: SUCCESS (19.101s)
[300.676533] Starting dynamic subtest: gt_contexts
[304.963261] Dynamic subtest gt_contexts: SUCCESS (4.298s)
[304.976430] Starting dynamic subtest: gt_lrc
[311.289511] Dynamic subtest gt_lrc: SUCCESS (6.324s)
[311.302304] Starting dynamic subtest: gt_mocs
[315.787273] Dynamic subtest gt_mocs: SUCCESS (4.496s)
[315.799879] Starting dynamic subtest: gt_pm
[324.652672] Dynamic subtest gt_pm: SUCCESS (8.862s)
[324.665420] Starting dynamic subtest: gt_heartbeat
[330.929459] Dynamic subtest gt_heartbeat: SUCCESS (6.277s)
[330.942442] Starting dynamic subtest: gt_tlb
[342.368334] Dynamic subtest gt_tlb: SUCCESS (11.438s)
[342.378966] Starting dynamic subtest: requests
[355.777621] Dynamic subtest requests: SUCCESS (13.407s)
[355.790293] Starting dynamic subtest: migrate
[363.942457] Dynamic subtest migrate: SUCCESS (8.163s)
[363.954937] Starting dynamic subtest: active
[370.213223] Dynamic subtest active: SUCCESS (6.269s)
[370.226482] Starting dynamic subtest: objects
[377.011415] Dynamic subtest objects: SUCCESS (6.797s)
[377.022290] Starting dynamic subtest: mman
[383.901545] Dynamic subtest mman: SUCCESS (6.888s)
[383.914920] Starting dynamic subtest: dmabuf
[390.229511] Dynamic subtest dmabuf: SUCCESS (6.326s)
[390.242315] Starting dynamic subtest: vma
[396.351720] Dynamic subtest vma: SUCCESS (6.117s)
[396.364171] Starting dynamic subtest: coherency
[404.568469] Dynamic subtest coherency: SUCCESS (8.218s)
[404.580742] Starting dynamic subtest: gtt
[416.875893] Dynamic subtest gtt: SUCCESS (12.306s)
[416.888816] Starting dynamic subtest: gem