[154.654657] Initializing watchdogs
[154.656133]   /dev/watchdog0
[154.856654] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a001 Intel Pineview (Gen3) Atom Processor D4xx/D5xx/N4xx/N5xx Integrated Graphics Controller (DeskTop Board D510MO)
[154.906455] [001/161] (960s left) i915_module_load (load)
[156.837294] Starting subtest: load
[164.422787] Subtest load: SUCCESS (7.592s)
[164.796529] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[164.808345] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[164.835673] [002/161] (950s left) core_auth (basic-auth)
[165.354281] Starting subtest: basic-auth
[165.359188] Subtest basic-auth: SUCCESS (0.005s)
[165.659840] [003/161] (950s left) debugfs_test (read_all_entries)
[166.137988] Starting subtest: read_all_entries
[166.356912] Subtest read_all_entries: SUCCESS (0.215s)
[166.705776] [004/161] (949s left) debugfs_test (basic-hwmon)
[167.163779] Starting subtest: basic-hwmon
[167.172988] Subtest basic-hwmon: SKIP (0.000s)
[167.515150] [005/161] (949s left) debugfs_test (sysfs)
[167.991680] Starting subtest: sysfs
[168.145118] Subtest sysfs: SUCCESS (0.155s)
[168.626418] [006/161] (948s left) fbdev (eof)
[169.114773] Starting subtest: eof
[169.119561] Subtest eof: SUCCESS (0.002s)
[169.413242] [007/161] (947s left) fbdev (info)
[169.853509] Starting subtest: info
[169.858437] Subtest info: SUCCESS (0.000s)
[170.146782] [008/161] (947s left) fbdev (nullptr)
[170.593463] Starting subtest: nullptr
[170.598473] Subtest nullptr: SUCCESS (0.001s)
[170.894941] [009/161] (946s left) fbdev (read)
[171.345479] Starting subtest: read
[171.660249] Subtest read: SUCCESS (0.314s)
[171.964498] [010/161] (946s left) fbdev (write)
[172.416211] Starting subtest: write
[172.594629] Subtest write: SUCCESS (0.183s)
[172.895516] [011/161] (945s left) gem_basic (bad-close)
[173.344626] Starting subtest: bad-close
[173.351670] Subtest bad-close: SUCCESS (0.000s)
[173.648623] [012/161] (944s left) gem_basic (create-close)
[174.097516] Starting subtest: create-close
[174.105712] Subtest create-close: SUCCESS (0.001s)
[174.399488] [013/161] (944s left) gem_basic (create-fd-close)
[174.845438] Starting subtest: create-fd-close
[174.855387] Subtest create-fd-close: SUCCESS (0.001s)
[175.169941] [014/161] (944s left) gem_busy (busy@all-engines)
[175.706786] Starting subtest: busy
[175.711457] Starting dynamic subtest: all-engines
[175.845531] Dynamic subtest all-engines: SUCCESS (0.141s)
[175.849856] Subtest busy: SUCCESS (0.146s)
[176.552210] [015/161] (942s left) gem_close_race (basic-process)
[177.081383] Starting subtest: basic-process
[177.294501] Subtest basic-process: SUCCESS (0.218s)
[177.758270] [016/161] (941s left) gem_close_race (basic-threads)
[178.283813] Starting subtest: basic-threads
[179.956538] Subtest basic-threads: SUCCESS (1.676s)
[180.407372] [017/161] (939s left) gem_ctx_create (basic)
[180.870122] Subtest basic: SKIP (0.000s)
[181.164960] [018/161] (939s left) gem_ctx_create (basic-files)
[181.629502] Subtest basic-files: SKIP (0.000s)
[181.912143] [019/161] (938s left) gem_ctx_exec (basic)
[182.365689] Subtest basic: SKIP (0.000s)
[182.662457] [020/161] (938s left) gem_exec_basic (basic)
[183.217271] Starting subtest: basic
[183.221814] Starting dynamic subtest: rcs0-smem
[183.226606] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[183.231505] Subtest basic: SUCCESS (0.009s)
[183.710493] [021/161] (937s left) gem_exec_create (basic)
[184.252220] Starting subtest: basic
[184.257293] Starting dynamic subtest: smem
[186.422917] Dynamic subtest smem: SUCCESS (2.169s)
[186.426822] Subtest basic: SUCCESS (2.172s)
[186.875383] [022/161] (934s left) gem_exec_fence (basic-busy)
[187.621438] Starting subtest: basic-busy
[187.629596] Starting dynamic subtest: rcs0
[187.667133] Dynamic subtest rcs0: SUCCESS (0.043s)
[187.670907] Subtest basic-busy: SUCCESS (0.048s)
[188.872518] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[188.884899] [023/161] (932s left) gem_exec_fence (basic-wait)
[189.639219] Starting subtest: basic-wait
[189.643970] Starting dynamic subtest: rcs0
[189.671817] Dynamic subtest rcs0: SUCCESS (0.036s)
[189.676105] Subtest basic-wait: SUCCESS (0.039s)
[190.681778] [024/161] (931s left) gem_exec_fence (basic-await)
[191.469785] Starting subtest: basic-await
[191.476844] Starting dynamic subtest: rcs0
[191.635300] Dynamic subtest rcs0: SUCCESS (0.158s)
[191.640684] Subtest basic-await: SUCCESS (0.164s)
[192.659576] [025/161] (929s left) gem_exec_fence (nb-await)
[193.410864] Starting subtest: nb-await
[193.415889] Starting dynamic subtest: rcs0
[193.482089] Dynamic subtest rcs0: SUCCESS (0.068s)
[193.485963] Subtest nb-await: SUCCESS (0.072s)
[194.451654] [026/161] (928s left) gem_exec_gttfill (basic)
[194.985983] Starting subtest: basic
[205.046804] Subtest basic: SUCCESS (10.061s)
[205.625392] [027/161] (917s left) gem_exec_parallel (engines)
[206.389150] Starting subtest: engines
[206.393678] Starting dynamic subtest: basic
[210.545775] Dynamic subtest basic: SUCCESS (4.161s)
[210.603492] Starting dynamic subtest: contexts
[210.611259] Dynamic subtest contexts: SKIP (0.004s)
[210.662397] Starting dynamic subtest: fds
[210.669192] Dynamic subtest fds: SKIP (0.004s)
[210.719259] Starting dynamic subtest: userptr
[214.860737] Dynamic subtest userptr: SUCCESS (4.297s)
[214.864159] Subtest engines: SUCCESS (8.478s)
[215.361216] [028/161] (907s left) gem_exec_store (basic)
[215.889228] Starting subtest: basic
[215.939361] Subtest basic: SUCCESS (0.051s)
[216.433645] [029/161] (907s left) gem_flink_basic (bad-flink)
[216.889854] Starting subtest: bad-flink
[216.895602] Subtest bad-flink: SUCCESS (0.000s)
[217.250664] [030/161] (906s left) gem_flink_basic (bad-open)
[217.700621] Starting subtest: bad-open
[217.704462] Subtest bad-open: SUCCESS (0.000s)
[218.053268] [031/161] (906s left) gem_flink_basic (basic)
[218.494763] Starting subtest: basic
[218.500274] Subtest basic: SUCCESS (0.001s)
[218.856085] [032/161] (905s left) gem_flink_basic (double-flink)
[219.306316] Starting subtest: double-flink
[219.311715] Subtest double-flink: SUCCESS (0.001s)
[219.671245] [033/161] (905s left) gem_flink_basic (flink-lifetime)
[220.122929] Starting subtest: flink-lifetime
[220.128250] Subtest flink-lifetime: SUCCESS (0.011s)
[220.499785] [034/161] (904s left) gem_huc_copy (huc-copy)
[220.961989] Subtest huc-copy: SKIP (0.000s)
[221.291878] [035/161] (904s left) gem_linear_blits (basic)
[222.072122] Starting subtest: basic
[222.124467] Subtest basic: SUCCESS (0.053s)
[222.572531] [036/161] (903s left) gem_mmap (basic)
[223.270329] Starting subtest: basic
[223.289575] Subtest basic: SUCCESS (0.003s)
[223.625314] [037/161] (902s left) gem_mmap_gtt (basic)
[224.076665] Starting subtest: basic
[224.081822] Subtest basic: SUCCESS (0.004s)
[224.431131] [038/161] (902s left) gem_render_linear_blits (basic)
[224.902879] Starting subtest: basic
[225.048237] Subtest basic: SUCCESS (0.145s)
[225.379818] [039/161] (901s left) gem_render_tiled_blits (basic)
[225.842247] Starting subtest: basic
[225.998541] Subtest basic: SUCCESS (0.157s)
[226.346898] [040/161] (900s left) gem_ringfill (basic-all)
[226.930216] Starting subtest: basic-all
[228.157277] Subtest basic-all: SUCCESS (1.224s)
[228.579638] [041/161] (898s left) gem_softpin (allocator-basic)
[229.043931] Subtest allocator-basic: SKIP (0.000s)
[229.387940] [042/161] (898s left) gem_softpin (allocator-basic-reserve)
[229.847401] Subtest allocator-basic-reserve: SKIP (0.000s)
[230.192659] [043/161] (897s left) gem_softpin (safe-alignment)
[230.651520] Starting subtest: safe-alignment
[230.665927] Subtest safe-alignment: SUCCESS (0.021s)
[231.022101] [044/161] (897s left) gem_sync (basic-all)
[231.552227] Starting subtest: basic-all
[233.725370] Subtest basic-all: SUCCESS (2.173s)
[234.227667] [045/161] (894s left) gem_sync (basic-each)
[234.771152] Starting subtest: basic-each
[236.949417] Subtest basic-each: SUCCESS (2.182s)
[237.448482] [046/161] (891s left) gem_tiled_blits (basic)
[238.269907] Starting subtest: basic
[238.374547] Subtest basic: SUCCESS (0.116s)
[238.821079] [047/161] (890s left) gem_tiled_fence_blits (basic)
[240.028559] Starting subtest: basic
[240.102787] Subtest basic: SUCCESS (0.071s)
[240.571121] [048/161] (889s left) gem_tiled_pread_basic
[243.229204] [049/161] (886s left) gem_wait (busy@all-engines)
[243.897865] Starting subtest: busy
[243.902871] Starting dynamic subtest: all-engines
[244.427503] Dynamic subtest all-engines: SUCCESS (0.533s)
[244.433969] Subtest busy: SUCCESS (0.538s)
[245.086955] [050/161] (885s left) gem_wait (wait@all-engines)
[245.671387] Starting subtest: wait
[245.676931] Starting dynamic subtest: all-engines
[246.718906] Dynamic subtest all-engines: SUCCESS (1.047s)
[246.724767] Subtest wait: SUCCESS (1.053s)
[247.384382] [051/161] (883s left) i915_getparams_basic (basic-eu-total)
[247.834068] Starting subtest: basic-eu-total
[247.841653] Subtest basic-eu-total: SUCCESS (0.000s)
[248.189753] [052/161] (882s left) i915_getparams_basic (basic-subslice-total)
[248.631383] Starting subtest: basic-subslice-total
[248.640905] Subtest basic-subslice-total: SUCCESS (0.000s)
[248.980659] [053/161] (882s left) i915_hangman (error-state-basic)
[249.458613] Starting subtest: error-state-basic
[249.853765] Subtest error-state-basic: SUCCESS (0.394s)
[250.243689] [054/161] (881s left) i915_pciid
[251.066914] [055/161] (881s left) kms_addfb_basic (addfb25-4-tiled)
[251.586103] Starting subtest: addfb25-4-tiled
[251.590899] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[251.973833] [056/161] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[252.548911] Starting subtest: addfb25-bad-modifier
[252.554961] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[252.932260] [057/161] (879s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[253.430619] Starting subtest: addfb25-framebuffer-vs-set-tiling
[253.435000] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[253.815999] [058/161] (879s left) kms_addfb_basic (addfb25-modifier-no-flag)
[254.317865] Starting subtest: addfb25-modifier-no-flag
[254.322588] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[254.700569] [059/161] (878s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[255.202153] Starting subtest: addfb25-x-tiled-legacy
[255.206757] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[255.582923] [060/161] (878s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[256.088576] Starting subtest: addfb25-x-tiled-mismatch-legacy
[256.093482] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[256.455172] [061/161] (877s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[256.973925] Starting subtest: addfb25-yf-tiled-legacy
[256.977915] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[257.343250] [062/161] (877s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[257.856471] Starting subtest: addfb25-y-tiled-legacy
[257.861463] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[258.236779] [063/161] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[258.771442] Starting subtest: addfb25-y-tiled-small-legacy
[258.780718] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[259.121664] [064/161] (876s left) kms_addfb_basic (bad-pitch-0)
[259.580574] Starting subtest: bad-pitch-0
[259.585116] Subtest bad-pitch-0: SUCCESS (0.000s)
[260.000418] [065/161] (875s left) kms_addfb_basic (bad-pitch-1024)
[260.455447] Starting subtest: bad-pitch-1024
[260.459593] Subtest bad-pitch-1024: SUCCESS (0.000s)
[260.891614] [066/161] (874s left) kms_addfb_basic (bad-pitch-128)
[261.343997] Starting subtest: bad-pitch-128
[261.348588] Subtest bad-pitch-128: SUCCESS (0.000s)
[261.758145] [067/161] (874s left) kms_addfb_basic (bad-pitch-256)
[262.212770] Starting subtest: bad-pitch-256
[262.217429] Subtest bad-pitch-256: SUCCESS (0.000s)
[262.642737] [068/161] (873s left) kms_addfb_basic (bad-pitch-32)
[263.096068] Starting subtest: bad-pitch-32
[263.099907] Subtest bad-pitch-32: SUCCESS (0.000s)
[263.502934] [069/161] (873s left) kms_addfb_basic (bad-pitch-63)
[263.953575] Starting subtest: bad-pitch-63
[263.957737] Subtest bad-pitch-63: SUCCESS (0.000s)
[264.397666] [070/161] (872s left) kms_addfb_basic (bad-pitch-65536)
[264.856570] Starting subtest: bad-pitch-65536
[264.861907] Subtest bad-pitch-65536: SUCCESS (0.002s)
[265.268231] [071/161] (872s left) kms_addfb_basic (bad-pitch-999)
[265.720562] Starting subtest: bad-pitch-999
[265.724069] Subtest bad-pitch-999: SUCCESS (0.000s)
[266.150915] [072/161] (871s left) kms_addfb_basic (basic)
[266.607642] Starting subtest: basic
[266.613574] Subtest basic: SUCCESS (0.000s)
[267.055092] [073/161] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[267.517328] Starting subtest: basic-x-tiled-legacy
[267.520625] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[267.947408] [074/161] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[268.405374] Starting subtest: basic-y-tiled-legacy
[268.409919] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[268.846705] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[269.340093] Starting subtest: bo-too-small
[269.345882] Subtest bo-too-small: SUCCESS (0.002s)
[269.740161] [076/161] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[270.237932] Starting subtest: bo-too-small-due-to-tiling
[270.241643] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[270.623203] [077/161] (868s left) kms_addfb_basic (clobberred-modifier)
[271.079581] Starting subtest: clobberred-modifier
[271.085947] Subtest clobberred-modifier: SUCCESS (0.001s)
[271.511410] [078/161] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[271.972449] Starting subtest: framebuffer-vs-set-tiling
[271.975764] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[272.400370] [079/161] (867s left) kms_addfb_basic (invalid-get-prop)
[272.856236] Starting subtest: invalid-get-prop
[272.862126] Subtest invalid-get-prop: SUCCESS (0.000s)
[273.383705] [080/161] (867s left) kms_addfb_basic (invalid-get-prop-any)
[273.838627] Starting subtest: invalid-get-prop-any
[273.842875] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[274.281166] [081/161] (866s left) kms_addfb_basic (invalid-set-prop)
[274.746098] Starting subtest: invalid-set-prop
[274.750665] Subtest invalid-set-prop: SUCCESS (0.000s)
[275.164745] [082/161] (865s left) kms_addfb_basic (invalid-set-prop-any)
[275.615573] Starting subtest: invalid-set-prop-any
[275.620382] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[276.026959] [083/161] (865s left) kms_addfb_basic (no-handle)
[276.506967] Starting subtest: no-handle
[276.511957] Subtest no-handle: SUCCESS (0.000s)
[276.929893] [084/161] (864s left) kms_addfb_basic (size-max)
[277.437765] Starting subtest: size-max
[277.442286] Subtest size-max: SUCCESS (0.001s)
[277.798404] [085/161] (864s left) kms_addfb_basic (small-bo)
[278.296727] Starting subtest: small-bo
[278.301573] Subtest small-bo: SUCCESS (0.000s)
[278.664918] [086/161] (863s left) kms_addfb_basic (tile-pitch-mismatch)
[279.116612] Starting subtest: tile-pitch-mismatch
[279.121203] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[279.551809] [087/161] (863s left) kms_addfb_basic (too-high)
[280.054295] Starting subtest: too-high
[280.058817] Subtest too-high: SUCCESS (0.006s)
[280.413117] [088/161] (862s left) kms_addfb_basic (too-wide)
[280.899368] Starting subtest: too-wide
[280.904920] Subtest too-wide: SUCCESS (0.000s)
[281.284212] [089/161] (862s left) kms_addfb_basic (unused-handle)
[281.736083] Starting subtest: unused-handle
[281.741333] Subtest unused-handle: SUCCESS (0.000s)
[282.149919] [090/161] (861s left) kms_addfb_basic (unused-modifier)
[282.594920] Starting subtest: unused-modifier
[282.600509] Subtest unused-modifier: SUCCESS (0.000s)
[283.029779] [091/161] (861s left) kms_addfb_basic (unused-offsets)
[283.482982] Starting subtest: unused-offsets
[283.488439] Subtest unused-offsets: SUCCESS (0.000s)
[283.895160] [092/161] (860s left) kms_addfb_basic (unused-pitches)
[284.350837] Starting subtest: unused-pitches
[284.355641] Subtest unused-pitches: SUCCESS (0.000s)
[284.761622] [093/161] (859s left) kms_busy (basic)
[285.270845] Starting subtest: basic
[285.275916] Starting dynamic subtest: flip
[286.306931] Dynamic subtest flip: SUCCESS (1.028s)
[286.356492] Starting dynamic subtest: modeset
[286.362635] Dynamic subtest modeset: SKIP (0.000s)
[286.366092] Subtest basic: SUCCESS (1.040s)
[286.822207] [094/161] (858s left) kms_prop_blob (basic)
[287.271516] Starting subtest: basic
[287.277696] Subtest basic: SUCCESS (0.000s)
[287.619724] [095/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[288.140446] Starting subtest: basic-busy-flip-before-cursor-atomic
[288.160367] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.019s)
[288.637220] [096/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[289.130565] Starting subtest: basic-busy-flip-before-cursor-legacy
[290.234844] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.105s)
[290.757769] [097/161] (855s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[291.259486] Starting subtest: basic-flip-after-cursor-atomic
[291.269603] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[291.623312] [098/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[292.117817] Starting subtest: basic-flip-after-cursor-legacy
[293.204825] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.090s)
[293.724341] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[294.231631] Starting subtest: basic-flip-after-cursor-varying-size
[295.334986] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.102s)
[295.856194] [100/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[296.355862] Starting subtest: basic-flip-before-cursor-atomic
[296.365351] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[296.713138] [101/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[297.223457] Starting subtest: basic-flip-before-cursor-legacy
[298.307842] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.087s)
[298.839238] [102/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[299.339669] Starting subtest: basic-flip-before-cursor-varying-size
[300.442163] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.102s)
[300.986860] [103/161] (846s left) kms_dsc (dsc-basic)
[301.484876] Subtest dsc-basic: SKIP (0.000s)
[301.808378] [104/161] (846s left) kms_flip (basic-flip-vs-dpms)
[302.309319] Starting subtest: basic-flip-vs-dpms
[302.316239] Starting dynamic subtest: A-VGA1
[304.036835] Dynamic subtest A-VGA1: SUCCESS (1.726s)
[304.096916] Starting dynamic subtest: B-VGA1
[305.577544] Dynamic subtest B-VGA1: SUCCESS (1.531s)
[305.581907] Subtest basic-flip-vs-dpms: SUCCESS (3.272s)
[306.304210] [105/161] (842s left) kms_flip (basic-flip-vs-modeset)
[306.813924] Starting subtest: basic-flip-vs-modeset
[306.819246] Starting dynamic subtest: A-VGA1
[308.463413] Dynamic subtest A-VGA1: SUCCESS (1.644s)
[308.511414] Starting dynamic subtest: B-VGA1
[309.948782] Dynamic subtest B-VGA1: SUCCESS (1.481s)
[309.953856] Subtest basic-flip-vs-modeset: SUCCESS (3.141s)
[310.571878] [106/161] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[311.105678] Starting subtest: basic-flip-vs-wf_vblank
[311.109835] Starting dynamic subtest: A-VGA1
[312.952189] Dynamic subtest A-VGA1: SUCCESS (1.836s)
[313.009236] Starting dynamic subtest: B-VGA1
[314.720532] Dynamic subtest B-VGA1: SUCCESS (1.763s)
[314.726443] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.613s)
[315.432977] [107/161] (833s left) kms_flip (basic-plain-flip)
[315.949457] Starting subtest: basic-plain-flip
[315.954590] Starting dynamic subtest: A-VGA1
[317.500807] Dynamic subtest A-VGA1: SUCCESS (1.539s)
[317.556850] Starting dynamic subtest: B-VGA1
[318.937241] Dynamic subtest B-VGA1: SUCCESS (1.428s)
[318.941871] Subtest basic-plain-flip: SUCCESS (2.986s)
[319.616840] [108/161] (830s left) kms_force_connector_basic (force-connector-state)
[320.164805] Starting subtest: force-connector-state
[320.482813] Subtest force-connector-state: SUCCESS (0.314s)
[321.150498] [109/161] (828s left) kms_force_connector_basic (force-edid)
[321.687439] Starting subtest: force-edid
[321.784615] Subtest force-edid: SUCCESS (0.100s)
[322.216795] [110/161] (828s left) kms_force_connector_basic (force-load-detect)
[322.821293] Starting subtest: force-load-detect
[323.269816] Subtest force-load-detect: SUCCESS (0.487s)
[323.857282] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes)
[324.393175] Starting subtest: prune-stale-modes
[324.505905] Subtest prune-stale-modes: SUCCESS (0.118s)
[324.927286] [112/161] (826s left) kms_frontbuffer_tracking (basic)
[325.449706] Subtest basic: SKIP (0.000s)
[325.804451] [113/161] (825s left) kms_hdmi_inject (inject-audio)
[326.262945] Subtest inject-audio: SKIP (0.000s)
[326.580225] [114/161] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[327.082833] Starting subtest: compare-crc-sanitycheck-xr24
[327.088356] Starting dynamic subtest: pipe-A-VGA-1
[327.459793] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s)
[327.523293] Starting dynamic subtest: pipe-B-VGA-1
[327.989096] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.519s)
[327.994905] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.908s)
[328.503743] [115/161] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[329.001480] Starting subtest: compare-crc-sanitycheck-nv12
[329.014714] Starting dynamic subtest: pipe-A-VGA-1
[329.025676] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[329.074621] Starting dynamic subtest: pipe-B-VGA-1
[329.082388] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[329.090669] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[329.393896] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[329.890791] Starting subtest: hang-read-crc
[329.896160] Starting dynamic subtest: pipe-A-VGA-1
[331.224185] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.332s)
[331.294520] Starting dynamic subtest: pipe-B-VGA-1
[332.678236] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.443s)
[332.683233] Subtest hang-read-crc: SUCCESS (2.790s)
[333.191762] [117/161] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[333.823725] Starting subtest: nonblocking-crc
[333.828758] Starting dynamic subtest: pipe-A-VGA-1
[334.414890] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.591s)
[334.475131] Starting dynamic subtest: pipe-B-VGA-1
[335.139325] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.716s)
[335.144498] Subtest nonblocking-crc: SUCCESS (1.323s)
[335.652466] [118/161] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[336.174925] Starting subtest: nonblocking-crc-frame-sequence
[336.180135] Starting dynamic subtest: pipe-A-VGA-1
[336.783451] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.604s)
[336.891284] Starting dynamic subtest: pipe-B-VGA-1
[337.514618] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.719s)
[337.519491] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.346s)
[338.020361] [119/161] (815s left) kms_pipe_crc_basic (read-crc)
[338.521083] Starting subtest: read-crc
[338.525924] Starting dynamic subtest: pipe-A-VGA-1
[339.048657] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.528s)
[339.098358] Starting dynamic subtest: pipe-B-VGA-1
[339.736572] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.678s)
[339.741485] Subtest read-crc: SUCCESS (1.223s)
[340.245278] [120/161] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[340.749627] Starting subtest: read-crc-frame-sequence
[340.754999] Starting dynamic subtest: pipe-A-VGA-1
[341.278734] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.523s)
[341.347955] Starting dynamic subtest: pipe-B-VGA-1
[341.971290] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.683s)
[341.977271] Subtest read-crc-frame-sequence: SUCCESS (1.226s)
[342.468739] [121/161] (811s left) kms_pm_backlight (basic-brightness)
[342.972294] Subtest basic-brightness: SKIP (0.000s)
[343.313165] [122/161] (810s left) kms_pm_rpm (basic-pci-d3-state)
[355.210570] Subtest basic-pci-d3-state: SKIP (0.000s)
[355.529833] [123/161] (799s left) kms_pm_rpm (basic-rte)
[355.979965] Starting subtest: basic-rte
[367.430523] Subtest basic-rte: SKIP (11.445s)
[367.758726] [124/161] (787s left) kms_psr (psr-primary-page-flip)
[368.255613] Subtest psr-primary-page-flip: SKIP (0.000s)
[368.587172] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[369.087816] Subtest psr-cursor-plane-move: SKIP (0.000s)
[369.426956] [126/161] (786s left) kms_psr (psr-sprite-plane-onoff)
[369.925526] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[370.270492] [127/161] (785s left) kms_psr (psr-primary-mmap-gtt)
[370.772384] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[371.110759] [128/161] (785s left) kms_setmode (basic-clone-single-crtc)
[371.572804] Starting subtest: basic-clone-single-crtc
[371.584687] Subtest basic-clone-single-crtc: SKIP (0.001s)
[371.935564] [129/161] (784s left) i915_pm_rps (basic-api)
[372.404762] Subtest basic-api: SKIP (0.000s)
[372.740530] [130/161] (784s left) prime_self_import (basic-llseek-bad)
[373.180700] Starting subtest: basic-llseek-bad
[373.190409] Subtest basic-llseek-bad: SUCCESS (0.012s)
[373.558913] [131/161] (783s left) prime_self_import (basic-llseek-size)
[373.996749] Starting subtest: basic-llseek-size
[374.019615] Subtest basic-llseek-size: SUCCESS (0.026s)
[374.384874] [132/161] (783s left) prime_self_import (basic-with_fd_dup)
[374.841408] Starting subtest: basic-with_fd_dup
[374.860445] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[375.226806] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[375.662127] Starting subtest: basic-with_one_bo
[375.684572] Subtest basic-with_one_bo: SUCCESS (0.026s)
[376.050224] [134/161] (782s left) prime_self_import (basic-with_one_bo_two_files)
[376.490633] Starting subtest: basic-with_one_bo_two_files
[376.509650] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[376.869559] [135/161] (781s left) prime_self_import (basic-with_two_bos)
[377.307621] Starting subtest: basic-with_two_bos
[377.330146] Subtest basic-with_two_bos: SUCCESS (0.023s)
[377.686440] [136/161] (781s left) prime_vgem (basic-fence-flip)
[378.181156] Starting subtest: basic-fence-flip
[378.961254] Subtest basic-fence-flip: SUCCESS (0.783s)
[379.339914] [137/161] (779s left) prime_vgem (basic-fence-mmap)
[379.814620] Starting subtest: basic-fence-mmap
[380.027308] Subtest basic-fence-mmap: SUCCESS (0.211s)
[380.397177] [138/161] (778s left) prime_vgem (basic-fence-read)
[380.873650] Starting subtest: basic-fence-read
[381.135653] Subtest basic-fence-read: SUCCESS (0.268s)
[381.512269] [139/161] (778s left) prime_vgem (basic-gtt)
[382.008262] Starting subtest: basic-gtt
[382.081999] Subtest basic-gtt: SUCCESS (0.079s)
[382.444273] [140/161] (777s left) prime_vgem (basic-read)
[382.924855] Starting subtest: basic-read
[383.024639] Subtest basic-read: SUCCESS (0.105s)
[383.398458] [141/161] (776s left) prime_vgem (basic-write)
[383.869933] Starting subtest: basic-write
[383.978930] Subtest basic-write: SUCCESS (0.113s)
[384.342349] [142/161] (776s left) vgem_basic (setversion)
[384.817777] Starting subtest: setversion
[384.826445] Subtest setversion: SUCCESS (0.000s)
[385.162589] [143/161] (775s left) vgem_basic (create)
[385.635050] Starting subtest: create
[385.640262] Subtest create: SUCCESS (0.003s)
[385.976948] [144/161] (775s left) vgem_basic (debugfs)
[386.415644] Starting subtest: debugfs
[386.419688] Subtest debugfs: SUCCESS (0.004s)
[386.757869] [145/161] (774s left) vgem_basic (dmabuf-export)
[387.214099] Starting subtest: dmabuf-export
[387.225723] Subtest dmabuf-export: SUCCESS (0.013s)
[387.577787] [146/161] (774s left) vgem_basic (dmabuf-fence)
[388.033235] Starting subtest: dmabuf-fence
[388.036889] Subtest dmabuf-fence: SUCCESS (0.006s)
[388.373449] [147/161] (773s left) vgem_basic (dmabuf-fence-before)
[388.814208] Starting subtest: dmabuf-fence-before
[388.818319] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[389.163375] [148/161] (773s left) vgem_basic (dmabuf-mmap)
[389.621154] Starting subtest: dmabuf-mmap
[389.696883] Subtest dmabuf-mmap: SUCCESS (0.082s)
[390.045360] [149/161] (772s left) vgem_basic (mmap)
[390.503949] Starting subtest: mmap
[390.561773] Subtest mmap: SUCCESS (0.065s)
[390.915915] [150/161] (772s left) vgem_basic (second-client)
[391.386745] Starting subtest: second-client
[391.420509] Subtest second-client: SUCCESS (0.033s)
[391.742692] [151/161] (771s left) vgem_basic (sysfs)
[392.198766] Starting subtest: sysfs
[392.204546] Subtest sysfs: SUCCESS (0.005s)
[392.544785] [152/161] (771s left) core_hotunplug (unbind-rebind)
[393.335723] Starting subtest: unbind-rebind
[399.137720] Subtest unbind-rebind: SUCCESS (5.801s)
[399.463228] [153/161] (764s left) vgem_basic (unload)
[399.917143] Starting subtest: unload
[429.687640] Subtest unload: SUCCESS (29.774s)
[430.225237] [154/161] (734s left) i915_module_load (reload)
[430.669168] Starting subtest: reload
[440.426388] Subtest reload: SUCCESS (9.751s)
[441.135338] [155/161] (724s left) gem_lmem_swapping (basic)
[442.086756] Subtest basic: SKIP (0.000s)
[442.437620] [156/161] (723s left) gem_lmem_swapping (parallel-random-engines)
[442.903802] Subtest parallel-random-engines: SKIP (0.000s)
[443.231652] [157/161] (722s left) gem_lmem_swapping (random-engines)
[443.699052] Subtest random-engines: SKIP (0.000s)
[444.013177] [158/161] (722s left) gem_lmem_swapping (verify-random)
[444.485482] Subtest verify-random: SKIP (0.000s)
[444.811247] [159/161] (721s left) i915_pm_rpm (module-reload)
[456.734867] Subtest module-reload: SKIP (0.000s)
[457.058587] [160/161] (709s left) i915_selftest (live)
[459.970543] Starting subtest: live
[459.973794] Starting dynamic subtest: sanitycheck
[467.276716] Dynamic subtest sanitycheck: SUCCESS (7.308s)
[467.364739] Starting dynamic subtest: uncore
[474.693508] Dynamic subtest uncore: SUCCESS (7.410s)
[474.769326] Starting dynamic subtest: workarounds
[482.095312] Dynamic subtest workarounds: SUCCESS (7.397s)
[482.136734] Starting dynamic subtest: gt_engines
[489.529173] Dynamic subtest gt_engines: SUCCESS (7.426s)
[489.586584] Starting dynamic subtest: gt_timelines
[503.065495] Dynamic subtest gt_timelines: SUCCESS (13.536s)
[503.106247] Starting dynamic subtest: gt_contexts
[510.391467] Dynamic subtest gt_contexts: SUCCESS (7.322s)
[510.434069] Starting dynamic subtest: gt_lrc
[517.754862] Dynamic subtest gt_lrc: SUCCESS (7.356s)
[517.806718] Starting dynamic subtest: gt_mocs
[525.080955] Dynamic subtest gt_mocs: SUCCESS (7.322s)
[525.130397] Starting dynamic subtest: gt_pm
[532.904484] Dynamic subtest gt_pm: SUCCESS (7.814s)
[532.987883] Starting dynamic subtest: gt_heartbeat
[540.871946] Dynamic subtest gt_heartbeat: SUCCESS (7.958s)
[540.937260] Starting dynamic subtest: gt_tlb
[548.442877] Dynamic subtest gt_tlb: SUCCESS (7.572s)
[548.503496] Starting dynamic subtest: requests
[558.489973] Dynamic subtest requests: SUCCESS (10.039s)
[558.595432] Starting dynamic subtest: migrate
[565.775171] Dynamic subtest migrate: SUCCESS (7.280s)
[565.820917] Starting dynamic subtest: active
[573.033492] Dynamic subtest active: SUCCESS (7.253s)
[573.080447] Starting dynamic subtest: objects
[581.249356] Dynamic subtest objects: SUCCESS (8.209s)
[581.296367] Starting dynamic subtest: mman
[595.988227] Dynamic subtest mman: SUCCESS (14.730s)
[596.038300] Starting dynamic subtest: dmabuf
[603.542503] Dynamic subtest dmabuf: SUCCESS (7.550s)
[603.644293] Starting dynamic subtest: vma
[610.873145] Dynamic subtest vma: SUCCESS (7.323s)
[610.922219] Starting dynamic subtest: coherency
[623.737137] Dynamic subtest coherency: SUCCESS (12.856s)
[623.779460] Starting dynamic subtest: gtt
[633.917291] Dynamic subtest gtt: SUCCESS (10.170s)
[633.977064] Starting dynamic subtest: gem
[641.510575] Dynamic subtest gem: SUCCESS (7.587s)
[641.600946] Starting dynamic subtest: evict
[648.980658] Dynamic subtest evict: SUCCESS (7.463s)
[649.067540] Starting dynamic subtest: hugepages
[656.413403] Dynamic subtest hugepages: SUCCESS (7.427s)
[656.454348] Starting dynamic subtest: gem_contexts
[663.698540] Dynamic subtest gem_contexts: SUCCESS (7.276s)
[663.779288] Starting dynamic subtest: client
[670.968258] Dynamic subtest client: SUCCESS (7.266s)
[671.016289] Starting dynamic subtest: gem_migrate
[678.238639] Dynamic subtest gem_migrate: SUCCESS (7.260s)
[678.318878] Starting dynamic subtest: reset
[687.572126] Dynamic subtest reset: SUCCESS (9.330s)
[687.612564] Starting dynamic subtest: memory_region
[695.198249] Dynamic subtest memory_region: SUCCESS (7.617s)
[695.254404] Starting dynamic subtest: hangcheck
[703.782264] Dynamic subtest hangcheck: SUCCESS (8.577s)
[703.828320] Starting dynamic subtest: execlists
[711.124821] Dynamic subtest execlists: SUCCESS (7.336s)
[711.171236] Starting dynamic subtest: ring_submission
[718.472392] Dynamic subtest ring_submission: SUCCESS (7.341s)
[718.522757] Starting dynamic subtest: perf
[725.852265] Dynamic subtest perf: SUCCESS (7.372s)
[725.904137] Starting dynamic subtest: slpc
[733.246999] Dynamic subtest slpc: SUCCESS (7.388s)
[733.296335] Starting dynamic subtest: guc
[740.578275] Dynamic subtest guc: SUCCESS (7.324s)
[740.625077] Starting dynamic subtest: guc_multi_lrc
[747.993771] Dynamic subtest guc_multi_lrc: SUCCESS (7.408s)
[748.085693] Starting dynamic subtest: guc_hang
[755.351351] Dynamic subtest guc_hang: SUCCESS (7.349s)
[755.405136] Starting dynamic subtest: late_gt_pm
[762.744215] Dynamic subtest late_gt_pm: SUCCESS (7.386s)
[762.747927] Subtest live: SUCCESS (302.774s)
[762.993670] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[763.004410] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[763.017627] [161/161] (404s left) dmabuf (all-tests)
[763.477835] Starting subtest: all-tests
[763.482362] Starting dynamic subtest: sanitycheck
[763.583271] Dynamic subtest sanitycheck: SUCCESS (0.111s)
[763.646995] Starting dynamic subtest: dma_fence
[763.843550] Dynamic subtest dma_fence: SUCCESS (0.254s)
[763.897342] Starting dynamic subtest: dma_fence_chain