[77.396487] Initializing watchdogs
[77.396615]   /dev/watchdog0
[77.413085] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[77.417823] [001/161] (960s left) i915_module_load (load)
[77.560310] Starting subtest: load
[78.799061] Subtest load: SUCCESS (1.212s)
[78.845484] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[78.847834] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[78.850674] [002/161] (959s left) core_auth (basic-auth)
[78.929632] Starting subtest: basic-auth
[78.933221] Subtest basic-auth: SUCCESS (0.002s)
[79.015721] [003/161] (959s left) debugfs_test (read_all_entries)
[79.090927] Starting subtest: read_all_entries
[79.318681] Subtest read_all_entries: SUCCESS (0.225s)
[79.413898] [004/161] (958s left) debugfs_test (basic-hwmon)
[79.460935] Starting subtest: basic-hwmon
[79.462621] Subtest basic-hwmon: SKIP (0.000s)
[79.572354] [005/161] (958s left) debugfs_test (sysfs)
[79.629491] Starting subtest: sysfs
[79.692112] Subtest sysfs: SUCCESS (0.061s)
[79.784695] [006/161] (958s left) fbdev (eof)
[79.840525] Starting subtest: eof
[79.842273] Subtest eof: SUCCESS (0.000s)
[79.895573] [007/161] (958s left) fbdev (info)
[79.936572] Starting subtest: info
[79.937417] Subtest info: SUCCESS (0.000s)
[80.008723] [008/161] (958s left) fbdev (nullptr)
[80.059620] Starting subtest: nullptr
[80.060603] Subtest nullptr: SUCCESS (0.000s)
[80.119393] [009/161] (958s left) fbdev (read)
[80.169428] Starting subtest: read
[82.091262] Subtest read: SUCCESS (1.887s)
[82.145919] [010/161] (956s left) fbdev (write)
[82.196160] Starting subtest: write
[83.168474] Subtest write: SUCCESS (0.953s)
[83.227919] [011/161] (955s left) gem_basic (bad-close)
[83.268799] Starting subtest: bad-close
[83.271293] Subtest bad-close: SUCCESS (0.000s)
[83.351965] [012/161] (955s left) gem_basic (create-close)
[83.394660] Starting subtest: create-close
[83.396157] Subtest create-close: SUCCESS (0.000s)
[83.494143] [013/161] (955s left) gem_basic (create-fd-close)
[83.538213] Starting subtest: create-fd-close
[83.539879] Subtest create-fd-close: SUCCESS (0.000s)
[83.635646] [014/161] (954s left) gem_busy (busy@all-engines)
[83.692430] Starting subtest: busy
[83.693405] Starting dynamic subtest: all-engines
[83.747407] Dynamic subtest all-engines: SUCCESS (0.055s)
[83.748218] Subtest busy: SUCCESS (0.055s)
[84.140379] [015/161] (954s left) gem_close_race (basic-process)
[84.198620] Starting subtest: basic-process
[84.262671] Subtest basic-process: SUCCESS (0.063s)
[84.453914] [016/161] (954s left) gem_close_race (basic-threads)
[84.512699] Starting subtest: basic-threads
[85.753576] Subtest basic-threads: SUCCESS (1.231s)
[85.940688] [017/161] (952s left) gem_ctx_create (basic)
[85.994932] Starting subtest: basic
[85.995853] Subtest basic: SUCCESS (0.000s)
[86.190921] [018/161] (952s left) gem_ctx_create (basic-files)
[86.244417] Starting subtest: basic-files
[88.268924] Subtest basic-files: SUCCESS (2.013s)
[88.482701] [019/161] (950s left) gem_ctx_exec (basic)
[88.556553] Starting subtest: basic
[88.562772] Subtest basic: SUCCESS (0.006s)
[88.723193] [020/161] (950s left) gem_exec_basic (basic)
[88.780951] Starting subtest: basic
[88.781864] Starting dynamic subtest: rcs0-smem
[88.783700] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[88.791925] Starting dynamic subtest: bcs0-smem
[88.792743] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[88.800557] Starting dynamic subtest: vcs0-smem
[88.801383] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[88.808981] Starting dynamic subtest: vecs0-smem
[88.809808] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[88.810589] Subtest basic: SUCCESS (0.007s)
[88.975060] [021/161] (949s left) gem_exec_create (basic)
[89.030437] Starting subtest: basic
[89.031448] Starting dynamic subtest: smem
[91.137919] Dynamic subtest smem: SUCCESS (2.098s)
[91.139223] Subtest basic: SUCCESS (2.099s)
[91.328848] [022/161] (947s left) gem_exec_fence (basic-busy)
[91.506233] Starting subtest: basic-busy
[91.507735] Starting dynamic subtest: rcs0
[91.584762] Dynamic subtest rcs0: SUCCESS (0.078s)
[91.602948] Starting dynamic subtest: bcs0
[91.635797] Dynamic subtest bcs0: SUCCESS (0.050s)
[91.650408] Starting dynamic subtest: vcs0
[91.686974] Dynamic subtest vcs0: SUCCESS (0.050s)
[91.702864] Starting dynamic subtest: vecs0
[91.740705] Dynamic subtest vecs0: SUCCESS (0.053s)
[91.742254] Subtest basic-busy: SUCCESS (0.234s)
[92.284406] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[92.286904] [023/161] (946s left) gem_exec_fence (basic-wait)
[92.461376] Starting subtest: basic-wait
[92.462990] Starting dynamic subtest: rcs0
[92.521718] Dynamic subtest rcs0: SUCCESS (0.060s)
[92.537261] Starting dynamic subtest: bcs0
[92.572998] Dynamic subtest bcs0: SUCCESS (0.050s)
[92.588422] Starting dynamic subtest: vcs0
[92.622739] Dynamic subtest vcs0: SUCCESS (0.049s)
[92.637574] Starting dynamic subtest: vecs0
[92.674662] Dynamic subtest vecs0: SUCCESS (0.051s)
[92.676766] Subtest basic-wait: SUCCESS (0.214s)
[93.204031] [024/161] (945s left) gem_exec_fence (basic-await)
[93.380464] Starting subtest: basic-await
[93.381730] Starting dynamic subtest: rcs0
[93.471195] Dynamic subtest rcs0: SUCCESS (0.091s)
[93.487925] Starting dynamic subtest: bcs0
[93.566475] Dynamic subtest bcs0: SUCCESS (0.094s)
[93.587340] Starting dynamic subtest: vcs0
[93.663626] Dynamic subtest vcs0: SUCCESS (0.096s)
[93.680708] Starting dynamic subtest: vecs0
[93.757879] Dynamic subtest vecs0: SUCCESS (0.092s)
[93.759550] Subtest basic-await: SUCCESS (0.376s)
[94.279486] [025/161] (944s left) gem_exec_fence (nb-await)
[94.454508] Starting subtest: nb-await
[94.455392] Starting dynamic subtest: rcs0
[94.519106] Dynamic subtest rcs0: SUCCESS (0.065s)
[94.538554] Starting dynamic subtest: bcs0
[94.588226] Dynamic subtest bcs0: SUCCESS (0.068s)
[94.606027] Starting dynamic subtest: vcs0
[94.651892] Dynamic subtest vcs0: SUCCESS (0.063s)
[94.663502] Starting dynamic subtest: vecs0
[94.714634] Dynamic subtest vecs0: SUCCESS (0.062s)
[94.716309] Subtest nb-await: SUCCESS (0.261s)
[95.238838] [026/161] (943s left) gem_exec_gttfill (basic)
[95.293601] Starting subtest: basic
[102.485260] Subtest basic: SUCCESS (7.174s)
[102.683475] [027/161] (936s left) gem_exec_parallel (engines)
[102.806061] Starting subtest: engines
[102.806953] Starting dynamic subtest: basic
[105.977909] Dynamic subtest basic: SUCCESS (3.170s)
[105.993488] Starting dynamic subtest: contexts
[109.575049] Dynamic subtest contexts: SUCCESS (3.586s)
[109.587691] Starting dynamic subtest: fds
[113.804532] Dynamic subtest fds: SUCCESS (4.227s)
[113.821865] Starting dynamic subtest: userptr
[116.245137] Dynamic subtest userptr: SUCCESS (2.448s)
[116.246496] Subtest engines: SUCCESS (13.433s)
[116.456252] [028/161] (922s left) gem_exec_store (basic)
[116.527562] Starting subtest: basic
[116.629127] Subtest basic: SUCCESS (0.101s)
[116.824062] [029/161] (922s left) gem_flink_basic (bad-flink)
[116.872969] Starting subtest: bad-flink
[116.873863] Subtest bad-flink: SUCCESS (0.000s)
[116.959716] [030/161] (922s left) gem_flink_basic (bad-open)
[117.008183] Starting subtest: bad-open
[117.009130] Subtest bad-open: SUCCESS (0.000s)
[117.098578] [031/161] (922s left) gem_flink_basic (basic)
[117.145815] Starting subtest: basic
[117.146579] Subtest basic: SUCCESS (0.000s)
[117.250918] [032/161] (922s left) gem_flink_basic (double-flink)
[117.300435] Starting subtest: double-flink
[117.301213] Subtest double-flink: SUCCESS (0.000s)
[117.405025] [033/161] (922s left) gem_flink_basic (flink-lifetime)
[117.453745] Starting subtest: flink-lifetime
[117.454657] Subtest flink-lifetime: SUCCESS (0.001s)
[117.561687] [034/161] (921s left) gem_huc_copy (huc-copy)
[117.618591] Starting subtest: huc-copy
[117.623518] Subtest huc-copy: SUCCESS (0.005s)
[117.742144] [035/161] (921s left) gem_linear_blits (basic)
[117.875553] Starting subtest: basic
[117.886775] Subtest basic: SUCCESS (0.011s)
[118.042656] [036/161] (921s left) gem_mmap (basic)
[118.137438] Starting subtest: basic
[118.141446] Subtest basic: SUCCESS (0.001s)
[118.239529] [037/161] (921s left) gem_mmap_gtt (basic)
[118.291921] Starting subtest: basic
[118.292749] Subtest basic: SUCCESS (0.001s)
[118.370056] [038/161] (921s left) gem_render_linear_blits (basic)
[118.426278] Starting subtest: basic
[118.475973] Subtest basic: SUCCESS (0.049s)
[118.574031] [039/161] (921s left) gem_render_tiled_blits (basic)
[118.627892] Starting subtest: basic
[118.692118] Subtest basic: SUCCESS (0.064s)
[118.791520] [040/161] (921s left) gem_ringfill (basic-all)
[119.095853] Starting subtest: basic-all
[120.250873] Subtest basic-all: SUCCESS (1.146s)
[120.375148] [041/161] (919s left) gem_softpin (allocator-basic)
[120.441678] Starting subtest: allocator-basic
[120.561600] Subtest allocator-basic: SUCCESS (0.111s)
[120.701110] [042/161] (919s left) gem_softpin (allocator-basic-reserve)
[120.760419] Starting subtest: allocator-basic-reserve
[120.864833] Subtest allocator-basic-reserve: SUCCESS (0.103s)
[120.984951] [043/161] (919s left) gem_softpin (safe-alignment)
[121.049082] Starting subtest: safe-alignment
[121.071626] Subtest safe-alignment: SUCCESS (0.023s)
[121.205048] [044/161] (918s left) gem_sync (basic-all)
[121.273112] Starting subtest: basic-all
[124.501321] Subtest basic-all: SUCCESS (3.227s)
[124.694670] [045/161] (915s left) gem_sync (basic-each)
[124.753731] Starting subtest: basic-each
[127.373679] Subtest basic-each: SUCCESS (2.618s)
[127.567121] [046/161] (912s left) gem_tiled_blits (basic)
[127.670285] Starting subtest: basic
[127.697224] Subtest basic: SUCCESS (0.027s)
[127.830651] [047/161] (912s left) gem_tiled_fence_blits (basic)
[127.998734] Starting subtest: basic
[128.020834] Subtest basic: SUCCESS (0.022s)
[128.149896] [048/161] (912s left) gem_tiled_pread_basic
[128.309067] [049/161] (912s left) gem_wait (busy@all-engines)
[128.381706] Starting subtest: busy
[128.382590] Starting dynamic subtest: all-engines
[128.949447] Dynamic subtest all-engines: SUCCESS (0.567s)
[128.950879] Subtest busy: SUCCESS (0.568s)
[129.170545] [050/161] (911s left) gem_wait (wait@all-engines)
[129.239839] Starting subtest: wait
[129.240672] Starting dynamic subtest: all-engines
[130.310482] Dynamic subtest all-engines: SUCCESS (1.069s)
[130.312094] Subtest wait: SUCCESS (1.070s)
[130.525322] [051/161] (909s left) i915_getparams_basic (basic-eu-total)
[130.570452] Starting subtest: basic-eu-total
[130.571961] Subtest basic-eu-total: SUCCESS (0.000s)
[130.647936] [052/161] (909s left) i915_getparams_basic (basic-subslice-total)
[130.692365] Starting subtest: basic-subslice-total
[130.693955] Subtest basic-subslice-total: SUCCESS (0.000s)
[130.771057] [053/161] (909s left) i915_hangman (error-state-basic)
[130.828844] Starting subtest: error-state-basic
[130.952829] Subtest error-state-basic: SUCCESS (0.124s)
[131.040866] [054/161] (909s left) i915_pciid
[131.165820] [055/161] (909s left) kms_addfb_basic (addfb25-4-tiled)
[131.247974] Starting subtest: addfb25-4-tiled
[131.248843] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[131.351801] [056/161] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[131.422124] Starting subtest: addfb25-bad-modifier
[131.423044] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[131.518807] [057/161] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[131.587182] Starting subtest: addfb25-framebuffer-vs-set-tiling
[131.588116] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[131.684461] [058/161] (909s left) kms_addfb_basic (addfb25-modifier-no-flag)
[131.755337] Starting subtest: addfb25-modifier-no-flag
[131.756211] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[131.860848] [059/161] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[131.932325] Starting subtest: addfb25-x-tiled-legacy
[131.933115] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[132.036532] [060/161] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[132.108147] Starting subtest: addfb25-x-tiled-mismatch-legacy
[132.108997] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[132.212968] [061/161] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[132.285131] Starting subtest: addfb25-yf-tiled-legacy
[132.286034] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[132.388126] [062/161] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[132.461124] Starting subtest: addfb25-y-tiled-legacy
[132.462058] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[132.544808] [063/161] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[132.620282] Starting subtest: addfb25-y-tiled-small-legacy
[132.621180] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[132.720870] [064/161] (908s left) kms_addfb_basic (bad-pitch-0)
[132.770530] Starting subtest: bad-pitch-0
[132.771329] Subtest bad-pitch-0: SUCCESS (0.000s)
[132.906146] [065/161] (908s left) kms_addfb_basic (bad-pitch-1024)
[132.953774] Starting subtest: bad-pitch-1024
[132.954536] Subtest bad-pitch-1024: SUCCESS (0.000s)
[133.080843] [066/161] (908s left) kms_addfb_basic (bad-pitch-128)
[133.129888] Starting subtest: bad-pitch-128
[133.130756] Subtest bad-pitch-128: SUCCESS (0.000s)
[133.256030] [067/161] (907s left) kms_addfb_basic (bad-pitch-256)
[133.308249] Starting subtest: bad-pitch-256
[133.309049] Subtest bad-pitch-256: SUCCESS (0.000s)
[133.437707] [068/161] (907s left) kms_addfb_basic (bad-pitch-32)
[133.487758] Starting subtest: bad-pitch-32
[133.488579] Subtest bad-pitch-32: SUCCESS (0.000s)
[133.624776] [069/161] (907s left) kms_addfb_basic (bad-pitch-63)
[133.675909] Starting subtest: bad-pitch-63
[133.676754] Subtest bad-pitch-63: SUCCESS (0.000s)
[133.798800] [070/161] (907s left) kms_addfb_basic (bad-pitch-65536)
[133.849912] Starting subtest: bad-pitch-65536
[133.850810] Subtest bad-pitch-65536: SUCCESS (0.000s)
[133.973858] [071/161] (907s left) kms_addfb_basic (bad-pitch-999)
[134.025156] Starting subtest: bad-pitch-999
[134.025978] Subtest bad-pitch-999: SUCCESS (0.000s)
[134.147798] [072/161] (907s left) kms_addfb_basic (basic)
[134.201009] Starting subtest: basic
[134.201861] Subtest basic: SUCCESS (0.000s)
[134.340864] [073/161] (907s left) kms_addfb_basic (basic-x-tiled-legacy)
[134.392621] Starting subtest: basic-x-tiled-legacy
[134.393405] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[134.524499] [074/161] (906s left) kms_addfb_basic (basic-y-tiled-legacy)
[134.579527] Starting subtest: basic-y-tiled-legacy
[134.580336] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[134.708711] [075/161] (906s left) kms_addfb_basic (bo-too-small)
[134.789505] Starting subtest: bo-too-small
[134.790445] Subtest bo-too-small: SUCCESS (0.001s)
[134.897399] [076/161] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[134.975306] Starting subtest: bo-too-small-due-to-tiling
[134.976333] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[135.090150] [077/161] (906s left) kms_addfb_basic (clobberred-modifier)
[135.140142] Starting subtest: clobberred-modifier
[135.140930] Subtest clobberred-modifier: SUCCESS (0.000s)
[135.265372] [078/161] (906s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[135.316516] Starting subtest: framebuffer-vs-set-tiling
[135.317284] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[135.457211] [079/161] (906s left) kms_addfb_basic (invalid-get-prop)
[135.507244] Starting subtest: invalid-get-prop
[135.508080] Subtest invalid-get-prop: SUCCESS (0.000s)
[135.647901] [080/161] (906s left) kms_addfb_basic (invalid-get-prop-any)
[135.698147] Starting subtest: invalid-get-prop-any
[135.698950] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[135.831279] [081/161] (906s left) kms_addfb_basic (invalid-set-prop)
[135.881636] Starting subtest: invalid-set-prop
[135.882436] Subtest invalid-set-prop: SUCCESS (0.000s)
[136.008167] [082/161] (905s left) kms_addfb_basic (invalid-set-prop-any)
[136.059768] Starting subtest: invalid-set-prop-any
[136.060530] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[136.190491] [083/161] (905s left) kms_addfb_basic (no-handle)
[136.241906] Starting subtest: no-handle
[136.242731] Subtest no-handle: SUCCESS (0.000s)
[136.372752] [084/161] (905s left) kms_addfb_basic (size-max)
[136.448907] Starting subtest: size-max
[136.449853] Subtest size-max: SUCCESS (0.000s)
[136.558713] [085/161] (905s left) kms_addfb_basic (small-bo)
[136.634315] Starting subtest: small-bo
[136.635217] Subtest small-bo: SUCCESS (0.000s)
[136.740365] [086/161] (905s left) kms_addfb_basic (tile-pitch-mismatch)
[136.791463] Starting subtest: tile-pitch-mismatch
[136.792215] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[136.941598] [087/161] (905s left) kms_addfb_basic (too-high)
[137.018157] Starting subtest: too-high
[137.019100] Subtest too-high: SUCCESS (0.001s)
[137.122881] [088/161] (905s left) kms_addfb_basic (too-wide)
[137.199192] Starting subtest: too-wide
[137.200140] Subtest too-wide: SUCCESS (0.000s)
[137.306691] [089/161] (904s left) kms_addfb_basic (unused-handle)
[137.360371] Starting subtest: unused-handle
[137.361120] Subtest unused-handle: SUCCESS (0.000s)
[137.482372] [090/161] (904s left) kms_addfb_basic (unused-modifier)
[137.533160] Starting subtest: unused-modifier
[137.533936] Subtest unused-modifier: SUCCESS (0.000s)
[137.666513] [091/161] (904s left) kms_addfb_basic (unused-offsets)
[137.717504] Starting subtest: unused-offsets
[137.718318] Subtest unused-offsets: SUCCESS (0.000s)
[137.840495] [092/161] (904s left) kms_addfb_basic (unused-pitches)
[137.892151] Starting subtest: unused-pitches
[137.892949] Subtest unused-pitches: SUCCESS (0.000s)
[138.023534] [093/161] (904s left) kms_busy (basic)
[138.103951] Starting subtest: basic
[138.104933] Starting dynamic subtest: flip
[138.769098] Dynamic subtest flip: SUCCESS (0.664s)
[138.790616] Starting dynamic subtest: modeset
[142.614429] Dynamic subtest modeset: SUCCESS (3.845s)
[142.615234] Subtest basic: SUCCESS (4.511s)
[143.447407] [094/161] (899s left) kms_prop_blob (basic)
[143.495496] Starting subtest: basic
[143.496329] Subtest basic: SUCCESS (0.000s)
[143.570401] [095/161] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[143.664233] Starting subtest: basic-busy-flip-before-cursor-atomic
[143.665777] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[143.763442] [096/161] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[143.855163] Starting subtest: basic-busy-flip-before-cursor-legacy
[143.856716] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[143.959649] [097/161] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[144.056307] Starting subtest: basic-flip-after-cursor-atomic
[144.790254] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.731s)
[145.690753] [098/161] (897s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[145.782534] Starting subtest: basic-flip-after-cursor-legacy
[146.506364] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.723s)
[147.399318] [099/161] (895s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[147.496708] Starting subtest: basic-flip-after-cursor-varying-size
[148.230568] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.731s)
[149.107935] [100/161] (893s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[149.204548] Starting subtest: basic-flip-before-cursor-atomic
[149.928683] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.724s)
[150.814776] [101/161] (892s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[150.904875] Starting subtest: basic-flip-before-cursor-legacy
[151.639478] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.732s)
[152.528708] [102/161] (890s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[152.626143] Starting subtest: basic-flip-before-cursor-varying-size
[153.350735] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.724s)
[154.235541] [103/161] (888s left) kms_dsc (dsc-basic)
[154.303947] Starting subtest: dsc-basic
[154.307637] Subtest dsc-basic: SKIP (0.001s)
[154.375195] [104/161] (888s left) kms_flip (basic-flip-vs-dpms)
[154.442808] Starting subtest: basic-flip-vs-dpms
[154.444829] Starting dynamic subtest: A-eDP1
[157.178201] Dynamic subtest A-eDP1: SUCCESS (2.733s)
[157.200698] Starting dynamic subtest: B-eDP1
[159.446389] Dynamic subtest B-eDP1: SUCCESS (2.265s)
[159.466925] Starting dynamic subtest: C-eDP1
[161.815229] Dynamic subtest C-eDP1: SUCCESS (2.369s)
[161.816289] Subtest basic-flip-vs-dpms: SUCCESS (7.373s)
[162.652506] [105/161] (880s left) kms_flip (basic-flip-vs-modeset)
[162.725556] Starting subtest: basic-flip-vs-modeset
[162.727909] Starting dynamic subtest: A-eDP1
[165.349849] Dynamic subtest A-eDP1: SUCCESS (2.617s)
[165.359931] Starting dynamic subtest: B-eDP1
[167.622674] Dynamic subtest B-eDP1: SUCCESS (2.275s)
[167.644814] Starting dynamic subtest: C-eDP1
[169.883575] Dynamic subtest C-eDP1: SUCCESS (2.260s)
[169.885933] Subtest basic-flip-vs-modeset: SUCCESS (7.158s)
[170.721613] [106/161] (872s left) kms_flip (basic-flip-vs-wf_vblank)
[170.800246] Starting subtest: basic-flip-vs-wf_vblank
[170.801474] Starting dynamic subtest: A-eDP1
[172.766476] Dynamic subtest A-eDP1: SUCCESS (1.964s)
[172.788697] Starting dynamic subtest: B-eDP1
[174.798657] Dynamic subtest B-eDP1: SUCCESS (2.030s)
[174.821883] Starting dynamic subtest: C-eDP1
[176.816601] Dynamic subtest C-eDP1: SUCCESS (2.011s)
[176.817865] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.013s)
[178.088600] [107/161] (865s left) kms_flip (basic-plain-flip)
[178.163217] Starting subtest: basic-plain-flip
[178.164561] Starting dynamic subtest: A-eDP1
[179.994920] Dynamic subtest A-eDP1: SUCCESS (1.830s)
[180.013490] Starting dynamic subtest: B-eDP1
[181.806757] Dynamic subtest B-eDP1: SUCCESS (1.810s)
[181.829795] Starting dynamic subtest: C-eDP1
[183.619212] Dynamic subtest C-eDP1: SUCCESS (1.807s)
[183.620249] Subtest basic-plain-flip: SUCCESS (5.455s)
[184.827270] [108/161] (858s left) kms_force_connector_basic (force-connector-state)
[184.885356] Starting subtest: force-connector-state
[185.331186] Subtest force-connector-state: SUCCESS (0.446s)
[186.431992] [109/161] (856s left) kms_force_connector_basic (force-edid)
[186.489351] Starting subtest: force-edid
[186.526976] Subtest force-edid: SUCCESS (0.038s)
[186.648216] [110/161] (856s left) kms_force_connector_basic (force-load-detect)
[186.706290] Starting subtest: force-load-detect
[186.707887] Subtest force-load-detect: SKIP (0.000s)
[186.817859] [111/161] (856s left) kms_force_connector_basic (prune-stale-modes)
[186.876488] Starting subtest: prune-stale-modes
[186.913019] Subtest prune-stale-modes: SUCCESS (0.037s)
[187.037226] [112/161] (856s left) kms_frontbuffer_tracking (basic)
[187.112189] Starting subtest: basic
[190.399459] Subtest basic: SUCCESS (3.287s)
[190.539922] [113/161] (852s left) kms_hdmi_inject (inject-audio)
[190.874559] Starting subtest: inject-audio
[191.035016] Subtest inject-audio: SUCCESS (0.160s)
[191.825754] [114/161] (851s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[191.896853] Starting subtest: compare-crc-sanitycheck-xr24
[191.897890] Starting dynamic subtest: pipe-A-eDP-1
[192.516602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[192.537559] Starting dynamic subtest: pipe-B-eDP-1
[193.859495] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[193.881901] Starting dynamic subtest: pipe-C-eDP-1
[195.134956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.269s)
[195.136014] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.236s)
[195.975432] [115/161] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[196.046511] Starting subtest: compare-crc-sanitycheck-nv12
[196.047534] Starting dynamic subtest: pipe-A-eDP-1
[196.728913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[196.750751] Starting dynamic subtest: pipe-B-eDP-1
[198.068755] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[198.085588] Starting dynamic subtest: pipe-C-eDP-1
[199.434967] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[199.435756] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.389s)
[200.273069] [116/161] (843s left) kms_pipe_crc_basic (hang-read-crc)
[200.345760] Starting subtest: hang-read-crc
[200.346665] Starting dynamic subtest: pipe-A-eDP-1
[202.417110] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s)
[202.428896] Starting dynamic subtest: pipe-B-eDP-1
[205.200111] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.782s)
[205.216218] Starting dynamic subtest: pipe-C-eDP-1
[207.962484] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[207.963286] Subtest hang-read-crc: SUCCESS (7.618s)
[208.838237] [117/161] (834s left) kms_pipe_crc_basic (nonblocking-crc)
[208.910660] Starting subtest: nonblocking-crc
[208.911429] Starting dynamic subtest: pipe-A-eDP-1
[209.629929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[209.649337] Starting dynamic subtest: pipe-B-eDP-1
[211.119009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s)
[211.133590] Starting dynamic subtest: pipe-C-eDP-1
[212.479366] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[212.480262] Subtest nonblocking-crc: SUCCESS (3.569s)
[213.343239] [118/161] (830s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[213.415449] Starting subtest: nonblocking-crc-frame-sequence
[213.416207] Starting dynamic subtest: pipe-A-eDP-1
[214.117780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[214.130259] Starting dynamic subtest: pipe-B-eDP-1
[215.604043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s)
[215.623912] Starting dynamic subtest: pipe-C-eDP-1
[216.986170] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[216.987363] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.570s)
[217.842798] [119/161] (825s left) kms_pipe_crc_basic (read-crc)
[217.910203] Starting subtest: read-crc
[217.910949] Starting dynamic subtest: pipe-A-eDP-1
[218.595376] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[218.612304] Starting dynamic subtest: pipe-B-eDP-1
[219.983267] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[219.999810] Starting dynamic subtest: pipe-C-eDP-1
[221.371444] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[221.372605] Subtest read-crc: SUCCESS (3.460s)
[222.243450] [120/161] (821s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[222.314186] Starting subtest: read-crc-frame-sequence
[222.314938] Starting dynamic subtest: pipe-A-eDP-1
[223.007710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[223.025062] Starting dynamic subtest: pipe-B-eDP-1
[224.393511] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[224.407197] Starting dynamic subtest: pipe-C-eDP-1
[225.749765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[225.750537] Subtest read-crc-frame-sequence: SUCCESS (3.436s)
[226.629314] [121/161] (817s left) kms_pm_backlight (basic-brightness)
[226.699969] Starting subtest: basic-brightness
[226.737105] Starting dynamic subtest: eDP-1
[227.269883] Dynamic subtest eDP-1: SUCCESS (0.534s)
[227.270776] Subtest basic-brightness: SUCCESS (0.571s)
[228.129308] [122/161] (815s left) kms_pm_rpm (basic-pci-d3-state)
[229.645918] Starting subtest: basic-pci-d3-state
[231.139571] Subtest basic-pci-d3-state: SUCCESS (1.493s)
[231.255286] [123/161] (812s left) kms_pm_rpm (basic-rte)
[231.297560] Starting subtest: basic-rte
[234.221466] Subtest basic-rte: SUCCESS (2.922s)
[235.734390] [124/161] (808s left) kms_psr (psr-primary-page-flip)
[235.808890] Starting subtest: psr-primary-page-flip
[235.809671] Starting dynamic subtest: eDP-1
[237.552379] Dynamic subtest eDP-1: SUCCESS (1.742s)
[237.553212] Subtest psr-primary-page-flip: SUCCESS (1.744s)
[238.408254] [125/161] (805s left) kms_psr (psr-cursor-plane-move)
[238.486078] Starting subtest: psr-cursor-plane-move
[238.486871] Starting dynamic subtest: eDP-1
[240.241226] Dynamic subtest eDP-1: SUCCESS (1.750s)
[240.242831] Subtest psr-cursor-plane-move: SUCCESS (1.753s)
[241.093802] [126/161] (802s left) kms_psr (psr-sprite-plane-onoff)
[241.170446] Starting subtest: psr-sprite-plane-onoff
[241.171458] Starting dynamic subtest: eDP-1
[242.969831] Dynamic subtest eDP-1: SUCCESS (1.797s)
[242.971204] Subtest psr-sprite-plane-onoff: SUCCESS (1.799s)
[243.893642] [127/161] (800s left) kms_psr (psr-primary-mmap-gtt)
[243.969457] Starting subtest: psr-primary-mmap-gtt
[243.970261] Starting dynamic subtest: eDP-1
[245.718458] Dynamic subtest eDP-1: SUCCESS (1.745s)
[245.719992] Subtest psr-primary-mmap-gtt: SUCCESS (1.747s)
[246.585645] [128/161] (797s left) kms_setmode (basic-clone-single-crtc)
[246.633658] Starting subtest: basic-clone-single-crtc
[246.635994] Subtest basic-clone-single-crtc: SKIP (0.000s)
[246.704342] [129/161] (797s left) i915_pm_rps (basic-api)
[246.752486] Starting subtest: basic-api
[246.754198] Subtest basic-api: SKIP (0.000s)
[246.846184] [130/161] (797s left) prime_self_import (basic-llseek-bad)
[246.888333] Starting subtest: basic-llseek-bad
[246.889921] Subtest basic-llseek-bad: SUCCESS (0.002s)
[246.981694] [131/161] (797s left) prime_self_import (basic-llseek-size)
[247.025186] Starting subtest: basic-llseek-size
[247.030883] Subtest basic-llseek-size: SUCCESS (0.006s)
[247.119775] [132/161] (797s left) prime_self_import (basic-with_fd_dup)
[247.161535] Starting subtest: basic-with_fd_dup
[247.166236] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[247.258692] [133/161] (797s left) prime_self_import (basic-with_one_bo)
[247.299431] Starting subtest: basic-with_one_bo
[247.306369] Subtest basic-with_one_bo: SUCCESS (0.004s)
[247.367373] [134/161] (796s left) prime_self_import (basic-with_one_bo_two_files)
[247.410875] Starting subtest: basic-with_one_bo_two_files
[247.414227] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[247.506932] [135/161] (796s left) prime_self_import (basic-with_two_bos)
[247.549502] Starting subtest: basic-with_two_bos
[247.552816] Subtest basic-with_two_bos: SUCCESS (0.003s)
[247.644437] [136/161] (796s left) prime_vgem (basic-fence-flip)
[247.703277] Starting subtest: basic-fence-flip
[247.971582] Subtest basic-fence-flip: SUCCESS (0.267s)
[248.078312] [137/161] (796s left) prime_vgem (basic-fence-mmap)
[248.148084] Starting subtest: basic-fence-mmap
[248.174457] Subtest basic-fence-mmap: SUCCESS (0.026s)
[248.252960] [138/161] (796s left) prime_vgem (basic-fence-read)
[248.322244] Starting subtest: basic-fence-read
[248.333053] Subtest basic-fence-read: SKIP (0.010s)
[248.418143] [139/161] (796s left) prime_vgem (basic-gtt)
[248.488992] Starting subtest: basic-gtt
[248.503044] Subtest basic-gtt: SUCCESS (0.015s)
[248.587150] [140/161] (796s left) prime_vgem (basic-read)
[248.657455] Starting subtest: basic-read
[248.664404] Subtest basic-read: SKIP (0.008s)
[248.761870] [141/161] (795s left) prime_vgem (basic-write)
[248.845054] Starting subtest: basic-write
[248.853401] Subtest basic-write: SKIP (0.008s)
[248.955818] [142/161] (795s left) vgem_basic (setversion)
[249.006845] Starting subtest: setversion
[249.008901] Subtest setversion: SUCCESS (0.000s)
[249.070915] [143/161] (795s left) vgem_basic (create)
[249.125169] Starting subtest: create
[249.126103] Subtest create: SUCCESS (0.001s)
[249.181308] [144/161] (795s left) vgem_basic (debugfs)
[249.238884] Starting subtest: debugfs
[249.240186] Subtest debugfs: SUCCESS (0.001s)
[249.304144] [145/161] (795s left) vgem_basic (dmabuf-export)
[249.355670] Starting subtest: dmabuf-export
[249.373669] Subtest dmabuf-export: SUCCESS (0.017s)
[249.470464] [146/161] (795s left) vgem_basic (dmabuf-fence)
[249.523195] Starting subtest: dmabuf-fence
[249.524371] Subtest dmabuf-fence: SUCCESS (0.001s)
[249.587152] [147/161] (795s left) vgem_basic (dmabuf-fence-before)
[249.637350] Starting subtest: dmabuf-fence-before
[249.638406] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[249.701765] [148/161] (795s left) vgem_basic (dmabuf-mmap)
[249.757679] Starting subtest: dmabuf-mmap
[249.774139] Subtest dmabuf-mmap: SUCCESS (0.020s)
[249.827156] [149/161] (795s left) vgem_basic (mmap)
[249.879308] Starting subtest: mmap
[249.889953] Subtest mmap: SUCCESS (0.011s)
[249.944166] [150/161] (795s left) vgem_basic (second-client)
[249.998346] Starting subtest: second-client
[250.013865] Subtest second-client: SUCCESS (0.016s)
[250.076523] [151/161] (795s left) vgem_basic (sysfs)
[250.128452] Starting subtest: sysfs
[250.129667] Subtest sysfs: SUCCESS (0.001s)
[250.190925] [152/161] (794s left) core_hotunplug (unbind-rebind)
[250.284884] Starting subtest: unbind-rebind
[254.826540] Subtest unbind-rebind: SUCCESS (4.541s)
[254.870418] [153/161] (790s left) vgem_basic (unload)
[254.915345] Starting subtest: unload
[283.976500] Subtest unload: SUCCESS (29.025s)
[284.061270] [154/161] (761s left) i915_module_load (reload)
[284.105984] Starting subtest: reload
[288.272963] Subtest reload: SUCCESS (4.165s)
[288.319442] [155/161] (756s left) gem_lmem_swapping (basic)
[288.370066] Subtest basic: SKIP (0.000s)
[288.422496] [156/161] (756s left) gem_lmem_swapping (parallel-random-engines)
[288.469611] Subtest parallel-random-engines: SKIP (0.000s)
[288.540780] [157/161] (756s left) gem_lmem_swapping (random-engines)
[288.602943] Subtest random-engines: SKIP (0.000s)
[288.653689] [158/161] (756s left) gem_lmem_swapping (verify-random)
[288.700814] Subtest verify-random: SKIP (0.000s)
[288.747414] [159/161] (756s left) i915_pm_rpm (module-reload)
[291.006384] Starting subtest: module-reload
[302.880350] Subtest module-reload: SUCCESS (11.863s)
[302.908799] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[302.910364] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[302.914068] [160/161] (742s left) i915_selftest (live)
[302.962251] Starting subtest: live
[302.963106] Starting dynamic subtest: sanitycheck
[305.233073] Dynamic subtest sanitycheck: SUCCESS (2.261s)
[305.244539] Starting dynamic subtest: uncore
[307.426855] Dynamic subtest uncore: SUCCESS (2.190s)
[307.437601] Starting dynamic subtest: workarounds
[310.419821] Dynamic subtest workarounds: SUCCESS (2.989s)
[310.430123] Starting dynamic subtest: gt_engines
[313.133736] Dynamic subtest gt_engines: SUCCESS (2.710s)
[313.144420] Starting dynamic subtest: gt_timelines
[323.301715] Dynamic subtest gt_timelines: SUCCESS (10.164s)
[323.313584] Starting dynamic subtest: gt_contexts
[325.748518] Dynamic subtest gt_contexts: SUCCESS (2.444s)
[325.757875] Starting dynamic subtest: gt_lrc
[330.414403] Dynamic subtest gt_lrc: SUCCESS (4.662s)
[330.427917] Starting dynamic subtest: gt_mocs
[333.175911] Dynamic subtest gt_mocs: SUCCESS (2.758s)
[333.187036] Starting dynamic subtest: gt_pm
[337.858973] Dynamic subtest gt_pm: SUCCESS (4.679s)
[337.870490] Starting dynamic subtest: gt_heartbeat
[340.157952] Dynamic subtest gt_heartbeat: SUCCESS (2.295s)
[340.168997] Starting dynamic subtest: gt_tlb
[343.584887] Dynamic subtest gt_tlb: SUCCESS (3.423s)
[343.595989] Starting dynamic subtest: requests
[352.638209] Dynamic subtest requests: SUCCESS (9.050s)
[352.649109] Starting dynamic subtest: migrate
[357.371698] Dynamic subtest migrate: SUCCESS (4.730s)
[357.382328] Starting dynamic subtest: active
[359.628989] Dynamic subtest active: SUCCESS (2.253s)
[359.639955] Starting dynamic subtest: objects
[362.589387] Dynamic subtest objects: SUCCESS (2.957s)
[362.597766] Starting dynamic subtest: mman
[368.339061] Dynamic subtest mman: SUCCESS (5.745s)
[368.352534] Starting dynamic subtest: dmabuf
[370.789094] Dynamic subtest dmabuf: SUCCESS (2.446s)
[370.801500] Starting dynamic subtest: vma
[373.122148] Dynamic subtest vma: SUCCESS (2.329s)
[373.135887] Starting dynamic subtest: coherency
[380.627795] Dynamic subtest coherency: SUCCESS (7.502s)
[380.637099] Starting dynamic subtest: gtt
[390.603101] Dynamic subtest gtt: SUCCESS (9.971s)
[390.616469] Starting dynamic subtest: gem
[393.118929] Dynamic subtest gem: SUCCESS (2.512s)
[393.132926] Starting dynamic subtest: evict
[397.032291] Dynamic subtest evict: SUCCESS (3.910s)
[397.042822] Starting dynamic subtest: hugepages
[406.019048] Dynamic subtest hugepages: SUCCESS (8.983s)
[406.029928] Starting dynamic subtest: gem_contexts
[421.367179] Dynamic subtest gem_contexts: SUCCESS (15.344s)
[421.378825] Starting dynamic subtest: client
[423.863496] Dynamic subtest client: SUCCESS (2.492s)
[423.875933] Starting dynamic subtest: gem_migrate
[426.233732] Dynamic subtest gem_migrate: SUCCESS (2.374s)
[426.254976] Starting dynamic subtest: reset
[431.012033] Dynamic subtest reset: SUCCESS (4.766s)
[431.023439] Starting dynamic subtest: memory_region
[433.405951] Dynamic subtest memory_region: SUCCESS (2.390s)
[433.417107] Starting dynamic subtest: hangcheck
[450.162219] Dynamic subtest hangcheck: SUCCESS (16.752s)
[450.173354] Starting dynamic subtest: execlists
[452.501049] Dynamic subtest execlists: SUCCESS (2.335s)
[452.514031] Starting dynamic subtest: ring_submission
[454.869888] Dynamic subtest ring_submission: SUCCESS (2.365s)
[454.880796] Starting dynamic subtest: perf
[457.299964] Dynamic subtest perf: SUCCESS (2.426s)
[457.320487] Starting dynamic subtest: slpc
[464.671776] Dynamic subtest slpc: SUCCESS (7.368s)
[464.682485] Starting dynamic subtest: guc
[467.804877] Dynamic subtest guc: SUCCESS (3.130s)
[467.817224] Starting dynamic subtest: guc_multi_lrc
[470.065910] Dynamic subtest guc_multi_lrc: SUCCESS (2.257s)
[470.077625] Starting dynamic subtest: guc_hang
[473.109046] Dynamic subtest guc_hang: SUCCESS (3.039s)
[473.120530] Starting dynamic subtest: late_gt_pm
[475.428943] Dynamic subtest late_gt_pm: SUCCESS (2.316s)
[475.430519] Subtest live: SUCCESS (172.450s)
[475.489137] [161/161] (570s left) dmabuf (all-tests)
[475.538932] Starting subtest: all-tests
[475.539872] Starting dynamic subtest: sanitycheck
[475.610351] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[475.640706] Starting dynamic subtest: dma_fence
[475.895167] Dynamic subtest dma_fence: SUCCESS (0.272s)
[475.910996] Starting dynamic subtest: dma_fence_chain
[486.676710] Dynamic subtest dma_fence_chain: SUCCESS (10.777s)
[486.696239] Starting dynamic subtest: dma_fence_unwrap
[486.764375] Dynamic subtest dma_fence_unwrap: SUCCESS (0.093s)
[486.790906] Starting dynamic subtest: dma_resv
[486.866531] Dynamic subtest dma_resv: SUCCESS (0.099s)
[486.868103] Subtest all-tests: SUCCESS (11.328s)
[486.917326] Closing watchdogs
Done.