[78.961095] Initializing watchdogs
[78.961414]   /dev/watchdog0
[79.023632] [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
[79.051124] [001/161] (960s left) i915_module_load (load)
[79.947331] Starting subtest: load
[85.302140] Subtest load: SUCCESS (5.389s)
[85.632610] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[85.653277] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[85.676574] [002/161] (954s left) core_auth (basic-auth)
[86.126123] Starting subtest: basic-auth
[86.135859] Subtest basic-auth: SUCCESS (0.011s)
[86.545641] [003/161] (953s left) debugfs_test (read_all_entries)
[86.967901] Starting subtest: read_all_entries
[87.264055] Subtest read_all_entries: SUCCESS (0.298s)
[87.968988] [004/161] (952s left) debugfs_test (basic-hwmon)
[88.244331] Starting subtest: basic-hwmon
[88.250146] Subtest basic-hwmon: SKIP (0.000s)
[88.877740] [005/161] (951s left) debugfs_test (sysfs)
[89.161978] Starting subtest: sysfs
[89.585558] Subtest sysfs: SUCCESS (0.424s)
[90.367337] [006/161] (950s left) fbdev (eof)
[90.641610] Starting subtest: eof
[90.643459] Subtest eof: SUCCESS (0.005s)
[90.869696] [007/161] (950s left) fbdev (info)
[91.116534] Starting subtest: info
[91.119960] Subtest info: SUCCESS (0.000s)
[91.322361] [008/161] (949s left) fbdev (nullptr)
[91.584574] Starting subtest: nullptr
[91.586559] Subtest nullptr: SUCCESS (0.000s)
[91.774473] [009/161] (949s left) fbdev (read)
[92.052830] Starting subtest: read
[94.134314] Subtest read: SUCCESS (2.079s)
[94.340569] [010/161] (947s left) fbdev (write)
[94.594324] Starting subtest: write
[95.693539] Subtest write: SUCCESS (1.095s)
[95.884736] [011/161] (945s left) gem_basic (bad-close)
[96.141109] Starting subtest: bad-close
[96.146230] Subtest bad-close: SUCCESS (0.000s)
[96.373925] [012/161] (945s left) gem_basic (create-close)
[96.633981] Starting subtest: create-close
[96.642213] Subtest create-close: SUCCESS (0.000s)
[96.858231] [013/161] (945s left) gem_basic (create-fd-close)
[97.113666] Starting subtest: create-fd-close
[97.121086] Subtest create-fd-close: SUCCESS (0.001s)
[97.339795] [014/161] (944s left) gem_busy (busy@all-engines)
[97.659525] Starting subtest: busy
[97.661213] Starting dynamic subtest: all-engines
[97.876781] Dynamic subtest all-engines: SUCCESS (0.217s)
[97.878360] Subtest busy: SUCCESS (0.219s)
[98.429883] [015/161] (943s left) gem_close_race (basic-process)
[98.760123] Starting subtest: basic-process
[98.917210] Subtest basic-process: SUCCESS (0.154s)
[99.263879] [016/161] (943s left) gem_close_race (basic-threads)
[99.588604] Starting subtest: basic-threads
[100.909160] Subtest basic-threads: SUCCESS (1.323s)
[101.269802] [017/161] (941s left) gem_ctx_create (basic)
[101.575560] Starting subtest: basic
[101.577216] Subtest basic: SUCCESS (0.000s)
[101.921524] [018/161] (940s left) gem_ctx_create (basic-files)
[102.233096] Starting subtest: basic-files
[104.315920] Subtest basic-files: SUCCESS (2.083s)
[104.652885] [019/161] (938s left) gem_ctx_exec (basic)
[104.927306] Starting subtest: basic
[104.937980] Subtest basic: SUCCESS (0.012s)
[105.199468] [020/161] (937s left) gem_exec_basic (basic)
[105.497105] Starting subtest: basic
[105.500609] Starting dynamic subtest: rcs0-smem
[105.509633] Dynamic subtest rcs0-smem: SUCCESS (0.008s)
[105.532997] Starting dynamic subtest: bcs0-smem
[105.541467] Dynamic subtest bcs0-smem: SUCCESS (0.025s)
[105.571227] Starting dynamic subtest: vcs0-smem
[105.572794] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[105.596980] Starting dynamic subtest: vecs0-smem
[105.599864] Dynamic subtest vecs0-smem: SUCCESS (0.024s)
[105.601951] Subtest basic: SUCCESS (0.072s)
[105.968607] [021/161] (937s left) gem_exec_create (basic)
[106.281749] Starting subtest: basic
[106.290594] Starting dynamic subtest: smem
[108.384601] Dynamic subtest smem: SUCCESS (2.100s)
[108.386404] Subtest basic: SUCCESS (2.103s)
[108.738868] [022/161] (934s left) gem_exec_fence (basic-busy)
[109.224180] Starting subtest: basic-busy
[109.225811] Starting dynamic subtest: rcs0
[109.265392] Dynamic subtest rcs0: SUCCESS (0.041s)
[109.292921] Starting dynamic subtest: bcs0
[109.308196] Dynamic subtest bcs0: SUCCESS (0.042s)
[109.333240] Starting dynamic subtest: vcs0
[109.348236] Dynamic subtest vcs0: SUCCESS (0.039s)
[109.372131] Starting dynamic subtest: vecs0
[109.392540] Dynamic subtest vecs0: SUCCESS (0.040s)
[109.394323] Subtest basic-busy: SUCCESS (0.169s)
[110.372409] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[110.384965] [023/161] (933s left) gem_exec_fence (basic-wait)
[110.862529] Starting subtest: basic-wait
[110.864173] Starting dynamic subtest: rcs0
[110.892991] Dynamic subtest rcs0: SUCCESS (0.027s)
[110.920074] Starting dynamic subtest: bcs0
[110.942454] Dynamic subtest bcs0: SUCCESS (0.047s)
[110.971266] Starting dynamic subtest: vcs0
[110.981959] Dynamic subtest vcs0: SUCCESS (0.035s)
[111.007901] Starting dynamic subtest: vecs0
[111.016171] Dynamic subtest vecs0: SUCCESS (0.033s)
[111.019913] Subtest basic-wait: SUCCESS (0.155s)
[111.861834] [024/161] (931s left) gem_exec_fence (basic-await)
[112.344390] Starting subtest: basic-await
[112.346814] Starting dynamic subtest: rcs0
[112.567372] Dynamic subtest rcs0: SUCCESS (0.215s)
[112.595332] Starting dynamic subtest: bcs0
[112.789861] Dynamic subtest bcs0: SUCCESS (0.213s)
[112.814711] Starting dynamic subtest: vcs0
[112.999439] Dynamic subtest vcs0: SUCCESS (0.219s)
[113.024247] Starting dynamic subtest: vecs0
[113.262659] Dynamic subtest vecs0: SUCCESS (0.259s)
[113.264595] Subtest basic-await: SUCCESS (0.919s)
[114.121363] [025/161] (929s left) gem_exec_fence (nb-await)
[114.601844] Starting subtest: nb-await
[114.603697] Starting dynamic subtest: rcs0
[114.695028] Dynamic subtest rcs0: SUCCESS (0.092s)
[114.719313] Starting dynamic subtest: bcs0
[114.794114] Dynamic subtest bcs0: SUCCESS (0.095s)
[114.819530] Starting dynamic subtest: vcs0
[114.903210] Dynamic subtest vcs0: SUCCESS (0.099s)
[114.934216] Starting dynamic subtest: vecs0
[115.004599] Dynamic subtest vecs0: SUCCESS (0.106s)
[115.006494] Subtest nb-await: SUCCESS (0.402s)
[115.838797] [026/161] (928s left) gem_exec_gttfill (basic)
[116.156518] Starting subtest: basic
[118.107087] Subtest basic: SKIP (1.917s)
[118.485771] [027/161] (925s left) gem_exec_parallel (engines)
[118.989125] Starting subtest: engines
[118.992670] Starting dynamic subtest: basic
[125.203299] Dynamic subtest basic: SUCCESS (6.218s)
[125.231099] Starting dynamic subtest: contexts
[135.877195] Dynamic subtest contexts: SUCCESS (10.670s)
[135.906309] Starting dynamic subtest: fds
[146.732996] Dynamic subtest fds: SUCCESS (10.849s)
[146.761892] Starting dynamic subtest: userptr
[152.956724] Dynamic subtest userptr: SUCCESS (6.224s)
[152.958300] Subtest engines: SUCCESS (33.970s)
[153.406910] [028/161] (891s left) gem_exec_store (basic)
[153.731780] Starting subtest: basic
[153.804477] Subtest basic: SUCCESS (0.078s)
[154.192782] [029/161] (890s left) gem_flink_basic (bad-flink)
[154.456920] Starting subtest: bad-flink
[154.460342] Subtest bad-flink: SUCCESS (0.000s)
[154.704788] [030/161] (890s left) gem_flink_basic (bad-open)
[154.969729] Starting subtest: bad-open
[154.973408] Subtest bad-open: SUCCESS (0.000s)
[155.214577] [031/161] (890s left) gem_flink_basic (basic)
[155.470116] Starting subtest: basic
[155.473114] Subtest basic: SUCCESS (0.001s)
[155.729145] [032/161] (889s left) gem_flink_basic (double-flink)
[155.978162] Starting subtest: double-flink
[155.980908] Subtest double-flink: SUCCESS (0.001s)
[156.227989] [033/161] (889s left) gem_flink_basic (flink-lifetime)
[156.524184] Starting subtest: flink-lifetime
[156.529184] Subtest flink-lifetime: SUCCESS (0.007s)
[156.771402] [034/161] (889s left) gem_huc_copy (huc-copy)
[157.038188] Subtest huc-copy: SKIP (0.000s)
[157.238943] [035/161] (888s left) gem_linear_blits (basic)
[157.874196] Subtest basic: SKIP (0.000s)
[158.090828] [036/161] (888s left) gem_mmap (basic)
[158.535133] Starting subtest: basic
[158.548689] Subtest basic: SUCCESS (0.002s)
[158.767446] [037/161] (887s left) gem_mmap_gtt (basic)
[159.031393] Starting subtest: basic
[159.033468] Subtest basic: SUCCESS (0.004s)
[159.271238] [038/161] (887s left) gem_render_linear_blits (basic)
[159.552638] Starting subtest: basic
[159.679374] Subtest basic: SUCCESS (0.122s)
[159.890835] [039/161] (886s left) gem_render_tiled_blits (basic)
[160.155490] Starting subtest: basic
[160.304442] Subtest basic: SUCCESS (0.145s)
[160.523249] [040/161] (886s left) gem_ringfill (basic-all)
[161.029185] Starting subtest: basic-all
[162.499886] Subtest basic-all: SUCCESS (1.467s)
[162.750784] [041/161] (884s left) gem_softpin (allocator-basic)
[163.026807] Starting subtest: allocator-basic
[163.397681] Subtest allocator-basic: SUCCESS (0.355s)
[163.687268] [042/161] (883s left) gem_softpin (allocator-basic-reserve)
[163.953243] Starting subtest: allocator-basic-reserve
[164.339500] Subtest allocator-basic-reserve: SUCCESS (0.357s)
[164.601876] [043/161] (882s left) gem_softpin (safe-alignment)
[164.881385] Starting subtest: safe-alignment
[164.942993] Subtest safe-alignment: SUCCESS (0.056s)
[165.192238] [044/161] (882s left) gem_sync (basic-all)
[165.507407] Starting subtest: basic-all
[168.545575] Subtest basic-all: SUCCESS (3.033s)
[168.909781] [045/161] (879s left) gem_sync (basic-each)
[169.223169] Starting subtest: basic-each
[172.175281] Subtest basic-each: SUCCESS (2.952s)
[172.562954] [046/161] (875s left) gem_tiled_blits (basic)
[173.165859] Subtest basic: SKIP (0.000s)
[173.378558] [047/161] (874s left) gem_tiled_fence_blits (basic)
[174.041761] Starting subtest: basic
[174.110671] Subtest basic: SUCCESS (0.066s)
[174.392667] [048/161] (874s left) gem_tiled_pread_basic
[175.776123] [049/161] (872s left) gem_wait (busy@all-engines)
[176.121528] Starting subtest: busy
[176.123809] Starting dynamic subtest: all-engines
[176.658570] Dynamic subtest all-engines: SUCCESS (0.538s)
[176.662591] Subtest busy: SUCCESS (0.540s)
[177.134451] [050/161] (871s left) gem_wait (wait@all-engines)
[177.475402] Starting subtest: wait
[177.477282] Starting dynamic subtest: all-engines
[178.521770] Dynamic subtest all-engines: SUCCESS (1.047s)
[178.523286] Subtest wait: SUCCESS (1.048s)
[178.973950] [051/161] (870s left) i915_getparams_basic (basic-eu-total)
[179.230487] Starting subtest: basic-eu-total
[179.235466] Subtest basic-eu-total: SUCCESS (0.000s)
[179.500137] [052/161] (869s left) i915_getparams_basic (basic-subslice-total)
[179.755159] Starting subtest: basic-subslice-total
[179.761557] Subtest basic-subslice-total: SUCCESS (0.000s)
[179.992410] [053/161] (869s left) i915_hangman (error-state-basic)
[180.310445] Starting subtest: error-state-basic
[180.327281] Subtest error-state-basic: SUCCESS (0.028s)
[180.635530] [054/161] (869s left) i915_pciid
[181.129362] [055/161] (868s left) kms_addfb_basic (addfb25-4-tiled)
[181.855565] Starting subtest: addfb25-4-tiled
[181.857245] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[182.098460] [056/161] (868s left) kms_addfb_basic (addfb25-bad-modifier)
[182.826556] Starting subtest: addfb25-bad-modifier
[182.831373] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[183.082743] [057/161] (867s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[183.825577] Starting subtest: addfb25-framebuffer-vs-set-tiling
[183.830349] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.004s)
[184.083969] [058/161] (866s left) kms_addfb_basic (addfb25-modifier-no-flag)
[184.777996] Starting subtest: addfb25-modifier-no-flag
[184.781109] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[185.005284] [059/161] (865s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[185.715555] Starting subtest: addfb25-x-tiled-legacy
[185.720604] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[185.965769] [060/161] (864s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[186.820661] Starting subtest: addfb25-x-tiled-mismatch-legacy
[186.827738] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s)
[187.091283] [061/161] (864s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[187.820906] Starting subtest: addfb25-yf-tiled-legacy
[187.823417] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[188.096859] [062/161] (863s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[188.786936] Starting subtest: addfb25-y-tiled-legacy
[188.789699] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[189.021137] [063/161] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[189.756201] Starting subtest: addfb25-y-tiled-small-legacy
[189.760497] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[190.016862] [064/161] (861s left) kms_addfb_basic (bad-pitch-0)
[190.281552] Starting subtest: bad-pitch-0
[190.284317] Subtest bad-pitch-0: SUCCESS (0.000s)
[190.978394] [065/161] (860s left) kms_addfb_basic (bad-pitch-1024)
[191.237646] Starting subtest: bad-pitch-1024
[191.240839] Subtest bad-pitch-1024: SUCCESS (0.000s)
[191.935909] [066/161] (860s left) kms_addfb_basic (bad-pitch-128)
[192.202555] Starting subtest: bad-pitch-128
[192.205581] Subtest bad-pitch-128: SUCCESS (0.000s)
[192.922293] [067/161] (859s left) kms_addfb_basic (bad-pitch-256)
[193.185520] Starting subtest: bad-pitch-256
[193.189271] Subtest bad-pitch-256: SUCCESS (0.000s)
[193.889781] [068/161] (858s left) kms_addfb_basic (bad-pitch-32)
[194.147505] Starting subtest: bad-pitch-32
[194.150047] Subtest bad-pitch-32: SUCCESS (0.000s)
[194.838845] [069/161] (857s left) kms_addfb_basic (bad-pitch-63)
[195.105769] Starting subtest: bad-pitch-63
[195.108395] Subtest bad-pitch-63: SUCCESS (0.000s)
[195.812752] [070/161] (857s left) kms_addfb_basic (bad-pitch-65536)
[196.070971] Starting subtest: bad-pitch-65536
[196.073708] Subtest bad-pitch-65536: SUCCESS (0.001s)
[196.816441] [071/161] (856s left) kms_addfb_basic (bad-pitch-999)
[197.079604] Starting subtest: bad-pitch-999
[197.083163] Subtest bad-pitch-999: SUCCESS (0.000s)
[197.807847] [072/161] (855s left) kms_addfb_basic (basic)
[198.060764] Starting subtest: basic
[198.065585] Subtest basic: SUCCESS (0.000s)
[198.762193] [073/161] (854s left) kms_addfb_basic (basic-x-tiled-legacy)
[199.024541] Starting subtest: basic-x-tiled-legacy
[199.026791] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[199.724454] [074/161] (853s left) kms_addfb_basic (basic-y-tiled-legacy)
[199.986613] Starting subtest: basic-y-tiled-legacy
[199.989837] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[200.718796] [075/161] (853s left) kms_addfb_basic (bo-too-small)
[201.501805] Starting subtest: bo-too-small
[201.512140] Subtest bo-too-small: SUCCESS (0.001s)
[201.760945] [076/161] (852s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[202.497828] Starting subtest: bo-too-small-due-to-tiling
[202.500810] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[202.728904] [077/161] (851s left) kms_addfb_basic (clobberred-modifier)
[202.987835] Starting subtest: clobberred-modifier
[202.991602] Subtest clobberred-modifier: SUCCESS (0.000s)
[203.689626] [078/161] (850s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[203.959824] Starting subtest: framebuffer-vs-set-tiling
[203.962883] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[204.677241] [079/161] (849s left) kms_addfb_basic (invalid-get-prop)
[204.932151] Starting subtest: invalid-get-prop
[204.934544] Subtest invalid-get-prop: SUCCESS (0.000s)
[205.665989] [080/161] (849s left) kms_addfb_basic (invalid-get-prop-any)
[205.924667] Starting subtest: invalid-get-prop-any
[205.927739] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[206.637896] [081/161] (848s left) kms_addfb_basic (invalid-set-prop)
[206.896571] Starting subtest: invalid-set-prop
[206.898919] Subtest invalid-set-prop: SUCCESS (0.000s)
[207.599464] [082/161] (847s left) kms_addfb_basic (invalid-set-prop-any)
[207.863306] Starting subtest: invalid-set-prop-any
[207.865165] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[208.583064] [083/161] (846s left) kms_addfb_basic (no-handle)
[208.846525] Starting subtest: no-handle
[208.848236] Subtest no-handle: SUCCESS (0.000s)
[209.559449] [084/161] (845s left) kms_addfb_basic (size-max)
[210.297993] Starting subtest: size-max
[210.300394] Subtest size-max: SUCCESS (0.001s)
[210.530799] [085/161] (845s left) kms_addfb_basic (small-bo)
[211.263231] Starting subtest: small-bo
[211.265525] Subtest small-bo: SUCCESS (0.000s)
[211.512239] [086/161] (844s left) kms_addfb_basic (tile-pitch-mismatch)
[211.764631] Starting subtest: tile-pitch-mismatch
[211.766833] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[212.478375] [087/161] (843s left) kms_addfb_basic (too-high)
[213.178859] Starting subtest: too-high
[213.188744] Subtest too-high: SUCCESS (0.010s)
[213.451768] [088/161] (842s left) kms_addfb_basic (too-wide)
[214.143513] Starting subtest: too-wide
[214.146477] Subtest too-wide: SUCCESS (0.000s)
[214.397146] [089/161] (842s left) kms_addfb_basic (unused-handle)
[214.656096] Starting subtest: unused-handle
[214.657548] Subtest unused-handle: SUCCESS (0.000s)
[215.373110] [090/161] (841s left) kms_addfb_basic (unused-modifier)
[215.630716] Starting subtest: unused-modifier
[215.634780] Subtest unused-modifier: SUCCESS (0.000s)
[216.376887] [091/161] (840s left) kms_addfb_basic (unused-offsets)
[216.640764] Starting subtest: unused-offsets
[216.642398] Subtest unused-offsets: SUCCESS (0.000s)
[217.363711] [092/161] (839s left) kms_addfb_basic (unused-pitches)
[217.617291] Starting subtest: unused-pitches
[217.620314] Subtest unused-pitches: SUCCESS (0.000s)
[218.345984] [093/161] (838s left) kms_busy (basic)
[219.137313] Starting subtest: basic
[219.138909] Starting dynamic subtest: flip
[220.064209] Dynamic subtest flip: SUCCESS (0.923s)
[220.124611] Starting dynamic subtest: modeset
[221.966504] Dynamic subtest modeset: SUCCESS (1.899s)
[221.973450] Subtest basic: SUCCESS (2.835s)
[222.657267] [094/161] (834s left) kms_prop_blob (basic)
[222.920142] Starting subtest: basic
[222.921853] Subtest basic: SUCCESS (0.001s)
[223.180231] [095/161] (834s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[223.908990] Starting subtest: basic-busy-flip-before-cursor-atomic
[224.976827] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.066s)
[225.586280] [096/161] (832s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[226.340131] Starting subtest: basic-busy-flip-before-cursor-legacy
[227.406852] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.062s)
[228.007602] [097/161] (830s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[228.726109] Starting subtest: basic-flip-after-cursor-atomic
[229.778210] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.044s)
[230.424324] [098/161] (827s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[231.187618] Starting subtest: basic-flip-after-cursor-legacy
[232.240657] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.046s)
[232.873700] [099/161] (825s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[233.621218] Starting subtest: basic-flip-after-cursor-varying-size
[234.667946] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.040s)
[235.265563] [100/161] (823s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[236.037198] Starting subtest: basic-flip-before-cursor-atomic
[237.080288] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.035s)
[237.688389] [101/161] (821s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[238.424635] Starting subtest: basic-flip-before-cursor-legacy
[239.463077] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.036s)
[240.055348] [102/161] (818s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[240.816120] Starting subtest: basic-flip-before-cursor-varying-size
[241.872192] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.048s)
[242.470907] [103/161] (816s left) kms_dsc (dsc-basic)
[243.235786] Subtest dsc-basic: SKIP (0.000s)
[243.433967] [104/161] (815s left) kms_flip (basic-flip-vs-dpms)
[244.193321] Starting subtest: basic-flip-vs-dpms
[244.201039] Starting dynamic subtest: C-HDMI-A2
[247.005974] Dynamic subtest C-HDMI-A2: SUCCESS (2.794s)
[247.012207] Subtest basic-flip-vs-dpms: SUCCESS (2.811s)
[247.649631] [105/161] (811s left) kms_flip (basic-flip-vs-modeset)
[248.418551] Starting subtest: basic-flip-vs-modeset
[248.422425] Starting dynamic subtest: C-HDMI-A2
[251.146077] Dynamic subtest C-HDMI-A2: SUCCESS (2.700s)
[251.149328] Subtest basic-flip-vs-modeset: SUCCESS (2.726s)
[251.865602] [106/161] (807s left) kms_flip (basic-flip-vs-wf_vblank)
[252.602441] Starting subtest: basic-flip-vs-wf_vblank
[252.617247] Starting dynamic subtest: C-HDMI-A2
[255.362816] Dynamic subtest C-HDMI-A2: SUCCESS (2.737s)
[255.364395] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.762s)
[255.687374] [107/161] (804s left) kms_flip (basic-plain-flip)
[256.452518] Starting subtest: basic-plain-flip
[256.456355] Starting dynamic subtest: C-HDMI-A2
[258.931159] Dynamic subtest C-HDMI-A2: SUCCESS (2.464s)
[258.935130] Subtest basic-plain-flip: SUCCESS (2.480s)
[259.242845] [108/161] (800s left) kms_force_connector_basic (force-connector-state)
[259.650135] Starting subtest: force-connector-state
[260.634858] Subtest force-connector-state: SUCCESS (0.980s)
[262.297507] [109/161] (798s left) kms_force_connector_basic (force-edid)
[262.724176] Starting subtest: force-edid
[262.832486] Subtest force-edid: SUCCESS (0.107s)
[263.771623] [110/161] (796s left) kms_force_connector_basic (force-load-detect)
[264.189468] Starting subtest: force-load-detect
[264.197576] Subtest force-load-detect: SKIP (0.000s)
[264.883288] [111/161] (795s left) kms_force_connector_basic (prune-stale-modes)
[265.331160] Starting subtest: prune-stale-modes
[265.463192] Subtest prune-stale-modes: SUCCESS (0.135s)
[266.416703] [112/161] (794s left) kms_frontbuffer_tracking (basic)
[267.264227] Starting subtest: basic
[272.251165] Subtest basic: SUCCESS (4.986s)
[272.523260] [113/161] (788s left) kms_hdmi_inject (inject-audio)
[272.896995] Starting subtest: inject-audio
[273.468236] Subtest inject-audio: SUCCESS (0.579s)
[274.233857] [114/161] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[275.019525] Starting subtest: compare-crc-sanitycheck-xr24
[275.022218] Starting dynamic subtest: pipe-C-HDMI-A-2
[275.552087] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.523s)
[275.556554] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.539s)
[276.207613] [115/161] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[277.008257] Starting subtest: compare-crc-sanitycheck-nv12
[277.010296] Starting dynamic subtest: pipe-C-HDMI-A-2
[277.016677] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[277.023384] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s)
[277.272545] [116/161] (784s left) kms_pipe_crc_basic (hang-read-crc)
[278.022570] Starting subtest: hang-read-crc
[278.024075] Starting dynamic subtest: pipe-C-HDMI-A-2
[279.582605] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.561s)
[279.594175] Subtest hang-read-crc: SUCCESS (1.573s)
[280.236142] [117/161] (781s left) kms_pipe_crc_basic (nonblocking-crc)
[281.035507] Starting subtest: nonblocking-crc
[281.037144] Starting dynamic subtest: pipe-C-HDMI-A-2
[281.733590] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.696s)
[281.735194] Subtest nonblocking-crc: SUCCESS (0.705s)
[282.375482] [118/161] (779s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[283.140137] Starting subtest: nonblocking-crc-frame-sequence
[283.147063] Starting dynamic subtest: pipe-C-HDMI-A-2
[283.880517] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.727s)
[283.884245] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.742s)
[284.494616] [119/161] (777s left) kms_pipe_crc_basic (read-crc)
[285.293457] Starting subtest: read-crc
[285.295131] Starting dynamic subtest: pipe-C-HDMI-A-2
[286.031472] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.731s)
[286.035400] Subtest read-crc: SUCCESS (0.749s)
[286.620168] [120/161] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[287.401086] Starting subtest: read-crc-frame-sequence
[287.403960] Starting dynamic subtest: pipe-C-HDMI-A-2
[288.043545] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.641s)
[288.046071] Subtest read-crc-frame-sequence: SUCCESS (0.650s)
[288.652294] [121/161] (774s left) kms_pm_backlight (basic-brightness)
[289.419650] Subtest basic-brightness: SKIP (0.000s)
[289.637172] [122/161] (773s left) kms_pm_rpm (basic-pci-d3-state)
[292.020325] Starting subtest: basic-pci-d3-state
[292.369387] Subtest basic-pci-d3-state: SUCCESS (0.345s)
[292.896905] [123/161] (770s left) kms_pm_rpm (basic-rte)
[293.152226] Starting subtest: basic-rte
[295.609406] Subtest basic-rte: SUCCESS (2.448s)
[296.773731] [124/161] (766s left) kms_psr (psr-primary-page-flip)
[297.578603] Subtest psr-primary-page-flip: SKIP (0.000s)
[297.800968] [125/161] (765s left) kms_psr (psr-cursor-plane-move)
[298.583619] Subtest psr-cursor-plane-move: SKIP (0.000s)
[298.797360] [126/161] (764s left) kms_psr (psr-sprite-plane-onoff)
[299.592387] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[299.814642] [127/161] (764s left) kms_psr (psr-primary-mmap-gtt)
[300.581112] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[300.808733] [128/161] (763s left) kms_setmode (basic-clone-single-crtc)
[301.085485] Starting subtest: basic-clone-single-crtc
[301.090350] Subtest basic-clone-single-crtc: SKIP (0.000s)
[301.357558] [129/161] (763s left) i915_pm_rps (basic-api)
[301.654629] Starting subtest: basic-api
[301.677154] Subtest basic-api: SUCCESS (0.022s)
[301.936178] [130/161] (762s left) prime_self_import (basic-llseek-bad)
[302.195754] Starting subtest: basic-llseek-bad
[302.210359] Subtest basic-llseek-bad: SUCCESS (0.010s)
[302.476613] [131/161] (762s left) prime_self_import (basic-llseek-size)
[302.724592] Starting subtest: basic-llseek-size
[302.738979] Subtest basic-llseek-size: SUCCESS (0.016s)
[303.002382] [132/161] (761s left) prime_self_import (basic-with_fd_dup)
[303.255270] Starting subtest: basic-with_fd_dup
[303.269220] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[303.517898] [133/161] (761s left) prime_self_import (basic-with_one_bo)
[303.782968] Starting subtest: basic-with_one_bo
[303.797754] Subtest basic-with_one_bo: SUCCESS (0.013s)
[304.034542] [134/161] (761s left) prime_self_import (basic-with_one_bo_two_files)
[304.286278] Starting subtest: basic-with_one_bo_two_files
[304.301817] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[304.538505] [135/161] (761s left) prime_self_import (basic-with_two_bos)
[304.792781] Starting subtest: basic-with_two_bos
[304.806554] Subtest basic-with_two_bos: SUCCESS (0.013s)
[305.049093] [136/161] (760s left) prime_vgem (basic-fence-flip)
[305.349179] Starting subtest: basic-fence-flip
[306.172118] Subtest basic-fence-flip: SKIP (0.819s)
[306.596464] [137/161] (759s left) prime_vgem (basic-fence-mmap)
[306.897588] Starting subtest: basic-fence-mmap
[307.021445] Subtest basic-fence-mmap: SUCCESS (0.119s)
[307.301463] [138/161] (758s left) prime_vgem (basic-fence-read)
[307.609093] Starting subtest: basic-fence-read
[307.863863] Subtest basic-fence-read: SUCCESS (0.256s)
[308.123662] [139/161] (758s left) prime_vgem (basic-gtt)
[308.422458] Starting subtest: basic-gtt
[308.478572] Subtest basic-gtt: SUCCESS (0.051s)
[308.748420] [140/161] (757s left) prime_vgem (basic-read)
[309.049050] Starting subtest: basic-read
[309.183776] Subtest basic-read: SUCCESS (0.111s)
[309.433340] [141/161] (757s left) prime_vgem (basic-write)
[309.757318] Starting subtest: basic-write
[309.919222] Subtest basic-write: SUCCESS (0.161s)
[310.182756] [142/161] (756s left) vgem_basic (setversion)
[310.457637] Starting subtest: setversion
[310.463135] Subtest setversion: SUCCESS (0.000s)
[310.704904] [143/161] (756s left) vgem_basic (create)
[310.991575] Starting subtest: create
[310.994989] Subtest create: SUCCESS (0.001s)
[311.231397] [144/161] (756s left) vgem_basic (debugfs)
[311.518143] Starting subtest: debugfs
[311.519983] Subtest debugfs: SUCCESS (0.002s)
[311.751265] [145/161] (755s left) vgem_basic (dmabuf-export)
[312.042611] Starting subtest: dmabuf-export
[312.047314] Subtest dmabuf-export: SUCCESS (0.009s)
[312.300741] [146/161] (755s left) vgem_basic (dmabuf-fence)
[312.579549] Starting subtest: dmabuf-fence
[312.581241] Subtest dmabuf-fence: SUCCESS (0.003s)
[312.806961] [147/161] (755s left) vgem_basic (dmabuf-fence-before)
[313.085994] Starting subtest: dmabuf-fence-before
[313.088270] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[313.309449] [148/161] (754s left) vgem_basic (dmabuf-mmap)
[313.597173] Starting subtest: dmabuf-mmap
[313.645188] Subtest dmabuf-mmap: SUCCESS (0.050s)
[313.877285] [149/161] (754s left) vgem_basic (mmap)
[314.144585] Starting subtest: mmap
[314.171669] Subtest mmap: SUCCESS (0.032s)
[314.396779] [150/161] (754s left) vgem_basic (second-client)
[314.683563] Starting subtest: second-client
[314.703924] Subtest second-client: SUCCESS (0.031s)
[314.944215] [151/161] (753s left) vgem_basic (sysfs)
[315.205524] Starting subtest: sysfs
[315.208559] Subtest sysfs: SUCCESS (0.003s)
[315.452930] [152/161] (753s left) core_hotunplug (unbind-rebind)
[315.924793] Starting subtest: unbind-rebind
[323.297757] Subtest unbind-rebind: SUCCESS (7.360s)
[323.502300] [153/161] (745s left) vgem_basic (unload)
[323.762772] Starting subtest: unload
[353.092428] Subtest unload: SUCCESS (29.322s)
[353.493389] [154/161] (715s left) i915_module_load (reload)
[353.747793] Starting subtest: reload
[360.999223] Subtest reload: SUCCESS (7.257s)
[361.438110] [155/161] (708s left) gem_lmem_swapping (basic)
[362.134622] Subtest basic: SKIP (0.000s)
[362.568819] [156/161] (707s left) gem_lmem_swapping (parallel-random-engines)
[362.858062] Subtest parallel-random-engines: SKIP (0.000s)
[363.070421] [157/161] (707s left) gem_lmem_swapping (random-engines)
[363.362531] Subtest random-engines: SKIP (0.000s)
[363.568705] [158/161] (707s left) gem_lmem_swapping (verify-random)
[363.846750] Subtest verify-random: SKIP (0.000s)
[364.046636] [159/161] (706s left) i915_pm_rpm (module-reload)
[366.738639] Starting subtest: module-reload
[384.900236] Subtest module-reload: SUCCESS (18.162s)
[385.054988] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[385.060998] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[385.078961] [160/161] (685s left) i915_selftest (live)
[385.361696] Starting subtest: live
[385.365217] Starting dynamic subtest: sanitycheck
[389.556138] Dynamic subtest sanitycheck: SUCCESS (4.188s)
[389.586241] Starting dynamic subtest: uncore
[393.891263] Dynamic subtest uncore: SUCCESS (4.326s)
[393.918331] Starting dynamic subtest: workarounds
[398.410778] Dynamic subtest workarounds: SUCCESS (4.504s)
[398.460404] Starting dynamic subtest: gt_engines
[403.277078] Dynamic subtest gt_engines: SUCCESS (4.859s)
[403.350128] Starting dynamic subtest: gt_timelines
[434.528720] Dynamic subtest gt_timelines: SUCCESS (31.222s)
[434.561334] Starting dynamic subtest: gt_contexts
[439.222522] Dynamic subtest gt_contexts: SUCCESS (4.707s)
[439.247034] Starting dynamic subtest: gt_lrc
[446.780353] Dynamic subtest gt_lrc: SUCCESS (7.554s)
[446.809899] Starting dynamic subtest: gt_mocs
[451.107527] Dynamic subtest gt_mocs: SUCCESS (4.314s)
[451.132580] Starting dynamic subtest: gt_pm
[456.532405] Dynamic subtest gt_pm: SUCCESS (5.420s)
[456.571346] Starting dynamic subtest: gt_heartbeat
[460.975766] Dynamic subtest gt_heartbeat: SUCCESS (4.433s)
[461.013151] Starting dynamic subtest: gt_tlb
[465.675851] Dynamic subtest gt_tlb: SUCCESS (4.682s)
[465.705439] Starting dynamic subtest: requests
[476.530557] Dynamic subtest requests: SUCCESS (10.848s)
[476.566310] Starting dynamic subtest: migrate
[484.147918] Dynamic subtest migrate: SUCCESS (7.615s)
[484.178470] Starting dynamic subtest: active
[488.725110] Dynamic subtest active: SUCCESS (4.560s)
[488.759982] Starting dynamic subtest: objects
[494.959164] Dynamic subtest objects: SUCCESS (6.234s)
[494.992879] Starting dynamic subtest: mman
[506.453605] Dynamic subtest mman: SUCCESS (11.476s)
[506.495914] Starting dynamic subtest: dmabuf
[510.842098] Dynamic subtest dmabuf: SUCCESS (4.377s)
[510.911464] Starting dynamic subtest: vma
[515.121197] Dynamic subtest vma: SUCCESS (4.254s)
[515.167563] Starting dynamic subtest: coherency
[524.604969] Dynamic subtest coherency: SUCCESS (9.482s)
[524.660239] Starting dynamic subtest: gtt
[535.992450] Dynamic subtest gtt: SUCCESS (11.380s)
[536.026594] Starting dynamic subtest: gem
[541.368669] Dynamic subtest gem: SUCCESS (5.370s)
[541.400023] Starting dynamic subtest: evict
[552.222431] Dynamic subtest evict: SUCCESS (10.835s)
[552.266683] Starting dynamic subtest: hugepages
[557.062447] Dynamic subtest hugepages: SUCCESS (4.828s)
[557.099211] Starting dynamic subtest: gem_contexts
[586.039065] Dynamic subtest gem_contexts: SUCCESS (28.966s)
[586.065294] Starting dynamic subtest: client
[597.758175] Dynamic subtest client: SUCCESS (11.704s)
[597.783372] Starting dynamic subtest: gem_migrate
[602.225767] Dynamic subtest gem_migrate: SUCCESS (4.459s)
[602.283181] Starting dynamic subtest: reset
[613.901123] Dynamic subtest reset: SUCCESS (11.668s)
[613.945956] Starting dynamic subtest: memory_region
[618.073433] Dynamic subtest memory_region: SUCCESS (4.164s)
[618.106676] Starting dynamic subtest: hangcheck
[645.992871] Dynamic subtest hangcheck: SUCCESS (27.912s)
[646.029075] Starting dynamic subtest: execlists
[656.548668] Dynamic subtest execlists: SUCCESS (10.548s)
[656.586418] Starting dynamic subtest: ring_submission
[660.908690] Dynamic subtest ring_submission: SUCCESS (4.344s)
[660.935664] Starting dynamic subtest: perf
[665.542514] Dynamic subtest perf: SUCCESS (4.621s)
[665.600690] Starting dynamic subtest: slpc
[669.838385] Dynamic subtest slpc: SUCCESS (4.284s)
[669.869782] Starting dynamic subtest: guc
[674.100286] Dynamic subtest guc: SUCCESS (4.250s)
[674.135228] Starting dynamic subtest: guc_multi_lrc
[678.290601] Dynamic subtest guc_multi_lrc: SUCCESS (4.187s)
[678.323048] Starting dynamic subtest: guc_hang
[682.776431] Dynamic subtest guc_hang: SUCCESS (4.471s)
[682.809166] Starting dynamic subtest: late_gt_pm
[687.063189] Dynamic subtest late_gt_pm: SUCCESS (4.276s)
[687.067698] Subtest live: SUCCESS (301.693s)
[687.237678] [161/161] (383s left) dmabuf (all-tests)
[687.557067] Starting subtest: all-tests
[687.565169] Starting dynamic subtest: sanitycheck
[687.615811] Dynamic subtest sanitycheck: SUCCESS (0.059s)
[687.669200] Starting dynamic subtest: dma_fence
[687.889695] Dynamic subtest dma_fence: SUCCESS (0.261s)
[687.945755] Starting dynamic subtest: dma_fence_chain
[711.483158] Dynamic subtest dma_fence_chain: SUCCESS (23.580s)
[711.543690] Starting dynamic subtest: dma_fence_unwrap
[711.580374] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s)
[711.621315] Starting dynamic subtest: dma_resv
[711.711845] Dynamic subtest dma_resv: SUCCESS (0.121s)
[711.719661] Subtest all-tests: SUCCESS (24.165s)
[711.846629] Closing watchdogs
Done.