[88.180306] Initializing watchdogs
[88.180905]   /dev/watchdog0
[88.357160] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[88.389776] [001/161] (960s left) i915_module_load (load)
[88.804152] Starting subtest: load
[101.308549] Subtest load: SUCCESS (12.610s)
[101.813829] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[101.836409] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[101.867667] [002/161] (947s left) core_auth (basic-auth)
[102.437344] Starting subtest: basic-auth
[102.443948] Subtest basic-auth: SUCCESS (0.007s)
[102.872881] [003/161] (946s left) debugfs_test (read_all_entries)
[103.408156] Starting subtest: read_all_entries
[105.338347] Subtest read_all_entries: SUCCESS (1.928s)
[105.916983] [004/161] (944s left) debugfs_test (basic-hwmon)
[106.371797] Starting subtest: basic-hwmon
[106.377429] Subtest basic-hwmon: SKIP (0.000s)
[106.909421] [005/161] (943s left) debugfs_test (sysfs)
[107.338116] Starting subtest: sysfs
[107.908689] Subtest sysfs: SUCCESS (0.572s)
[108.452284] [006/161] (942s left) fbdev (eof)
[108.875958] Starting subtest: eof
[108.882856] Subtest eof: SUCCESS (0.005s)
[109.308899] [007/161] (941s left) fbdev (info)
[109.674340] Starting subtest: info
[109.677667] Subtest info: SUCCESS (0.000s)
[110.124535] [008/161] (941s left) fbdev (nullptr)
[110.498446] Starting subtest: nullptr
[110.501412] Subtest nullptr: SUCCESS (0.001s)
[110.923872] [009/161] (940s left) fbdev (read)
[111.300235] Starting subtest: read
[124.991762] Subtest read: SUCCESS (13.658s)
[125.395415] [010/161] (926s left) fbdev (write)
[125.783507] Starting subtest: write
[132.912863] Subtest write: SUCCESS (7.123s)
[133.365617] [011/161] (918s left) gem_basic (bad-close)
[133.741162] Starting subtest: bad-close
[133.746709] Subtest bad-close: SUCCESS (0.000s)
[134.155661] [012/161] (918s left) gem_basic (create-close)
[134.537580] Starting subtest: create-close
[134.543286] Subtest create-close: SUCCESS (0.001s)
[134.963782] [013/161] (917s left) gem_basic (create-fd-close)
[135.342231] Starting subtest: create-fd-close
[135.347765] Subtest create-fd-close: SUCCESS (0.001s)
[135.766315] [014/161] (917s left) gem_busy (busy@all-engines)
[136.240122] Starting subtest: busy
[136.243257] Starting dynamic subtest: all-engines
[136.554208] Dynamic subtest all-engines: SUCCESS (0.315s)
[136.557918] Subtest busy: SUCCESS (0.317s)
[137.411922] [015/161] (916s left) gem_close_race (basic-process)
[137.890812] Starting subtest: basic-process
[138.038831] Subtest basic-process: SUCCESS (0.148s)
[138.594731] [016/161] (915s left) gem_close_race (basic-threads)
[139.089659] Starting subtest: basic-threads
[140.598105] Subtest basic-threads: SUCCESS (1.512s)
[141.153743] [017/161] (913s left) gem_ctx_create (basic)
[141.614949] Starting subtest: basic
[141.618142] Subtest basic: SUCCESS (0.000s)
[142.180667] [018/161] (912s left) gem_ctx_create (basic-files)
[142.646789] Starting subtest: basic-files
[144.760836] Subtest basic-files: SUCCESS (2.117s)
[145.477454] [019/161] (909s left) gem_ctx_exec (basic)
[145.872559] Starting subtest: basic
[145.890579] Subtest basic: SUCCESS (0.020s)
[146.358962] [020/161] (908s left) gem_exec_basic (basic)
[146.792350] Starting subtest: basic
[146.795456] Starting dynamic subtest: rcs0-smem
[146.801632] Dynamic subtest rcs0-smem: SUCCESS (0.009s)
[146.861208] Starting dynamic subtest: bcs0-smem
[146.864192] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[146.921251] Starting dynamic subtest: vcs0-smem
[146.924312] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[146.991197] Starting dynamic subtest: vecs0-smem
[146.994423] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[147.000126] Subtest basic: SUCCESS (0.027s)
[147.378875] [021/161] (908s left) gem_exec_create (basic)
[147.843768] Starting subtest: basic
[147.846885] Starting dynamic subtest: smem
[150.077960] Dynamic subtest smem: SUCCESS (2.234s)
[150.081415] Subtest basic: SUCCESS (2.236s)
[150.628607] [022/161] (905s left) gem_exec_fence (basic-busy)
[151.299110] Starting subtest: basic-busy
[151.302364] Starting dynamic subtest: rcs0
[151.376147] Dynamic subtest rcs0: SUCCESS (0.079s)
[151.438366] Starting dynamic subtest: bcs0
[151.445124] Dynamic subtest bcs0: SUCCESS (0.064s)
[151.504940] Starting dynamic subtest: vcs0
[151.516888] Dynamic subtest vcs0: SUCCESS (0.068s)
[151.580848] Starting dynamic subtest: vecs0
[151.586664] Dynamic subtest vecs0: SUCCESS (0.062s)
[151.589695] Subtest basic-busy: SUCCESS (0.281s)
[153.040697] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[153.061845] [023/161] (903s left) gem_exec_fence (basic-wait)
[153.758206] Starting subtest: basic-wait
[153.762774] Starting dynamic subtest: rcs0
[153.868168] Dynamic subtest rcs0: SUCCESS (0.110s)
[153.931999] Starting dynamic subtest: bcs0
[153.935445] Dynamic subtest bcs0: SUCCESS (0.061s)
[153.996283] Starting dynamic subtest: vcs0
[153.999480] Dynamic subtest vcs0: SUCCESS (0.064s)
[154.061133] Starting dynamic subtest: vecs0
[154.064203] Dynamic subtest vecs0: SUCCESS (0.063s)
[154.067088] Subtest basic-wait: SUCCESS (0.305s)
[155.358210] [024/161] (901s left) gem_exec_fence (basic-await)
[156.026194] Starting subtest: basic-await
[156.029423] Starting dynamic subtest: rcs0
[156.363875] Dynamic subtest rcs0: SUCCESS (0.337s)
[156.424593] Starting dynamic subtest: bcs0
[156.668752] Dynamic subtest bcs0: SUCCESS (0.301s)
[156.731183] Starting dynamic subtest: vcs0
[156.977096] Dynamic subtest vcs0: SUCCESS (0.309s)
[157.038332] Starting dynamic subtest: vecs0
[157.283095] Dynamic subtest vecs0: SUCCESS (0.301s)
[157.286230] Subtest basic-await: SUCCESS (1.257s)
[158.515077] [025/161] (898s left) gem_exec_fence (nb-await)
[159.186169] Starting subtest: nb-await
[159.190609] Starting dynamic subtest: rcs0
[159.300393] Dynamic subtest rcs0: SUCCESS (0.111s)
[159.361801] Starting dynamic subtest: bcs0
[159.388757] Dynamic subtest bcs0: SUCCESS (0.089s)
[159.452181] Starting dynamic subtest: vcs0
[159.475337] Dynamic subtest vcs0: SUCCESS (0.084s)
[159.538108] Starting dynamic subtest: vecs0
[159.562886] Dynamic subtest vecs0: SUCCESS (0.086s)
[159.565950] Subtest nb-await: SUCCESS (0.378s)
[160.832561] [026/161] (896s left) gem_exec_gttfill (basic)
[161.298401] Starting subtest: basic
[198.698615] Subtest basic: SUCCESS (37.393s)
[199.313994] [027/161] (858s left) gem_exec_parallel (engines)
[199.944525] Starting subtest: engines
[199.947772] Starting dynamic subtest: basic
[206.440059] Dynamic subtest basic: SUCCESS (6.496s)
[206.509091] Starting dynamic subtest: contexts
[217.397417] Dynamic subtest contexts: SUCCESS (10.946s)
[217.465742] Starting dynamic subtest: fds
[230.518920] Dynamic subtest fds: SUCCESS (13.111s)
[230.595891] Starting dynamic subtest: userptr
[236.150375] Dynamic subtest userptr: SUCCESS (5.647s)
[236.153780] Subtest engines: SUCCESS (36.208s)
[236.784353] [028/161] (821s left) gem_exec_store (basic)
[237.253821] Starting subtest: basic
[237.381378] Subtest basic: SUCCESS (0.128s)
[237.973724] [029/161] (820s left) gem_flink_basic (bad-flink)
[238.339830] Starting subtest: bad-flink
[238.342615] Subtest bad-flink: SUCCESS (0.000s)
[238.787824] [030/161] (820s left) gem_flink_basic (bad-open)
[239.161444] Starting subtest: bad-open
[239.164753] Subtest bad-open: SUCCESS (0.000s)
[239.612653] [031/161] (819s left) gem_flink_basic (basic)
[239.984977] Starting subtest: basic
[239.988725] Subtest basic: SUCCESS (0.001s)
[240.455898] [032/161] (819s left) gem_flink_basic (double-flink)
[240.825195] Starting subtest: double-flink
[240.828092] Subtest double-flink: SUCCESS (0.000s)
[241.283123] [033/161] (818s left) gem_flink_basic (flink-lifetime)
[241.656833] Starting subtest: flink-lifetime
[241.663941] Subtest flink-lifetime: SUCCESS (0.009s)
[242.122834] [034/161] (818s left) gem_huc_copy (huc-copy)
[242.536780] Starting subtest: huc-copy
[242.556659] Subtest huc-copy: SUCCESS (0.020s)
[243.038441] [035/161] (817s left) gem_linear_blits (basic)
[244.138688] Starting subtest: basic
[244.172797] Subtest basic: SUCCESS (0.047s)
[244.749459] [036/161] (816s left) gem_mmap (basic)
[245.312411] Starting subtest: basic
[245.325698] Subtest basic: SUCCESS (0.004s)
[245.786773] [037/161] (815s left) gem_mmap_gtt (basic)
[246.160964] Starting subtest: basic
[246.164353] Subtest basic: SUCCESS (0.005s)
[246.620863] [038/161] (815s left) gem_render_linear_blits (basic)
[247.025296] Starting subtest: basic
[247.256276] Subtest basic: SUCCESS (0.230s)
[247.706676] [039/161] (814s left) gem_render_tiled_blits (basic)
[248.108755] Starting subtest: basic
[248.382724] Subtest basic: SUCCESS (0.276s)
[248.836067] [040/161] (813s left) gem_ringfill (basic-all)
[249.708685] Starting subtest: basic-all
[251.183663] Subtest basic-all: SUCCESS (1.468s)
[251.637426] [041/161] (811s left) gem_softpin (allocator-basic)
[252.044216] Starting subtest: allocator-basic
[252.722385] Subtest allocator-basic: SUCCESS (0.669s)
[253.275549] [042/161] (810s left) gem_softpin (allocator-basic-reserve)
[253.684697] Starting subtest: allocator-basic-reserve
[254.365856] Subtest allocator-basic-reserve: SUCCESS (0.675s)
[254.941794] [043/161] (808s left) gem_softpin (safe-alignment)
[255.346617] Starting subtest: safe-alignment
[255.425834] Subtest safe-alignment: SUCCESS (0.081s)
[255.900342] [044/161] (808s left) gem_sync (basic-all)
[256.371681] Starting subtest: basic-all
[261.594103] Subtest basic-all: SUCCESS (5.225s)
[262.188820] [045/161] (802s left) gem_sync (basic-each)
[262.654224] Starting subtest: basic-each
[266.220802] Subtest basic-each: SUCCESS (3.565s)
[266.814945] [046/161] (798s left) gem_tiled_blits (basic)
[267.745975] Starting subtest: basic
[267.859797] Subtest basic: SUCCESS (0.123s)
[268.385863] [047/161] (796s left) gem_tiled_fence_blits (basic)
[269.528328] Starting subtest: basic
[269.591943] Subtest basic: SUCCESS (0.076s)
[270.148168] [048/161] (795s left) gem_tiled_pread_basic
[271.128182] [049/161] (794s left) gem_wait (busy@all-engines)
[271.647251] Starting subtest: busy
[271.650171] Starting dynamic subtest: all-engines
[272.232434] Dynamic subtest all-engines: SUCCESS (0.596s)
[272.235832] Subtest busy: SUCCESS (0.598s)
[272.954945] [050/161] (793s left) gem_wait (wait@all-engines)
[273.479891] Starting subtest: wait
[273.483426] Starting dynamic subtest: all-engines
[274.597991] Dynamic subtest all-engines: SUCCESS (1.128s)
[274.601103] Subtest wait: SUCCESS (1.130s)
[275.327483] [051/161] (791s left) i915_getparams_basic (basic-eu-total)
[275.698304] Starting subtest: basic-eu-total
[275.704631] Subtest basic-eu-total: SUCCESS (0.000s)
[276.152909] [052/161] (790s left) i915_getparams_basic (basic-subslice-total)
[276.524758] Starting subtest: basic-subslice-total
[276.530720] Subtest basic-subslice-total: SUCCESS (0.000s)
[276.976246] [053/161] (790s left) i915_hangman (error-state-basic)
[277.422964] Starting subtest: error-state-basic
[278.282271] Subtest error-state-basic: SUCCESS (0.857s)
[278.768936] [054/161] (789s left) i915_pciid
[279.590355] [055/161] (788s left) kms_addfb_basic (addfb25-4-tiled)
[280.115672] Starting subtest: addfb25-4-tiled
[280.118664] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[280.593138] [056/161] (788s left) kms_addfb_basic (addfb25-bad-modifier)
[281.075058] Starting subtest: addfb25-bad-modifier
[281.078249] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[281.558838] [057/161] (787s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[282.041150] Starting subtest: addfb25-framebuffer-vs-set-tiling
[282.044773] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s)
[282.525470] [058/161] (786s left) kms_addfb_basic (addfb25-modifier-no-flag)
[283.002557] Starting subtest: addfb25-modifier-no-flag
[283.005690] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[283.473115] [059/161] (786s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[283.955453] Starting subtest: addfb25-x-tiled-legacy
[283.958335] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[284.425691] [060/161] (785s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[284.908595] Starting subtest: addfb25-x-tiled-mismatch-legacy
[284.911947] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[285.386608] [061/161] (785s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[285.867222] Starting subtest: addfb25-yf-tiled-legacy
[285.870454] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[286.336363] [062/161] (784s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[286.819446] Starting subtest: addfb25-y-tiled-legacy
[286.822660] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[287.302308] [063/161] (783s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[287.780251] Starting subtest: addfb25-y-tiled-small-legacy
[287.784655] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[288.256694] [064/161] (783s left) kms_addfb_basic (bad-pitch-0)
[288.649744] Starting subtest: bad-pitch-0
[288.654660] Subtest bad-pitch-0: SUCCESS (0.000s)
[289.236872] [065/161] (782s left) kms_addfb_basic (bad-pitch-1024)
[289.612445] Starting subtest: bad-pitch-1024
[289.615435] Subtest bad-pitch-1024: SUCCESS (0.000s)
[290.189835] [066/161] (782s left) kms_addfb_basic (bad-pitch-128)
[290.571423] Starting subtest: bad-pitch-128
[290.574606] Subtest bad-pitch-128: SUCCESS (0.000s)
[291.153427] [067/161] (781s left) kms_addfb_basic (bad-pitch-256)
[291.533824] Starting subtest: bad-pitch-256
[291.536834] Subtest bad-pitch-256: SUCCESS (0.000s)
[292.098682] [068/161] (781s left) kms_addfb_basic (bad-pitch-32)
[292.471273] Starting subtest: bad-pitch-32
[292.474447] Subtest bad-pitch-32: SUCCESS (0.000s)
[293.049929] [069/161] (780s left) kms_addfb_basic (bad-pitch-63)
[293.429399] Starting subtest: bad-pitch-63
[293.432413] Subtest bad-pitch-63: SUCCESS (0.000s)
[294.012377] [070/161] (779s left) kms_addfb_basic (bad-pitch-65536)
[294.389845] Starting subtest: bad-pitch-65536
[294.393332] Subtest bad-pitch-65536: SUCCESS (0.002s)
[294.972906] [071/161] (779s left) kms_addfb_basic (bad-pitch-999)
[295.350833] Starting subtest: bad-pitch-999
[295.354462] Subtest bad-pitch-999: SUCCESS (0.000s)
[295.922493] [072/161] (778s left) kms_addfb_basic (basic)
[296.299563] Starting subtest: basic
[296.302906] Subtest basic: SUCCESS (0.000s)
[296.879256] [073/161] (778s left) kms_addfb_basic (basic-x-tiled-legacy)
[297.261168] Starting subtest: basic-x-tiled-legacy
[297.264533] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[297.830402] [074/161] (777s left) kms_addfb_basic (basic-y-tiled-legacy)
[298.211780] Starting subtest: basic-y-tiled-legacy
[298.214687] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[298.780443] [075/161] (776s left) kms_addfb_basic (bo-too-small)
[299.264115] Starting subtest: bo-too-small
[299.267684] Subtest bo-too-small: SUCCESS (0.002s)
[299.739870] [076/161] (776s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[300.225341] Starting subtest: bo-too-small-due-to-tiling
[300.228483] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[300.696646] [077/161] (775s left) kms_addfb_basic (clobberred-modifier)
[301.073774] Starting subtest: clobberred-modifier
[301.076699] Subtest clobberred-modifier: SUCCESS (0.001s)
[301.634488] [078/161] (775s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[302.014620] Starting subtest: framebuffer-vs-set-tiling
[302.017500] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[302.603711] [079/161] (774s left) kms_addfb_basic (invalid-get-prop)
[302.984637] Starting subtest: invalid-get-prop
[302.987737] Subtest invalid-get-prop: SUCCESS (0.000s)
[303.567516] [080/161] (774s left) kms_addfb_basic (invalid-get-prop-any)
[303.965218] Starting subtest: invalid-get-prop-any
[303.967860] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[304.547583] [081/161] (773s left) kms_addfb_basic (invalid-set-prop)
[304.922659] Starting subtest: invalid-set-prop
[304.925930] Subtest invalid-set-prop: SUCCESS (0.000s)
[305.484870] [082/161] (772s left) kms_addfb_basic (invalid-set-prop-any)
[305.862777] Starting subtest: invalid-set-prop-any
[305.865767] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[306.434914] [083/161] (772s left) kms_addfb_basic (no-handle)
[306.818176] Starting subtest: no-handle
[306.820803] Subtest no-handle: SUCCESS (0.000s)
[307.383417] [084/161] (771s left) kms_addfb_basic (size-max)
[307.867952] Starting subtest: size-max
[307.871208] Subtest size-max: SUCCESS (0.001s)
[308.338596] [085/161] (771s left) kms_addfb_basic (small-bo)
[308.817847] Starting subtest: small-bo
[308.821251] Subtest small-bo: SUCCESS (0.000s)
[309.283384] [086/161] (770s left) kms_addfb_basic (tile-pitch-mismatch)
[309.665348] Starting subtest: tile-pitch-mismatch
[309.668297] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[310.235972] [087/161] (770s left) kms_addfb_basic (too-high)
[310.713243] Starting subtest: too-high
[310.721192] Subtest too-high: SUCCESS (0.006s)
[311.201410] [088/161] (769s left) kms_addfb_basic (too-wide)
[311.686346] Starting subtest: too-wide
[311.689321] Subtest too-wide: SUCCESS (0.000s)
[312.155171] [089/161] (768s left) kms_addfb_basic (unused-handle)
[312.527932] Starting subtest: unused-handle
[312.531619] Subtest unused-handle: SUCCESS (0.000s)
[313.115569] [090/161] (768s left) kms_addfb_basic (unused-modifier)
[313.489532] Starting subtest: unused-modifier
[313.492969] Subtest unused-modifier: SUCCESS (0.000s)
[314.075448] [091/161] (767s left) kms_addfb_basic (unused-offsets)
[314.449600] Starting subtest: unused-offsets
[314.452819] Subtest unused-offsets: SUCCESS (0.000s)
[315.029565] [092/161] (767s left) kms_addfb_basic (unused-pitches)
[315.397226] Starting subtest: unused-pitches
[315.400108] Subtest unused-pitches: SUCCESS (0.001s)
[315.970616] [093/161] (766s left) kms_busy (basic)
[316.478662] Starting subtest: basic
[316.483204] Starting dynamic subtest: flip
[319.518839] Dynamic subtest flip: SUCCESS (3.032s)
[319.601775] Starting dynamic subtest: modeset
[325.009172] Dynamic subtest modeset: SUCCESS (5.489s)
[325.011718] Subtest basic: SUCCESS (8.533s)
[326.332264] [094/161] (756s left) kms_prop_blob (basic)
[326.713359] Starting subtest: basic
[326.716426] Subtest basic: SUCCESS (0.000s)
[327.174791] [095/161] (756s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[327.807263] Starting subtest: basic-busy-flip-before-cursor-atomic
[327.812751] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[328.400633] [096/161] (755s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[329.011176] Starting subtest: basic-busy-flip-before-cursor-legacy
[329.016675] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s)
[329.613071] [097/161] (754s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[330.234569] Starting subtest: basic-flip-after-cursor-atomic
[331.852218] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.619s)
[333.113896] [098/161] (751s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[333.771681] Starting subtest: basic-flip-after-cursor-legacy
[335.390407] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.619s)
[336.639945] [099/161] (748s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[337.268454] Starting subtest: basic-flip-after-cursor-varying-size
[339.673949] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.398s)
[340.711882] [100/161] (744s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[341.331114] Starting subtest: basic-flip-before-cursor-atomic
[342.937079] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.605s)
[344.249768] [101/161] (741s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[344.868745] Starting subtest: basic-flip-before-cursor-legacy
[346.479846] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.613s)
[347.782870] [102/161] (738s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[348.407654] Starting subtest: basic-flip-before-cursor-varying-size
[350.810796] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.398s)
[351.843622] [103/161] (734s left) kms_dsc (dsc-basic)
[352.326715] Starting subtest: dsc-basic
[352.341263] Subtest dsc-basic: SKIP (0.003s)
[352.786894] [104/161] (733s left) kms_flip (basic-flip-vs-dpms)
[353.267297] Starting subtest: basic-flip-vs-dpms
[353.277758] Starting dynamic subtest: A-eDP1
[357.173914] Dynamic subtest A-eDP1: SUCCESS (3.896s)
[357.259244] Starting dynamic subtest: B-eDP1
[360.481059] Dynamic subtest B-eDP1: SUCCESS (3.298s)
[360.563636] Starting dynamic subtest: C-eDP1
[363.829058] Dynamic subtest C-eDP1: SUCCESS (3.346s)
[363.835803] Subtest basic-flip-vs-dpms: SUCCESS (10.570s)
[365.083902] [105/161] (722s left) kms_flip (basic-flip-vs-modeset)
[365.570824] Starting subtest: basic-flip-vs-modeset
[365.585566] Starting dynamic subtest: A-eDP1
[369.894237] Dynamic subtest A-eDP1: SUCCESS (4.310s)
[369.979430] Starting dynamic subtest: B-eDP1
[373.038888] Dynamic subtest B-eDP1: SUCCESS (3.137s)
[373.127127] Starting dynamic subtest: C-eDP1
[376.074334] Dynamic subtest C-eDP1: SUCCESS (3.030s)
[376.081774] Subtest basic-flip-vs-modeset: SUCCESS (10.512s)
[377.296394] [106/161] (710s left) kms_flip (basic-flip-vs-wf_vblank)
[377.778246] Starting subtest: basic-flip-vs-wf_vblank
[377.792988] Starting dynamic subtest: A-eDP1
[380.891672] Dynamic subtest A-eDP1: SUCCESS (3.098s)
[380.979244] Starting dynamic subtest: B-eDP1
[383.790105] Dynamic subtest B-eDP1: SUCCESS (2.892s)
[383.874946] Starting dynamic subtest: C-eDP1
[386.795672] Dynamic subtest C-eDP1: SUCCESS (3.000s)
[386.806232] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.026s)
[388.801982] [107/161] (699s left) kms_flip (basic-plain-flip)
[389.284071] Starting subtest: basic-plain-flip
[389.298907] Starting dynamic subtest: A-eDP1
[392.102669] Dynamic subtest A-eDP1: SUCCESS (2.803s)
[392.187850] Starting dynamic subtest: B-eDP1
[395.408704] Dynamic subtest B-eDP1: SUCCESS (3.299s)
[395.498794] Starting dynamic subtest: C-eDP1
[398.077663] Dynamic subtest C-eDP1: SUCCESS (2.664s)
[398.087807] Subtest basic-plain-flip: SUCCESS (8.803s)
[400.082978] [108/161] (688s left) kms_force_connector_basic (force-connector-state)
[400.486541] Starting subtest: force-connector-state
[401.340418] Subtest force-connector-state: SUCCESS (0.851s)
[402.999094] [109/161] (685s left) kms_force_connector_basic (force-edid)
[403.397455] Starting subtest: force-edid
[403.495684] Subtest force-edid: SUCCESS (0.102s)
[404.148943] [110/161] (684s left) kms_force_connector_basic (force-load-detect)
[404.549343] Starting subtest: force-load-detect
[404.555398] Subtest force-load-detect: SKIP (0.000s)
[405.127286] [111/161] (684s left) kms_force_connector_basic (prune-stale-modes)
[405.531671] Starting subtest: prune-stale-modes
[405.640270] Subtest prune-stale-modes: SUCCESS (0.109s)
[406.285225] [112/161] (683s left) kms_frontbuffer_tracking (basic)
[406.805265] Starting subtest: basic
[434.110894] Subtest basic: SUCCESS (27.309s)
[434.715933] [113/161] (655s left) kms_hdmi_inject (inject-audio)
[435.554278] Starting subtest: inject-audio
[436.106980] Subtest inject-audio: SUCCESS (0.548s)
[437.511095] [114/161] (653s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[437.999764] Starting subtest: compare-crc-sanitycheck-xr24
[438.008691] Starting dynamic subtest: pipe-A-eDP-1
[439.807335] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.794s)
[439.897638] Starting dynamic subtest: pipe-B-eDP-1
[442.049780] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.229s)
[442.139509] Starting dynamic subtest: pipe-C-eDP-1
[444.305744] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.247s)
[444.308835] Subtest compare-crc-sanitycheck-xr24: SUCCESS (6.310s)
[445.527867] [115/161] (645s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[446.015650] Starting subtest: compare-crc-sanitycheck-nv12
[446.021805] Starting dynamic subtest: pipe-A-eDP-1
[448.982599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.954s)
[449.077404] Starting dynamic subtest: pipe-B-eDP-1
[452.388535] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.398s)
[452.481884] Starting dynamic subtest: pipe-C-eDP-1
[455.694197] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.287s)
[455.698710] Subtest compare-crc-sanitycheck-nv12: SUCCESS (9.680s)
[456.953714] [116/161] (634s left) kms_pipe_crc_basic (hang-read-crc)
[457.439720] Starting subtest: hang-read-crc
[457.453544] Starting dynamic subtest: pipe-A-eDP-1
[463.500471] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.047s)
[463.589133] Starting dynamic subtest: pipe-B-eDP-1
[469.234801] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.725s)
[469.328782] Starting dynamic subtest: pipe-C-eDP-1
[475.450346] Dynamic subtest pipe-C-eDP-1: SUCCESS (6.200s)
[475.453578] Subtest hang-read-crc: SUCCESS (18.016s)
[476.707127] [117/161] (615s left) kms_pipe_crc_basic (nonblocking-crc)
[477.196788] Starting subtest: nonblocking-crc
[477.208361] Starting dynamic subtest: pipe-A-eDP-1
[480.078247] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.868s)
[480.175758] Starting dynamic subtest: pipe-B-eDP-1
[482.596630] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.498s)
[482.691972] Starting dynamic subtest: pipe-C-eDP-1
[485.019126] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[485.022455] Subtest nonblocking-crc: SUCCESS (7.821s)
[486.299775] [118/161] (605s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[486.790628] Starting subtest: nonblocking-crc-frame-sequence
[486.797107] Starting dynamic subtest: pipe-A-eDP-1
[488.873582] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[488.975140] Starting dynamic subtest: pipe-B-eDP-1
[491.402742] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.510s)
[491.502415] Starting dynamic subtest: pipe-C-eDP-1
[493.821732] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.405s)
[493.824779] Subtest nonblocking-crc-frame-sequence: SUCCESS (7.037s)
[495.106308] [119/161] (597s left) kms_pipe_crc_basic (read-crc)
[495.599831] Starting subtest: read-crc
[495.605230] Starting dynamic subtest: pipe-A-eDP-1
[497.626623] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.016s)
[497.718327] Starting dynamic subtest: pipe-B-eDP-1
[500.119772] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.475s)
[500.216288] Starting dynamic subtest: pipe-C-eDP-1
[502.487818] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.356s)
[502.491134] Subtest read-crc: SUCCESS (6.896s)
[503.711712] [120/161] (589s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[504.209926] Starting subtest: read-crc-frame-sequence
[504.221146] Starting dynamic subtest: pipe-A-eDP-1
[506.246350] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.024s)
[506.342086] Starting dynamic subtest: pipe-B-eDP-1
[508.715194] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.451s)
[508.809215] Starting dynamic subtest: pipe-C-eDP-1
[511.057928] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.321s)
[511.061060] Subtest read-crc-frame-sequence: SUCCESS (6.846s)
[512.313151] [121/161] (581s left) kms_pm_backlight (basic-brightness)
[512.813218] Starting subtest: basic-brightness
[513.289763] Starting dynamic subtest: eDP-1
[513.785661] Dynamic subtest eDP-1: SUCCESS (0.499s)
[513.820181] Subtest basic-brightness: SUCCESS (0.976s)
[515.000944] [122/161] (578s left) kms_pm_rpm (basic-pci-d3-state)
[517.507362] Starting subtest: basic-pci-d3-state
[519.475777] Subtest basic-pci-d3-state: SUCCESS (1.968s)
[520.115069] [123/161] (573s left) kms_pm_rpm (basic-rte)
[520.491687] Starting subtest: basic-rte
[524.496244] Subtest basic-rte: SUCCESS (4.008s)
[526.860054] [124/161] (567s left) kms_psr (psr-primary-page-flip)
[527.350258] Starting subtest: psr-primary-page-flip
[527.361923] Starting dynamic subtest: eDP-1
[530.134936] Dynamic subtest eDP-1: SUCCESS (2.775s)
[530.138327] Subtest psr-primary-page-flip: SUCCESS (2.788s)
[531.422681] [125/161] (563s left) kms_psr (psr-cursor-plane-move)
[531.911614] Starting subtest: psr-cursor-plane-move
[531.914898] Starting dynamic subtest: eDP-1
[534.476601] Dynamic subtest eDP-1: SUCCESS (2.558s)
[534.480132] Subtest psr-cursor-plane-move: SUCCESS (2.570s)
[535.754186] [126/161] (559s left) kms_psr (psr-sprite-plane-onoff)
[536.240938] Starting subtest: psr-sprite-plane-onoff
[536.251712] Starting dynamic subtest: eDP-1
[538.897374] Dynamic subtest eDP-1: SUCCESS (2.643s)
[538.900353] Subtest psr-sprite-plane-onoff: SUCCESS (2.655s)
[540.199750] [127/161] (555s left) kms_psr (psr-primary-mmap-gtt)
[540.688197] Starting subtest: psr-primary-mmap-gtt
[540.698290] Starting dynamic subtest: eDP-1
[544.109753] Dynamic subtest eDP-1: SUCCESS (3.412s)
[544.112576] Subtest psr-primary-mmap-gtt: SUCCESS (3.424s)
[545.356191] [128/161] (550s left) kms_setmode (basic-clone-single-crtc)
[545.743738] Starting subtest: basic-clone-single-crtc
[545.752636] Subtest basic-clone-single-crtc: SKIP (0.001s)
[546.229998] [129/161] (550s left) i915_pm_rps (basic-api)
[546.650898] Starting subtest: basic-api
[546.656834] Subtest basic-api: SKIP (0.004s)
[547.153319] [130/161] (549s left) prime_self_import (basic-llseek-bad)
[547.517191] Starting subtest: basic-llseek-bad
[547.531240] Subtest basic-llseek-bad: SUCCESS (0.014s)
[548.018461] [131/161] (549s left) prime_self_import (basic-llseek-size)
[548.394107] Starting subtest: basic-llseek-size
[548.407759] Subtest basic-llseek-size: SUCCESS (0.021s)
[548.901502] [132/161] (548s left) prime_self_import (basic-with_fd_dup)
[549.267829] Starting subtest: basic-with_fd_dup
[549.290218] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[549.787912] [133/161] (548s left) prime_self_import (basic-with_one_bo)
[550.156199] Starting subtest: basic-with_one_bo
[550.177349] Subtest basic-with_one_bo: SUCCESS (0.021s)
[550.680980] [134/161] (547s left) prime_self_import (basic-with_one_bo_two_files)
[551.050775] Starting subtest: basic-with_one_bo_two_files
[551.072728] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[551.553576] [135/161] (547s left) prime_self_import (basic-with_two_bos)
[551.923293] Starting subtest: basic-with_two_bos
[551.945512] Subtest basic-with_two_bos: SUCCESS (0.022s)
[552.426150] [136/161] (546s left) prime_vgem (basic-fence-flip)
[552.884201] Starting subtest: basic-fence-flip
[554.335989] Subtest basic-fence-flip: SUCCESS (1.459s)
[554.918397] [137/161] (544s left) prime_vgem (basic-fence-mmap)
[555.361489] Starting subtest: basic-fence-mmap
[555.570091] Subtest basic-fence-mmap: SUCCESS (0.199s)
[556.052381] [138/161] (543s left) prime_vgem (basic-fence-read)
[556.490807] Starting subtest: basic-fence-read
[556.549108] Subtest basic-fence-read: SKIP (0.056s)
[557.053438] [139/161] (543s left) prime_vgem (basic-gtt)
[557.502421] Starting subtest: basic-gtt
[557.591661] Subtest basic-gtt: SUCCESS (0.089s)
[558.093205] [140/161] (542s left) prime_vgem (basic-read)
[558.547768] Starting subtest: basic-read
[558.603994] Subtest basic-read: SKIP (0.052s)
[559.120833] [141/161] (542s left) prime_vgem (basic-write)
[559.567162] Starting subtest: basic-write
[559.626345] Subtest basic-write: SKIP (0.056s)
[560.142113] [142/161] (541s left) vgem_basic (setversion)
[560.557684] Starting subtest: setversion
[560.563849] Subtest setversion: SUCCESS (0.000s)
[561.003260] [143/161] (540s left) vgem_basic (create)
[561.409432] Starting subtest: create
[561.412662] Subtest create: SUCCESS (0.002s)
[561.857921] [144/161] (540s left) vgem_basic (debugfs)
[562.272993] Starting subtest: debugfs
[562.281163] Subtest debugfs: SUCCESS (0.003s)
[562.736867] [145/161] (539s left) vgem_basic (dmabuf-export)
[563.145063] Starting subtest: dmabuf-export
[563.161721] Subtest dmabuf-export: SUCCESS (0.015s)
[563.625666] [146/161] (539s left) vgem_basic (dmabuf-fence)
[564.031973] Starting subtest: dmabuf-fence
[564.035450] Subtest dmabuf-fence: SUCCESS (0.003s)
[564.496389] [147/161] (539s left) vgem_basic (dmabuf-fence-before)
[564.905967] Starting subtest: dmabuf-fence-before
[564.909225] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[565.368796] [148/161] (538s left) vgem_basic (dmabuf-mmap)
[565.771807] Starting subtest: dmabuf-mmap
[565.868182] Subtest dmabuf-mmap: SUCCESS (0.099s)
[566.323062] [149/161] (537s left) vgem_basic (mmap)
[566.729404] Starting subtest: mmap
[566.790627] Subtest mmap: SUCCESS (0.065s)
[567.246101] [150/161] (537s left) vgem_basic (second-client)
[567.653224] Starting subtest: second-client
[567.695529] Subtest second-client: SUCCESS (0.047s)
[568.148052] [151/161] (536s left) vgem_basic (sysfs)
[568.553849] Starting subtest: sysfs
[568.557301] Subtest sysfs: SUCCESS (0.004s)
[569.017103] [152/161] (536s left) core_hotunplug (unbind-rebind)
[569.715172] Starting subtest: unbind-rebind
[578.902129] Subtest unbind-rebind: SUCCESS (9.188s)
[579.307799] [153/161] (526s left) vgem_basic (unload)
[579.686528] Starting subtest: unload
[609.396260] Subtest unload: SUCCESS (29.706s)
[610.042814] [154/161] (496s left) i915_module_load (reload)
[610.415096] Starting subtest: reload
[625.088400] Subtest reload: SUCCESS (14.659s)
[625.737174] [155/161] (481s left) gem_lmem_swapping (basic)
[626.287176] Subtest basic: SKIP (0.000s)
[626.712576] [156/161] (480s left) gem_lmem_swapping (parallel-random-engines)
[627.130578] Subtest parallel-random-engines: SKIP (0.000s)
[627.554705] [157/161] (480s left) gem_lmem_swapping (random-engines)
[627.966266] Subtest random-engines: SKIP (0.000s)
[628.386824] [158/161] (479s left) gem_lmem_swapping (verify-random)
[628.799680] Subtest verify-random: SKIP (0.000s)
[629.226103] [159/161] (479s left) i915_pm_rpm (module-reload)
[632.627217] Starting subtest: module-reload
[666.609310] Subtest module-reload: SUCCESS (33.978s)
[666.861384] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[666.874560] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[666.898143] [160/161] (441s left) i915_selftest (live)
[667.302230] Starting subtest: live
[667.313096] Starting dynamic subtest: sanitycheck
[677.675824] Dynamic subtest sanitycheck: SUCCESS (10.358s)
[677.742538] Starting dynamic subtest: uncore
[688.072745] Dynamic subtest uncore: SUCCESS (10.398s)
[688.148140] Starting dynamic subtest: workarounds
[701.297666] Dynamic subtest workarounds: SUCCESS (13.204s)
[701.362942] Starting dynamic subtest: gt_engines
[712.408253] Dynamic subtest gt_engines: SUCCESS (11.101s)
[712.475722] Starting dynamic subtest: gt_timelines
[758.053571] Dynamic subtest gt_timelines: SUCCESS (45.634s)
[758.121909] Starting dynamic subtest: gt_contexts
[768.602205] Dynamic subtest gt_contexts: SUCCESS (10.535s)
[768.669543] Starting dynamic subtest: gt_lrc
[782.521361] Dynamic subtest gt_lrc: SUCCESS (13.913s)
[782.588662] Starting dynamic subtest: gt_mocs
�������������������������������������������������������������