[79.588037] Initializing watchdogs
[79.588164]   /dev/watchdog0
[79.604605] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[79.610275] [001/161] (960s left) i915_module_load (load)
[79.753185] Starting subtest: load
[81.011930] Subtest load: SUCCESS (1.247s)
[81.048833] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[81.050318] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[81.052871] [002/161] (959s left) core_auth (basic-auth)
[81.132689] Starting subtest: basic-auth
[81.133941] Subtest basic-auth: SUCCESS (0.002s)
[81.211888] [003/161] (958s left) debugfs_test (read_all_entries)
[81.298776] Starting subtest: read_all_entries
[81.525194] Subtest read_all_entries: SUCCESS (0.231s)
[81.608869] [004/161] (958s left) debugfs_test (basic-hwmon)
[81.658667] Starting subtest: basic-hwmon
[81.660429] Subtest basic-hwmon: SKIP (0.000s)
[81.754932] [005/161] (958s left) debugfs_test (sysfs)
[81.805151] Starting subtest: sysfs
[81.861775] Subtest sysfs: SUCCESS (0.057s)
[81.953462] [006/161] (958s left) fbdev (eof)
[82.008393] Starting subtest: eof
[82.009699] Subtest eof: SUCCESS (0.001s)
[82.064909] [007/161] (958s left) fbdev (info)
[82.106570] Starting subtest: info
[82.107951] Subtest info: SUCCESS (0.000s)
[82.175524] [008/161] (958s left) fbdev (nullptr)
[82.234374] Starting subtest: nullptr
[82.235874] Subtest nullptr: SUCCESS (0.000s)
[82.299504] [009/161] (958s left) fbdev (read)
[82.351258] Starting subtest: read
[84.251434] Subtest read: SUCCESS (1.881s)
[84.305046] [010/161] (956s left) fbdev (write)
[84.362019] Starting subtest: write
[85.345323] Subtest write: SUCCESS (0.970s)
[85.402215] [011/161] (955s left) gem_basic (bad-close)
[85.449286] Starting subtest: bad-close
[85.451093] Subtest bad-close: SUCCESS (0.000s)
[85.523154] [012/161] (955s left) gem_basic (create-close)
[85.566937] Starting subtest: create-close
[85.568471] Subtest create-close: SUCCESS (0.000s)
[85.667073] [013/161] (954s left) gem_basic (create-fd-close)
[85.713210] Starting subtest: create-fd-close
[85.715245] Subtest create-fd-close: SUCCESS (0.000s)
[85.803845] [014/161] (954s left) gem_busy (busy@all-engines)
[85.861891] Starting subtest: busy
[85.862882] Starting dynamic subtest: all-engines
[85.914367] Dynamic subtest all-engines: SUCCESS (0.052s)
[85.915674] Subtest busy: SUCCESS (0.053s)
[86.271705] [015/161] (954s left) gem_close_race (basic-process)
[86.332547] Starting subtest: basic-process
[86.376691] Subtest basic-process: SUCCESS (0.043s)
[86.565698] [016/161] (954s left) gem_close_race (basic-threads)
[86.626269] Starting subtest: basic-threads
[87.786544] Subtest basic-threads: SUCCESS (1.157s)
[87.976792] [017/161] (952s left) gem_ctx_create (basic)
[88.034457] Starting subtest: basic
[88.035321] Subtest basic: SUCCESS (0.000s)
[88.229548] [018/161] (952s left) gem_ctx_create (basic-files)
[88.286643] Starting subtest: basic-files
[90.303347] Subtest basic-files: SUCCESS (2.012s)
[90.563892] [019/161] (950s left) gem_ctx_exec (basic)
[90.610213] Starting subtest: basic
[90.615698] Subtest basic: SUCCESS (0.005s)
[90.724024] [020/161] (950s left) gem_exec_basic (basic)
[90.784940] Starting subtest: basic
[90.785865] Starting dynamic subtest: rcs0-smem
[90.787642] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[90.798883] Starting dynamic subtest: bcs0-smem
[90.799651] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[90.806719] Starting dynamic subtest: vcs0-smem
[90.807430] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[90.814317] Starting dynamic subtest: vecs0-smem
[90.815062] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[90.815788] Subtest basic: SUCCESS (0.009s)
[90.989687] [021/161] (949s left) gem_exec_create (basic)
[91.049826] Starting subtest: basic
[91.050672] Starting dynamic subtest: smem
[93.156566] Dynamic subtest smem: SUCCESS (2.103s)
[93.157920] Subtest basic: SUCCESS (2.103s)
[93.351334] [022/161] (947s left) gem_exec_fence (basic-busy)
[93.535262] Starting subtest: basic-busy
[93.536320] Starting dynamic subtest: rcs0
[93.591703] Dynamic subtest rcs0: SUCCESS (0.057s)
[93.601195] Starting dynamic subtest: bcs0
[93.644512] Dynamic subtest bcs0: SUCCESS (0.051s)
[93.661030] Starting dynamic subtest: vcs0
[93.695828] Dynamic subtest vcs0: SUCCESS (0.051s)
[93.711274] Starting dynamic subtest: vecs0
[93.744703] Dynamic subtest vecs0: SUCCESS (0.048s)
[93.746175] Subtest basic-busy: SUCCESS (0.210s)
[94.330499] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[94.332736] [023/161] (946s left) gem_exec_fence (basic-wait)
[94.511704] Starting subtest: basic-wait
[94.512764] Starting dynamic subtest: rcs0
[94.568598] Dynamic subtest rcs0: SUCCESS (0.057s)
[94.584239] Starting dynamic subtest: bcs0
[94.619953] Dynamic subtest bcs0: SUCCESS (0.050s)
[94.636184] Starting dynamic subtest: vcs0
[94.673234] Dynamic subtest vcs0: SUCCESS (0.052s)
[94.688921] Starting dynamic subtest: vecs0
[94.726731] Dynamic subtest vecs0: SUCCESS (0.053s)
[94.728732] Subtest basic-wait: SUCCESS (0.216s)
[95.268669] [024/161] (945s left) gem_exec_fence (basic-await)
[95.447460] Starting subtest: basic-await
[95.448627] Starting dynamic subtest: rcs0
[95.539813] Dynamic subtest rcs0: SUCCESS (0.093s)
[95.552327] Starting dynamic subtest: bcs0
[95.632595] Dynamic subtest bcs0: SUCCESS (0.092s)
[95.651282] Starting dynamic subtest: vcs0
[95.728698] Dynamic subtest vcs0: SUCCESS (0.094s)
[95.745833] Starting dynamic subtest: vecs0
[95.823178] Dynamic subtest vecs0: SUCCESS (0.094s)
[95.825368] Subtest basic-await: SUCCESS (0.376s)
[96.350574] [025/161] (944s left) gem_exec_fence (nb-await)
[96.527471] Starting subtest: nb-await
[96.528391] Starting dynamic subtest: rcs0
[96.592335] Dynamic subtest rcs0: SUCCESS (0.065s)
[96.604926] Starting dynamic subtest: bcs0
[96.654439] Dynamic subtest bcs0: SUCCESS (0.061s)
[96.672253] Starting dynamic subtest: vcs0
[96.720420] Dynamic subtest vcs0: SUCCESS (0.065s)
[96.738153] Starting dynamic subtest: vecs0
[96.789392] Dynamic subtest vecs0: SUCCESS (0.067s)
[96.790952] Subtest nb-await: SUCCESS (0.261s)
[97.310175] [026/161] (943s left) gem_exec_gttfill (basic)
[97.368092] Starting subtest: basic
[104.702722] Subtest basic: SUCCESS (7.322s)
[104.898388] [027/161] (936s left) gem_exec_parallel (engines)
[105.036902] Starting subtest: engines
[105.037877] Starting dynamic subtest: basic
[108.101148] Dynamic subtest basic: SUCCESS (3.065s)
[108.118357] Starting dynamic subtest: contexts
[111.825494] Dynamic subtest contexts: SUCCESS (3.714s)
[111.841381] Starting dynamic subtest: fds
[116.766146] Dynamic subtest fds: SUCCESS (4.939s)
[116.783855] Starting dynamic subtest: userptr
[119.480535] Dynamic subtest userptr: SUCCESS (2.722s)
[119.481760] Subtest engines: SUCCESS (14.443s)
[119.686696] [028/161] (921s left) gem_exec_store (basic)
[119.763507] Starting subtest: basic
[119.849657] Subtest basic: SUCCESS (0.087s)
[120.049119] [029/161] (921s left) gem_flink_basic (bad-flink)
[120.103785] Starting subtest: bad-flink
[120.104684] Subtest bad-flink: SUCCESS (0.000s)
[120.194372] [030/161] (921s left) gem_flink_basic (bad-open)
[120.246193] Starting subtest: bad-open
[120.247019] Subtest bad-open: SUCCESS (0.000s)
[120.330913] [031/161] (921s left) gem_flink_basic (basic)
[120.382380] Starting subtest: basic
[120.383202] Subtest basic: SUCCESS (0.000s)
[120.487708] [032/161] (921s left) gem_flink_basic (double-flink)
[120.539183] Starting subtest: double-flink
[120.539967] Subtest double-flink: SUCCESS (0.000s)
[120.638413] [033/161] (920s left) gem_flink_basic (flink-lifetime)
[120.689717] Starting subtest: flink-lifetime
[120.690704] Subtest flink-lifetime: SUCCESS (0.001s)
[120.812560] [034/161] (920s left) gem_huc_copy (huc-copy)
[120.870519] Starting subtest: huc-copy
[120.877101] Subtest huc-copy: SUCCESS (0.007s)
[121.013339] [035/161] (920s left) gem_linear_blits (basic)
[121.150439] Starting subtest: basic
[121.162111] Subtest basic: SUCCESS (0.012s)
[121.314616] [036/161] (920s left) gem_mmap (basic)
[121.412134] Starting subtest: basic
[121.416645] Subtest basic: SUCCESS (0.001s)
[121.517228] [037/161] (920s left) gem_mmap_gtt (basic)
[121.568309] Starting subtest: basic
[121.569120] Subtest basic: SUCCESS (0.001s)
[121.652802] [038/161] (920s left) gem_render_linear_blits (basic)
[121.708829] Starting subtest: basic
[121.767668] Subtest basic: SUCCESS (0.059s)
[121.862899] [039/161] (920s left) gem_render_tiled_blits (basic)
[121.919354] Starting subtest: basic
[121.987315] Subtest basic: SUCCESS (0.068s)
[122.096725] [040/161] (919s left) gem_ringfill (basic-all)
[122.405740] Starting subtest: basic-all
[123.575502] Subtest basic-all: SUCCESS (1.161s)
[123.706962] [041/161] (918s left) gem_softpin (allocator-basic)
[123.775330] Starting subtest: allocator-basic
[123.897739] Subtest allocator-basic: SUCCESS (0.114s)
[124.038618] [042/161] (918s left) gem_softpin (allocator-basic-reserve)
[124.100782] Starting subtest: allocator-basic-reserve
[124.216959] Subtest allocator-basic-reserve: SUCCESS (0.108s)
[124.358722] [043/161] (917s left) gem_softpin (safe-alignment)
[124.422235] Starting subtest: safe-alignment
[124.444534] Subtest safe-alignment: SUCCESS (0.021s)
[124.569118] [044/161] (917s left) gem_sync (basic-all)
[124.640168] Starting subtest: basic-all
[127.879505] Subtest basic-all: SUCCESS (3.238s)
[128.078176] [045/161] (914s left) gem_sync (basic-each)
[128.140650] Starting subtest: basic-each
[130.775996] Subtest basic-each: SUCCESS (2.634s)
[130.974917] [046/161] (911s left) gem_tiled_blits (basic)
[131.084766] Starting subtest: basic
[131.114280] Subtest basic: SUCCESS (0.028s)
[131.265089] [047/161] (911s left) gem_tiled_fence_blits (basic)
[131.437214] Starting subtest: basic
[131.460235] Subtest basic: SUCCESS (0.023s)
[131.600986] [048/161] (910s left) gem_tiled_pread_basic
[131.756064] [049/161] (910s left) gem_wait (busy@all-engines)
[131.830137] Starting subtest: busy
[131.830986] Starting dynamic subtest: all-engines
[132.396342] Dynamic subtest all-engines: SUCCESS (0.565s)
[132.397286] Subtest busy: SUCCESS (0.566s)
[132.617814] [050/161] (909s left) gem_wait (wait@all-engines)
[132.689453] Starting subtest: wait
[132.690271] Starting dynamic subtest: all-engines
[133.767487] Dynamic subtest all-engines: SUCCESS (1.077s)
[133.769123] Subtest wait: SUCCESS (1.077s)
[133.991097] [051/161] (908s left) i915_getparams_basic (basic-eu-total)
[134.037778] Starting subtest: basic-eu-total
[134.039303] Subtest basic-eu-total: SUCCESS (0.000s)
[134.115589] [052/161] (908s left) i915_getparams_basic (basic-subslice-total)
[134.161761] Starting subtest: basic-subslice-total
[134.163336] Subtest basic-subslice-total: SUCCESS (0.000s)
[134.241267] [053/161] (908s left) i915_hangman (error-state-basic)
[134.301148] Starting subtest: error-state-basic
[134.423100] Subtest error-state-basic: SUCCESS (0.121s)
[134.503889] [054/161] (908s left) i915_pciid
[134.624470] [055/161] (908s left) kms_addfb_basic (addfb25-4-tiled)
[134.708121] Starting subtest: addfb25-4-tiled
[134.709037] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[134.810629] [056/161] (907s left) kms_addfb_basic (addfb25-bad-modifier)
[134.882261] Starting subtest: addfb25-bad-modifier
[134.883246] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[134.978406] [057/161] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[135.050089] Starting subtest: addfb25-framebuffer-vs-set-tiling
[135.050995] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[135.152445] [058/161] (907s left) kms_addfb_basic (addfb25-modifier-no-flag)
[135.226167] Starting subtest: addfb25-modifier-no-flag
[135.227033] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[135.321619] [059/161] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[135.396092] Starting subtest: addfb25-x-tiled-legacy
[135.397035] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[135.496828] [060/161] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[135.573379] Starting subtest: addfb25-x-tiled-mismatch-legacy
[135.574410] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[135.680691] [061/161] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[135.755830] Starting subtest: addfb25-yf-tiled-legacy
[135.756595] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[135.866428] [062/161] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[135.943323] Starting subtest: addfb25-y-tiled-legacy
[135.944080] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[136.047968] [063/161] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[136.132069] Starting subtest: addfb25-y-tiled-small-legacy
[136.133042] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[136.226400] [064/161] (906s left) kms_addfb_basic (bad-pitch-0)
[136.279008] Starting subtest: bad-pitch-0
[136.279808] Subtest bad-pitch-0: SUCCESS (0.000s)
[136.416727] [065/161] (906s left) kms_addfb_basic (bad-pitch-1024)
[136.468957] Starting subtest: bad-pitch-1024
[136.469766] Subtest bad-pitch-1024: SUCCESS (0.000s)
[136.599447] [066/161] (906s left) kms_addfb_basic (bad-pitch-128)
[136.652505] Starting subtest: bad-pitch-128
[136.653271] Subtest bad-pitch-128: SUCCESS (0.000s)
[136.774751] [067/161] (906s left) kms_addfb_basic (bad-pitch-256)
[136.827609] Starting subtest: bad-pitch-256
[136.828433] Subtest bad-pitch-256: SUCCESS (0.000s)
[136.948787] [068/161] (906s left) kms_addfb_basic (bad-pitch-32)
[137.002054] Starting subtest: bad-pitch-32
[137.002841] Subtest bad-pitch-32: SUCCESS (0.000s)
[137.135601] [069/161] (906s left) kms_addfb_basic (bad-pitch-63)
[137.192125] Starting subtest: bad-pitch-63
[137.192901] Subtest bad-pitch-63: SUCCESS (0.000s)
[137.326687] [070/161] (906s left) kms_addfb_basic (bad-pitch-65536)
[137.380133] Starting subtest: bad-pitch-65536
[137.381157] Subtest bad-pitch-65536: SUCCESS (0.000s)
[137.507399] [071/161] (906s left) kms_addfb_basic (bad-pitch-999)
[137.559974] Starting subtest: bad-pitch-999
[137.560771] Subtest bad-pitch-999: SUCCESS (0.000s)
[137.691887] [072/161] (905s left) kms_addfb_basic (basic)
[137.746464] Starting subtest: basic
[137.747265] Subtest basic: SUCCESS (0.000s)
[137.883503] [073/161] (905s left) kms_addfb_basic (basic-x-tiled-legacy)
[137.936110] Starting subtest: basic-x-tiled-legacy
[137.936905] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[138.065879] [074/161] (905s left) kms_addfb_basic (basic-y-tiled-legacy)
[138.120385] Starting subtest: basic-y-tiled-legacy
[138.121253] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[138.250070] [075/161] (905s left) kms_addfb_basic (bo-too-small)
[138.331158] Starting subtest: bo-too-small
[138.332040] Subtest bo-too-small: SUCCESS (0.000s)
[138.432468] [076/161] (905s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[138.512466] Starting subtest: bo-too-small-due-to-tiling
[138.519862] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[138.608714] [077/161] (905s left) kms_addfb_basic (clobberred-modifier)
[138.663360] Starting subtest: clobberred-modifier
[138.664168] Subtest clobberred-modifier: SUCCESS (0.000s)
[138.801442] [078/161] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[138.856298] Starting subtest: framebuffer-vs-set-tiling
[138.857085] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[138.984616] [079/161] (904s left) kms_addfb_basic (invalid-get-prop)
[139.038810] Starting subtest: invalid-get-prop
[139.040059] Subtest invalid-get-prop: SUCCESS (0.000s)
[139.174708] [080/161] (904s left) kms_addfb_basic (invalid-get-prop-any)
[139.229039] Starting subtest: invalid-get-prop-any
[139.229926] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[139.357682] [081/161] (904s left) kms_addfb_basic (invalid-set-prop)
[139.412278] Starting subtest: invalid-set-prop
[139.413071] Subtest invalid-set-prop: SUCCESS (0.000s)
[139.541886] [082/161] (904s left) kms_addfb_basic (invalid-set-prop-any)
[139.594169] Starting subtest: invalid-set-prop-any
[139.596013] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[139.724860] [083/161] (904s left) kms_addfb_basic (no-handle)
[139.778257] Starting subtest: no-handle
[139.779071] Subtest no-handle: SUCCESS (0.000s)
[139.908068] [084/161] (904s left) kms_addfb_basic (size-max)
[139.988937] Starting subtest: size-max
[139.989814] Subtest size-max: SUCCESS (0.000s)
[140.093521] [085/161] (904s left) kms_addfb_basic (small-bo)
[140.175361] Starting subtest: small-bo
[140.176192] Subtest small-bo: SUCCESS (0.000s)
[140.275640] [086/161] (904s left) kms_addfb_basic (tile-pitch-mismatch)
[140.330353] Starting subtest: tile-pitch-mismatch
[140.331288] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[140.458790] [087/161] (903s left) kms_addfb_basic (too-high)
[140.540033] Starting subtest: too-high
[140.540838] Subtest too-high: SUCCESS (0.001s)
[140.649729] [088/161] (903s left) kms_addfb_basic (too-wide)
[140.730121] Starting subtest: too-wide
[140.730995] Subtest too-wide: SUCCESS (0.000s)
[140.833225] [089/161] (903s left) kms_addfb_basic (unused-handle)
[140.886872] Starting subtest: unused-handle
[140.887671] Subtest unused-handle: SUCCESS (0.000s)
[141.015195] [090/161] (903s left) kms_addfb_basic (unused-modifier)
[141.068632] Starting subtest: unused-modifier
[141.069604] Subtest unused-modifier: SUCCESS (0.000s)
[141.201525] [091/161] (903s left) kms_addfb_basic (unused-offsets)
[141.256840] Starting subtest: unused-offsets
[141.257726] Subtest unused-offsets: SUCCESS (0.000s)
[141.383753] [092/161] (903s left) kms_addfb_basic (unused-pitches)
[141.437975] Starting subtest: unused-pitches
[141.439539] Subtest unused-pitches: SUCCESS (0.000s)
[141.573239] [093/161] (903s left) kms_busy (basic)
[141.655991] Starting subtest: basic
[141.658263] Starting dynamic subtest: flip
[142.335190] Dynamic subtest flip: SUCCESS (0.676s)
[142.356563] Starting dynamic subtest: modeset
[146.170222] Dynamic subtest modeset: SUCCESS (3.835s)
[146.171856] Subtest basic: SUCCESS (4.513s)
[147.007913] [094/161] (897s left) kms_prop_blob (basic)
[147.058316] Starting subtest: basic
[147.059505] Subtest basic: SUCCESS (0.000s)
[147.134973] [095/161] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[147.230325] Starting subtest: basic-busy-flip-before-cursor-atomic
[147.231767] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[147.327650] [096/161] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[147.419130] Starting subtest: basic-busy-flip-before-cursor-legacy
[147.420668] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[147.520483] [097/161] (897s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[147.613651] Starting subtest: basic-flip-after-cursor-atomic
[148.336644] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.721s)
[149.245021] [098/161] (895s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[149.341447] Starting subtest: basic-flip-after-cursor-legacy
[150.067655] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.725s)
[150.953672] [099/161] (894s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[151.054732] Starting subtest: basic-flip-after-cursor-varying-size
[151.785029] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.729s)
[152.666845] [100/161] (892s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[152.767711] Starting subtest: basic-flip-before-cursor-atomic
[153.502349] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.733s)
[154.375872] [101/161] (890s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[154.472753] Starting subtest: basic-flip-before-cursor-legacy
[155.202357] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.728s)
[156.085495] [102/161] (889s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[156.181881] Starting subtest: basic-flip-before-cursor-varying-size
[156.915573] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.732s)
[157.799660] [103/161] (887s left) kms_dsc (dsc-basic)
[157.875961] Starting subtest: dsc-basic
[157.879568] Subtest dsc-basic: SKIP (0.001s)
[157.948064] [104/161] (887s left) kms_flip (basic-flip-vs-dpms)
[158.018500] Starting subtest: basic-flip-vs-dpms
[158.020276] Starting dynamic subtest: A-eDP1
[160.737175] Dynamic subtest A-eDP1: SUCCESS (2.716s)
[160.758848] Starting dynamic subtest: B-eDP1
[163.009951] Dynamic subtest B-eDP1: SUCCESS (2.271s)
[163.030717] Starting dynamic subtest: C-eDP1
[165.369452] Dynamic subtest C-eDP1: SUCCESS (2.357s)
[165.370573] Subtest basic-flip-vs-dpms: SUCCESS (7.351s)
[166.198511] [105/161] (879s left) kms_flip (basic-flip-vs-modeset)
[166.274912] Starting subtest: basic-flip-vs-modeset
[166.277253] Starting dynamic subtest: A-eDP1
[168.905788] Dynamic subtest A-eDP1: SUCCESS (2.627s)
[168.923695] Starting dynamic subtest: B-eDP1
[171.167490] Dynamic subtest B-eDP1: SUCCESS (2.262s)
[171.187990] Starting dynamic subtest: C-eDP1
[173.426159] Dynamic subtest C-eDP1: SUCCESS (2.258s)
[173.428366] Subtest basic-flip-vs-modeset: SUCCESS (7.152s)
[174.259927] [106/161] (871s left) kms_flip (basic-flip-vs-wf_vblank)
[174.340975] Starting subtest: basic-flip-vs-wf_vblank
[174.343406] Starting dynamic subtest: A-eDP1
[176.307480] Dynamic subtest A-eDP1: SUCCESS (1.963s)
[176.328878] Starting dynamic subtest: B-eDP1
[178.328985] Dynamic subtest B-eDP1: SUCCESS (2.020s)
[178.353832] Starting dynamic subtest: C-eDP1
[180.356863] Dynamic subtest C-eDP1: SUCCESS (2.022s)
[180.357663] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.012s)
[181.630022] [107/161] (863s left) kms_flip (basic-plain-flip)
[181.706742] Starting subtest: basic-plain-flip
[181.708874] Starting dynamic subtest: A-eDP1
[183.540516] Dynamic subtest A-eDP1: SUCCESS (1.831s)
[183.562650] Starting dynamic subtest: B-eDP1
[185.355901] Dynamic subtest B-eDP1: SUCCESS (1.813s)
[185.376860] Starting dynamic subtest: C-eDP1
[187.171985] Dynamic subtest C-eDP1: SUCCESS (1.814s)
[187.174881] Subtest basic-plain-flip: SUCCESS (5.467s)
[188.366694] [108/161] (857s left) kms_force_connector_basic (force-connector-state)
[188.427193] Starting subtest: force-connector-state
[188.874204] Subtest force-connector-state: SUCCESS (0.447s)
[189.971683] [109/161] (855s left) kms_force_connector_basic (force-edid)
[190.032207] Starting subtest: force-edid
[190.064953] Subtest force-edid: SUCCESS (0.033s)
[190.202753] [110/161] (855s left) kms_force_connector_basic (force-load-detect)
[190.262269] Starting subtest: force-load-detect
[190.264411] Subtest force-load-detect: SKIP (0.000s)
[190.379402] [111/161] (855s left) kms_force_connector_basic (prune-stale-modes)
[190.440404] Starting subtest: prune-stale-modes
[190.480183] Subtest prune-stale-modes: SUCCESS (0.040s)
[190.606209] [112/161] (854s left) kms_frontbuffer_tracking (basic)
[190.684948] Starting subtest: basic
[193.973549] Subtest basic: SUCCESS (3.288s)
[194.088509] [113/161] (851s left) kms_hdmi_inject (inject-audio)
[194.431960] Starting subtest: inject-audio
[194.583966] Subtest inject-audio: SUCCESS (0.152s)
[195.354862] [114/161] (850s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[195.428690] Starting subtest: compare-crc-sanitycheck-xr24
[195.429525] Starting dynamic subtest: pipe-A-eDP-1
[196.044894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[196.057759] Starting dynamic subtest: pipe-B-eDP-1
[197.415158] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[197.435922] Starting dynamic subtest: pipe-C-eDP-1
[198.761837] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[198.763310] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.333s)
[199.622425] [115/161] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[199.694623] Starting subtest: compare-crc-sanitycheck-nv12
[199.695429] Starting dynamic subtest: pipe-A-eDP-1
[200.376489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[200.399308] Starting dynamic subtest: pipe-B-eDP-1
[201.727654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[201.753559] Starting dynamic subtest: pipe-C-eDP-1
[203.056924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[203.057732] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.363s)
[203.910707] [116/161] (841s left) kms_pipe_crc_basic (hang-read-crc)
[203.982171] Starting subtest: hang-read-crc
[203.982968] Starting dynamic subtest: pipe-A-eDP-1
[206.051606] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.068s)
[206.070912] Starting dynamic subtest: pipe-B-eDP-1
[208.822206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[208.843020] Starting dynamic subtest: pipe-C-eDP-1
[211.601593] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[211.602382] Subtest hang-read-crc: SUCCESS (7.620s)
[212.487702] [117/161] (833s left) kms_pipe_crc_basic (nonblocking-crc)
[212.559112] Starting subtest: nonblocking-crc
[212.559949] Starting dynamic subtest: pipe-A-eDP-1
[213.292859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[213.312782] Starting dynamic subtest: pipe-B-eDP-1
[214.774182] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[214.787392] Starting dynamic subtest: pipe-C-eDP-1
[216.253069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[216.253858] Subtest nonblocking-crc: SUCCESS (3.694s)
[217.097631] [118/161] (828s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[217.169632] Starting subtest: nonblocking-crc-frame-sequence
[217.170410] Starting dynamic subtest: pipe-A-eDP-1
[217.887496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[217.903388] Starting dynamic subtest: pipe-B-eDP-1
[219.377356] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s)
[219.397226] Starting dynamic subtest: pipe-C-eDP-1
[220.746563] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[220.747717] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.577s)
[221.601882] [119/161] (824s left) kms_pipe_crc_basic (read-crc)
[221.676384] Starting subtest: read-crc
[221.677609] Starting dynamic subtest: pipe-A-eDP-1
[222.364480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[222.381938] Starting dynamic subtest: pipe-B-eDP-1
[223.748262] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[223.767818] Starting dynamic subtest: pipe-C-eDP-1
[225.125554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[225.126781] Subtest read-crc: SUCCESS (3.449s)
[226.010418] [120/161] (819s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[226.096811] Starting subtest: read-crc-frame-sequence
[226.097584] Starting dynamic subtest: pipe-A-eDP-1
[226.767009] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[226.783559] Starting dynamic subtest: pipe-B-eDP-1
[228.148183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[228.164180] Starting dynamic subtest: pipe-C-eDP-1
[229.437794] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s)
[229.438576] Subtest read-crc-frame-sequence: SUCCESS (3.355s)
[230.300290] [121/161] (815s left) kms_pm_backlight (basic-brightness)
[230.374084] Starting subtest: basic-brightness
[230.411463] Starting dynamic subtest: eDP-1
[230.939449] Dynamic subtest eDP-1: SUCCESS (0.530s)
[230.940262] Subtest basic-brightness: SUCCESS (0.566s)
[231.803839] [122/161] (814s left) kms_pm_rpm (basic-pci-d3-state)
[233.322813] Starting subtest: basic-pci-d3-state
[234.788708] Subtest basic-pci-d3-state: SUCCESS (1.466s)
[234.913046] [123/161] (811s left) kms_pm_rpm (basic-rte)
[234.960156] Starting subtest: basic-rte
[237.913207] Subtest basic-rte: SUCCESS (2.950s)
[239.440576] [124/161] (806s left) kms_psr (psr-primary-page-flip)
[239.516872] Starting subtest: psr-primary-page-flip
[239.517760] Starting dynamic subtest: eDP-1
[241.249049] Dynamic subtest eDP-1: SUCCESS (1.732s)
[241.249911] Subtest psr-primary-page-flip: SUCCESS (1.734s)
[242.118907] [125/161] (804s left) kms_psr (psr-cursor-plane-move)
[242.199266] Starting subtest: psr-cursor-plane-move
[242.200233] Starting dynamic subtest: eDP-1
[243.919285] Dynamic subtest eDP-1: SUCCESS (1.717s)
[243.920204] Subtest psr-cursor-plane-move: SUCCESS (1.719s)
[244.804116] [126/161] (801s left) kms_psr (psr-sprite-plane-onoff)
[244.886134] Starting subtest: psr-sprite-plane-onoff
[244.887074] Starting dynamic subtest: eDP-1
[246.666703] Dynamic subtest eDP-1: SUCCESS (1.780s)
[246.667792] Subtest psr-sprite-plane-onoff: SUCCESS (1.782s)
[247.591162] [127/161] (798s left) kms_psr (psr-primary-mmap-gtt)
[247.670387] Starting subtest: psr-primary-mmap-gtt
[247.671352] Starting dynamic subtest: eDP-1
[249.394385] Dynamic subtest eDP-1: SUCCESS (1.720s)
[249.395666] Subtest psr-primary-mmap-gtt: SUCCESS (1.722s)
[250.272694] [128/161] (796s left) kms_setmode (basic-clone-single-crtc)
[250.326066] Starting subtest: basic-clone-single-crtc
[250.328413] Subtest basic-clone-single-crtc: SKIP (0.000s)
[250.405190] [129/161] (795s left) i915_pm_rps (basic-api)
[250.455599] Starting subtest: basic-api
[250.457349] Subtest basic-api: SKIP (0.000s)
[250.547911] [130/161] (795s left) prime_self_import (basic-llseek-bad)
[250.592267] Starting subtest: basic-llseek-bad
[250.594228] Subtest basic-llseek-bad: SUCCESS (0.002s)
[250.685788] [131/161] (795s left) prime_self_import (basic-llseek-size)
[250.730189] Starting subtest: basic-llseek-size
[250.731887] Subtest basic-llseek-size: SUCCESS (0.003s)
[250.831663] [132/161] (795s left) prime_self_import (basic-with_fd_dup)
[250.874860] Starting subtest: basic-with_fd_dup
[250.876377] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[250.973347] [133/161] (795s left) prime_self_import (basic-with_one_bo)
[251.016188] Starting subtest: basic-with_one_bo
[251.020174] Subtest basic-with_one_bo: SUCCESS (0.004s)
[251.098203] [134/161] (795s left) prime_self_import (basic-with_one_bo_two_files)
[251.141891] Starting subtest: basic-with_one_bo_two_files
[251.145350] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[251.254123] [135/161] (795s left) prime_self_import (basic-with_two_bos)
[251.298873] Starting subtest: basic-with_two_bos
[251.301323] Subtest basic-with_two_bos: SUCCESS (0.003s)
[251.397442] [136/161] (795s left) prime_vgem (basic-fence-flip)
[251.458325] Starting subtest: basic-fence-flip
[251.717365] Subtest basic-fence-flip: SUCCESS (0.259s)
[251.815470] [137/161] (794s left) prime_vgem (basic-fence-mmap)
[251.885453] Starting subtest: basic-fence-mmap
[251.913936] Subtest basic-fence-mmap: SUCCESS (0.029s)
[252.016370] [138/161] (794s left) prime_vgem (basic-fence-read)
[252.097251] Starting subtest: basic-fence-read
[252.107492] Subtest basic-fence-read: SKIP (0.010s)
[252.212102] [139/161] (794s left) prime_vgem (basic-gtt)
[252.287246] Starting subtest: basic-gtt
[252.300761] Subtest basic-gtt: SUCCESS (0.014s)
[252.409436] [140/161] (794s left) prime_vgem (basic-read)
[252.480460] Starting subtest: basic-read
[252.490268] Subtest basic-read: SKIP (0.009s)
[252.587160] [141/161] (794s left) prime_vgem (basic-write)
[252.658271] Starting subtest: basic-write
[252.669049] Subtest basic-write: SKIP (0.011s)
[252.784459] [142/161] (794s left) vgem_basic (setversion)
[252.836744] Starting subtest: setversion
[252.838396] Subtest setversion: SUCCESS (0.000s)
[252.901863] [143/161] (794s left) vgem_basic (create)
[252.955492] Starting subtest: create
[252.956541] Subtest create: SUCCESS (0.000s)
[253.021928] [144/161] (794s left) vgem_basic (debugfs)
[253.075459] Starting subtest: debugfs
[253.076465] Subtest debugfs: SUCCESS (0.000s)
[253.135768] [145/161] (793s left) vgem_basic (dmabuf-export)
[253.189943] Starting subtest: dmabuf-export
[253.200787] Subtest dmabuf-export: SUCCESS (0.009s)
[253.290847] [146/161] (793s left) vgem_basic (dmabuf-fence)
[253.342486] Starting subtest: dmabuf-fence
[253.343492] Subtest dmabuf-fence: SUCCESS (0.001s)
[253.405632] [147/161] (793s left) vgem_basic (dmabuf-fence-before)
[253.459934] Starting subtest: dmabuf-fence-before
[253.460835] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[253.524940] [148/161] (793s left) vgem_basic (dmabuf-mmap)
[253.578590] Starting subtest: dmabuf-mmap
[253.592148] Subtest dmabuf-mmap: SUCCESS (0.014s)
[253.652237] [149/161] (793s left) vgem_basic (mmap)
[253.706435] Starting subtest: mmap
[253.717146] Subtest mmap: SUCCESS (0.011s)
[253.772857] [150/161] (793s left) vgem_basic (second-client)
[253.827665] Starting subtest: second-client
[253.846964] Subtest second-client: SUCCESS (0.017s)
[253.907105] [151/161] (793s left) vgem_basic (sysfs)
[253.963279] Starting subtest: sysfs
[253.964060] Subtest sysfs: SUCCESS (0.001s)
[254.027296] [152/161] (793s left) core_hotunplug (unbind-rebind)
[254.130968] Starting subtest: unbind-rebind
[259.312871] Subtest unbind-rebind: SUCCESS (5.183s)
[259.358326] [153/161] (788s left) vgem_basic (unload)
[259.402854] Starting subtest: unload
[288.529791] Subtest unload: SUCCESS (29.092s)
[288.612763] [154/161] (758s left) i915_module_load (reload)
[288.660691] Starting subtest: reload
[292.200927] Subtest reload: SUCCESS (3.541s)
[292.251023] [155/161] (755s left) gem_lmem_swapping (basic)
[292.303782] Subtest basic: SKIP (0.000s)
[292.353360] [156/161] (755s left) gem_lmem_swapping (parallel-random-engines)
[292.404369] Subtest parallel-random-engines: SKIP (0.000s)
[292.514644] [157/161] (755s left) gem_lmem_swapping (random-engines)
[292.580412] Subtest random-engines: SKIP (0.000s)
[292.633706] [158/161] (755s left) gem_lmem_swapping (verify-random)
[292.680929] Subtest verify-random: SKIP (0.000s)
[292.740477] [159/161] (755s left) i915_pm_rpm (module-reload)
[294.927225] Starting subtest: module-reload
[307.013627] Subtest module-reload: SUCCESS (12.077s)
[307.047386] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[307.048697] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[307.052245] [160/161] (740s left) i915_selftest (live)
[307.103440] Starting subtest: live
[307.104395] Starting dynamic subtest: sanitycheck
[309.364955] Dynamic subtest sanitycheck: SUCCESS (2.251s)
[309.377998] Starting dynamic subtest: uncore
[311.555975] Dynamic subtest uncore: SUCCESS (2.187s)
[311.568429] Starting dynamic subtest: workarounds
[314.534947] Dynamic subtest workarounds: SUCCESS (2.975s)
[314.545590] Starting dynamic subtest: gt_engines
[317.216758] Dynamic subtest gt_engines: SUCCESS (2.678s)
[317.227948] Starting dynamic subtest: gt_timelines
[327.495640] Dynamic subtest gt_timelines: SUCCESS (10.274s)
[327.506465] Starting dynamic subtest: gt_contexts
[329.849392] Dynamic subtest gt_contexts: SUCCESS (2.358s)
[329.869073] Starting dynamic subtest: gt_lrc
[334.606183] Dynamic subtest gt_lrc: SUCCESS (4.744s)
[334.616870] Starting dynamic subtest: gt_mocs
[337.360225] Dynamic subtest gt_mocs: SUCCESS (2.750s)
[337.373988] Starting dynamic subtest: gt_pm
[341.917099] Dynamic subtest gt_pm: SUCCESS (4.553s)
[341.927889] Starting dynamic subtest: gt_heartbeat
[344.173664] Dynamic subtest gt_heartbeat: SUCCESS (2.253s)
[344.183943] Starting dynamic subtest: gt_tlb
[347.516749] Dynamic subtest gt_tlb: SUCCESS (3.339s)
[347.527582] Starting dynamic subtest: requests
[356.107116] Dynamic subtest requests: SUCCESS (8.586s)
[356.118545] Starting dynamic subtest: migrate
[361.157690] Dynamic subtest migrate: SUCCESS (5.047s)
[361.168581] Starting dynamic subtest: active
[363.429940] Dynamic subtest active: SUCCESS (2.272s)
[363.441643] Starting dynamic subtest: objects
[366.317917] Dynamic subtest objects: SUCCESS (2.880s)
[366.328985] Starting dynamic subtest: mman
[372.033988] Dynamic subtest mman: SUCCESS (5.712s)
[372.047741] Starting dynamic subtest: dmabuf
[374.420447] Dynamic subtest dmabuf: SUCCESS (2.383s)
[374.429227] Starting dynamic subtest: vma
[376.792849] Dynamic subtest vma: SUCCESS (2.369s)
[376.802547] Starting dynamic subtest: coherency
[381.461987] Dynamic subtest coherency: SUCCESS (4.666s)
[381.475309] Starting dynamic subtest: gtt
[391.183065] Dynamic subtest gtt: SUCCESS (9.717s)
[391.193970] Starting dynamic subtest: gem
[393.805954] Dynamic subtest gem: SUCCESS (2.619s)
[393.817027] Starting dynamic subtest: evict
[397.717528] Dynamic subtest evict: SUCCESS (3.908s)
[397.727967] Starting dynamic subtest: hugepages
[406.094508] Dynamic subtest hugepages: SUCCESS (8.374s)
[406.103149] Starting dynamic subtest: gem_contexts
[421.391382] Dynamic subtest gem_contexts: SUCCESS (15.293s)
[421.401236] Starting dynamic subtest: client
[423.901339] Dynamic subtest client: SUCCESS (2.506s)
[423.911883] Starting dynamic subtest: gem_migrate
[426.242743] Dynamic subtest gem_migrate: SUCCESS (2.337s)
[426.255038] Starting dynamic subtest: reset
[431.031077] Dynamic subtest reset: SUCCESS (4.784s)
[431.043038] Starting dynamic subtest: memory_region
[433.441940] Dynamic subtest memory_region: SUCCESS (2.407s)
[433.455662] Starting dynamic subtest: hangcheck
[450.942073] Dynamic subtest hangcheck: SUCCESS (17.496s)
[450.953392] Starting dynamic subtest: execlists
[453.333114] Dynamic subtest execlists: SUCCESS (2.387s)
[453.344277] Starting dynamic subtest: ring_submission
[455.687944] Dynamic subtest ring_submission: SUCCESS (2.351s)
[455.699210] Starting dynamic subtest: perf
[458.186948] Dynamic subtest perf: SUCCESS (2.495s)
[458.199353] Starting dynamic subtest: slpc
[465.535120] Dynamic subtest slpc: SUCCESS (7.344s)
[465.545778] Starting dynamic subtest: guc
[468.657241] Dynamic subtest guc: SUCCESS (3.118s)
[468.671552] Starting dynamic subtest: guc_multi_lrc
[470.881903] Dynamic subtest guc_multi_lrc: SUCCESS (2.221s)
[470.894443] Starting dynamic subtest: guc_hang
[473.832956] Dynamic subtest guc_hang: SUCCESS (2.947s)
[473.844983] Starting dynamic subtest: late_gt_pm
[476.133894] Dynamic subtest late_gt_pm: SUCCESS (2.297s)
[476.135494] Subtest live: SUCCESS (169.013s)
[476.175101] [161/161] (571s left) dmabuf (all-tests)
[476.222955] Starting subtest: all-tests
[476.224198] Starting dynamic subtest: sanitycheck
[476.299568] Dynamic subtest sanitycheck: SUCCESS (0.075s)
[476.330631] Starting dynamic subtest: dma_fence
[476.562099] Dynamic subtest dma_fence: SUCCESS (0.250s)
[476.581229] Starting dynamic subtest: dma_fence_chain
[487.212132] Dynamic subtest dma_fence_chain: SUCCESS (10.646s)
[487.222712] Starting dynamic subtest: dma_fence_unwrap
[487.308357] Dynamic subtest dma_fence_unwrap: SUCCESS (0.101s)
[487.338302] Starting dynamic subtest: dma_resv
[487.410313] Dynamic subtest dma_resv: SUCCESS (0.098s)
[487.412569] Subtest all-tests: SUCCESS (11.188s)
[487.459119] Closing watchdogs
Done.