[43.347263] Initializing watchdogs
[43.347317]   /dev/watchdog0
[43.362814] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[43.379786] [001/162] (960s left) i915_module_load (load)
[43.499555] Starting subtest: load
[46.825057] Subtest load: SUCCESS (3.317s)
[46.894024] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.896797] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[46.908924] [002/162] (957s left) core_auth (basic-auth)
[48.857476] Starting subtest: basic-auth
[48.866255] Subtest basic-auth: SUCCESS (0.002s)
[49.004468] [003/162] (955s left) core_debugfs (read-all-entries)
[49.122424] Starting subtest: read-all-entries
[49.275949] Subtest read-all-entries: SUCCESS (0.164s)
[49.503815] [004/162] (954s left) core_sysfs (read-all-entries)
[49.617036] Starting subtest: read-all-entries
[49.630298] Subtest read-all-entries: SUCCESS (0.011s)
[49.785774] [005/162] (954s left) fbdev (eof)
[49.902464] Starting subtest: eof
[49.919689] Subtest eof: SUCCESS (0.001s)
[50.086039] [006/162] (954s left) fbdev (info)
[50.172720] Starting subtest: info
[50.179545] Subtest info: SUCCESS (0.000s)
[50.394055] [007/162] (954s left) fbdev (nullptr)
[50.494530] Starting subtest: nullptr
[50.501284] Subtest nullptr: SUCCESS (0.000s)
[50.636443] [008/162] (954s left) fbdev (read)
[50.743800] Starting subtest: read
[52.599644] Subtest read: SUCCESS (1.848s)
[52.770444] [009/162] (952s left) fbdev (write)
[52.891123] Starting subtest: write
[53.904273] Subtest write: SUCCESS (1.005s)
[54.077961] [010/162] (950s left) gem_basic (bad-close)
[54.194883] Starting subtest: bad-close
[54.218034] Subtest bad-close: SUCCESS (0.000s)
[54.346551] [011/162] (950s left) gem_basic (create-close)
[54.454146] Starting subtest: create-close
[54.477088] Subtest create-close: SUCCESS (0.000s)
[54.599751] [012/162] (950s left) gem_basic (create-fd-close)
[54.670288] Starting subtest: create-fd-close
[54.692382] Subtest create-fd-close: SUCCESS (0.000s)
[54.813939] [013/162] (950s left) gem_busy (busy@all-engines)
[54.898257] Starting subtest: busy
[54.907098] Starting dynamic subtest: all-engines
[54.935877] Dynamic subtest all-engines: SUCCESS (0.050s)
[54.942413] Subtest busy: SUCCESS (0.051s)
[56.903258] [014/162] (948s left) gem_close_race (basic-process)
[56.985098] Starting subtest: basic-process
[57.057925] Subtest basic-process: SUCCESS (0.073s)
[57.302844] [015/162] (948s left) gem_close_race (basic-threads)
[57.375006] Starting subtest: basic-threads
[58.685493] Subtest basic-threads: SUCCESS (1.309s)
[58.935427] [016/162] (946s left) gem_ctx_create (basic)
[59.023679] Starting subtest: basic
[59.037031] Subtest basic: SUCCESS (0.000s)
[59.233808] [017/162] (946s left) gem_ctx_create (basic-files)
[59.306196] Starting subtest: basic-files
[61.308277] Subtest basic-files: SUCCESS (2.008s)
[62.922819] [018/162] (942s left) gem_ctx_exec (basic)
[62.988594] Starting subtest: basic
[62.994971] Subtest basic: SUCCESS (0.008s)
[63.181564] [019/162] (942s left) gem_exec_basic (basic)
[63.250658] Starting subtest: basic
[63.256984] Starting dynamic subtest: rcs0-smem
[63.273425] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[63.290856] Starting dynamic subtest: bcs0-smem
[63.299782] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[63.318915] Starting dynamic subtest: vcs0-smem
[63.325347] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[63.342080] Starting dynamic subtest: vcs1-smem
[63.351782] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[63.369633] Starting dynamic subtest: vecs0-smem
[63.378538] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[63.397730] Starting dynamic subtest: ccs0-smem
[63.404168] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[63.420724] Subtest basic: SUCCESS (0.015s)
[64.894902] [020/162] (940s left) gem_exec_create (basic)
[64.961202] Starting subtest: basic
[64.970874] Starting dynamic subtest: smem
[68.836044] Dynamic subtest smem: SUCCESS (3.869s)
[68.849068] Subtest basic: SUCCESS (3.870s)
[69.064411] [021/162] (936s left) gem_exec_fence (basic-busy)
[69.243137] Starting subtest: basic-busy
[69.252410] Starting dynamic subtest: rcs0
[69.298277] Dynamic subtest rcs0: SUCCESS (0.063s)
[69.317560] Starting dynamic subtest: bcs0
[69.357912] Dynamic subtest bcs0: SUCCESS (0.057s)
[69.369403] Starting dynamic subtest: vcs0
[69.404959] Dynamic subtest vcs0: SUCCESS (0.053s)
[69.416183] Starting dynamic subtest: vcs1
[69.461265] Dynamic subtest vcs1: SUCCESS (0.056s)
[69.472853] Starting dynamic subtest: vecs0
[69.517350] Dynamic subtest vecs0: SUCCESS (0.056s)
[69.528808] Starting dynamic subtest: ccs0
[69.578319] Dynamic subtest ccs0: SUCCESS (0.061s)
[69.584671] Subtest basic-busy: SUCCESS (0.347s)
[71.959940] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[71.971426] [022/162] (933s left) gem_exec_fence (basic-wait)
[72.170775] Starting subtest: basic-wait
[72.179484] Starting dynamic subtest: rcs0
[72.506559] Dynamic subtest rcs0: SUCCESS (0.335s)
[72.527347] Starting dynamic subtest: bcs0
[72.566723] Dynamic subtest bcs0: SUCCESS (0.059s)
[72.588846] Starting dynamic subtest: vcs0
[72.612921] Dynamic subtest vcs0: SUCCESS (0.053s)
[72.632429] Starting dynamic subtest: vcs1
[72.669782] Dynamic subtest vcs1: SUCCESS (0.052s)
[72.680916] Starting dynamic subtest: vecs0
[72.719982] Dynamic subtest vecs0: SUCCESS (0.051s)
[72.740073] Starting dynamic subtest: ccs0
[72.770565] Dynamic subtest ccs0: SUCCESS (0.055s)
[72.780920] Subtest basic-wait: SUCCESS (0.606s)
[75.000105] [023/162] (930s left) gem_exec_fence (basic-await)
[75.188040] Starting subtest: basic-await
[75.204430] Starting dynamic subtest: rcs0
[75.279113] Dynamic subtest rcs0: SUCCESS (0.094s)
[75.301136] Starting dynamic subtest: bcs0
[75.364784] Dynamic subtest bcs0: SUCCESS (0.085s)
[75.382659] Starting dynamic subtest: vcs0
[75.442316] Dynamic subtest vcs0: SUCCESS (0.083s)
[75.462006] Starting dynamic subtest: vcs1
[75.533127] Dynamic subtest vcs1: SUCCESS (0.080s)
[75.551543] Starting dynamic subtest: vecs0
[75.601157] Dynamic subtest vecs0: SUCCESS (0.077s)
[75.620411] Starting dynamic subtest: ccs0
[75.684506] Dynamic subtest ccs0: SUCCESS (0.081s)
[75.697841] Subtest basic-await: SUCCESS (0.503s)
[78.010894] [024/162] (927s left) gem_exec_fence (nb-await)
[78.199626] Starting subtest: nb-await
[78.212996] Starting dynamic subtest: rcs0
[78.278188] Dynamic subtest rcs0: SUCCESS (0.083s)
[78.322315] Starting dynamic subtest: bcs0
[78.345954] Dynamic subtest bcs0: SUCCESS (0.063s)
[78.382038] Starting dynamic subtest: vcs0
[78.404187] Dynamic subtest vcs0: SUCCESS (0.059s)
[78.437111] Starting dynamic subtest: vcs1
[78.463397] Dynamic subtest vcs1: SUCCESS (0.059s)
[78.496574] Starting dynamic subtest: vecs0
[78.515667] Dynamic subtest vecs0: SUCCESS (0.062s)
[78.559812] Starting dynamic subtest: ccs0
[78.582758] Dynamic subtest ccs0: SUCCESS (0.064s)
[78.592612] Subtest nb-await: SUCCESS (0.392s)
[80.029927] [025/162] (926s left) gem_exec_gttfill (basic)
[80.111292] Starting subtest: basic
[83.680658] Subtest basic: SUCCESS (3.584s)
[83.950752] [026/162] (922s left) gem_exec_parallel (engines)
[84.033293] Starting subtest: engines
[84.040016] Starting dynamic subtest: basic
[85.874830] Dynamic subtest basic: SUCCESS (1.833s)
[85.892040] Starting dynamic subtest: contexts
[90.366312] Dynamic subtest contexts: SUCCESS (4.491s)
[90.378476] Starting dynamic subtest: fds
[95.882019] Dynamic subtest fds: SUCCESS (5.515s)
[95.899775] Starting dynamic subtest: userptr
[97.821829] Dynamic subtest userptr: SUCCESS (1.939s)
[97.828806] Subtest engines: SUCCESS (13.781s)
[98.088997] [027/162] (908s left) gem_exec_store (basic)
[98.194632] Starting subtest: basic
[98.296267] Subtest basic: SUCCESS (0.137s)
[98.535206] [028/162] (907s left) gem_flink_basic (bad-flink)
[98.616400] Starting subtest: bad-flink
[98.625125] Subtest bad-flink: SUCCESS (0.000s)
[98.716648] [029/162] (907s left) gem_flink_basic (bad-open)
[98.787905] Starting subtest: bad-open
[98.796511] Subtest bad-open: SUCCESS (0.000s)
[98.899070] [030/162] (907s left) gem_flink_basic (basic)
[98.977373] Starting subtest: basic
[98.992628] Subtest basic: SUCCESS (0.000s)
[99.125491] [031/162] (907s left) gem_flink_basic (double-flink)
[99.196260] Starting subtest: double-flink
[99.209641] Subtest double-flink: SUCCESS (0.000s)
[99.326867] [032/162] (907s left) gem_flink_basic (flink-lifetime)
[99.396143] Starting subtest: flink-lifetime
[99.409337] Subtest flink-lifetime: SUCCESS (0.001s)
[99.543814] [033/162] (907s left) gem_huc_copy (huc-copy)
[99.602965] Starting subtest: huc-copy
[99.609246] Subtest huc-copy: SUCCESS (0.005s)
[99.770763] [034/162] (906s left) gem_linear_blits (basic)
[99.898904] Starting subtest: basic
[99.921918] Subtest basic: SUCCESS (0.023s)
[100.150694] [035/162] (906s left) gem_mmap (basic)
[100.238896] Subtest basic: SKIP (0.000s)
[100.295035] [036/162] (906s left) gem_mmap_gtt (basic)
[100.353917] Subtest basic: SKIP (0.000s)
[100.403428] [037/162] (906s left) gem_render_linear_blits (basic)
[100.476525] Starting subtest: basic
[100.530790] Subtest basic: SUCCESS (0.039s)
[100.616469] [038/162] (906s left) gem_render_tiled_blits (basic)
[100.710601] Subtest basic: SKIP (0.000s)
[100.787410] [039/162] (906s left) gem_ringfill (basic-all)
[106.865956] Starting subtest: basic-all
[108.023471] Subtest basic-all: SUCCESS (1.170s)
[108.202176] [040/162] (898s left) gem_softpin (allocator-basic)
[108.275395] Starting subtest: allocator-basic
[108.360648] Subtest allocator-basic: SUCCESS (0.095s)
[108.592378] [041/162] (898s left) gem_softpin (allocator-basic-reserve)
[108.685596] Starting subtest: allocator-basic-reserve
[108.741702] Subtest allocator-basic-reserve: SUCCESS (0.088s)
[108.932616] [042/162] (898s left) gem_softpin (safe-alignment)
[108.984301] Starting subtest: safe-alignment
[109.016698] Subtest safe-alignment: SUCCESS (0.036s)
[110.895232] [043/162] (896s left) gem_sync (basic-all)
[110.998620] Starting subtest: basic-all
[114.846292] Subtest basic-all: SUCCESS (3.889s)
[115.067441] [044/162] (892s left) gem_sync (basic-each)
[115.165139] Starting subtest: basic-each
[117.872309] Subtest basic-each: SUCCESS (2.754s)
[118.087905] [045/162] (889s left) gem_tiled_blits (basic)
[118.148214] Subtest basic: SKIP (0.000s)
[118.204735] [046/162] (889s left) gem_tiled_fence_blits (basic)
[118.266116] Subtest basic: SKIP (0.000s)
[118.315825] [047/162] (889s left) gem_tiled_pread_basic
[118.440669] [048/162] (889s left) gem_wait (busy@all-engines)
[118.496415] Starting subtest: busy
[118.502998] Starting dynamic subtest: all-engines
[119.840813] Dynamic subtest all-engines: SUCCESS (1.332s)
[119.849821] Subtest busy: SUCCESS (1.333s)
[120.120712] [049/162] (887s left) gem_wait (wait@all-engines)
[120.197111] Starting subtest: wait
[120.213730] Starting dynamic subtest: all-engines
[121.829186] Dynamic subtest all-engines: SUCCESS (1.623s)
[121.842485] Subtest wait: SUCCESS (1.623s)
[122.168352] [050/162] (885s left) i915_getparams_basic (basic-eu-total)
[122.253713] Starting subtest: basic-eu-total
[122.273074] Subtest basic-eu-total: SUCCESS (0.000s)
[122.451679] [051/162] (885s left) i915_getparams_basic (basic-subslice-total)
[122.518284] Starting subtest: basic-subslice-total
[122.542253] Subtest basic-subslice-total: SUCCESS (0.000s)
[122.747613] [052/162] (885s left) i915_hangman (error-state-basic)
[122.829234] Starting subtest: error-state-basic
[122.972857] Subtest error-state-basic: SUCCESS (0.142s)
[123.200998] [053/162] (884s left) i915_pciid
[123.373545] [054/162] (884s left) intel_hwmon (hwmon-read)
[123.431922] Subtest hwmon-read: SKIP (0.000s)
[123.492767] [055/162] (884s left) intel_hwmon (hwmon-write)
[123.554584] Subtest hwmon-write: SKIP (0.000s)
[123.609603] [056/162] (884s left) kms_addfb_basic (addfb25-4-tiled)
[123.703558] Starting subtest: addfb25-4-tiled
[123.709945] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[123.843624] [057/162] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[123.917945] Starting subtest: addfb25-bad-modifier
[123.924560] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[124.059637] [058/162] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[124.147970] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[124.294628] [059/162] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[124.382473] Starting subtest: addfb25-modifier-no-flag
[124.399040] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[124.515704] [060/162] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[124.611278] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[124.761126] [061/162] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[124.855391] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[125.024065] [062/162] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[125.125659] Starting subtest: addfb25-yf-tiled-legacy
[125.134369] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[125.270312] [063/162] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[125.376104] Starting subtest: addfb25-y-tiled-legacy
[125.384872] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[125.515456] [064/162] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[125.610498] Starting subtest: addfb25-y-tiled-small-legacy
[125.633354] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[125.778760] [065/162] (883s left) kms_addfb_basic (bad-pitch-0)
[125.855567] Starting subtest: bad-pitch-0
[125.867102] Subtest bad-pitch-0: SUCCESS (0.000s)
[126.006473] [066/162] (882s left) kms_addfb_basic (bad-pitch-1024)
[126.074006] Starting subtest: bad-pitch-1024
[126.083552] Subtest bad-pitch-1024: SUCCESS (0.000s)
[126.257369] [067/162] (882s left) kms_addfb_basic (bad-pitch-128)
[126.325584] Starting subtest: bad-pitch-128
[126.334993] Subtest bad-pitch-128: SUCCESS (0.000s)
[126.513253] [068/162] (882s left) kms_addfb_basic (bad-pitch-256)
[126.586788] Starting subtest: bad-pitch-256
[126.593411] Subtest bad-pitch-256: SUCCESS (0.000s)
[126.860319] [069/162] (882s left) kms_addfb_basic (bad-pitch-32)
[126.932994] Starting subtest: bad-pitch-32
[126.947549] Subtest bad-pitch-32: SUCCESS (0.000s)
[127.087809] [070/162] (882s left) kms_addfb_basic (bad-pitch-63)
[127.154563] Starting subtest: bad-pitch-63
[127.167105] Subtest bad-pitch-63: SUCCESS (0.000s)
[127.305760] [071/162] (881s left) kms_addfb_basic (bad-pitch-65536)
[127.372095] Starting subtest: bad-pitch-65536
[127.378511] Subtest bad-pitch-65536: SUCCESS (0.000s)
[127.569676] [072/162] (881s left) kms_addfb_basic (bad-pitch-999)
[127.639824] Starting subtest: bad-pitch-999
[127.653014] Subtest bad-pitch-999: SUCCESS (0.000s)
[127.804717] [073/162] (881s left) kms_addfb_basic (basic)
[127.875608] Starting subtest: basic
[127.888844] Subtest basic: SUCCESS (0.000s)
[128.078399] [074/162] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[128.165530] Starting subtest: basic-x-tiled-legacy
[128.188656] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[128.372797] [075/162] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[128.448820] Starting subtest: basic-y-tiled-legacy
[128.471813] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[128.607300] [076/162] (881s left) kms_addfb_basic (bo-too-small)
[128.697898] Starting subtest: bo-too-small
[128.704326] Subtest bo-too-small: SUCCESS (0.000s)
[128.853975] [077/162] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[128.950209] Starting subtest: bo-too-small-due-to-tiling
[128.973121] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[129.099688] [078/162] (880s left) kms_addfb_basic (clobberred-modifier)
[129.159034] Starting subtest: clobberred-modifier
[129.172109] Subtest clobberred-modifier: SKIP (0.000s)
[129.344555] [079/162] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[129.399354] Starting subtest: framebuffer-vs-set-tiling
[129.412598] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[129.561188] [080/162] (880s left) kms_addfb_basic (invalid-get-prop)
[129.613774] Starting subtest: invalid-get-prop
[129.620541] Subtest invalid-get-prop: SUCCESS (0.000s)
[129.785305] [081/162] (880s left) kms_addfb_basic (invalid-get-prop-any)
[129.847225] Starting subtest: invalid-get-prop-any
[129.853724] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[129.987624] [082/162] (880s left) kms_addfb_basic (invalid-set-prop)
[130.041441] Starting subtest: invalid-set-prop
[130.048037] Subtest invalid-set-prop: SUCCESS (0.000s)
[130.219610] [083/162] (879s left) kms_addfb_basic (invalid-set-prop-any)
[130.280552] Starting subtest: invalid-set-prop-any
[130.287076] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[130.418304] [084/162] (879s left) kms_addfb_basic (no-handle)
[130.473241] Starting subtest: no-handle
[130.480070] Subtest no-handle: SUCCESS (0.000s)
[130.713029] [085/162] (879s left) kms_addfb_basic (size-max)
[130.800053] Starting subtest: size-max
[130.806589] Subtest size-max: SUCCESS (0.000s)
[130.963952] [086/162] (879s left) kms_addfb_basic (small-bo)
[131.043301] Starting subtest: small-bo
[131.052720] Subtest small-bo: SUCCESS (0.000s)
[131.235669] [087/162] (879s left) kms_addfb_basic (tile-pitch-mismatch)
[131.304633] Starting subtest: tile-pitch-mismatch
[131.320656] Subtest tile-pitch-mismatch: SKIP (0.000s)
[131.505181] [088/162] (878s left) kms_addfb_basic (too-high)
[131.589891] Starting subtest: too-high
[131.596583] Subtest too-high: SUCCESS (0.001s)
[131.791642] [089/162] (878s left) kms_addfb_basic (too-wide)
[131.872417] Starting subtest: too-wide
[131.882112] Subtest too-wide: SUCCESS (0.000s)
[132.040371] [090/162] (878s left) kms_addfb_basic (unused-handle)
[132.095233] Starting subtest: unused-handle
[132.101784] Subtest unused-handle: SUCCESS (0.000s)
[132.286100] [091/162] (878s left) kms_addfb_basic (unused-modifier)
[132.346423] Starting subtest: unused-modifier
[132.352880] Subtest unused-modifier: SUCCESS (0.000s)
[132.522036] [092/162] (878s left) kms_addfb_basic (unused-offsets)
[132.576534] Starting subtest: unused-offsets
[132.583050] Subtest unused-offsets: SUCCESS (0.000s)
[132.750352] [093/162] (877s left) kms_addfb_basic (unused-pitches)
[132.810713] Starting subtest: unused-pitches
[132.817325] Subtest unused-pitches: SUCCESS (0.000s)
[132.995403] [094/162] (877s left) kms_busy (basic)
[133.079497] Starting subtest: basic
[133.086482] Starting dynamic subtest: flip
[133.796852] Dynamic subtest flip: SUCCESS (0.720s)
[133.811682] Starting dynamic subtest: modeset
[137.221100] Dynamic subtest modeset: SUCCESS (3.425s)
[137.227281] Subtest basic: SUCCESS (4.147s)
[138.071408] [095/162] (872s left) kms_prop_blob (basic)
[138.130184] Starting subtest: basic
[138.136372] Subtest basic: SUCCESS (0.000s)
[138.236755] [096/162] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[138.354274] Starting subtest: basic-busy-flip-before-cursor-atomic
[138.366583] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[138.520555] [097/162] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[138.637385] Starting subtest: basic-busy-flip-before-cursor-legacy
[138.649777] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[138.820886] [098/162] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[138.937810] Starting subtest: basic-flip-after-cursor-atomic
[140.141521] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.205s)
[141.028444] [099/162] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[141.135241] Starting subtest: basic-flip-after-cursor-legacy
[142.346184] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.206s)
[143.268789] [100/162] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[143.378707] Starting subtest: basic-flip-after-cursor-varying-size
[144.591222] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.212s)
[145.501908] [101/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[145.611667] Starting subtest: basic-flip-before-cursor-atomic
[146.816626] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.208s)
[147.759171] [102/162] (863s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[147.872167] Starting subtest: basic-flip-before-cursor-legacy
[149.084982] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.204s)
[149.988445] [103/162] (861s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[150.114822] Starting subtest: basic-flip-before-cursor-varying-size
[151.329680] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.224s)
[152.230645] [104/162] (859s left) kms_dsc (dsc-basic)
[152.312514] Starting subtest: dsc-basic
[152.352021] Subtest dsc-basic: SKIP (0.001s)
[152.506451] [105/162] (859s left) kms_flip (basic-flip-vs-dpms)
[152.594911] Starting subtest: basic-flip-vs-dpms
[152.601675] Starting dynamic subtest: A-eDP1
[155.307038] Dynamic subtest A-eDP1: SUCCESS (2.715s)
[155.353699] Starting dynamic subtest: B-eDP1
[157.581338] Dynamic subtest B-eDP1: SUCCESS (2.278s)
[157.594641] Starting dynamic subtest: C-eDP1
[159.829942] Dynamic subtest C-eDP1: SUCCESS (2.243s)
[159.851898] Starting dynamic subtest: D-eDP1
[162.092231] Dynamic subtest D-eDP1: SUCCESS (2.261s)
[162.105700] Subtest basic-flip-vs-dpms: SUCCESS (9.508s)
[162.973938] [106/162] (848s left) kms_flip (basic-flip-vs-modeset)
[163.059316] Starting subtest: basic-flip-vs-modeset
[163.065500] Starting dynamic subtest: A-eDP1
[165.609672] Dynamic subtest A-eDP1: SUCCESS (2.554s)
[165.627491] Starting dynamic subtest: B-eDP1
[167.784140] Dynamic subtest B-eDP1: SUCCESS (2.169s)
[167.801940] Starting dynamic subtest: C-eDP1
[169.952739] Dynamic subtest C-eDP1: SUCCESS (2.163s)
[169.967456] Starting dynamic subtest: D-eDP1
[172.122603] Dynamic subtest D-eDP1: SUCCESS (2.167s)
[172.136107] Subtest basic-flip-vs-modeset: SUCCESS (9.060s)
[172.969412] [107/162] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[173.077811] Starting subtest: basic-flip-vs-wf_vblank
[173.084345] Starting dynamic subtest: A-eDP1
[175.040633] Dynamic subtest A-eDP1: SUCCESS (1.972s)
[175.088536] Starting dynamic subtest: B-eDP1
[177.072687] Dynamic subtest B-eDP1: SUCCESS (2.031s)
[177.118647] Starting dynamic subtest: C-eDP1
[179.085892] Dynamic subtest C-eDP1: SUCCESS (2.020s)
[179.124135] Starting dynamic subtest: D-eDP1
[181.013829] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[181.020904] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.958s)
[182.337497] [108/162] (829s left) kms_flip (basic-plain-flip)
[182.422736] Starting subtest: basic-plain-flip
[182.429722] Starting dynamic subtest: A-eDP1
[184.107498] Dynamic subtest A-eDP1: SUCCESS (1.690s)
[184.121654] Starting dynamic subtest: B-eDP1
[185.868736] Dynamic subtest B-eDP1: SUCCESS (1.755s)
[185.910759] Starting dynamic subtest: C-eDP1
[187.590300] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[187.619543] Starting dynamic subtest: D-eDP1
[189.317983] Dynamic subtest D-eDP1: SUCCESS (1.722s)
[189.326841] Subtest basic-plain-flip: SUCCESS (6.891s)
[190.642896] [109/162] (821s left) kms_force_connector_basic (force-connector-state)
[190.707767] Starting subtest: force-connector-state
[191.309062] Subtest force-connector-state: SUCCESS (0.591s)
[192.365714] [110/162] (819s left) kms_force_connector_basic (force-edid)
[192.441784] Starting subtest: force-edid
[192.739290] Subtest force-edid: SUCCESS (0.295s)
[192.910073] [111/162] (819s left) kms_force_connector_basic (force-load-detect)
[192.975156] Starting subtest: force-load-detect
[192.997858] Subtest force-load-detect: SKIP (0.000s)
[193.140711] [112/162] (818s left) kms_force_connector_basic (prune-stale-modes)
[193.210753] Starting subtest: prune-stale-modes
[193.575022] Subtest prune-stale-modes: SUCCESS (0.358s)
[193.745758] [113/162] (818s left) kms_frontbuffer_tracking (basic)
[193.851288] Starting subtest: basic
[199.019758] Subtest basic: SUCCESS (5.185s)
[199.168542] [114/162] (813s left) kms_hdmi_inject (inject-audio)
[199.515458] Starting subtest: inject-audio
[199.764803] Subtest inject-audio: SUCCESS (0.250s)
[200.427672] [115/162] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[200.513548] Starting subtest: compare-crc-sanitycheck-xr24
[200.520857] Starting dynamic subtest: pipe-A-eDP-1
[201.248165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[201.265983] Starting dynamic subtest: pipe-B-eDP-1
[202.626726] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[202.644480] Starting dynamic subtest: pipe-C-eDP-1
[203.964211] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s)
[203.981871] Starting dynamic subtest: pipe-D-eDP-1
[205.245862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[205.262246] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.726s)
[206.158230] [116/162] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[206.253569] Starting subtest: compare-crc-sanitycheck-nv12
[206.270053] Starting dynamic subtest: pipe-A-eDP-1
[207.267851] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.012s)
[207.284860] Starting dynamic subtest: pipe-B-eDP-1
[208.714943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s)
[208.732737] Starting dynamic subtest: pipe-C-eDP-1
[210.045327] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.327s)
[210.063124] Starting dynamic subtest: pipe-D-eDP-1
[211.428051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s)
[211.444533] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.184s)
[212.375335] [117/162] (800s left) kms_pipe_crc_basic (hang-read-crc)
[212.463422] Starting subtest: hang-read-crc
[212.469721] Starting dynamic subtest: pipe-A-eDP-1
[214.833047] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.371s)
[214.881191] Starting dynamic subtest: pipe-B-eDP-1
[217.948288] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.113s)
[217.961143] Starting dynamic subtest: pipe-C-eDP-1
[220.960563] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.015s)
[220.978255] Starting dynamic subtest: pipe-D-eDP-1
[223.980709] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.012s)
[223.986934] Subtest hang-read-crc: SUCCESS (11.521s)
[224.863723] [118/162] (787s left) kms_pipe_crc_basic (nonblocking-crc)
[224.952406] Starting subtest: nonblocking-crc
[224.965742] Starting dynamic subtest: pipe-A-eDP-1
[225.835671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[225.848662] Starting dynamic subtest: pipe-B-eDP-1
[227.359064] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s)
[227.372053] Starting dynamic subtest: pipe-C-eDP-1
[228.818261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.458s)
[228.831134] Starting dynamic subtest: pipe-D-eDP-1
[230.309932] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[230.319708] Subtest nonblocking-crc: SUCCESS (5.359s)
[231.246155] [119/162] (781s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[231.325427] Starting subtest: nonblocking-crc-frame-sequence
[231.335228] Starting dynamic subtest: pipe-A-eDP-1
[232.221548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[232.239247] Starting dynamic subtest: pipe-B-eDP-1
[233.761489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s)
[233.777462] Starting dynamic subtest: pipe-C-eDP-1
[235.261924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[235.305439] Starting dynamic subtest: pipe-D-eDP-1
[236.727635] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.470s)
[236.734211] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.389s)
[237.732569] [120/162] (774s left) kms_pipe_crc_basic (read-crc)
[237.809584] Starting subtest: read-crc
[237.815766] Starting dynamic subtest: pipe-A-eDP-1
[238.630973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[238.648555] Starting dynamic subtest: pipe-B-eDP-1
[240.116527] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s)
[240.134299] Starting dynamic subtest: pipe-C-eDP-1
[241.586722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s)
[241.604439] Starting dynamic subtest: pipe-D-eDP-1
[242.952779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[242.966233] Subtest read-crc: SUCCESS (5.140s)
[243.853691] [121/162] (768s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[243.941941] Starting subtest: read-crc-frame-sequence
[243.955268] Starting dynamic subtest: pipe-A-eDP-1
[244.771877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[244.785581] Starting dynamic subtest: pipe-B-eDP-1
[246.228757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[246.242278] Starting dynamic subtest: pipe-C-eDP-1
[247.637035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[247.650357] Starting dynamic subtest: pipe-D-eDP-1
[249.051314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[249.057746] Subtest read-crc-frame-sequence: SUCCESS (5.113s)
[249.955685] [122/162] (762s left) kms_pm_backlight (basic-brightness)
[250.048621] Starting subtest: basic-brightness
[250.120731] Starting dynamic subtest: eDP-1
[250.412656] Dynamic subtest eDP-1: SUCCESS (0.293s)
[250.429077] Subtest basic-brightness: SUCCESS (0.364s)
[251.256258] [123/162] (761s left) kms_pm_rpm (basic-pci-d3-state)
[252.990660] Starting subtest: basic-pci-d3-state
[254.449711] Subtest basic-pci-d3-state: SUCCESS (1.466s)
[254.597772] [124/162] (758s left) kms_pm_rpm (basic-rte)
[254.663545] Starting subtest: basic-rte
[257.594076] Subtest basic-rte: SUCCESS (2.941s)
[259.405606] [125/162] (753s left) kms_psr (psr-primary-page-flip)
[259.478617] Starting subtest: psr-primary-page-flip
[259.484840] Starting dynamic subtest: eDP-1
[261.406814] Dynamic subtest eDP-1: SUCCESS (1.926s)
[261.412980] Subtest psr-primary-page-flip: SUCCESS (1.928s)
[262.240206] [126/162] (750s left) kms_psr (psr-cursor-plane-move)
[262.319981] Starting subtest: psr-cursor-plane-move
[262.326177] Starting dynamic subtest: eDP-1
[264.189179] Dynamic subtest eDP-1: SUCCESS (1.873s)
[264.195349] Subtest psr-cursor-plane-move: SUCCESS (1.874s)
[265.047951] [127/162] (748s left) kms_psr (psr-sprite-plane-onoff)
[265.126411] Starting subtest: psr-sprite-plane-onoff
[265.132626] Starting dynamic subtest: eDP-1
[267.042165] Dynamic subtest eDP-1: SUCCESS (1.910s)
[267.058154] Subtest psr-sprite-plane-onoff: SUCCESS (1.911s)
[267.949828] [128/162] (745s left) kms_psr (psr-primary-mmap-gtt)
[268.045863] Starting subtest: psr-primary-mmap-gtt
[268.056648] Starting dynamic subtest: eDP-1
[269.713500] Dynamic subtest eDP-1: SKIP (1.649s)
[269.732612] Subtest psr-primary-mmap-gtt: SKIP (1.650s)
[269.942957] [129/162] (743s left) kms_setmode (basic-clone-single-crtc)
[270.024596] Starting subtest: basic-clone-single-crtc
[270.053235] Subtest basic-clone-single-crtc: SKIP (0.000s)
[270.129653] [130/162] (743s left) i915_pm_rps (basic-api)
[270.200741] Starting subtest: basic-api
[270.213556] Subtest basic-api: SKIP (0.001s)
[270.458429] [131/162] (742s left) prime_self_import (basic-llseek-bad)
[270.522708] Starting subtest: basic-llseek-bad
[270.541270] Subtest basic-llseek-bad: SUCCESS (0.002s)
[270.682925] [132/162] (742s left) prime_self_import (basic-llseek-size)
[270.748514] Starting subtest: basic-llseek-size
[270.771151] Subtest basic-llseek-size: SUCCESS (0.002s)
[270.900768] [133/162] (742s left) prime_self_import (basic-with_fd_dup)
[270.949846] Starting subtest: basic-with_fd_dup
[270.973185] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[271.124064] [134/162] (742s left) prime_self_import (basic-with_one_bo)
[271.193961] Starting subtest: basic-with_one_bo
[271.217071] Subtest basic-with_one_bo: SUCCESS (0.002s)
[271.377321] [135/162] (742s left) prime_self_import (basic-with_one_bo_two_files)
[271.444886] Starting subtest: basic-with_one_bo_two_files
[271.466887] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[271.599182] [136/162] (742s left) prime_self_import (basic-with_two_bos)
[271.678074] Starting subtest: basic-with_two_bos
[271.700035] Subtest basic-with_two_bos: SUCCESS (0.002s)
[271.827355] [137/162] (741s left) prime_vgem (basic-fence-flip)
[271.926796] Starting subtest: basic-fence-flip
[272.414332] Subtest basic-fence-flip: SUCCESS (0.493s)
[272.603158] [138/162] (741s left) prime_vgem (basic-fence-mmap)
[272.707342] Starting subtest: basic-fence-mmap
[272.730054] Subtest basic-fence-mmap: SKIP (0.000s)
[272.816556] [139/162] (741s left) prime_vgem (basic-fence-read)
[272.900154] Starting subtest: basic-fence-read
[272.912535] Subtest basic-fence-read: SKIP (0.012s)
[273.032795] [140/162] (740s left) prime_vgem (basic-gtt)
[273.125642] Starting subtest: basic-gtt
[273.147643] Subtest basic-gtt: SKIP (0.000s)
[273.263234] [141/162] (740s left) prime_vgem (basic-read)
[273.361460] Starting subtest: basic-read
[273.380606] Subtest basic-read: SKIP (0.011s)
[273.500598] [142/162] (740s left) prime_vgem (basic-write)
[273.591679] Starting subtest: basic-write
[273.604879] Subtest basic-write: SKIP (0.011s)
[273.717430] [143/162] (740s left) vgem_basic (setversion)
[273.807044] Starting subtest: setversion
[273.829660] Subtest setversion: SUCCESS (0.000s)
[273.893241] [144/162] (740s left) vgem_basic (create)
[273.981276] Starting subtest: create
[273.987507] Subtest create: SUCCESS (0.000s)
[274.077678] [145/162] (740s left) vgem_basic (debugfs)
[274.165587] Starting subtest: debugfs
[274.171789] Subtest debugfs: SUCCESS (0.000s)
[274.268950] [146/162] (740s left) vgem_basic (dmabuf-export)
[274.356357] Starting subtest: dmabuf-export
[274.378859] Subtest dmabuf-export: SUCCESS (0.003s)
[274.498754] [147/162] (739s left) vgem_basic (dmabuf-fence)
[274.581630] Starting subtest: dmabuf-fence
[274.598210] Subtest dmabuf-fence: SUCCESS (0.000s)
[274.683065] [148/162] (739s left) vgem_basic (dmabuf-fence-before)
[274.772810] Starting subtest: dmabuf-fence-before
[274.779003] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[274.861385] [149/162] (739s left) vgem_basic (dmabuf-mmap)
[274.949191] Starting subtest: dmabuf-mmap
[274.955318] Subtest dmabuf-mmap: SUCCESS (0.020s)
[275.061914] [150/162] (739s left) vgem_basic (mmap)
[275.149880] Starting subtest: mmap
[275.160338] Subtest mmap: SUCCESS (0.012s)
[275.254297] [151/162] (739s left) vgem_basic (second-client)
[275.339403] Starting subtest: second-client
[275.362025] Subtest second-client: SUCCESS (0.033s)
[275.466173] [152/162] (739s left) vgem_basic (sysfs)
[275.542233] Starting subtest: sysfs
[275.553820] Subtest sysfs: SUCCESS (0.000s)
[275.657891] [153/162] (739s left) core_hotunplug (unbind-rebind)
[275.775666] Starting subtest: unbind-rebind
[281.875585] Subtest unbind-rebind: SUCCESS (6.125s)
[281.967593] [154/162] (732s left) vgem_basic (unload)
[282.036104] Starting subtest: unload
[311.189536] Subtest unload: SUCCESS (29.149s)
[311.930487] [155/162] (703s left) i915_module_load (reload)
[312.215811] Starting subtest: reload
[318.788331] Subtest reload: SUCCESS (6.580s)
[318.915555] [156/162] (696s left) gem_lmem_swapping (basic)
[319.069732] Subtest basic: SKIP (0.000s)
[319.176036] [157/162] (696s left) gem_lmem_swapping (parallel-random-engines)
[319.322423] Subtest parallel-random-engines: SKIP (0.000s)
[319.462103] [158/162] (696s left) gem_lmem_swapping (random-engines)
[319.606567] Subtest random-engines: SKIP (0.000s)
[319.734887] [159/162] (696s left) gem_lmem_swapping (verify-random)
[319.873191] Subtest verify-random: SKIP (0.000s)
[320.002574] [160/162] (695s left) i915_pm_rpm (module-reload)
[322.402990] Starting subtest: module-reload
[342.293879] Subtest module-reload: SUCCESS (19.895s)
[342.368963] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[342.370566] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[342.384998] [161/162] (673s left) i915_selftest (live)
[342.496693] Starting subtest: live
[342.510027] Starting dynamic subtest: sanitycheck
[346.121049] Dynamic subtest sanitycheck: SUCCESS (3.622s)
[346.141843] Starting dynamic subtest: uncore
[350.860108] Dynamic subtest uncore: SUCCESS (4.737s)
[350.880605] Starting dynamic subtest: workarounds
[377.626578] Dynamic subtest workarounds: FAIL (24.931s)
[377.649705] Starting dynamic subtest: gt_engines
[380.521292] Dynamic subtest gt_engines: SUCCESS (4.727s)
[380.541837] Starting dynamic subtest: gt_timelines
[399.106042] Dynamic subtest gt_timelines: SUCCESS (18.591s)
[399.121855] Starting dynamic subtest: gt_contexts
[402.016770] Dynamic subtest gt_contexts: SUCCESS (2.909s)
[402.032378] Starting dynamic subtest: gt_lrc
[408.267864] Dynamic subtest gt_lrc: SUCCESS (6.249s)
[408.283429] Starting dynamic subtest: gt_mocs
[413.218931] Dynamic subtest gt_mocs: SUCCESS (4.950s)
[413.234572] Starting dynamic subtest: gt_pm
[418.221599] Dynamic subtest gt_pm: SUCCESS (4.990s)
[418.243556] Starting dynamic subtest: gt_heartbeat
[422.817753] Dynamic subtest gt_heartbeat: SUCCESS (4.601s)
[422.836850] Starting dynamic subtest: gt_tlb
[432.295079] Dynamic subtest gt_tlb: SUCCESS (9.471s)
[432.316848] Starting dynamic subtest: requests