[93.796831] Initializing watchdogs
[93.797690]   /dev/watchdog0
[94.070653] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[94.141120] [001/161] (960s left) i915_module_load (load)
[94.731252] Starting subtest: load
[105.926101] Subtest load: SUCCESS (11.198s)
[106.248060] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[106.264705] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[106.285479] [002/161] (948s left) core_auth (basic-auth)
[106.856253] Starting subtest: basic-auth
[106.869590] Subtest basic-auth: SUCCESS (0.009s)
[107.288381] [003/161] (948s left) debugfs_test (read_all_entries)
[107.710736] Starting subtest: read_all_entries
[109.195065] Subtest read_all_entries: SUCCESS (1.485s)
[109.718453] [004/161] (945s left) debugfs_test (basic-hwmon)
[110.120656] Starting subtest: basic-hwmon
[110.126173] Subtest basic-hwmon: SKIP (0.000s)
[110.675485] [005/161] (945s left) debugfs_test (sysfs)
[111.081328] Starting subtest: sysfs
[111.567245] Subtest sysfs: SUCCESS (0.485s)
[112.074672] [006/161] (944s left) fbdev (eof)
[112.466277] Starting subtest: eof
[112.472620] Subtest eof: SUCCESS (0.005s)
[112.890234] [007/161] (943s left) fbdev (info)
[113.248517] Starting subtest: info
[113.251801] Subtest info: SUCCESS (0.000s)
[113.700845] [008/161] (943s left) fbdev (nullptr)
[114.068876] Starting subtest: nullptr
[114.071902] Subtest nullptr: SUCCESS (0.000s)
[114.510543] [009/161] (942s left) fbdev (read)
[114.886368] Starting subtest: read
[128.587219] Subtest read: SUCCESS (13.694s)
[129.019871] [010/161] (928s left) fbdev (write)
[129.407613] Starting subtest: write
[136.537105] Subtest write: SUCCESS (7.124s)
[137.001794] [011/161] (921s left) gem_basic (bad-close)
[137.368899] Starting subtest: bad-close
[137.374802] Subtest bad-close: SUCCESS (0.000s)
[137.779906] [012/161] (920s left) gem_basic (create-close)
[138.150946] Starting subtest: create-close
[138.157175] Subtest create-close: SUCCESS (0.001s)
[138.555755] [013/161] (920s left) gem_basic (create-fd-close)
[138.930741] Starting subtest: create-fd-close
[138.936604] Subtest create-fd-close: SUCCESS (0.001s)
[139.336639] [014/161] (919s left) gem_busy (busy@all-engines)
[139.803158] Starting subtest: busy
[139.806478] Starting dynamic subtest: all-engines
[140.162550] Dynamic subtest all-engines: SUCCESS (0.349s)
[140.165713] Subtest busy: SUCCESS (0.353s)
[140.987920] [015/161] (918s left) gem_close_race (basic-process)
[141.463700] Starting subtest: basic-process
[141.614117] Subtest basic-process: SUCCESS (0.151s)
[142.172355] [016/161] (917s left) gem_close_race (basic-threads)
[142.638104] Starting subtest: basic-threads
[144.070596] Subtest basic-threads: SUCCESS (1.426s)
[144.608833] [017/161] (915s left) gem_ctx_create (basic)
[145.079245] Starting subtest: basic
[145.082524] Subtest basic: SUCCESS (0.001s)
[145.628330] [018/161] (914s left) gem_ctx_create (basic-files)
[146.088120] Starting subtest: basic-files
[148.202430] Subtest basic-files: SUCCESS (2.116s)
[148.827793] [019/161] (911s left) gem_ctx_exec (basic)
[149.215473] Starting subtest: basic
[149.233934] Subtest basic: SUCCESS (0.021s)
[149.683366] [020/161] (911s left) gem_exec_basic (basic)
[150.109478] Starting subtest: basic
[150.112431] Starting dynamic subtest: rcs0-smem
[150.120844] Dynamic subtest rcs0-smem: SUCCESS (0.009s)
[150.179904] Starting dynamic subtest: bcs0-smem
[150.182998] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[150.240554] Starting dynamic subtest: vcs0-smem
[150.243534] Dynamic subtest vcs0-smem: SUCCESS (0.004s)
[150.309568] Starting dynamic subtest: vecs0-smem
[150.312870] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[150.315928] Subtest basic: SUCCESS (0.029s)
[150.697598] [021/161] (910s left) gem_exec_create (basic)
[151.162588] Starting subtest: basic
[151.165715] Starting dynamic subtest: smem
[153.376248] Dynamic subtest smem: SUCCESS (2.217s)
[153.380526] Subtest basic: SUCCESS (2.219s)
[153.940613] [022/161] (907s left) gem_exec_fence (basic-busy)
[154.602833] Starting subtest: basic-busy
[154.606442] Starting dynamic subtest: rcs0
[154.690824] Dynamic subtest rcs0: SUCCESS (0.086s)
[154.752941] Starting dynamic subtest: bcs0
[154.760974] Dynamic subtest bcs0: SUCCESS (0.064s)
[154.820854] Starting dynamic subtest: vcs0
[154.827161] Dynamic subtest vcs0: SUCCESS (0.060s)
[154.887261] Starting dynamic subtest: vecs0
[154.895153] Dynamic subtest vecs0: SUCCESS (0.062s)
[154.898124] Subtest basic-busy: SUCCESS (0.279s)
[156.321443] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[156.344470] [023/161] (905s left) gem_exec_fence (basic-wait)
[157.001061] Starting subtest: basic-wait
[157.004309] Starting dynamic subtest: rcs0
[157.108246] Dynamic subtest rcs0: SUCCESS (0.106s)
[157.169377] Starting dynamic subtest: bcs0
[157.172488] Dynamic subtest bcs0: SUCCESS (0.060s)
[157.234360] Starting dynamic subtest: vcs0
[157.237629] Dynamic subtest vcs0: SUCCESS (0.059s)
[157.299156] Starting dynamic subtest: vecs0
[157.302145] Dynamic subtest vecs0: SUCCESS (0.067s)
[157.305949] Subtest basic-wait: SUCCESS (0.299s)
[158.549890] [024/161] (903s left) gem_exec_fence (basic-await)
[159.209254] Starting subtest: basic-await
[159.212567] Starting dynamic subtest: rcs0
[159.554087] Dynamic subtest rcs0: SUCCESS (0.344s)
[159.615989] Starting dynamic subtest: bcs0
[159.860674] Dynamic subtest bcs0: SUCCESS (0.303s)
[159.926345] Starting dynamic subtest: vcs0
[160.160648] Dynamic subtest vcs0: SUCCESS (0.299s)
[160.227325] Starting dynamic subtest: vecs0
[160.467759] Dynamic subtest vecs0: SUCCESS (0.304s)
[160.471279] Subtest basic-await: SUCCESS (1.260s)
[161.692737] [025/161] (901s left) gem_exec_fence (nb-await)
[162.356381] Starting subtest: nb-await
[162.359758] Starting dynamic subtest: rcs0
[162.462770] Dynamic subtest rcs0: SUCCESS (0.109s)
[162.525699] Starting dynamic subtest: bcs0
[162.551757] Dynamic subtest bcs0: SUCCESS (0.088s)
[162.613884] Starting dynamic subtest: vcs0
[162.644349] Dynamic subtest vcs0: SUCCESS (0.088s)
[162.706329] Starting dynamic subtest: vecs0
[162.731948] Dynamic subtest vecs0: SUCCESS (0.086s)
[162.735092] Subtest nb-await: SUCCESS (0.380s)
[164.018520] [026/161] (899s left) gem_exec_gttfill (basic)
[164.483680] Starting subtest: basic
[202.735401] Subtest basic: SUCCESS (38.220s)
[203.323387] [027/161] (860s left) gem_exec_parallel (engines)
[203.959801] Starting subtest: engines
[203.966147] Starting dynamic subtest: basic
[210.563172] Dynamic subtest basic: SUCCESS (6.609s)
[210.634165] Starting dynamic subtest: contexts
[220.331340] Dynamic subtest contexts: SUCCESS (9.756s)
[220.401429] Starting dynamic subtest: fds
[233.366514] Dynamic subtest fds: SUCCESS (13.033s)
[233.440453] Starting dynamic subtest: userptr
[239.097358] Dynamic subtest userptr: SUCCESS (5.738s)
[239.100964] Subtest engines: SUCCESS (35.144s)
[239.718519] [028/161] (824s left) gem_exec_store (basic)
[240.180954] Starting subtest: basic
[240.321269] Subtest basic: SUCCESS (0.142s)
[240.916554] [029/161] (823s left) gem_flink_basic (bad-flink)
[241.284913] Starting subtest: bad-flink
[241.288459] Subtest bad-flink: SUCCESS (0.000s)
[241.760669] [030/161] (822s left) gem_flink_basic (bad-open)
[242.133853] Starting subtest: bad-open
[242.137172] Subtest bad-open: SUCCESS (0.000s)
[242.586701] [031/161] (822s left) gem_flink_basic (basic)
[242.964401] Starting subtest: basic
[242.967756] Subtest basic: SUCCESS (0.001s)
[243.430464] [032/161] (821s left) gem_flink_basic (double-flink)
[243.802948] Starting subtest: double-flink
[243.806392] Subtest double-flink: SUCCESS (0.001s)
[244.276445] [033/161] (821s left) gem_flink_basic (flink-lifetime)
[244.644981] Starting subtest: flink-lifetime
[244.652139] Subtest flink-lifetime: SUCCESS (0.009s)
[245.136344] [034/161] (820s left) gem_huc_copy (huc-copy)
[245.540822] Starting subtest: huc-copy
[245.560814] Subtest huc-copy: SUCCESS (0.020s)
[246.075191] [035/161] (820s left) gem_linear_blits (basic)
[247.119693] Starting subtest: basic
[247.176926] Subtest basic: SUCCESS (0.059s)
[247.719305] [036/161] (819s left) gem_mmap (basic)
[248.272765] Starting subtest: basic
[248.292735] Subtest basic: SUCCESS (0.003s)
[248.738343] [037/161] (818s left) gem_mmap_gtt (basic)
[249.117906] Starting subtest: basic
[249.121511] Subtest basic: SUCCESS (0.005s)
[249.582898] [038/161] (818s left) gem_render_linear_blits (basic)
[249.999283] Starting subtest: basic
[250.198588] Subtest basic: SUCCESS (0.203s)
[250.647394] [039/161] (817s left) gem_render_tiled_blits (basic)
[251.057291] Starting subtest: basic
[251.353053] Subtest basic: SUCCESS (0.299s)
[251.809312] [040/161] (816s left) gem_ringfill (basic-all)
[252.682127] Starting subtest: basic-all
[254.169795] Subtest basic-all: SUCCESS (1.481s)
[254.625464] [041/161] (814s left) gem_softpin (allocator-basic)
[255.034391] Starting subtest: allocator-basic
[255.703620] Subtest allocator-basic: SUCCESS (0.664s)
[256.251640] [042/161] (812s left) gem_softpin (allocator-basic-reserve)
[256.679741] Starting subtest: allocator-basic-reserve
[257.399120] Subtest allocator-basic-reserve: SUCCESS (0.709s)
[257.940738] [043/161] (811s left) gem_softpin (safe-alignment)
[258.344349] Starting subtest: safe-alignment
[258.426475] Subtest safe-alignment: SUCCESS (0.081s)
[258.918564] [044/161] (810s left) gem_sync (basic-all)
[259.379551] Starting subtest: basic-all
[264.599309] Subtest basic-all: SUCCESS (5.220s)
[265.192865] [045/161] (805s left) gem_sync (basic-each)
[265.650652] Starting subtest: basic-each
[269.245645] Subtest basic-each: SUCCESS (3.595s)
[269.850686] [046/161] (800s left) gem_tiled_blits (basic)
[270.785889] Starting subtest: basic
[270.913320] Subtest basic: SUCCESS (0.128s)
[271.438897] [047/161] (799s left) gem_tiled_fence_blits (basic)
[272.650423] Starting subtest: basic
[272.717158] Subtest basic: SUCCESS (0.076s)
[273.288693] [048/161] (798s left) gem_tiled_pread_basic
[274.297323] [049/161] (797s left) gem_wait (busy@all-engines)
[274.822995] Starting subtest: busy
[274.826127] Starting dynamic subtest: all-engines
[275.407172] Dynamic subtest all-engines: SUCCESS (0.591s)
[275.410282] Subtest busy: SUCCESS (0.594s)
[276.129637] [050/161] (796s left) gem_wait (wait@all-engines)
[276.641993] Starting subtest: wait
[276.644878] Starting dynamic subtest: all-engines
[277.739777] Dynamic subtest all-engines: SUCCESS (1.105s)
[277.743071] Subtest wait: SUCCESS (1.107s)
[278.460512] [051/161] (794s left) i915_getparams_basic (basic-eu-total)
[278.824990] Starting subtest: basic-eu-total
[278.830277] Subtest basic-eu-total: SUCCESS (0.000s)
[279.280401] [052/161] (793s left) i915_getparams_basic (basic-subslice-total)
[279.650472] Starting subtest: basic-subslice-total
[279.656356] Subtest basic-subslice-total: SUCCESS (0.000s)
[280.105473] [053/161] (793s left) i915_hangman (error-state-basic)
[280.556739] Starting subtest: error-state-basic
[281.386134] Subtest error-state-basic: SUCCESS (0.828s)
[281.880207] [054/161] (791s left) i915_pciid
[282.704627] [055/161] (791s left) kms_addfb_basic (addfb25-4-tiled)
[283.212378] Starting subtest: addfb25-4-tiled
[283.215879] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[283.689691] [056/161] (790s left) kms_addfb_basic (addfb25-bad-modifier)
[284.170833] Starting subtest: addfb25-bad-modifier
[284.174412] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[284.637206] [057/161] (790s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[285.119726] Starting subtest: addfb25-framebuffer-vs-set-tiling
[285.122923] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s)
[285.596832] [058/161] (789s left) kms_addfb_basic (addfb25-modifier-no-flag)
[286.065587] Starting subtest: addfb25-modifier-no-flag
[286.068618] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[286.556409] [059/161] (788s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[287.047940] Starting subtest: addfb25-x-tiled-legacy
[287.050975] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[287.531275] [060/161] (788s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[288.013422] Starting subtest: addfb25-x-tiled-mismatch-legacy
[288.016650] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[288.488891] [061/161] (787s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[288.962595] Starting subtest: addfb25-yf-tiled-legacy
[288.966141] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[289.434666] [062/161] (787s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[289.913440] Starting subtest: addfb25-y-tiled-legacy
[289.916909] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[290.395676] [063/161] (786s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[290.878781] Starting subtest: addfb25-y-tiled-small-legacy
[290.882124] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[291.370911] [064/161] (786s left) kms_addfb_basic (bad-pitch-0)
[291.743519] Starting subtest: bad-pitch-0
[291.746526] Subtest bad-pitch-0: SUCCESS (0.000s)
[292.316682] [065/161] (785s left) kms_addfb_basic (bad-pitch-1024)
[292.689229] Starting subtest: bad-pitch-1024
[292.691906] Subtest bad-pitch-1024: SUCCESS (0.000s)
[293.262901] [066/161] (784s left) kms_addfb_basic (bad-pitch-128)
[293.632375] Starting subtest: bad-pitch-128
[293.635351] Subtest bad-pitch-128: SUCCESS (0.000s)
[294.205472] [067/161] (784s left) kms_addfb_basic (bad-pitch-256)
[294.580201] Starting subtest: bad-pitch-256
[294.582933] Subtest bad-pitch-256: SUCCESS (0.000s)
[295.161289] [068/161] (783s left) kms_addfb_basic (bad-pitch-32)
[295.537385] Starting subtest: bad-pitch-32
[295.540510] Subtest bad-pitch-32: SUCCESS (0.000s)
[296.109899] [069/161] (783s left) kms_addfb_basic (bad-pitch-63)
[296.508686] Starting subtest: bad-pitch-63
[296.511643] Subtest bad-pitch-63: SUCCESS (0.000s)
[297.090463] [070/161] (782s left) kms_addfb_basic (bad-pitch-65536)
[297.465862] Starting subtest: bad-pitch-65536
[297.469436] Subtest bad-pitch-65536: SUCCESS (0.002s)
[298.035412] [071/161] (781s left) kms_addfb_basic (bad-pitch-999)
[298.410406] Starting subtest: bad-pitch-999
[298.413379] Subtest bad-pitch-999: SUCCESS (0.000s)
[298.986693] [072/161] (781s left) kms_addfb_basic (basic)
[299.353828] Starting subtest: basic
[299.357522] Subtest basic: SUCCESS (0.000s)
[299.933902] [073/161] (780s left) kms_addfb_basic (basic-x-tiled-legacy)
[300.311932] Starting subtest: basic-x-tiled-legacy
[300.314954] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[300.880621] [074/161] (780s left) kms_addfb_basic (basic-y-tiled-legacy)
[301.255340] Starting subtest: basic-y-tiled-legacy
[301.258378] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[301.854728] [075/161] (779s left) kms_addfb_basic (bo-too-small)
[302.337487] Starting subtest: bo-too-small
[302.341130] Subtest bo-too-small: SUCCESS (0.002s)
[302.808664] [076/161] (779s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[303.287996] Starting subtest: bo-too-small-due-to-tiling
[303.291488] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[303.759244] [077/161] (778s left) kms_addfb_basic (clobberred-modifier)
[304.131944] Starting subtest: clobberred-modifier
[304.134999] Subtest clobberred-modifier: SUCCESS (0.001s)
[304.704847] [078/161] (777s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[305.083713] Starting subtest: framebuffer-vs-set-tiling
[305.086675] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[305.664911] [079/161] (777s left) kms_addfb_basic (invalid-get-prop)
[306.038045] Starting subtest: invalid-get-prop
[306.040874] Subtest invalid-get-prop: SUCCESS (0.000s)
[306.601810] [080/161] (776s left) kms_addfb_basic (invalid-get-prop-any)
[306.970239] Starting subtest: invalid-get-prop-any
[306.973286] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[307.541596] [081/161] (776s left) kms_addfb_basic (invalid-set-prop)
[307.917166] Starting subtest: invalid-set-prop
[307.919924] Subtest invalid-set-prop: SUCCESS (0.000s)
[308.488483] [082/161] (775s left) kms_addfb_basic (invalid-set-prop-any)
[308.864837] Starting subtest: invalid-set-prop-any
[308.867664] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[309.439847] [083/161] (775s left) kms_addfb_basic (no-handle)
[309.814965] Starting subtest: no-handle
[309.817966] Subtest no-handle: SUCCESS (0.000s)
[310.391892] [084/161] (774s left) kms_addfb_basic (size-max)
[310.869655] Starting subtest: size-max
[310.873199] Subtest size-max: SUCCESS (0.001s)
[311.355481] [085/161] (773s left) kms_addfb_basic (small-bo)
[311.830987] Starting subtest: small-bo
[311.834384] Subtest small-bo: SUCCESS (0.000s)
[312.300670] [086/161] (773s left) kms_addfb_basic (tile-pitch-mismatch)
[312.682930] Starting subtest: tile-pitch-mismatch
[312.685695] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[313.258703] [087/161] (772s left) kms_addfb_basic (too-high)
[313.733379] Starting subtest: too-high
[313.737541] Subtest too-high: SUCCESS (0.006s)
[314.209406] [088/161] (772s left) kms_addfb_basic (too-wide)
[314.686746] Starting subtest: too-wide
[314.689774] Subtest too-wide: SUCCESS (0.000s)
[315.152113] [089/161] (771s left) kms_addfb_basic (unused-handle)
[315.526818] Starting subtest: unused-handle
[315.530240] Subtest unused-handle: SUCCESS (0.000s)
[316.101503] [090/161] (771s left) kms_addfb_basic (unused-modifier)
[316.482290] Starting subtest: unused-modifier
[316.491130] Subtest unused-modifier: SUCCESS (0.000s)
[317.089882] [091/161] (770s left) kms_addfb_basic (unused-offsets)
[317.464216] Starting subtest: unused-offsets
[317.467198] Subtest unused-offsets: SUCCESS (0.001s)
[318.036428] [092/161] (769s left) kms_addfb_basic (unused-pitches)
[318.407645] Starting subtest: unused-pitches
[318.410579] Subtest unused-pitches: SUCCESS (0.000s)
[318.985888] [093/161] (769s left) kms_busy (basic)
[319.492067] Starting subtest: basic
[319.497181] Starting dynamic subtest: flip
[321.786252] Dynamic subtest flip: SUCCESS (2.288s)
[321.870870] Starting dynamic subtest: modeset
[327.020242] Dynamic subtest modeset: SUCCESS (5.224s)
[327.022775] Subtest basic: SUCCESS (7.523s)
[328.336882] [094/161] (760s left) kms_prop_blob (basic)
[328.708715] Starting subtest: basic
[328.711995] Subtest basic: SUCCESS (0.000s)
[329.163571] [095/161] (759s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[329.793078] Starting subtest: basic-busy-flip-before-cursor-atomic
[329.798678] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[330.388688] [096/161] (759s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[330.999617] Starting subtest: basic-busy-flip-before-cursor-legacy
[331.005327] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[331.607716] [097/161] (758s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[332.226792] Starting subtest: basic-flip-after-cursor-atomic
[333.842255] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.616s)
[335.120694] [098/161] (755s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[335.762276] Starting subtest: basic-flip-after-cursor-legacy
[337.386809] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.625s)
[338.647404] [099/161] (751s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[339.258322] Starting subtest: basic-flip-after-cursor-varying-size
[340.873048] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.613s)
[342.187976] [100/161] (748s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[342.817209] Starting subtest: basic-flip-before-cursor-atomic
[344.425592] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.606s)
[345.719706] [101/161] (745s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[346.334229] Starting subtest: basic-flip-before-cursor-legacy
[347.961529] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.627s)
[349.246276] [102/161] (742s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[349.858868] Starting subtest: basic-flip-before-cursor-varying-size
[351.467672] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.610s)
[352.781199] [103/161] (739s left) kms_dsc (dsc-basic)
[353.263143] Starting subtest: dsc-basic
[353.276255] Subtest dsc-basic: SKIP (0.003s)
[353.727469] [104/161] (738s left) kms_flip (basic-flip-vs-dpms)
[354.209351] Starting subtest: basic-flip-vs-dpms
[354.222856] Starting dynamic subtest: A-eDP1
[358.041867] Dynamic subtest A-eDP1: SUCCESS (3.822s)
[358.128245] Starting dynamic subtest: B-eDP1
[361.331646] Dynamic subtest B-eDP1: SUCCESS (3.282s)
[361.414495] Starting dynamic subtest: C-eDP1
[364.620621] Dynamic subtest C-eDP1: SUCCESS (3.281s)
[364.627102] Subtest basic-flip-vs-dpms: SUCCESS (10.417s)
[365.901685] [105/161] (726s left) kms_flip (basic-flip-vs-modeset)
[366.381567] Starting subtest: basic-flip-vs-modeset
[366.392239] Starting dynamic subtest: A-eDP1
[370.747934] Dynamic subtest A-eDP1: SUCCESS (4.350s)
[370.835898] Starting dynamic subtest: B-eDP1
[374.284945] Dynamic subtest B-eDP1: SUCCESS (3.535s)
[374.366347] Starting dynamic subtest: C-eDP1
[377.400317] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[377.406920] Subtest basic-flip-vs-modeset: SUCCESS (11.028s)
[378.605364] [106/161] (714s left) kms_flip (basic-flip-vs-wf_vblank)
[379.093959] Starting subtest: basic-flip-vs-wf_vblank
[379.104586] Starting dynamic subtest: A-eDP1
[382.199113] Dynamic subtest A-eDP1: SUCCESS (3.094s)
[382.283791] Starting dynamic subtest: B-eDP1
[385.198622] Dynamic subtest B-eDP1: SUCCESS (2.994s)
[385.286649] Starting dynamic subtest: C-eDP1
[388.353213] Dynamic subtest C-eDP1: SUCCESS (3.145s)
[388.366914] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.276s)
[390.336356] [107/161] (703s left) kms_flip (basic-plain-flip)
[390.814448] Starting subtest: basic-plain-flip
[390.825945] Starting dynamic subtest: A-eDP1
[393.623089] Dynamic subtest A-eDP1: SUCCESS (2.797s)
[393.709049] Starting dynamic subtest: B-eDP1
[396.414388] Dynamic subtest B-eDP1: SUCCESS (2.785s)
[396.502622] Starting dynamic subtest: C-eDP1
[399.097929] Dynamic subtest C-eDP1: SUCCESS (2.676s)
[399.106599] Subtest basic-plain-flip: SUCCESS (8.294s)
[401.217406] [108/161] (692s left) kms_force_connector_basic (force-connector-state)
[401.621169] Starting subtest: force-connector-state
[402.486338] Subtest force-connector-state: SUCCESS (0.868s)
[404.229468] [109/161] (690s left) kms_force_connector_basic (force-edid)
[404.628381] Starting subtest: force-edid
[404.727092] Subtest force-edid: SUCCESS (0.097s)
[405.368616] [110/161] (689s left) kms_force_connector_basic (force-load-detect)
[405.764661] Starting subtest: force-load-detect
[405.771890] Subtest force-load-detect: SKIP (0.000s)
[406.344847] [111/161] (688s left) kms_force_connector_basic (prune-stale-modes)
[406.771285] Starting subtest: prune-stale-modes
[406.893760] Subtest prune-stale-modes: SUCCESS (0.121s)
[407.531468] [112/161] (688s left) kms_frontbuffer_tracking (basic)
[408.044810] Starting subtest: basic
[435.544814] Subtest basic: SUCCESS (27.504s)
[436.135267] [113/161] (659s left) kms_hdmi_inject (inject-audio)
[436.975414] Starting subtest: inject-audio
[437.510107] Subtest inject-audio: SUCCESS (0.530s)
[438.616342] [114/161] (657s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[439.103115] Starting subtest: compare-crc-sanitycheck-xr24
[439.107779] Starting dynamic subtest: pipe-A-eDP-1
[440.907828] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s)
[441.005824] Starting dynamic subtest: pipe-B-eDP-1
[443.133404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.206s)
[443.222194] Starting dynamic subtest: pipe-C-eDP-1
[446.135437] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.994s)
[446.138552] Subtest compare-crc-sanitycheck-xr24: SUCCESS (7.038s)
[447.221607] [115/161] (649s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[447.712374] Starting subtest: compare-crc-sanitycheck-nv12
[447.718099] Starting dynamic subtest: pipe-A-eDP-1
[450.686627] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.966s)
[450.780163] Starting dynamic subtest: pipe-B-eDP-1
[454.084863] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.382s)
[454.175098] Starting dynamic subtest: pipe-C-eDP-1
[457.392189] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.288s)
[457.402571] Subtest compare-crc-sanitycheck-nv12: SUCCESS (9.677s)
[458.663636] [116/161] (638s left) kms_pipe_crc_basic (hang-read-crc)
[459.150326] Starting subtest: hang-read-crc
[459.154599] Starting dynamic subtest: pipe-A-eDP-1
[464.383602] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.228s)
[464.478625] Starting dynamic subtest: pipe-B-eDP-1
[470.077555] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.677s)
[470.170052] Starting dynamic subtest: pipe-C-eDP-1
[475.527743] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.434s)
[475.530643] Subtest hang-read-crc: SUCCESS (16.383s)
[476.775336] [117/161] (620s left) kms_pipe_crc_basic (nonblocking-crc)
[477.265705] Starting subtest: nonblocking-crc
[477.277048] Starting dynamic subtest: pipe-A-eDP-1
[479.341717] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s)
[479.436347] Starting dynamic subtest: pipe-B-eDP-1
[481.867965] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.511s)
[481.963422] Starting dynamic subtest: pipe-C-eDP-1
[484.272304] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.390s)
[484.282993] Subtest nonblocking-crc: SUCCESS (7.016s)
[485.573572] [118/161] (612s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[486.057343] Starting subtest: nonblocking-crc-frame-sequence
[486.067755] Starting dynamic subtest: pipe-A-eDP-1
[488.149374] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.078s)
[488.243112] Starting dynamic subtest: pipe-B-eDP-1
[490.675872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.512s)
[490.774693] Starting dynamic subtest: pipe-C-eDP-1
[493.126056] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.436s)
[493.136309] Subtest nonblocking-crc-frame-sequence: SUCCESS (7.073s)
[494.390310] [119/161] (603s left) kms_pipe_crc_basic (read-crc)
[494.878966] Starting subtest: read-crc
[494.884585] Starting dynamic subtest: pipe-A-eDP-1
[496.909649] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.021s)
[497.011310] Starting dynamic subtest: pipe-B-eDP-1
[500.109365] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.180s)
[500.200768] Starting dynamic subtest: pipe-C-eDP-1
[502.426121] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.303s)
[502.428830] Subtest read-crc: SUCCESS (7.554s)
[503.688395] [120/161] (594s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[504.174532] Starting subtest: read-crc-frame-sequence
[504.183120] Starting dynamic subtest: pipe-A-eDP-1
[506.201884] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.013s)
[506.292924] Starting dynamic subtest: pipe-B-eDP-1
[508.673337] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.455s)
[508.771417] Starting dynamic subtest: pipe-C-eDP-1
[511.800690] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.113s)
[511.803599] Subtest read-crc-frame-sequence: SUCCESS (7.631s)
[512.796179] [121/161] (586s left) kms_pm_backlight (basic-brightness)
[513.281542] Starting subtest: basic-brightness
[513.779108] Starting dynamic subtest: eDP-1
[514.269122] Dynamic subtest eDP-1: SUCCESS (0.505s)
[514.284970] Subtest basic-brightness: SUCCESS (0.990s)
[515.499104] [122/161] (583s left) kms_pm_rpm (basic-pci-d3-state)
[518.071728] Starting subtest: basic-pci-d3-state
[520.135803] Subtest basic-pci-d3-state: SUCCESS (2.052s)
[520.705478] [123/161] (579s left) kms_pm_rpm (basic-rte)
[521.089181] Starting subtest: basic-rte
[525.167237] Subtest basic-rte: SUCCESS (4.079s)
[530.260416] [124/161] (569s left) kms_psr (psr-primary-page-flip)
[530.753233] Starting subtest: psr-primary-page-flip
[530.763637] Starting dynamic subtest: eDP-1
[533.515658] Dynamic subtest eDP-1: SUCCESS (2.755s)
[533.526688] Subtest psr-primary-page-flip: SUCCESS (2.767s)
[534.812095] [125/161] (565s left) kms_psr (psr-cursor-plane-move)
[535.306798] Starting subtest: psr-cursor-plane-move
[535.309904] Starting dynamic subtest: eDP-1
[537.857129] Dynamic subtest eDP-1: SUCCESS (2.547s)
[537.859885] Subtest psr-cursor-plane-move: SUCCESS (2.559s)
[539.140127] [126/161] (561s left) kms_psr (psr-sprite-plane-onoff)
[539.643087] Starting subtest: psr-sprite-plane-onoff
[539.646173] Starting dynamic subtest: eDP-1
[543.205421] Dynamic subtest eDP-1: SUCCESS (3.554s)
[543.208226] Subtest psr-sprite-plane-onoff: SUCCESS (3.566s)
[544.284983] [127/161] (557s left) kms_psr (psr-primary-mmap-gtt)
[544.770357] Starting subtest: psr-primary-mmap-gtt
[544.780508] Starting dynamic subtest: eDP-1
[547.554823] Dynamic subtest eDP-1: SUCCESS (2.778s)
[547.565576] Subtest psr-primary-mmap-gtt: SUCCESS (2.790s)
[548.825042] [128/161] (553s left) kms_setmode (basic-clone-single-crtc)
[549.214569] Starting subtest: basic-clone-single-crtc
[549.223428] Subtest basic-clone-single-crtc: SKIP (0.001s)
[549.701739] [129/161] (552s left) i915_pm_rps (basic-api)
[550.127220] Starting subtest: basic-api
[550.133077] Subtest basic-api: SKIP (0.003s)
[550.624823] [130/161] (551s left) prime_self_import (basic-llseek-bad)
[550.995666] Starting subtest: basic-llseek-bad
[551.009779] Subtest basic-llseek-bad: SUCCESS (0.014s)
[551.495640] [131/161] (551s left) prime_self_import (basic-llseek-size)
[551.873099] Starting subtest: basic-llseek-size
[551.887338] Subtest basic-llseek-size: SUCCESS (0.021s)
[552.370422] [132/161] (551s left) prime_self_import (basic-with_fd_dup)
[552.735173] Starting subtest: basic-with_fd_dup
[552.758456] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[553.256577] [133/161] (550s left) prime_self_import (basic-with_one_bo)
[553.628110] Starting subtest: basic-with_one_bo
[553.649905] Subtest basic-with_one_bo: SUCCESS (0.022s)
[554.154919] [134/161] (550s left) prime_self_import (basic-with_one_bo_two_files)
[554.523224] Starting subtest: basic-with_one_bo_two_files
[554.546211] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[555.030159] [135/161] (549s left) prime_self_import (basic-with_two_bos)
[555.396434] Starting subtest: basic-with_two_bos
[555.418777] Subtest basic-with_two_bos: SUCCESS (0.021s)
[555.911993] [136/161] (549s left) prime_vgem (basic-fence-flip)
[556.363727] Starting subtest: basic-fence-flip
[557.833208] Subtest basic-fence-flip: SUCCESS (1.476s)
[558.413156] [137/161] (546s left) prime_vgem (basic-fence-mmap)
[558.851447] Starting subtest: basic-fence-mmap
[559.056772] Subtest basic-fence-mmap: SUCCESS (0.196s)
[559.542577] [138/161] (546s left) prime_vgem (basic-fence-read)
[559.983489] Starting subtest: basic-fence-read
[560.036107] Subtest basic-fence-read: SKIP (0.057s)
[560.550612] [139/161] (545s left) prime_vgem (basic-gtt)
[561.006212] Starting subtest: basic-gtt
[561.089329] Subtest basic-gtt: SUCCESS (0.089s)
[561.588625] [140/161] (544s left) prime_vgem (basic-read)
[562.040195] Starting subtest: basic-read
[562.091496] Subtest basic-read: SKIP (0.055s)
[562.606538] [141/161] (544s left) prime_vgem (basic-write)
[563.056572] Starting subtest: basic-write
[563.108871] Subtest basic-write: SKIP (0.056s)
[563.623663] [142/161] (543s left) vgem_basic (setversion)
[564.033178] Starting subtest: setversion
[564.039718] Subtest setversion: SUCCESS (0.000s)
[564.486148] [143/161] (543s left) vgem_basic (create)
[564.896956] Starting subtest: create
[564.900441] Subtest create: SUCCESS (0.002s)
[565.358686] [144/161] (542s left) vgem_basic (debugfs)
[565.769185] Starting subtest: debugfs
[565.772426] Subtest debugfs: SUCCESS (0.002s)
[566.241951] [145/161] (542s left) vgem_basic (dmabuf-export)
[566.649731] Starting subtest: dmabuf-export
[566.663993] Subtest dmabuf-export: SUCCESS (0.018s)
[567.155410] [146/161] (541s left) vgem_basic (dmabuf-fence)
[567.559195] Starting subtest: dmabuf-fence
[567.562724] Subtest dmabuf-fence: SUCCESS (0.003s)
[568.037132] [147/161] (541s left) vgem_basic (dmabuf-fence-before)
[568.442712] Starting subtest: dmabuf-fence-before
[568.446176] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[568.910437] [148/161] (540s left) vgem_basic (dmabuf-mmap)
[569.316456] Starting subtest: dmabuf-mmap
[569.414575] Subtest dmabuf-mmap: SUCCESS (0.102s)
[569.873642] [149/161] (540s left) vgem_basic (mmap)
[570.281580] Starting subtest: mmap
[570.342234] Subtest mmap: SUCCESS (0.065s)
[570.801218] [150/161] (539s left) vgem_basic (second-client)
[571.210461] Starting subtest: second-client
[571.260321] Subtest second-client: SUCCESS (0.047s)
[571.730494] [151/161] (539s left) vgem_basic (sysfs)
[572.136752] Starting subtest: sysfs
[572.140315] Subtest sysfs: SUCCESS (0.004s)
[572.607256] [152/161] (538s left) core_hotunplug (unbind-rebind)
[573.304191] Starting subtest: unbind-rebind
[582.531536] Subtest unbind-rebind: SUCCESS (9.230s)
[582.939275] [153/161] (528s left) vgem_basic (unload)
[583.318248] Starting subtest: unload
[613.054507] Subtest unload: SUCCESS (29.700s)
[613.690895] [154/161] (498s left) i915_module_load (reload)
[614.055283] Starting subtest: reload
[628.793842] Subtest reload: SUCCESS (14.717s)
[629.425989] [155/161] (483s left) gem_lmem_swapping (basic)
[630.035106] Subtest basic: SKIP (0.000s)
[630.470811] [156/161] (482s left) gem_lmem_swapping (parallel-random-engines)
[630.876731] Subtest parallel-random-engines: SKIP (0.000s)
[631.294639] [157/161] (482s left) gem_lmem_swapping (random-engines)
[631.729280] Subtest random-engines: SKIP (0.000s)
[632.154165] [158/161] (481s left) gem_lmem_swapping (verify-random)
[632.569133] Subtest verify-random: SKIP (0.000s)
[632.999308] [159/161] (481s left) i915_pm_rpm (module-reload)
[637.230131] Starting subtest: module-reload
[671.362684] Subtest module-reload: SUCCESS (34.128s)
[671.615628] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[671.628801] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[671.656167] [160/161] (442s left) i915_selftest (live)
[672.058647] Starting subtest: live
[672.061722] Starting dynamic subtest: sanitycheck
[682.483822] Dynamic subtest sanitycheck: SUCCESS (10.414s)
[682.552685] Starting dynamic subtest: uncore
[692.964747] Dynamic subtest uncore: SUCCESS (10.466s)
[693.035949] Starting dynamic subtest: workarounds
��������������������������������������������������������������������������������������������������������������