[76.142091] Initializing watchdogs
[76.142473]   /dev/watchdog0
[76.216554] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller
[76.236822] [001/161] (960s left) i915_module_load (load)
[77.252252] Starting subtest: load
[82.886228] Subtest load: SUCCESS (5.709s)
[83.309870] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[83.330219] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[83.356127] [002/161] (953s left) core_auth (basic-auth)
[83.781142] Starting subtest: basic-auth
[83.783971] Subtest basic-auth: SUCCESS (0.008s)
[84.129365] [003/161] (953s left) debugfs_test (read_all_entries)
[84.557104] Starting subtest: read_all_entries
[84.883632] Subtest read_all_entries: SUCCESS (0.329s)
[85.639695] [004/161] (951s left) debugfs_test (basic-hwmon)
[85.933494] Starting subtest: basic-hwmon
[85.938993] Subtest basic-hwmon: SKIP (0.000s)
[86.609749] [005/161] (951s left) debugfs_test (sysfs)
[86.900817] Starting subtest: sysfs
[87.313185] Subtest sysfs: SUCCESS (0.418s)
[88.074889] [006/161] (949s left) fbdev (eof)
[88.349908] Starting subtest: eof
[88.353300] Subtest eof: SUCCESS (0.004s)
[88.562349] [007/161] (949s left) fbdev (info)
[88.814718] Starting subtest: info
[88.818257] Subtest info: SUCCESS (0.000s)
[89.017299] [008/161] (949s left) fbdev (nullptr)
[89.294247] Starting subtest: nullptr
[89.296153] Subtest nullptr: SUCCESS (0.002s)
[89.531478] [009/161] (948s left) fbdev (read)
[89.809676] Starting subtest: read
[91.962112] Subtest read: SUCCESS (2.162s)
[92.170811] [010/161] (946s left) fbdev (write)
[92.429643] Starting subtest: write
[93.572410] Subtest write: SUCCESS (1.146s)
[93.784752] [011/161] (944s left) gem_basic (bad-close)
[94.059096] Starting subtest: bad-close
[94.065654] Subtest bad-close: SUCCESS (0.000s)
[94.284787] [012/161] (944s left) gem_basic (create-close)
[94.559194] Starting subtest: create-close
[94.562492] Subtest create-close: SUCCESS (0.001s)
[94.796618] [013/161] (944s left) gem_basic (create-fd-close)
[95.059773] Starting subtest: create-fd-close
[95.065911] Subtest create-fd-close: SUCCESS (0.001s)
[95.309239] [014/161] (943s left) gem_busy (busy@all-engines)
[95.637789] Starting subtest: busy
[95.639692] Starting dynamic subtest: all-engines
[95.857977] Dynamic subtest all-engines: SUCCESS (0.221s)
[95.860086] Subtest busy: SUCCESS (0.228s)
[96.455850] [015/161] (942s left) gem_close_race (basic-process)
[96.784097] Starting subtest: basic-process
[96.955351] Subtest basic-process: SUCCESS (0.173s)
[97.326656] [016/161] (942s left) gem_close_race (basic-threads)
[97.661660] Starting subtest: basic-threads
[98.949099] Subtest basic-threads: SUCCESS (1.287s)
[99.330942] [017/161] (940s left) gem_ctx_create (basic)
[99.655509] Starting subtest: basic
[99.657461] Subtest basic: SUCCESS (0.000s)
[100.030497] [018/161] (939s left) gem_ctx_create (basic-files)
[100.358576] Starting subtest: basic-files
[102.438444] Subtest basic-files: SUCCESS (2.081s)
[102.789768] [019/161] (937s left) gem_ctx_exec (basic)
[103.064253] Starting subtest: basic
[103.079551] Subtest basic: SUCCESS (0.012s)
[103.338652] [020/161] (936s left) gem_exec_basic (basic)
[103.631802] Starting subtest: basic
[103.637591] Starting dynamic subtest: rcs0-smem
[103.641455] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[103.671872] Starting dynamic subtest: bcs0-smem
[103.674714] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[103.703579] Starting dynamic subtest: vcs0-smem
[103.705309] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[103.739765] Starting dynamic subtest: vecs0-smem
[103.744329] Dynamic subtest vecs0-smem: SUCCESS (0.022s)
[103.748323] Subtest basic: SUCCESS (0.040s)
[104.020273] [021/161] (936s left) gem_exec_create (basic)
[104.340838] Starting subtest: basic
[104.347310] Starting dynamic subtest: smem
[106.440749] Dynamic subtest smem: SUCCESS (2.095s)
[106.445257] Subtest basic: SUCCESS (2.100s)
[106.803416] [022/161] (933s left) gem_exec_fence (basic-busy)
[107.302739] Starting subtest: basic-busy
[107.308728] Starting dynamic subtest: rcs0
[107.334425] Dynamic subtest rcs0: SUCCESS (0.033s)
[107.363969] Starting dynamic subtest: bcs0
[107.378124] Dynamic subtest bcs0: SUCCESS (0.044s)
[107.409071] Starting dynamic subtest: vcs0
[107.427069] Dynamic subtest vcs0: SUCCESS (0.044s)
[107.450799] Starting dynamic subtest: vecs0
[107.458842] Dynamic subtest vecs0: SUCCESS (0.030s)
[107.462907] Subtest basic-busy: SUCCESS (0.162s)
[108.454582] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[108.463975] [023/161] (932s left) gem_exec_fence (basic-wait)
[108.956575] Starting subtest: basic-wait
[108.960798] Starting dynamic subtest: rcs0
[108.992517] Dynamic subtest rcs0: SUCCESS (0.035s)
[109.029154] Starting dynamic subtest: bcs0
[109.032722] Dynamic subtest bcs0: SUCCESS (0.036s)
[109.059698] Starting dynamic subtest: vcs0
[109.078398] Dynamic subtest vcs0: SUCCESS (0.043s)
[109.103156] Starting dynamic subtest: vecs0
[109.121382] Dynamic subtest vecs0: SUCCESS (0.041s)
[109.123140] Subtest basic-wait: SUCCESS (0.163s)
[109.994904] [024/161] (931s left) gem_exec_fence (basic-await)
[110.491723] Starting subtest: basic-await
[110.495796] Starting dynamic subtest: rcs0
[110.741760] Dynamic subtest rcs0: SUCCESS (0.247s)
[110.772783] Starting dynamic subtest: bcs0
[110.978822] Dynamic subtest bcs0: SUCCESS (0.224s)
[111.004721] Starting dynamic subtest: vcs0
[111.195976] Dynamic subtest vcs0: SUCCESS (0.223s)
[111.230856] Starting dynamic subtest: vecs0
[111.417386] Dynamic subtest vecs0: SUCCESS (0.222s)
[111.420983] Subtest basic-await: SUCCESS (0.925s)
[112.261826] [025/161] (929s left) gem_exec_fence (nb-await)
[112.748130] Starting subtest: nb-await
[112.751717] Starting dynamic subtest: rcs0
[112.846708] Dynamic subtest rcs0: SUCCESS (0.094s)
[112.879254] Starting dynamic subtest: bcs0
[112.948308] Dynamic subtest bcs0: SUCCESS (0.091s)
[112.974210] Starting dynamic subtest: vcs0
[113.045947] Dynamic subtest vcs0: SUCCESS (0.096s)
[113.073190] Starting dynamic subtest: vecs0
[113.146498] Dynamic subtest vecs0: SUCCESS (0.096s)
[113.148613] Subtest nb-await: SUCCESS (0.391s)
[114.013760] [026/161] (927s left) gem_exec_gttfill (basic)
[114.329973] Starting subtest: basic
[147.202158] Subtest basic: SUCCESS (32.865s)
[147.628701] [027/161] (894s left) gem_exec_parallel (engines)
[148.132271] Starting subtest: engines
[148.142292] Starting dynamic subtest: basic
[156.885865] Dynamic subtest basic: SUCCESS (8.758s)
[156.913184] Starting dynamic subtest: contexts
[167.321909] Dynamic subtest contexts: SUCCESS (10.435s)
[167.352409] Starting dynamic subtest: fds
[178.822824] Dynamic subtest fds: SUCCESS (11.495s)
[178.855486] Starting dynamic subtest: userptr
[185.170640] Dynamic subtest userptr: SUCCESS (6.346s)
[185.172693] Subtest engines: SUCCESS (37.043s)
[185.609477] [028/161] (856s left) gem_exec_store (basic)
[185.932664] Starting subtest: basic
[185.973253] Subtest basic: SUCCESS (0.054s)
[186.378750] [029/161] (855s left) gem_flink_basic (bad-flink)
[186.651181] Starting subtest: bad-flink
[186.654285] Subtest bad-flink: SUCCESS (0.000s)
[186.904412] [030/161] (855s left) gem_flink_basic (bad-open)
[187.163084] Starting subtest: bad-open
[187.165637] Subtest bad-open: SUCCESS (0.000s)
[187.400503] [031/161] (855s left) gem_flink_basic (basic)
[187.659277] Starting subtest: basic
[187.662522] Subtest basic: SUCCESS (0.000s)
[187.917600] [032/161] (854s left) gem_flink_basic (double-flink)
[188.185103] Starting subtest: double-flink
[188.189679] Subtest double-flink: SUCCESS (0.000s)
[188.435423] [033/161] (854s left) gem_flink_basic (flink-lifetime)
[188.700904] Starting subtest: flink-lifetime
[188.709713] Subtest flink-lifetime: SUCCESS (0.009s)
[188.976730] [034/161] (854s left) gem_huc_copy (huc-copy)
[189.256491] Subtest huc-copy: SKIP (0.000s)
[189.483647] [035/161] (853s left) gem_linear_blits (basic)
[190.077964] Starting subtest: basic
[190.157196] Subtest basic: SUCCESS (0.074s)
[190.458400] [036/161] (853s left) gem_mmap (basic)
[190.872768] Starting subtest: basic
[190.884120] Subtest basic: SUCCESS (0.001s)
[191.140526] [037/161] (852s left) gem_mmap_gtt (basic)
[191.395760] Starting subtest: basic
[191.398614] Subtest basic: SUCCESS (0.003s)
[191.661397] [038/161] (852s left) gem_render_linear_blits (basic)
[191.958627] Starting subtest: basic
[192.088259] Subtest basic: SUCCESS (0.127s)
[192.306753] [039/161] (851s left) gem_render_tiled_blits (basic)
[192.591383] Starting subtest: basic
[192.779400] Subtest basic: SUCCESS (0.181s)
[193.014879] [040/161] (851s left) gem_ringfill (basic-all)
[193.517420] Starting subtest: basic-all
[194.946474] Subtest basic-all: SUCCESS (1.428s)
[195.232539] [041/161] (849s left) gem_softpin (allocator-basic)
[195.510737] Starting subtest: allocator-basic
[195.873111] Subtest allocator-basic: SUCCESS (0.361s)
[196.206188] [042/161] (848s left) gem_softpin (allocator-basic-reserve)
[196.481815] Starting subtest: allocator-basic-reserve
[196.857669] Subtest allocator-basic-reserve: SUCCESS (0.372s)
[197.177265] [043/161] (847s left) gem_softpin (safe-alignment)
[197.464611] Starting subtest: safe-alignment
[197.509579] Subtest safe-alignment: SUCCESS (0.043s)
[197.783303] [044/161] (847s left) gem_sync (basic-all)
[198.116452] Starting subtest: basic-all
[201.209299] Subtest basic-all: SUCCESS (3.093s)
[201.607555] [045/161] (843s left) gem_sync (basic-each)
[201.932707] Starting subtest: basic-each
[204.682189] Subtest basic-each: SUCCESS (2.748s)
[205.090482] [046/161] (840s left) gem_tiled_blits (basic)
[205.611356] Starting subtest: basic
[205.706199] Subtest basic: SUCCESS (0.090s)
[206.014887] [047/161] (839s left) gem_tiled_fence_blits (basic)
[206.683834] Starting subtest: basic
[206.749746] Subtest basic: SUCCESS (0.068s)
[207.068418] [048/161] (838s left) gem_tiled_pread_basic
[208.582259] [049/161] (837s left) gem_wait (busy@all-engines)
[208.944870] Starting subtest: busy
[208.949265] Starting dynamic subtest: all-engines
[209.468426] Dynamic subtest all-engines: SUCCESS (0.532s)
[209.472176] Subtest busy: SUCCESS (0.534s)
[209.962255] [050/161] (836s left) gem_wait (wait@all-engines)
[210.305983] Starting subtest: wait
[210.308441] Starting dynamic subtest: all-engines
[211.358219] Dynamic subtest all-engines: SUCCESS (1.049s)
[211.359987] Subtest wait: SUCCESS (1.052s)
[211.869486] [051/161] (834s left) i915_getparams_basic (basic-eu-total)
[212.134277] Starting subtest: basic-eu-total
[212.140784] Subtest basic-eu-total: SUCCESS (0.000s)
[212.399720] [052/161] (834s left) i915_getparams_basic (basic-subslice-total)
[212.661437] Starting subtest: basic-subslice-total
[212.666750] Subtest basic-subslice-total: SUCCESS (0.000s)
[212.935237] [053/161] (834s left) i915_hangman (error-state-basic)
[213.234279] Starting subtest: error-state-basic
[213.270734] Subtest error-state-basic: SUCCESS (0.025s)
[213.555346] [054/161] (833s left) i915_pciid
[214.053542] [055/161] (833s left) kms_addfb_basic (addfb25-4-tiled)
[214.783773] Starting subtest: addfb25-4-tiled
[214.787247] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[215.034349] [056/161] (832s left) kms_addfb_basic (addfb25-bad-modifier)
[215.751447] Starting subtest: addfb25-bad-modifier
[215.760187] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[216.021896] [057/161] (831s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[216.764916] Starting subtest: addfb25-framebuffer-vs-set-tiling
[216.767705] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[217.031586] [058/161] (831s left) kms_addfb_basic (addfb25-modifier-no-flag)
[217.751584] Starting subtest: addfb25-modifier-no-flag
[217.754642] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[218.006679] [059/161] (830s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[218.750594] Starting subtest: addfb25-x-tiled-legacy
[218.752487] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[219.013105] [060/161] (829s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[219.778753] Starting subtest: addfb25-x-tiled-mismatch-legacy
[219.782195] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[220.041930] [061/161] (828s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[220.809692] Starting subtest: addfb25-yf-tiled-legacy
[220.816314] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[221.070843] [062/161] (827s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[221.826605] Starting subtest: addfb25-y-tiled-legacy
[221.829211] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[222.086307] [063/161] (826s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[222.847164] Starting subtest: addfb25-y-tiled-small-legacy
[222.850953] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[223.104755] [064/161] (826s left) kms_addfb_basic (bad-pitch-0)
[223.374382] Starting subtest: bad-pitch-0
[223.378725] Subtest bad-pitch-0: SUCCESS (0.000s)
[224.115779] [065/161] (825s left) kms_addfb_basic (bad-pitch-1024)
[224.384208] Starting subtest: bad-pitch-1024
[224.388191] Subtest bad-pitch-1024: SUCCESS (0.000s)
[225.130459] [066/161] (824s left) kms_addfb_basic (bad-pitch-128)
[225.406357] Starting subtest: bad-pitch-128
[225.408453] Subtest bad-pitch-128: SUCCESS (0.000s)
[226.126942] [067/161] (823s left) kms_addfb_basic (bad-pitch-256)
[226.389579] Starting subtest: bad-pitch-256
[226.394155] Subtest bad-pitch-256: SUCCESS (0.000s)
[227.122383] [068/161] (822s left) kms_addfb_basic (bad-pitch-32)
[227.397969] Starting subtest: bad-pitch-32
[227.401246] Subtest bad-pitch-32: SUCCESS (0.000s)
[228.137301] [069/161] (822s left) kms_addfb_basic (bad-pitch-63)
[228.400347] Starting subtest: bad-pitch-63
[228.402939] Subtest bad-pitch-63: SUCCESS (0.000s)
[229.127391] [070/161] (821s left) kms_addfb_basic (bad-pitch-65536)
[229.381807] Starting subtest: bad-pitch-65536
[229.385436] Subtest bad-pitch-65536: SUCCESS (0.002s)
[230.135911] [071/161] (820s left) kms_addfb_basic (bad-pitch-999)
[230.393831] Starting subtest: bad-pitch-999
[230.397664] Subtest bad-pitch-999: SUCCESS (0.000s)
[231.129603] [072/161] (819s left) kms_addfb_basic (basic)
[231.403648] Starting subtest: basic
[231.405464] Subtest basic: SUCCESS (0.000s)
[232.124839] [073/161] (818s left) kms_addfb_basic (basic-x-tiled-legacy)
[232.392117] Starting subtest: basic-x-tiled-legacy
[232.394596] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[233.124222] [074/161] (818s left) kms_addfb_basic (basic-y-tiled-legacy)
[233.396322] Starting subtest: basic-y-tiled-legacy
[233.399115] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[234.135952] [075/161] (817s left) kms_addfb_basic (bo-too-small)
[234.861452] Starting subtest: bo-too-small
[234.865498] Subtest bo-too-small: SUCCESS (0.001s)
[235.226768] [076/161] (816s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[236.002661] Starting subtest: bo-too-small-due-to-tiling
[236.006680] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[236.255479] [077/161] (815s left) kms_addfb_basic (clobberred-modifier)
[236.525761] Starting subtest: clobberred-modifier
[236.527639] Subtest clobberred-modifier: SUCCESS (0.000s)
[237.249658] [078/161] (814s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[237.528307] Starting subtest: framebuffer-vs-set-tiling
[237.530424] Subtest framebuffer-vs-set-tiling: SUCCESS (0.002s)
[238.253663] [079/161] (814s left) kms_addfb_basic (invalid-get-prop)
[238.517942] Starting subtest: invalid-get-prop
[238.519826] Subtest invalid-get-prop: SUCCESS (0.000s)
[239.255945] [080/161] (813s left) kms_addfb_basic (invalid-get-prop-any)
[239.528838] Starting subtest: invalid-get-prop-any
[239.533084] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[240.254914] [081/161] (812s left) kms_addfb_basic (invalid-set-prop)
[240.527986] Starting subtest: invalid-set-prop
[240.532622] Subtest invalid-set-prop: SUCCESS (0.000s)
[241.278352] [082/161] (811s left) kms_addfb_basic (invalid-set-prop-any)
[241.549289] Starting subtest: invalid-set-prop-any
[241.551613] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[242.269716] [083/161] (810s left) kms_addfb_basic (no-handle)
[242.536779] Starting subtest: no-handle
[242.540214] Subtest no-handle: SUCCESS (0.000s)
[243.292932] [084/161] (810s left) kms_addfb_basic (size-max)
[244.053057] Starting subtest: size-max
[244.057445] Subtest size-max: SUCCESS (0.000s)
[244.304557] [085/161] (809s left) kms_addfb_basic (small-bo)
[245.052216] Starting subtest: small-bo
[245.055684] Subtest small-bo: SUCCESS (0.000s)
[245.311894] [086/161] (808s left) kms_addfb_basic (tile-pitch-mismatch)
[245.594953] Starting subtest: tile-pitch-mismatch
[245.598643] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[246.357552] [087/161] (807s left) kms_addfb_basic (too-high)
[247.090589] Starting subtest: too-high
[247.092365] Subtest too-high: SUCCESS (0.007s)
[247.362622] [088/161] (806s left) kms_addfb_basic (too-wide)
[248.109593] Starting subtest: too-wide
[248.113530] Subtest too-wide: SUCCESS (0.000s)
[248.368359] [089/161] (806s left) kms_addfb_basic (unused-handle)
[248.640939] Starting subtest: unused-handle
[248.644670] Subtest unused-handle: SUCCESS (0.000s)
[249.370353] [090/161] (805s left) kms_addfb_basic (unused-modifier)
[249.648255] Starting subtest: unused-modifier
[249.649964] Subtest unused-modifier: SUCCESS (0.000s)
[250.491844] [091/161] (804s left) kms_addfb_basic (unused-offsets)
[250.769598] Starting subtest: unused-offsets
[250.772379] Subtest unused-offsets: SUCCESS (0.000s)
[251.548096] [092/161] (803s left) kms_addfb_basic (unused-pitches)
[251.809447] Starting subtest: unused-pitches
[251.813601] Subtest unused-pitches: SUCCESS (0.000s)
[252.559922] [093/161] (802s left) kms_busy (basic)
[253.325467] Starting subtest: basic
[253.332348] Starting dynamic subtest: flip
[254.437273] Dynamic subtest flip: SUCCESS (1.089s)
[254.509261] Starting dynamic subtest: modeset
[256.432093] Dynamic subtest modeset: SUCCESS (1.995s)
[256.437246] Subtest basic: SUCCESS (3.110s)
[257.183175] [094/161] (798s left) kms_prop_blob (basic)
[257.447616] Starting subtest: basic
[257.451714] Subtest basic: SUCCESS (0.000s)
[257.709489] [095/161] (797s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[258.466123] Starting subtest: basic-busy-flip-before-cursor-atomic
[259.542407] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.075s)
[260.222770] [096/161] (795s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[260.998605] Starting subtest: basic-busy-flip-before-cursor-legacy
[262.060149] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.061s)
[262.790716] [097/161] (793s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[263.579159] Starting subtest: basic-flip-after-cursor-atomic
[264.626434] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.043s)
[265.465992] [098/161] (790s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[266.224632] Starting subtest: basic-flip-after-cursor-legacy
[267.263772] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.034s)
[267.878773] [099/161] (788s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[268.674600] Starting subtest: basic-flip-after-cursor-varying-size
[269.715694] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.048s)
[270.323513] [100/161] (786s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[271.099054] Starting subtest: basic-flip-before-cursor-atomic
[272.143832] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.042s)
[272.760948] [101/161] (784s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[273.526600] Starting subtest: basic-flip-before-cursor-legacy
[274.569172] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.039s)
[275.191841] [102/161] (781s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[275.984646] Starting subtest: basic-flip-before-cursor-varying-size
[277.024507] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s)
[277.683533] [103/161] (779s left) kms_dsc (dsc-basic)
[278.469440] Subtest dsc-basic: SKIP (0.000s)
[278.683829] [104/161] (778s left) kms_flip (basic-flip-vs-dpms)
[279.441977] Starting subtest: basic-flip-vs-dpms
[279.459784] Starting dynamic subtest: C-HDMI-A2
[282.466277] Dynamic subtest C-HDMI-A2: SUCCESS (3.005s)
[282.476954] Subtest basic-flip-vs-dpms: SUCCESS (3.033s)
[283.145200] [105/161] (774s left) kms_flip (basic-flip-vs-modeset)
[283.942644] Starting subtest: basic-flip-vs-modeset
[283.960748] Starting dynamic subtest: C-HDMI-A2
[286.677451] Dynamic subtest C-HDMI-A2: SUCCESS (2.708s)
[286.689209] Subtest basic-flip-vs-modeset: SUCCESS (2.733s)
[287.499115] [106/161] (770s left) kms_flip (basic-flip-vs-wf_vblank)
[288.311950] Starting subtest: basic-flip-vs-wf_vblank
[288.327301] Starting dynamic subtest: C-HDMI-A2
[291.125436] Dynamic subtest C-HDMI-A2: SUCCESS (2.791s)
[291.127379] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.817s)
[291.473532] [107/161] (766s left) kms_flip (basic-plain-flip)
[292.202712] Starting subtest: basic-plain-flip
[292.212284] Starting dynamic subtest: C-HDMI-A2
[294.707229] Dynamic subtest C-HDMI-A2: SUCCESS (2.492s)
[294.709177] Subtest basic-plain-flip: SUCCESS (2.514s)
[295.065438] [108/161] (763s left) kms_force_connector_basic (force-connector-state)
[295.512796] Starting subtest: force-connector-state
[296.439199] Subtest force-connector-state: SUCCESS (0.920s)
[298.051399] [109/161] (760s left) kms_force_connector_basic (force-edid)
[298.469360] Starting subtest: force-edid
[298.593299] Subtest force-edid: SUCCESS (0.111s)
[299.492932] [110/161] (759s left) kms_force_connector_basic (force-load-detect)
[299.894257] Starting subtest: force-load-detect
[299.898812] Subtest force-load-detect: SKIP (0.000s)
[300.583512] [111/161] (758s left) kms_force_connector_basic (prune-stale-modes)
[301.029651] Starting subtest: prune-stale-modes
[301.223629] Subtest prune-stale-modes: SUCCESS (0.198s)
[302.231448] [112/161] (757s left) kms_frontbuffer_tracking (basic)
[303.056135] Starting subtest: basic
[308.045869] Subtest basic: SUCCESS (4.993s)
[308.340542] [113/161] (751s left) kms_hdmi_inject (inject-audio)
[308.734874] Starting subtest: inject-audio
[309.469525] Subtest inject-audio: SUCCESS (0.738s)
[310.590912] [114/161] (749s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[311.432693] Starting subtest: compare-crc-sanitycheck-xr24
[311.434504] Starting dynamic subtest: pipe-C-HDMI-A-2
[312.011676] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.569s)
[312.016941] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.581s)
[312.673648] [115/161] (747s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[313.465424] Starting subtest: compare-crc-sanitycheck-nv12
[313.469720] Starting dynamic subtest: pipe-C-HDMI-A-2
[313.473388] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.004s)
[313.486754] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[313.738810] [116/161] (746s left) kms_pipe_crc_basic (hang-read-crc)
[314.497660] Starting subtest: hang-read-crc
[314.513198] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.180561] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.673s)
[316.186284] Subtest hang-read-crc: SUCCESS (1.687s)
[316.825649] [117/161] (743s left) kms_pipe_crc_basic (nonblocking-crc)
[317.601154] Starting subtest: nonblocking-crc
[317.610189] Starting dynamic subtest: pipe-C-HDMI-A-2
[318.329429] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.718s)
[318.332243] Subtest nonblocking-crc: SUCCESS (0.732s)
[318.976745] [118/161] (741s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[319.746688] Starting subtest: nonblocking-crc-frame-sequence
[319.749574] Starting dynamic subtest: pipe-C-HDMI-A-2
[320.510392] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.758s)
[320.513649] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.768s)
[321.116529] [119/161] (739s left) kms_pipe_crc_basic (read-crc)
[321.896530] Starting subtest: read-crc
[321.899533] Starting dynamic subtest: pipe-C-HDMI-A-2
[322.615786] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.705s)
[322.617799] Subtest read-crc: SUCCESS (0.721s)
[323.245208] [120/161] (737s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[323.997732] Starting subtest: read-crc-frame-sequence
[324.010150] Starting dynamic subtest: pipe-C-HDMI-A-2
[324.674614] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.664s)
[324.679811] Subtest read-crc-frame-sequence: SUCCESS (0.682s)
[325.362877] [121/161] (735s left) kms_pm_backlight (basic-brightness)
[326.090118] Subtest basic-brightness: SKIP (0.000s)
[326.296257] [122/161] (735s left) kms_pm_rpm (basic-pci-d3-state)
[328.744157] Starting subtest: basic-pci-d3-state
[329.128584] Subtest basic-pci-d3-state: SUCCESS (0.373s)
[329.643535] [123/161] (732s left) kms_pm_rpm (basic-rte)
[329.902101] Starting subtest: basic-rte
[332.401651] Subtest basic-rte: SUCCESS (2.495s)
[333.555506] [124/161] (728s left) kms_psr (psr-primary-page-flip)
[334.376950] Subtest psr-primary-page-flip: SKIP (0.000s)
[334.617929] [125/161] (727s left) kms_psr (psr-cursor-plane-move)
[335.413898] Subtest psr-cursor-plane-move: SKIP (0.000s)
[335.655867] [126/161] (726s left) kms_psr (psr-sprite-plane-onoff)
[336.487343] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[336.753648] [127/161] (725s left) kms_psr (psr-primary-mmap-gtt)
[337.526940] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[337.770243] [128/161] (725s left) kms_setmode (basic-clone-single-crtc)
[338.052684] Starting subtest: basic-clone-single-crtc
[338.057824] Subtest basic-clone-single-crtc: SKIP (0.001s)
[338.326991] [129/161] (724s left) i915_pm_rps (basic-api)
[338.614354] Starting subtest: basic-api
[338.634275] Subtest basic-api: SUCCESS (0.017s)
[338.896800] [130/161] (724s left) prime_self_import (basic-llseek-bad)
[339.167571] Starting subtest: basic-llseek-bad
[339.172301] Subtest basic-llseek-bad: SUCCESS (0.011s)
[339.433626] [131/161] (724s left) prime_self_import (basic-llseek-size)
[339.690940] Starting subtest: basic-llseek-size
[339.705172] Subtest basic-llseek-size: SUCCESS (0.016s)
[339.964690] [132/161] (723s left) prime_self_import (basic-with_fd_dup)
[340.257680] Starting subtest: basic-with_fd_dup
[340.263175] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[340.523723] [133/161] (723s left) prime_self_import (basic-with_one_bo)
[340.795034] Starting subtest: basic-with_one_bo
[340.802907] Subtest basic-with_one_bo: SUCCESS (0.017s)
[341.051356] [134/161] (723s left) prime_self_import (basic-with_one_bo_two_files)
[341.311547] Starting subtest: basic-with_one_bo_two_files
[341.320649] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[341.599445] [135/161] (722s left) prime_self_import (basic-with_two_bos)
[341.860266] Starting subtest: basic-with_two_bos
[341.874905] Subtest basic-with_two_bos: SUCCESS (0.017s)
[342.126136] [136/161] (722s left) prime_vgem (basic-fence-flip)
[342.447788] Starting subtest: basic-fence-flip
[343.326569] Subtest basic-fence-flip: SKIP (0.877s)
[343.643377] [137/161] (721s left) prime_vgem (basic-fence-mmap)
[343.945406] Starting subtest: basic-fence-mmap
[344.075822] Subtest basic-fence-mmap: SUCCESS (0.131s)
[344.375920] [138/161] (720s left) prime_vgem (basic-fence-read)
[344.700665] Starting subtest: basic-fence-read
[344.960399] Subtest basic-fence-read: SUCCESS (0.266s)
[345.265878] [139/161] (719s left) prime_vgem (basic-gtt)
[345.554434] Starting subtest: basic-gtt
[345.604482] Subtest basic-gtt: SUCCESS (0.050s)
[345.890450] [140/161] (719s left) prime_vgem (basic-read)
[346.187416] Starting subtest: basic-read
[346.303350] Subtest basic-read: SUCCESS (0.111s)
[346.557483] [141/161] (719s left) prime_vgem (basic-write)
[346.861355] Starting subtest: basic-write
[347.012186] Subtest basic-write: SUCCESS (0.156s)
[347.310601] [142/161] (718s left) vgem_basic (setversion)
[347.582049] Starting subtest: setversion
[347.587247] Subtest setversion: SUCCESS (0.000s)
[347.821679] [143/161] (718s left) vgem_basic (create)
[348.103789] Starting subtest: create
[348.106667] Subtest create: SUCCESS (0.004s)
[348.370328] [144/161] (717s left) vgem_basic (debugfs)
[348.661243] Starting subtest: debugfs
[348.662941] Subtest debugfs: SUCCESS (0.002s)
[348.886889] [145/161] (717s left) vgem_basic (dmabuf-export)
[349.172766] Starting subtest: dmabuf-export
[349.178329] Subtest dmabuf-export: SUCCESS (0.012s)
[349.442727] [146/161] (717s left) vgem_basic (dmabuf-fence)
[349.738659] Starting subtest: dmabuf-fence
[349.743427] Subtest dmabuf-fence: SUCCESS (0.002s)
[349.987686] [147/161] (716s left) vgem_basic (dmabuf-fence-before)
[350.270103] Starting subtest: dmabuf-fence-before
[350.272644] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[350.507218] [148/161] (716s left) vgem_basic (dmabuf-mmap)
[350.783578] Starting subtest: dmabuf-mmap
[350.833526] Subtest dmabuf-mmap: SUCCESS (0.053s)
[351.071717] [149/161] (716s left) vgem_basic (mmap)
[351.350682] Starting subtest: mmap
[351.377312] Subtest mmap: SUCCESS (0.032s)
[351.618262] [150/161] (715s left) vgem_basic (second-client)
[351.906340] Starting subtest: second-client
[351.972162] Subtest second-client: SUCCESS (0.063s)
[352.211398] [151/161] (715s left) vgem_basic (sysfs)
[352.509691] Starting subtest: sysfs
[352.512171] Subtest sysfs: SUCCESS (0.002s)
[352.739205] [152/161] (715s left) core_hotunplug (unbind-rebind)
[353.216053] Starting subtest: unbind-rebind
[359.518335] Subtest unbind-rebind: SUCCESS (6.286s)
[359.751212] [153/161] (708s left) vgem_basic (unload)
[360.027887] Starting subtest: unload
[389.294056] Subtest unload: SUCCESS (29.267s)
[389.716173] [154/161] (678s left) i915_module_load (reload)
[389.978572] Starting subtest: reload
[397.691176] Subtest reload: SUCCESS (7.705s)
[398.152685] [155/161] (670s left) gem_lmem_swapping (basic)
[398.714675] Subtest basic: SKIP (0.000s)
[399.200138] [156/161] (669s left) gem_lmem_swapping (parallel-random-engines)
[399.652867] Subtest parallel-random-engines: SKIP (0.000s)
[399.881633] [157/161] (669s left) gem_lmem_swapping (random-engines)
[400.206342] Subtest random-engines: SKIP (0.000s)
[400.444144] [158/161] (669s left) gem_lmem_swapping (verify-random)
[400.737947] Subtest verify-random: SKIP (0.000s)
[400.958164] [159/161] (668s left) i915_pm_rpm (module-reload)
[403.634325] Starting subtest: module-reload
[423.277280] Subtest module-reload: SUCCESS (19.645s)
[423.425926] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[423.431989] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[423.448574] [160/161] (646s left) i915_selftest (live)
[423.737713] Starting subtest: live
[423.741492] Starting dynamic subtest: sanitycheck
[428.536149] Dynamic subtest sanitycheck: SUCCESS (4.791s)
[428.564188] Starting dynamic subtest: uncore
[433.000416] Dynamic subtest uncore: SUCCESS (4.459s)
[433.039410] Starting dynamic subtest: workarounds
[437.797284] Dynamic subtest workarounds: SUCCESS (4.791s)
[437.831937] Starting dynamic subtest: gt_engines
[442.957647] Dynamic subtest gt_engines: SUCCESS (5.147s)
[443.001898] Starting dynamic subtest: gt_timelines
[475.439392] Dynamic subtest gt_timelines: SUCCESS (32.469s)
[475.501249] Starting dynamic subtest: gt_contexts
[480.317764] Dynamic subtest gt_contexts: SUCCESS (4.859s)
[480.365463] Starting dynamic subtest: gt_lrc
[488.277455] Dynamic subtest gt_lrc: SUCCESS (7.955s)
[488.329245] Starting dynamic subtest: gt_mocs
[492.892312] Dynamic subtest gt_mocs: SUCCESS (4.602s)
[492.928044] Starting dynamic subtest: gt_pm
[498.557231] Dynamic subtest gt_pm: SUCCESS (5.650s)
[498.608275] Starting dynamic subtest: gt_heartbeat
[503.241993] Dynamic subtest gt_heartbeat: SUCCESS (4.677s)
[503.279925] Starting dynamic subtest: gt_tlb
[508.347612] Dynamic subtest gt_tlb: SUCCESS (5.092s)
[508.390092] Starting dynamic subtest: requests
[519.424066] Dynamic subtest requests: SUCCESS (11.066s)
[519.452534] Starting dynamic subtest: migrate
[527.944264] Dynamic subtest migrate: SUCCESS (8.509s)
[528.006319] Starting dynamic subtest: active
[532.760943] Dynamic subtest active: SUCCESS (4.808s)
[532.806737] Starting dynamic subtest: objects
[539.697178] Dynamic subtest objects: SUCCESS (6.922s)
[539.730088] Starting dynamic subtest: mman
[551.144833] Dynamic subtest mman: SUCCESS (11.441s)
[551.189125] Starting dynamic subtest: dmabuf
[555.723179] Dynamic subtest dmabuf: SUCCESS (4.563s)
[555.777073] Starting dynamic subtest: vma
[560.395553] Dynamic subtest vma: SUCCESS (4.658s)
[560.432818] Starting dynamic subtest: coherency
[569.955045] Dynamic subtest coherency: SUCCESS (9.547s)
[569.987417] Starting dynamic subtest: gtt
[582.141467] Dynamic subtest gtt: SUCCESS (12.177s)
[582.176139] Starting dynamic subtest: gem
[587.969224] Dynamic subtest gem: SUCCESS (5.815s)
[588.051068] Starting dynamic subtest: evict
[599.377805] Dynamic subtest evict: SUCCESS (11.400s)
[599.425251] Starting dynamic subtest: hugepages
[604.571049] Dynamic subtest hugepages: SUCCESS (5.184s)
[604.643873] Starting dynamic subtest: gem_contexts
[633.662389] Dynamic subtest gem_contexts: SUCCESS (29.074s)
[633.699449] Starting dynamic subtest: client
[638.278255] Dynamic subtest client: SUCCESS (4.601s)
[638.329170] Starting dynamic subtest: gem_migrate
[642.981383] Dynamic subtest gem_migrate: SUCCESS (4.691s)
[643.026713] Starting dynamic subtest: reset
[655.967876] Dynamic subtest reset: SUCCESS (12.985s)
[656.016349] Starting dynamic subtest: memory_region
[660.393815] Dynamic subtest memory_region: SUCCESS (4.413s)
[660.445435] Starting dynamic subtest: hangcheck
[688.385194] Dynamic subtest hangcheck: SUCCESS (27.967s)
[688.421050] Starting dynamic subtest: execlists
[699.691101] Dynamic subtest execlists: SUCCESS (11.294s)
[699.741368] Starting dynamic subtest: ring_submission
[704.297786] Dynamic subtest ring_submission: SUCCESS (4.593s)
[704.331563] Starting dynamic subtest: perf
[709.286204] Dynamic subtest perf: SUCCESS (4.979s)
[709.334215] Starting dynamic subtest: slpc
[713.792772] Dynamic subtest slpc: SUCCESS (4.498s)
[713.836711] Starting dynamic subtest: guc
[718.099436] Dynamic subtest guc: SUCCESS (4.298s)
[718.169294] Starting dynamic subtest: guc_multi_lrc
[722.391816] Dynamic subtest guc_multi_lrc: SUCCESS (4.277s)
[722.421598] Starting dynamic subtest: guc_hang
[727.084981] Dynamic subtest guc_hang: SUCCESS (4.689s)
[727.147261] Starting dynamic subtest: late_gt_pm
[731.899282] Dynamic subtest late_gt_pm: SUCCESS (4.805s)
[731.904205] Subtest live: SUCCESS (308.160s)
[732.068832] [161/161] (338s left) dmabuf (all-tests)
[732.378515] Starting subtest: all-tests
[732.381085] Starting dynamic subtest: sanitycheck
[732.459931] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[732.511274] Starting dynamic subtest: dma_fence
[732.782533] Dynamic subtest dma_fence: SUCCESS (0.315s)
[732.818452] Starting dynamic subtest: dma_fence_chain