[108.646641] Initializing watchdogs
[108.647489]   /dev/watchdog0
[108.775538] [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)
[108.814874] [001/161] (960s left) i915_module_load (load)
[110.367248] Starting subtest: load
[118.198255] Subtest load: SUCCESS (7.833s)
[118.562253] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[118.570674] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[118.598988] [002/161] (951s left) core_auth (basic-auth)
[119.152541] Starting subtest: basic-auth
[119.160291] Subtest basic-auth: SUCCESS (0.005s)
[119.467466] [003/161] (950s left) debugfs_test (read_all_entries)
[119.961562] Starting subtest: read_all_entries
[120.225361] Subtest read_all_entries: SUCCESS (0.268s)
[120.645651] [004/161] (949s left) debugfs_test (basic-hwmon)
[121.132233] Starting subtest: basic-hwmon
[121.140892] Subtest basic-hwmon: SKIP (0.000s)
[121.496858] [005/161] (949s left) debugfs_test (sysfs)
[121.973322] Starting subtest: sysfs
[122.117274] Subtest sysfs: SUCCESS (0.142s)
[122.481373] [006/161] (948s left) fbdev (eof)
[122.987170] Starting subtest: eof
[122.991123] Subtest eof: SUCCESS (0.003s)
[123.290719] [007/161] (947s left) fbdev (info)
[123.728862] Starting subtest: info
[123.732770] Subtest info: SUCCESS (0.000s)
[124.037977] [008/161] (947s left) fbdev (nullptr)
[124.501949] Starting subtest: nullptr
[124.505770] Subtest nullptr: SUCCESS (0.001s)
[124.801549] [009/161] (946s left) fbdev (read)
[125.249961] Starting subtest: read
[125.555287] Subtest read: SUCCESS (0.307s)
[125.852353] [010/161] (946s left) fbdev (write)
[126.301819] Starting subtest: write
[126.486990] Subtest write: SUCCESS (0.187s)
[126.795363] [011/161] (945s left) gem_basic (bad-close)
[127.256800] Starting subtest: bad-close
[127.265918] Subtest bad-close: SUCCESS (0.000s)
[127.560709] [012/161] (944s left) gem_basic (create-close)
[128.031125] Starting subtest: create-close
[128.038606] Subtest create-close: SUCCESS (0.001s)
[128.350262] [013/161] (944s left) gem_basic (create-fd-close)
[128.807591] Starting subtest: create-fd-close
[128.816464] Subtest create-fd-close: SUCCESS (0.001s)
[129.120514] [014/161] (943s left) gem_busy (busy@all-engines)
[129.665693] Starting subtest: busy
[129.670717] Starting dynamic subtest: all-engines
[129.807428] Dynamic subtest all-engines: SUCCESS (0.141s)
[129.811435] Subtest busy: SUCCESS (0.146s)
[130.526786] [015/161] (942s left) gem_close_race (basic-process)
[131.070244] Starting subtest: basic-process
[131.304561] Subtest basic-process: SUCCESS (0.235s)
[131.755548] [016/161] (941s left) gem_close_race (basic-threads)
[132.304823] Starting subtest: basic-threads
[133.846228] Subtest basic-threads: SUCCESS (1.546s)
[134.296648] [017/161] (939s left) gem_ctx_create (basic)
[134.769405] Subtest basic: SKIP (0.000s)
[135.065191] [018/161] (939s left) gem_ctx_create (basic-files)
[135.593899] Subtest basic-files: SKIP (0.000s)
[135.881482] [019/161] (938s left) gem_ctx_exec (basic)
[136.351913] Subtest basic: SKIP (0.000s)
[136.671524] [020/161] (938s left) gem_exec_basic (basic)
[137.194297] Starting subtest: basic
[137.199682] Starting dynamic subtest: rcs0-smem
[137.204074] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[137.207283] Subtest basic: SUCCESS (0.010s)
[137.665661] [021/161] (937s left) gem_exec_create (basic)
[138.188613] Starting subtest: basic
[138.194784] Starting dynamic subtest: smem
[140.353882] Dynamic subtest smem: SUCCESS (2.165s)
[140.357880] Subtest basic: SUCCESS (2.168s)
[140.814324] [022/161] (934s left) gem_exec_fence (basic-busy)
[141.559667] Starting subtest: basic-busy
[141.570328] Starting dynamic subtest: rcs0
[141.620118] Dynamic subtest rcs0: SUCCESS (0.060s)
[141.624062] Subtest basic-busy: SUCCESS (0.064s)
[142.804631] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[142.817627] [023/161] (932s left) gem_exec_fence (basic-wait)
[143.585521] Starting subtest: basic-wait
[143.590634] Starting dynamic subtest: rcs0
[143.626126] Dynamic subtest rcs0: SUCCESS (0.042s)
[143.630508] Subtest basic-wait: SUCCESS (0.046s)
[144.586140] [024/161] (931s left) gem_exec_fence (basic-await)
[145.335643] Starting subtest: basic-await
[145.340445] Starting dynamic subtest: rcs0
[145.489355] Dynamic subtest rcs0: SUCCESS (0.144s)
[145.493731] Subtest basic-await: SUCCESS (0.149s)
[146.456705] [025/161] (929s left) gem_exec_fence (nb-await)
[147.219834] Starting subtest: nb-await
[147.224926] Starting dynamic subtest: rcs0
[147.290522] Dynamic subtest rcs0: SUCCESS (0.067s)
[147.294814] Subtest nb-await: SUCCESS (0.071s)
[148.257349] [026/161] (928s left) gem_exec_gttfill (basic)
[148.789355] Starting subtest: basic
[158.953769] Subtest basic: SUCCESS (10.165s)
[159.615388] [027/161] (917s left) gem_exec_parallel (engines)
[160.341287] Starting subtest: engines
[160.345861] Starting dynamic subtest: basic
[164.503525] Dynamic subtest basic: SUCCESS (4.167s)
[164.553241] Starting dynamic subtest: contexts
[164.559793] Dynamic subtest contexts: SKIP (0.005s)
[164.600639] Starting dynamic subtest: fds
[164.607616] Dynamic subtest fds: SKIP (0.005s)
[164.647095] Starting dynamic subtest: userptr
[168.846326] Dynamic subtest userptr: SUCCESS (4.322s)
[168.850956] Subtest engines: SUCCESS (8.511s)
[169.340535] [028/161] (907s left) gem_exec_store (basic)
[169.887930] Starting subtest: basic
[169.933415] Subtest basic: SUCCESS (0.049s)
[170.422252] [029/161] (907s left) gem_flink_basic (bad-flink)
[170.886669] Starting subtest: bad-flink
[170.891877] Subtest bad-flink: SUCCESS (0.000s)
[171.244423] [030/161] (906s left) gem_flink_basic (bad-open)
[171.690721] Starting subtest: bad-open
[171.695348] Subtest bad-open: SUCCESS (0.000s)
[172.042989] [031/161] (906s left) gem_flink_basic (basic)
[172.493606] Starting subtest: basic
[172.498342] Subtest basic: SUCCESS (0.001s)
[172.850946] [032/161] (905s left) gem_flink_basic (double-flink)
[173.300335] Starting subtest: double-flink
[173.305560] Subtest double-flink: SUCCESS (0.001s)
[173.674566] [033/161] (905s left) gem_flink_basic (flink-lifetime)
[174.133964] Starting subtest: flink-lifetime
[174.145198] Subtest flink-lifetime: SUCCESS (0.011s)
[174.507545] [034/161] (904s left) gem_huc_copy (huc-copy)
[174.978660] Subtest huc-copy: SKIP (0.000s)
[175.302343] [035/161] (904s left) gem_linear_blits (basic)
[176.113348] Starting subtest: basic
[176.165613] Subtest basic: SUCCESS (0.053s)
[176.611233] [036/161] (903s left) gem_mmap (basic)
[177.298201] Starting subtest: basic
[177.315888] Subtest basic: SUCCESS (0.003s)
[177.662227] [037/161] (902s left) gem_mmap_gtt (basic)
[178.113312] Starting subtest: basic
[178.118262] Subtest basic: SUCCESS (0.005s)
[178.465972] [038/161] (902s left) gem_render_linear_blits (basic)
[178.949428] Starting subtest: basic
[179.100665] Subtest basic: SUCCESS (0.153s)
[179.448943] [039/161] (901s left) gem_render_tiled_blits (basic)
[179.926902] Starting subtest: basic
[180.135633] Subtest basic: SUCCESS (0.203s)
[180.532852] [040/161] (900s left) gem_ringfill (basic-all)
[181.134566] Starting subtest: basic-all
[182.352779] Subtest basic-all: SUCCESS (1.219s)
[182.718600] [041/161] (898s left) gem_softpin (allocator-basic)
[183.188500] Subtest allocator-basic: SKIP (0.000s)
[183.526248] [042/161] (898s left) gem_softpin (allocator-basic-reserve)
[183.999706] Subtest allocator-basic-reserve: SKIP (0.000s)
[184.351240] [043/161] (897s left) gem_softpin (safe-alignment)
[184.818524] Starting subtest: safe-alignment
[184.835293] Subtest safe-alignment: SUCCESS (0.021s)
[185.197399] [044/161] (897s left) gem_sync (basic-all)
[185.729984] Starting subtest: basic-all
[187.959527] Subtest basic-all: SUCCESS (2.226s)
[188.446558] [045/161] (894s left) gem_sync (basic-each)
[188.980491] Starting subtest: basic-each
[191.172674] Subtest basic-each: SUCCESS (2.194s)
[191.672423] [046/161] (891s left) gem_tiled_blits (basic)
[192.513320] Starting subtest: basic
[192.628684] Subtest basic: SUCCESS (0.114s)
[193.054195] [047/161] (890s left) gem_tiled_fence_blits (basic)
[194.186973] Starting subtest: basic
[194.247852] Subtest basic: SUCCESS (0.068s)
[194.687507] [048/161] (889s left) gem_tiled_pread_basic
[197.654162] [049/161] (886s left) gem_wait (busy@all-engines)
[198.258179] Starting subtest: busy
[198.262411] Starting dynamic subtest: all-engines
[198.788608] Dynamic subtest all-engines: SUCCESS (0.538s)
[198.794126] Subtest busy: SUCCESS (0.543s)
[199.457474] [050/161] (884s left) gem_wait (wait@all-engines)
[200.063904] Starting subtest: wait
[200.069137] Starting dynamic subtest: all-engines
[201.112610] Dynamic subtest all-engines: SUCCESS (1.052s)
[201.120624] Subtest wait: SUCCESS (1.059s)
[201.815926] [051/161] (882s left) i915_getparams_basic (basic-eu-total)
[202.288408] Starting subtest: basic-eu-total
[202.296943] Subtest basic-eu-total: SUCCESS (0.000s)
[202.657931] [052/161] (882s left) i915_getparams_basic (basic-subslice-total)
[203.141944] Starting subtest: basic-subslice-total
[203.152880] Subtest basic-subslice-total: SUCCESS (0.000s)
[203.519222] [053/161] (881s left) i915_hangman (error-state-basic)
[204.009405] Starting subtest: error-state-basic
[204.412278] Subtest error-state-basic: SUCCESS (0.398s)
[204.747294] [054/161] (880s left) i915_pciid
[205.579627] [055/161] (880s left) kms_addfb_basic (addfb25-4-tiled)
[206.108129] Starting subtest: addfb25-4-tiled
[206.112382] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[206.481930] [056/161] (879s left) kms_addfb_basic (addfb25-bad-modifier)
[206.986816] Starting subtest: addfb25-bad-modifier
[206.992267] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[207.362558] [057/161] (879s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[207.882698] Starting subtest: addfb25-framebuffer-vs-set-tiling
[207.888353] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[208.255987] [058/161] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[208.765598] Starting subtest: addfb25-modifier-no-flag
[208.770182] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[209.139997] [059/161] (878s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[209.656340] Starting subtest: addfb25-x-tiled-legacy
[209.661455] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[210.032663] [060/161] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[210.603418] Starting subtest: addfb25-x-tiled-mismatch-legacy
[210.609545] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[210.989300] [061/161] (877s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[211.514991] Starting subtest: addfb25-yf-tiled-legacy
[211.519504] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[211.873408] [062/161] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[212.392347] Starting subtest: addfb25-y-tiled-legacy
[212.398141] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[212.752600] [063/161] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[213.270613] Starting subtest: addfb25-y-tiled-small-legacy
[213.280185] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[213.645922] [064/161] (875s left) kms_addfb_basic (bad-pitch-0)
[214.108707] Starting subtest: bad-pitch-0
[214.113416] Subtest bad-pitch-0: SUCCESS (0.000s)
[214.538629] [065/161] (874s left) kms_addfb_basic (bad-pitch-1024)
[214.996749] Starting subtest: bad-pitch-1024
[215.001317] Subtest bad-pitch-1024: SUCCESS (0.000s)
[215.426873] [066/161] (874s left) kms_addfb_basic (bad-pitch-128)
[215.880195] Starting subtest: bad-pitch-128
[215.884266] Subtest bad-pitch-128: SUCCESS (0.000s)
[216.298518] [067/161] (873s left) kms_addfb_basic (bad-pitch-256)
[216.754313] Starting subtest: bad-pitch-256
[216.758381] Subtest bad-pitch-256: SUCCESS (0.000s)
[217.176951] [068/161] (873s left) kms_addfb_basic (bad-pitch-32)
[217.635307] Starting subtest: bad-pitch-32
[217.639277] Subtest bad-pitch-32: SUCCESS (0.000s)
[218.056295] [069/161] (872s left) kms_addfb_basic (bad-pitch-63)
[218.505586] Starting subtest: bad-pitch-63
[218.509875] Subtest bad-pitch-63: SUCCESS (0.000s)
[218.929402] [070/161] (872s left) kms_addfb_basic (bad-pitch-65536)
[219.395679] Starting subtest: bad-pitch-65536
[219.400131] Subtest bad-pitch-65536: SUCCESS (0.002s)
[219.814593] [071/161] (871s left) kms_addfb_basic (bad-pitch-999)
[220.281776] Starting subtest: bad-pitch-999
[220.286993] Subtest bad-pitch-999: SUCCESS (0.000s)
[220.706198] [072/161] (870s left) kms_addfb_basic (basic)
[221.160537] Starting subtest: basic
[221.166131] Subtest basic: SUCCESS (0.000s)
[221.584132] [073/161] (870s left) kms_addfb_basic (basic-x-tiled-legacy)
[222.052767] Starting subtest: basic-x-tiled-legacy
[222.057450] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[222.469348] [074/161] (869s left) kms_addfb_basic (basic-y-tiled-legacy)
[222.935289] Starting subtest: basic-y-tiled-legacy
[222.939873] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[223.336980] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[223.845922] Starting subtest: bo-too-small
[223.851373] Subtest bo-too-small: SUCCESS (0.002s)
[224.228280] [076/161] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[224.746407] Starting subtest: bo-too-small-due-to-tiling
[224.751797] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[225.169760] [077/161] (868s left) kms_addfb_basic (clobberred-modifier)
[225.646924] Starting subtest: clobberred-modifier
[225.650825] Subtest clobberred-modifier: SUCCESS (0.001s)
[226.079381] [078/161] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[226.542835] Starting subtest: framebuffer-vs-set-tiling
[226.547704] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[226.989603] [079/161] (867s left) kms_addfb_basic (invalid-get-prop)
[227.450284] Starting subtest: invalid-get-prop
[227.454689] Subtest invalid-get-prop: SUCCESS (0.000s)
[227.882512] [080/161] (866s left) kms_addfb_basic (invalid-get-prop-any)
[228.339614] Starting subtest: invalid-get-prop-any
[228.344923] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[228.781458] [081/161] (865s left) kms_addfb_basic (invalid-set-prop)
[229.237909] Starting subtest: invalid-set-prop
[229.243836] Subtest invalid-set-prop: SUCCESS (0.000s)
[229.686538] [082/161] (865s left) kms_addfb_basic (invalid-set-prop-any)
[230.151551] Starting subtest: invalid-set-prop-any
[230.156613] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[230.583721] [083/161] (864s left) kms_addfb_basic (no-handle)
[231.046580] Starting subtest: no-handle
[231.051156] Subtest no-handle: SUCCESS (0.000s)
[231.467413] [084/161] (864s left) kms_addfb_basic (size-max)
[231.980918] Starting subtest: size-max
[231.985907] Subtest size-max: SUCCESS (0.001s)
[232.361664] [085/161] (863s left) kms_addfb_basic (small-bo)
[232.883469] Starting subtest: small-bo
[232.887832] Subtest small-bo: SUCCESS (0.000s)
[233.252448] [086/161] (863s left) kms_addfb_basic (tile-pitch-mismatch)
[233.718494] Starting subtest: tile-pitch-mismatch
[233.722901] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[234.168928] [087/161] (862s left) kms_addfb_basic (too-high)
[234.669530] Starting subtest: too-high
[234.673523] Subtest too-high: SUCCESS (0.006s)
[235.054569] [088/161] (861s left) kms_addfb_basic (too-wide)
[235.548384] Starting subtest: too-wide
[235.553088] Subtest too-wide: SUCCESS (0.000s)
[235.912266] [089/161] (861s left) kms_addfb_basic (unused-handle)
[236.370796] Starting subtest: unused-handle
[236.375996] Subtest unused-handle: SUCCESS (0.000s)
[236.800652] [090/161] (860s left) kms_addfb_basic (unused-modifier)
[237.261936] Starting subtest: unused-modifier
[237.267406] Subtest unused-modifier: SUCCESS (0.000s)
[237.694161] [091/161] (860s left) kms_addfb_basic (unused-offsets)
[238.150918] Starting subtest: unused-offsets
[238.154588] Subtest unused-offsets: SUCCESS (0.000s)
[238.571326] [092/161] (859s left) kms_addfb_basic (unused-pitches)
[239.035816] Starting subtest: unused-pitches
[239.040799] Subtest unused-pitches: SUCCESS (0.000s)
[239.451135] [093/161] (859s left) kms_busy (basic)
[239.971511] Starting subtest: basic
[239.975608] Starting dynamic subtest: flip
[241.092469] Dynamic subtest flip: SUCCESS (1.118s)
[241.144359] Starting dynamic subtest: modeset
[241.151854] Dynamic subtest modeset: SKIP (0.000s)
[241.156299] Subtest basic: SUCCESS (1.129s)
[241.603685] [094/161] (857s left) kms_prop_blob (basic)
[242.068334] Starting subtest: basic
[242.073387] Subtest basic: SUCCESS (0.000s)
[242.410554] [095/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[242.923368] Starting subtest: basic-busy-flip-before-cursor-atomic
[242.944862] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.019s)
[243.312943] [096/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[243.820231] Starting subtest: basic-busy-flip-before-cursor-legacy
[244.932876] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.112s)
[245.445685] [097/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[245.939741] Starting subtest: basic-flip-after-cursor-atomic
[245.948955] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[246.317962] [098/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[246.826473] Starting subtest: basic-flip-after-cursor-legacy
[247.912844] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.086s)
[248.433674] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[248.945701] Starting subtest: basic-flip-after-cursor-varying-size
[250.051217] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.103s)
[250.558869] [100/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[251.068880] Starting subtest: basic-flip-before-cursor-atomic
[251.078000] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[251.425376] [101/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[251.934699] Starting subtest: basic-flip-before-cursor-legacy
[253.016844] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.086s)
[253.531831] [102/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[254.032607] Starting subtest: basic-flip-before-cursor-varying-size
[255.124349] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.090s)
[255.672792] [103/161] (846s left) kms_dsc (dsc-basic)
[256.180823] Subtest dsc-basic: SKIP (0.000s)
[256.532682] [104/161] (845s left) kms_flip (basic-flip-vs-dpms)
[257.044217] Starting subtest: basic-flip-vs-dpms
[257.049787] Starting dynamic subtest: A-VGA1
[258.699753] Dynamic subtest A-VGA1: SUCCESS (1.654s)
[258.754289] Starting dynamic subtest: B-VGA1
[260.232446] Dynamic subtest B-VGA1: SUCCESS (1.520s)
[260.240533] Subtest basic-flip-vs-dpms: SUCCESS (3.186s)
[260.919746] [105/161] (841s left) kms_flip (basic-flip-vs-modeset)
[261.425851] Starting subtest: basic-flip-vs-modeset
[261.431071] Starting dynamic subtest: A-VGA1
[263.112750] Dynamic subtest A-VGA1: SUCCESS (1.683s)
[263.167960] Starting dynamic subtest: B-VGA1
[264.597672] Dynamic subtest B-VGA1: SUCCESS (1.478s)
[264.604792] Subtest basic-flip-vs-modeset: SUCCESS (3.172s)
[265.241606] [106/161] (837s left) kms_flip (basic-flip-vs-wf_vblank)
[265.759957] Starting subtest: basic-flip-vs-wf_vblank
[265.765917] Starting dynamic subtest: A-VGA1
[267.582722] Dynamic subtest A-VGA1: SUCCESS (1.816s)
[267.631703] Starting dynamic subtest: B-VGA1
[269.313358] Dynamic subtest B-VGA1: SUCCESS (1.727s)
[269.320797] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.556s)
[270.013491] [107/161] (833s left) kms_flip (basic-plain-flip)
[270.659584] Starting subtest: basic-plain-flip
[270.664622] Starting dynamic subtest: A-VGA1
[272.197315] Dynamic subtest A-VGA1: SUCCESS (1.531s)
[272.250912] Starting dynamic subtest: B-VGA1
[273.645973] Dynamic subtest B-VGA1: SUCCESS (1.445s)
[273.652268] Subtest basic-plain-flip: SUCCESS (2.987s)
[274.335722] [108/161] (829s left) kms_force_connector_basic (force-connector-state)
[274.876134] Starting subtest: force-connector-state
[275.149534] Subtest force-connector-state: SUCCESS (0.274s)
[275.813143] [109/161] (828s left) kms_force_connector_basic (force-edid)
[276.381695] Starting subtest: force-edid
[276.494539] Subtest force-edid: SUCCESS (0.116s)
[276.924777] [110/161] (827s left) kms_force_connector_basic (force-load-detect)
[277.477956] Starting subtest: force-load-detect
[277.914624] Subtest force-load-detect: SUCCESS (0.436s)
[278.527488] [111/161] (825s left) kms_force_connector_basic (prune-stale-modes)
[279.063413] Starting subtest: prune-stale-modes
[279.183155] Subtest prune-stale-modes: SUCCESS (0.117s)
[279.639648] [112/161] (825s left) kms_frontbuffer_tracking (basic)
[280.159914] Subtest basic: SKIP (0.000s)
[280.522211] [113/161] (824s left) kms_hdmi_inject (inject-audio)
[280.982526] Subtest inject-audio: SKIP (0.000s)
[281.315379] [114/161] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[281.822157] Starting subtest: compare-crc-sanitycheck-xr24
[281.826994] Starting dynamic subtest: pipe-A-VGA-1
[282.221641] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.392s)
[282.277592] Starting dynamic subtest: pipe-B-VGA-1
[282.764666] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.532s)
[282.770502] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.941s)
[283.285668] [115/161] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[283.787630] Starting subtest: compare-crc-sanitycheck-nv12
[283.792250] Starting dynamic subtest: pipe-A-VGA-1
[283.803492] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[283.862279] Starting dynamic subtest: pipe-B-VGA-1
[283.870286] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[283.878623] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[284.181359] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[284.670735] Starting subtest: hang-read-crc
[284.674787] Starting dynamic subtest: pipe-A-VGA-1
[286.059236] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.383s)
[286.123362] Starting dynamic subtest: pipe-B-VGA-1
[287.534422] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.459s)
[287.541582] Subtest hang-read-crc: SUCCESS (2.859s)
[288.022113] [117/161] (818s left) kms_pipe_crc_basic (nonblocking-crc)
[288.535242] Starting subtest: nonblocking-crc
[288.545105] Starting dynamic subtest: pipe-A-VGA-1
[289.148383] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.604s)
[289.198651] Starting dynamic subtest: pipe-B-VGA-1
[289.895847] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.735s)
[289.901788] Subtest nonblocking-crc: SUCCESS (1.359s)
[290.401642] [118/161] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[290.911791] Starting subtest: nonblocking-crc-frame-sequence
[290.916809] Starting dynamic subtest: pipe-A-VGA-1
[291.503724] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.593s)
[291.613506] Starting dynamic subtest: pipe-B-VGA-1
[292.243365] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.726s)
[292.248406] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.339s)
[292.754305] [119/161] (814s left) kms_pipe_crc_basic (read-crc)
[293.257682] Starting subtest: read-crc
[293.271653] Starting dynamic subtest: pipe-A-VGA-1
[293.792769] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.525s)
[293.861798] Starting dynamic subtest: pipe-B-VGA-1
[294.438474] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.636s)
[294.442323] Subtest read-crc: SUCCESS (1.180s)
[294.944512] [120/161] (812s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[295.445949] Starting subtest: read-crc-frame-sequence
[295.450139] Starting dynamic subtest: pipe-A-VGA-1
[295.990584] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.537s)
[296.037887] Starting dynamic subtest: pipe-B-VGA-1
[296.654700] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.657s)
[296.659171] Subtest read-crc-frame-sequence: SUCCESS (1.212s)
[297.162769] [121/161] (810s left) kms_pm_backlight (basic-brightness)
[297.668541] Subtest basic-brightness: SKIP (0.000s)
[298.001962] [122/161] (810s left) kms_pm_rpm (basic-pci-d3-state)
[309.930839] Subtest basic-pci-d3-state: SKIP (0.000s)
[310.245603] [123/161] (798s left) kms_pm_rpm (basic-rte)
[310.692965] Starting subtest: basic-rte
[322.136533] Subtest basic-rte: SKIP (11.440s)
[322.466470] [124/161] (786s left) kms_psr (psr-primary-page-flip)
[322.981806] Subtest psr-primary-page-flip: SKIP (0.000s)
[323.310482] [125/161] (785s left) kms_psr (psr-cursor-plane-move)
[323.815238] Subtest psr-cursor-plane-move: SKIP (0.000s)
[324.155899] [126/161] (785s left) kms_psr (psr-sprite-plane-onoff)
[324.664932] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[325.000665] [127/161] (784s left) kms_psr (psr-primary-mmap-gtt)
[325.501584] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[325.817922] [128/161] (784s left) kms_setmode (basic-clone-single-crtc)
[326.274552] Starting subtest: basic-clone-single-crtc
[326.287202] Subtest basic-clone-single-crtc: SKIP (0.001s)
[326.634328] [129/161] (783s left) i915_pm_rps (basic-api)
[327.103085] Subtest basic-api: SKIP (0.000s)
[327.441820] [130/161] (783s left) prime_self_import (basic-llseek-bad)
[327.873520] Starting subtest: basic-llseek-bad
[327.888657] Subtest basic-llseek-bad: SUCCESS (0.015s)
[328.245374] [131/161] (782s left) prime_self_import (basic-llseek-size)
[328.687535] Starting subtest: basic-llseek-size
[328.708927] Subtest basic-llseek-size: SUCCESS (0.022s)
[329.065826] [132/161] (782s left) prime_self_import (basic-with_fd_dup)
[329.508952] Starting subtest: basic-with_fd_dup
[329.530886] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[329.896333] [133/161] (781s left) prime_self_import (basic-with_one_bo)
[330.430526] Starting subtest: basic-with_one_bo
[330.450325] Subtest basic-with_one_bo: SUCCESS (0.021s)
[330.806981] [134/161] (781s left) prime_self_import (basic-with_one_bo_two_files)
[331.246282] Starting subtest: basic-with_one_bo_two_files
[331.266228] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[331.618158] [135/161] (780s left) prime_self_import (basic-with_two_bos)
[332.067741] Starting subtest: basic-with_two_bos
[332.089981] Subtest basic-with_two_bos: SUCCESS (0.024s)
[332.450476] [136/161] (780s left) prime_vgem (basic-fence-flip)
[332.930829] Starting subtest: basic-fence-flip
[333.623561] Subtest basic-fence-flip: SUCCESS (0.690s)
[334.005609] [137/161] (779s left) prime_vgem (basic-fence-mmap)
[334.500337] Starting subtest: basic-fence-mmap
[334.709220] Subtest basic-fence-mmap: SUCCESS (0.210s)
[335.091463] [138/161] (778s left) prime_vgem (basic-fence-read)
[335.562762] Starting subtest: basic-fence-read
[335.823394] Subtest basic-fence-read: SUCCESS (0.259s)
[336.195725] [139/161] (777s left) prime_vgem (basic-gtt)
[336.684927] Starting subtest: basic-gtt
[336.767931] Subtest basic-gtt: SUCCESS (0.086s)
[337.141483] [140/161] (776s left) prime_vgem (basic-read)
[337.637656] Starting subtest: basic-read
[337.738931] Subtest basic-read: SUCCESS (0.104s)
[338.101328] [141/161] (776s left) prime_vgem (basic-write)
[338.585931] Starting subtest: basic-write
[338.697413] Subtest basic-write: SUCCESS (0.117s)
[339.071906] [142/161] (775s left) vgem_basic (setversion)
[339.540998] Starting subtest: setversion
[339.549767] Subtest setversion: SUCCESS (0.000s)
[339.889311] [143/161] (775s left) vgem_basic (create)
[340.343703] Starting subtest: create
[340.349684] Subtest create: SUCCESS (0.003s)
[340.687434] [144/161] (774s left) vgem_basic (debugfs)
[341.146601] Starting subtest: debugfs
[341.151106] Subtest debugfs: SUCCESS (0.003s)
[341.486540] [145/161] (774s left) vgem_basic (dmabuf-export)
[341.946490] Starting subtest: dmabuf-export
[341.962679] Subtest dmabuf-export: SUCCESS (0.018s)
[342.323772] [146/161] (773s left) vgem_basic (dmabuf-fence)
[342.778203] Starting subtest: dmabuf-fence
[342.781926] Subtest dmabuf-fence: SUCCESS (0.005s)
[343.126679] [147/161] (773s left) vgem_basic (dmabuf-fence-before)
[343.600566] Starting subtest: dmabuf-fence-before
[343.604970] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[343.937798] [148/161] (772s left) vgem_basic (dmabuf-mmap)
[344.408793] Starting subtest: dmabuf-mmap
[344.489949] Subtest dmabuf-mmap: SUCCESS (0.083s)
[344.848986] [149/161] (772s left) vgem_basic (mmap)
[345.380156] Starting subtest: mmap
[345.433417] Subtest mmap: SUCCESS (0.059s)
[345.775655] [150/161] (771s left) vgem_basic (second-client)
[346.230600] Starting subtest: second-client
[346.266449] Subtest second-client: SUCCESS (0.030s)
[346.607908] [151/161] (770s left) vgem_basic (sysfs)
[347.060567] Starting subtest: sysfs
[347.066334] Subtest sysfs: SUCCESS (0.005s)
[347.409936] [152/161] (770s left) core_hotunplug (unbind-rebind)
[348.178821] Starting subtest: unbind-rebind
[354.002871] Subtest unbind-rebind: SUCCESS (5.826s)
[354.327758] [153/161] (763s left) vgem_basic (unload)
[354.781846] Starting subtest: unload
[384.442098] Subtest unload: SUCCESS (29.660s)
[384.992387] [154/161] (733s left) i915_module_load (reload)
[385.436625] Starting subtest: reload
[395.272193] Subtest reload: SUCCESS (9.828s)
[396.062311] [155/161] (723s left) gem_lmem_swapping (basic)
[396.897453] Subtest basic: SKIP (0.000s)
[397.226680] [156/161] (722s left) gem_lmem_swapping (parallel-random-engines)
[397.691663] Subtest parallel-random-engines: SKIP (0.000s)
[398.007243] [157/161] (721s left) gem_lmem_swapping (random-engines)
[398.485754] Subtest random-engines: SKIP (0.000s)
[398.811767] [158/161] (721s left) gem_lmem_swapping (verify-random)
[399.296872] Subtest verify-random: SKIP (0.000s)
[399.626638] [159/161] (720s left) i915_pm_rpm (module-reload)
[411.553919] Subtest module-reload: SKIP (0.000s)
[411.894769] [160/161] (709s left) i915_selftest (live)
[414.810954] Starting subtest: live
[414.814470] Starting dynamic subtest: sanitycheck
[422.294514] Dynamic subtest sanitycheck: SUCCESS (7.486s)
[422.339885] Starting dynamic subtest: uncore
[429.562950] Dynamic subtest uncore: SUCCESS (7.260s)
[429.645316] Starting dynamic subtest: workarounds
[437.100564] Dynamic subtest workarounds: SUCCESS (7.530s)
[437.182568] Starting dynamic subtest: gt_engines
[444.558533] Dynamic subtest gt_engines: SUCCESS (7.451s)
[444.598418] Starting dynamic subtest: gt_timelines
[458.082446] Dynamic subtest gt_timelines: SUCCESS (13.521s)
[458.130617] Starting dynamic subtest: gt_contexts
[465.409970] Dynamic subtest gt_contexts: SUCCESS (7.318s)
[465.480367] Starting dynamic subtest: gt_lrc
[472.860157] Dynamic subtest gt_lrc: SUCCESS (7.443s)
[472.937528] Starting dynamic subtest: gt_mocs
[480.204900] Dynamic subtest gt_mocs: SUCCESS (7.336s)
[480.250987] Starting dynamic subtest: gt_pm
[487.989471] Dynamic subtest gt_pm: SUCCESS (7.783s)
[488.042634] Starting dynamic subtest: gt_heartbeat
[495.444152] Dynamic subtest gt_heartbeat: SUCCESS (7.443s)
[495.503190] Starting dynamic subtest: gt_tlb
[502.820747] Dynamic subtest gt_tlb: SUCCESS (7.377s)
[502.881582] Starting dynamic subtest: requests
[512.807987] Dynamic subtest requests: SUCCESS (9.981s)
[512.857734] Starting dynamic subtest: migrate
[520.104132] Dynamic subtest migrate: SUCCESS (7.289s)
[520.153264] Starting dynamic subtest: active
[527.639647] Dynamic subtest active: SUCCESS (7.530s)
[527.723208] Starting dynamic subtest: objects
[535.876397] Dynamic subtest objects: SUCCESS (8.231s)
[535.922346] Starting dynamic subtest: mman
[550.683341] Dynamic subtest mman: SUCCESS (14.800s)
[550.732702] Starting dynamic subtest: dmabuf
[558.390565] Dynamic subtest dmabuf: SUCCESS (7.702s)
[558.483525] Starting dynamic subtest: vma
[565.825648] Dynamic subtest vma: SUCCESS (7.430s)
[565.876920] Starting dynamic subtest: coherency
[578.837132] Dynamic subtest coherency: SUCCESS (13.003s)
[578.885118] Starting dynamic subtest: gtt
[589.174216] Dynamic subtest gtt: SUCCESS (10.330s)
[589.221236] Starting dynamic subtest: gem
[596.705743] Dynamic subtest gem: SUCCESS (7.525s)
[596.793795] Starting dynamic subtest: evict
[604.180237] Dynamic subtest evict: SUCCESS (7.466s)
[604.278687] Starting dynamic subtest: hugepages
[611.474477] Dynamic subtest hugepages: SUCCESS (7.285s)
[611.534218] Starting dynamic subtest: gem_contexts
[618.899842] Dynamic subtest gem_contexts: SUCCESS (7.420s)
[618.946490] Starting dynamic subtest: client
[626.297136] Dynamic subtest client: SUCCESS (7.388s)
[626.380144] Starting dynamic subtest: gem_migrate
[633.799187] Dynamic subtest gem_migrate: SUCCESS (7.500s)
[633.854475] Starting dynamic subtest: reset
[643.211678] Dynamic subtest reset: SUCCESS (9.405s)
[643.258655] Starting dynamic subtest: memory_region
[650.715965] Dynamic subtest memory_region: SUCCESS (7.495s)
[650.782846] Starting dynamic subtest: hangcheck
[659.227731] Dynamic subtest hangcheck: SUCCESS (8.502s)
[659.294809] Starting dynamic subtest: execlists
[666.667246] Dynamic subtest execlists: SUCCESS (7.436s)
[666.726616] Starting dynamic subtest: ring_submission
[674.034215] Dynamic subtest ring_submission: SUCCESS (7.362s)
[674.082466] Starting dynamic subtest: perf
[681.439784] Dynamic subtest perf: SUCCESS (7.397s)
[681.516909] Starting dynamic subtest: slpc
[688.843943] Dynamic subtest slpc: SUCCESS (7.397s)
[688.941977] Starting dynamic subtest: guc
[697.244582] Dynamic subtest guc: SUCCESS (8.395s)
[697.293727] Starting dynamic subtest: guc_multi_lrc
[704.705678] Dynamic subtest guc_multi_lrc: SUCCESS (7.452s)
[704.752844] Starting dynamic subtest: guc_hang
[712.164147] Dynamic subtest guc_hang: SUCCESS (7.448s)
[712.242146] Starting dynamic subtest: late_gt_pm
[719.556573] Dynamic subtest late_gt_pm: SUCCESS (7.388s)
[719.561924] Subtest live: SUCCESS (304.749s)
[719.810257] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[719.820970] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[719.837276] [161/161] (401s left) dmabuf (all-tests)
[720.364085] Starting subtest: all-tests
[720.370483] Starting dynamic subtest: sanitycheck
[720.477414] Dynamic subtest sanitycheck: SUCCESS (0.111s)
[720.528518] Starting dynamic subtest: dma_fence
[720.743681] Dynamic subtest dma_fence: SUCCESS (0.261s)
[720.798083] Starting dynamic subtest: dma_fence_chain