[77.674927] Initializing watchdogs
[77.675470]   /dev/watchdog0
[77.754485] [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
[77.786149] [001/161] (960s left) i915_module_load (load)
[78.712398] Starting subtest: load
[84.482721] Subtest load: SUCCESS (5.752s)
[84.943524] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[84.958582] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[84.978813] [002/161] (953s left) core_auth (basic-auth)
[85.521148] Starting subtest: basic-auth
[85.542363] Subtest basic-auth: SUCCESS (0.042s)
[85.891790] [003/161] (953s left) debugfs_test (read_all_entries)
[86.280555] Starting subtest: read_all_entries
[86.563277] Subtest read_all_entries: SUCCESS (0.288s)
[87.276323] [004/161] (951s left) debugfs_test (basic-hwmon)
[87.568326] Starting subtest: basic-hwmon
[87.573652] Subtest basic-hwmon: SKIP (0.000s)
[88.378346] [005/161] (950s left) debugfs_test (sysfs)
[88.669880] Starting subtest: sysfs
[89.069055] Subtest sysfs: SUCCESS (0.398s)
[89.812913] [006/161] (949s left) fbdev (eof)
[90.104690] Starting subtest: eof
[90.107502] Subtest eof: SUCCESS (0.004s)
[90.323149] [007/161] (949s left) fbdev (info)
[90.581224] Starting subtest: info
[90.587494] Subtest info: SUCCESS (0.000s)
[90.806750] [008/161] (949s left) fbdev (nullptr)
[91.083743] Starting subtest: nullptr
[91.087221] Subtest nullptr: SUCCESS (0.000s)
[91.343941] [009/161] (948s left) fbdev (read)
[91.615297] Starting subtest: read
[93.767202] Subtest read: SUCCESS (2.149s)
[93.974251] [010/161] (946s left) fbdev (write)
[94.266432] Starting subtest: write
[95.403708] Subtest write: SUCCESS (1.136s)
[95.616539] [011/161] (944s left) gem_basic (bad-close)
[95.898886] Starting subtest: bad-close
[95.904591] Subtest bad-close: SUCCESS (0.000s)
[96.151985] [012/161] (944s left) gem_basic (create-close)
[96.418782] Starting subtest: create-close
[96.425183] Subtest create-close: SUCCESS (0.001s)
[96.656374] [013/161] (944s left) gem_basic (create-fd-close)
[96.937810] Starting subtest: create-fd-close
[96.942683] Subtest create-fd-close: SUCCESS (0.001s)
[97.171712] [014/161] (943s left) gem_busy (busy@all-engines)
[97.505186] Starting subtest: busy
[97.508352] Starting dynamic subtest: all-engines
[97.718135] Dynamic subtest all-engines: SUCCESS (0.217s)
[97.721686] Subtest busy: SUCCESS (0.220s)
[98.292765] [015/161] (942s left) gem_close_race (basic-process)
[98.633906] Starting subtest: basic-process
[98.813619] Subtest basic-process: SUCCESS (0.184s)
[99.185749] [016/161] (942s left) gem_close_race (basic-threads)
[99.520795] Starting subtest: basic-threads
[100.740198] Subtest basic-threads: SUCCESS (1.214s)
[101.125789] [017/161] (940s left) gem_ctx_create (basic)
[101.446704] Starting subtest: basic
[101.450584] Subtest basic: SUCCESS (0.000s)
[101.812796] [018/161] (939s left) gem_ctx_create (basic-files)
[102.150947] Starting subtest: basic-files
[104.272129] Subtest basic-files: SUCCESS (2.126s)
[104.642988] [019/161] (937s left) gem_ctx_exec (basic)
[104.938118] Starting subtest: basic
[104.961474] Subtest basic: SUCCESS (0.020s)
[105.224793] [020/161] (936s left) gem_exec_basic (basic)
[105.526493] Starting subtest: basic
[105.528589] Starting dynamic subtest: rcs0-smem
[105.531238] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[105.572851] Starting dynamic subtest: bcs0-smem
[105.574741] Dynamic subtest bcs0-smem: SUCCESS (0.024s)
[105.614590] Starting dynamic subtest: vcs0-smem
[105.616429] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[105.640105] Starting dynamic subtest: vecs0-smem
[105.641799] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[105.643489] Subtest basic: SUCCESS (0.043s)
[105.948294] [021/161] (936s left) gem_exec_create (basic)
[106.263397] Starting subtest: basic
[106.266207] Starting dynamic subtest: smem
[108.373527] Dynamic subtest smem: SUCCESS (2.107s)
[108.376883] Subtest basic: SUCCESS (2.109s)
[108.731198] [022/161] (933s left) gem_exec_fence (basic-busy)
[109.232785] Starting subtest: basic-busy
[109.237512] Starting dynamic subtest: rcs0
[109.256280] Dynamic subtest rcs0: SUCCESS (0.026s)
[109.287928] Starting dynamic subtest: bcs0
[109.293533] Dynamic subtest bcs0: SUCCESS (0.035s)
[109.317503] Starting dynamic subtest: vcs0
[109.325092] Dynamic subtest vcs0: SUCCESS (0.032s)
[109.349450] Starting dynamic subtest: vecs0
[109.363984] Dynamic subtest vecs0: SUCCESS (0.033s)
[109.366290] Subtest basic-busy: SUCCESS (0.134s)
[110.378737] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[110.385578] [023/161] (932s left) gem_exec_fence (basic-wait)
[110.879380] Starting subtest: basic-wait
[110.883982] Starting dynamic subtest: rcs0
[110.905828] Dynamic subtest rcs0: SUCCESS (0.029s)
[110.955416] Starting dynamic subtest: bcs0
[110.958564] Dynamic subtest bcs0: SUCCESS (0.033s)
[110.985401] Starting dynamic subtest: vcs0
[110.987672] Dynamic subtest vcs0: SUCCESS (0.041s)
[111.019458] Starting dynamic subtest: vecs0
[111.027600] Dynamic subtest vecs0: SUCCESS (0.036s)
[111.029292] Subtest basic-wait: SUCCESS (0.150s)
[111.870725] [024/161] (931s left) gem_exec_fence (basic-await)
[112.377942] Starting subtest: basic-await
[112.381873] Starting dynamic subtest: rcs0
[112.617865] Dynamic subtest rcs0: SUCCESS (0.236s)
[112.645694] Starting dynamic subtest: bcs0
[112.856336] Dynamic subtest bcs0: SUCCESS (0.235s)
[112.888225] Starting dynamic subtest: vcs0
[113.088478] Dynamic subtest vcs0: SUCCESS (0.218s)
[113.113738] Starting dynamic subtest: vecs0
[113.321180] Dynamic subtest vecs0: SUCCESS (0.233s)
[113.323312] Subtest basic-await: SUCCESS (0.941s)
[114.178911] [025/161] (928s left) gem_exec_fence (nb-await)
[114.681833] Starting subtest: nb-await
[114.685770] Starting dynamic subtest: rcs0
[114.783803] Dynamic subtest rcs0: SUCCESS (0.100s)
[114.809600] Starting dynamic subtest: bcs0
[114.887267] Dynamic subtest bcs0: SUCCESS (0.095s)
[114.915754] Starting dynamic subtest: vcs0
[114.989967] Dynamic subtest vcs0: SUCCESS (0.098s)
[115.016100] Starting dynamic subtest: vecs0
[115.086938] Dynamic subtest vecs0: SUCCESS (0.100s)
[115.089535] Subtest nb-await: SUCCESS (0.405s)
[115.955848] [026/161] (927s left) gem_exec_gttfill (basic)
[116.285855] Starting subtest: basic
[148.959183] Subtest basic: SUCCESS (32.681s)
[149.400481] [027/161] (894s left) gem_exec_parallel (engines)
[149.903315] Starting subtest: engines
[149.911523] Starting dynamic subtest: basic
[158.527457] Dynamic subtest basic: SUCCESS (8.614s)
[158.567134] Starting dynamic subtest: contexts
[168.688255] Dynamic subtest contexts: SUCCESS (10.174s)
[168.717058] Starting dynamic subtest: fds
[180.322381] Dynamic subtest fds: SUCCESS (11.628s)
[180.354825] Starting dynamic subtest: userptr
[186.606666] Dynamic subtest userptr: SUCCESS (6.283s)
[186.608807] Subtest engines: SUCCESS (36.708s)
[187.046722] [028/161] (856s left) gem_exec_store (basic)
[187.367644] Starting subtest: basic
[187.450404] Subtest basic: SUCCESS (0.087s)
[187.856623] [029/161] (856s left) gem_flink_basic (bad-flink)
[188.121618] Starting subtest: bad-flink
[188.124339] Subtest bad-flink: SUCCESS (0.000s)
[188.385180] [030/161] (855s left) gem_flink_basic (bad-open)
[188.645729] Starting subtest: bad-open
[188.647751] Subtest bad-open: SUCCESS (0.000s)
[188.923698] [031/161] (855s left) gem_flink_basic (basic)
[189.193169] Starting subtest: basic
[189.199714] Subtest basic: SUCCESS (0.001s)
[189.456831] [032/161] (855s left) gem_flink_basic (double-flink)
[189.726384] Starting subtest: double-flink
[189.728875] Subtest double-flink: SUCCESS (0.001s)
[189.998590] [033/161] (854s left) gem_flink_basic (flink-lifetime)
[190.264434] Starting subtest: flink-lifetime
[190.266963] Subtest flink-lifetime: SUCCESS (0.007s)
[190.531234] [034/161] (854s left) gem_huc_copy (huc-copy)
[190.814706] Subtest huc-copy: SKIP (0.000s)
[191.046376] [035/161] (854s left) gem_linear_blits (basic)
[191.647841] Starting subtest: basic
[191.703592] Subtest basic: SUCCESS (0.057s)
[192.006191] [036/161] (853s left) gem_mmap (basic)
[192.440761] Starting subtest: basic
[192.454929] Subtest basic: SUCCESS (0.002s)
[192.724746] [037/161] (852s left) gem_mmap_gtt (basic)
[193.006405] Starting subtest: basic
[193.015629] Subtest basic: SUCCESS (0.008s)
[193.304263] [038/161] (852s left) gem_render_linear_blits (basic)
[193.591071] Starting subtest: basic
[193.744428] Subtest basic: SUCCESS (0.147s)
[193.963247] [039/161] (852s left) gem_render_tiled_blits (basic)
[194.234360] Starting subtest: basic
[194.407586] Subtest basic: SUCCESS (0.159s)
[194.633615] [040/161] (851s left) gem_ringfill (basic-all)
[195.177499] Starting subtest: basic-all
[196.615213] Subtest basic-all: SUCCESS (1.439s)
[196.937988] [041/161] (849s left) gem_softpin (allocator-basic)
[197.216280] Starting subtest: allocator-basic
[197.581405] Subtest allocator-basic: SUCCESS (0.364s)
[197.893444] [042/161] (848s left) gem_softpin (allocator-basic-reserve)
[198.180145] Starting subtest: allocator-basic-reserve
[198.559701] Subtest allocator-basic-reserve: SUCCESS (0.373s)
[198.867681] [043/161] (848s left) gem_softpin (safe-alignment)
[199.164523] Starting subtest: safe-alignment
[199.211654] Subtest safe-alignment: SUCCESS (0.046s)
[199.487691] [044/161] (847s left) gem_sync (basic-all)
[199.812692] Starting subtest: basic-all
[202.932577] Subtest basic-all: SUCCESS (3.118s)
[203.332780] [045/161] (844s left) gem_sync (basic-each)
[203.665491] Starting subtest: basic-each
[206.467633] Subtest basic-each: SUCCESS (2.798s)
[206.877960] [046/161] (840s left) gem_tiled_blits (basic)
[207.372279] Starting subtest: basic
[207.458656] Subtest basic: SUCCESS (0.085s)
[207.804182] [047/161] (840s left) gem_tiled_fence_blits (basic)
[208.496823] Starting subtest: basic
[208.565625] Subtest basic: SUCCESS (0.063s)
[208.857860] [048/161] (839s left) gem_tiled_pread_basic
[210.191181] [049/161] (838s left) gem_wait (busy@all-engines)
[210.544528] Starting subtest: busy
[210.549587] Starting dynamic subtest: all-engines
[211.085595] Dynamic subtest all-engines: SUCCESS (0.540s)
[211.087493] Subtest busy: SUCCESS (0.542s)
[211.616973] [050/161] (836s left) gem_wait (wait@all-engines)
[211.970173] Starting subtest: wait
[211.975363] Starting dynamic subtest: all-engines
[213.023774] Dynamic subtest all-engines: SUCCESS (1.053s)
[213.026700] Subtest wait: SUCCESS (1.054s)
[213.507811] [051/161] (835s left) i915_getparams_basic (basic-eu-total)
[213.767353] Starting subtest: basic-eu-total
[213.772440] Subtest basic-eu-total: SUCCESS (0.000s)
[214.017609] [052/161] (834s left) i915_getparams_basic (basic-subslice-total)
[214.280756] Starting subtest: basic-subslice-total
[214.286130] Subtest basic-subslice-total: SUCCESS (0.001s)
[214.540095] [053/161] (834s left) i915_hangman (error-state-basic)
[214.867647] Starting subtest: error-state-basic
[214.915803] Subtest error-state-basic: SUCCESS (0.059s)
[215.176767] [054/161] (834s left) i915_pciid
[215.679740] [055/161] (833s left) kms_addfb_basic (addfb25-4-tiled)
[216.429695] Starting subtest: addfb25-4-tiled
[216.434084] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[216.698831] [056/161] (832s left) kms_addfb_basic (addfb25-bad-modifier)
[217.443338] Starting subtest: addfb25-bad-modifier
[217.447301] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[217.697218] [057/161] (832s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[218.467527] Starting subtest: addfb25-framebuffer-vs-set-tiling
[218.469986] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[218.736152] [058/161] (831s left) kms_addfb_basic (addfb25-modifier-no-flag)
[219.489636] Starting subtest: addfb25-modifier-no-flag
[219.494182] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[219.767174] [059/161] (830s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[220.543133] Starting subtest: addfb25-x-tiled-legacy
[220.546104] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[220.820763] [060/161] (829s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[221.568279] Starting subtest: addfb25-x-tiled-mismatch-legacy
[221.569982] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[221.838276] [061/161] (828s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[222.584210] Starting subtest: addfb25-yf-tiled-legacy
[222.586537] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.003s)
[222.950956] [062/161] (828s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[223.686865] Starting subtest: addfb25-y-tiled-legacy
[223.689066] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[223.971757] [063/161] (827s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[224.826786] Starting subtest: addfb25-y-tiled-small-legacy
[224.831961] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s)
[225.164970] [064/161] (826s left) kms_addfb_basic (bad-pitch-0)
[225.432538] Starting subtest: bad-pitch-0
[225.434415] Subtest bad-pitch-0: SUCCESS (0.000s)
[226.189456] [065/161] (825s left) kms_addfb_basic (bad-pitch-1024)
[226.460147] Starting subtest: bad-pitch-1024
[226.463609] Subtest bad-pitch-1024: SUCCESS (0.000s)
[227.181717] [066/161] (824s left) kms_addfb_basic (bad-pitch-128)
[227.449562] Starting subtest: bad-pitch-128
[227.453667] Subtest bad-pitch-128: SUCCESS (0.000s)
[228.143737] [067/161] (823s left) kms_addfb_basic (bad-pitch-256)
[228.411565] Starting subtest: bad-pitch-256
[228.414438] Subtest bad-pitch-256: SUCCESS (0.000s)
[229.155838] [068/161] (823s left) kms_addfb_basic (bad-pitch-32)
[229.433736] Starting subtest: bad-pitch-32
[229.435617] Subtest bad-pitch-32: SUCCESS (0.000s)
[230.146720] [069/161] (822s left) kms_addfb_basic (bad-pitch-63)
[230.422489] Starting subtest: bad-pitch-63
[230.425950] Subtest bad-pitch-63: SUCCESS (0.000s)
[231.184513] [070/161] (821s left) kms_addfb_basic (bad-pitch-65536)
[231.455236] Starting subtest: bad-pitch-65536
[231.457688] Subtest bad-pitch-65536: SUCCESS (0.001s)
[232.200215] [071/161] (820s left) kms_addfb_basic (bad-pitch-999)
[232.465336] Starting subtest: bad-pitch-999
[232.468684] Subtest bad-pitch-999: SUCCESS (0.000s)
[233.225564] [072/161] (819s left) kms_addfb_basic (basic)
[233.494559] Starting subtest: basic
[233.498623] Subtest basic: SUCCESS (0.001s)
[234.250925] [073/161] (819s left) kms_addfb_basic (basic-x-tiled-legacy)
[234.528702] Starting subtest: basic-x-tiled-legacy
[234.531382] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[235.286622] [074/161] (818s left) kms_addfb_basic (basic-y-tiled-legacy)
[235.552816] Starting subtest: basic-y-tiled-legacy
[235.556537] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[236.286247] [075/161] (817s left) kms_addfb_basic (bo-too-small)
[237.060250] Starting subtest: bo-too-small
[237.063423] Subtest bo-too-small: SUCCESS (0.003s)
[237.332752] [076/161] (816s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[238.172803] Starting subtest: bo-too-small-due-to-tiling
[238.176925] Subtest bo-too-small-due-to-tiling: SUCCESS (0.004s)
[238.431584] [077/161] (815s left) kms_addfb_basic (clobberred-modifier)
[238.705049] Starting subtest: clobberred-modifier
[238.707331] Subtest clobberred-modifier: SUCCESS (0.000s)
[239.459911] [078/161] (814s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[239.740665] Starting subtest: framebuffer-vs-set-tiling
[239.744175] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[240.457827] [079/161] (814s left) kms_addfb_basic (invalid-get-prop)
[240.727444] Starting subtest: invalid-get-prop
[240.730202] Subtest invalid-get-prop: SUCCESS (0.001s)
[241.455674] [080/161] (813s left) kms_addfb_basic (invalid-get-prop-any)
[241.744342] Starting subtest: invalid-get-prop-any
[241.747109] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[242.501812] [081/161] (812s left) kms_addfb_basic (invalid-set-prop)
[242.762087] Starting subtest: invalid-set-prop
[242.765301] Subtest invalid-set-prop: SUCCESS (0.000s)
[243.536582] [082/161] (811s left) kms_addfb_basic (invalid-set-prop-any)
[243.821308] Starting subtest: invalid-set-prop-any
[243.823281] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[244.581191] [083/161] (810s left) kms_addfb_basic (no-handle)
[244.876196] Starting subtest: no-handle
[244.881427] Subtest no-handle: SUCCESS (0.000s)
[245.906739] [084/161] (809s left) kms_addfb_basic (size-max)
[247.070686] Starting subtest: size-max
[247.079094] Subtest size-max: SUCCESS (0.000s)
[247.505334] [085/161] (808s left) kms_addfb_basic (small-bo)
[248.462358] Starting subtest: small-bo
[248.465576] Subtest small-bo: SUCCESS (0.000s)
[248.730257] [086/161] (807s left) kms_addfb_basic (tile-pitch-mismatch)
[249.012522] Starting subtest: tile-pitch-mismatch
[249.015083] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[249.771755] [087/161] (806s left) kms_addfb_basic (too-high)
[250.570805] Starting subtest: too-high
[250.573936] Subtest too-high: SUCCESS (0.004s)
[250.814241] [088/161] (805s left) kms_addfb_basic (too-wide)
[251.582796] Starting subtest: too-wide
[251.587315] Subtest too-wide: SUCCESS (0.000s)
[251.860527] [089/161] (804s left) kms_addfb_basic (unused-handle)
[252.130829] Starting subtest: unused-handle
[252.134534] Subtest unused-handle: SUCCESS (0.000s)
[252.965575] [090/161] (804s left) kms_addfb_basic (unused-modifier)
[253.233766] Starting subtest: unused-modifier
[253.237349] Subtest unused-modifier: SUCCESS (0.000s)
[254.025165] [091/161] (803s left) kms_addfb_basic (unused-offsets)
[254.304879] Starting subtest: unused-offsets
[254.308381] Subtest unused-offsets: SUCCESS (0.000s)
[255.077649] [092/161] (802s left) kms_addfb_basic (unused-pitches)
[255.344575] Starting subtest: unused-pitches
[255.347627] Subtest unused-pitches: SUCCESS (0.001s)
[256.100889] [093/161] (801s left) kms_busy (basic)
[256.885619] Starting subtest: basic
[256.901092] Starting dynamic subtest: flip
[257.904326] Dynamic subtest flip: SUCCESS (0.997s)
[257.970239] Starting dynamic subtest: modeset
[259.992811] Dynamic subtest modeset: SUCCESS (2.083s)
[259.998909] Subtest basic: SUCCESS (3.097s)
[260.716713] [094/161] (797s left) kms_prop_blob (basic)
[260.992754] Starting subtest: basic
[260.995306] Subtest basic: SUCCESS (0.000s)
[261.249747] [095/161] (796s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[261.979856] Starting subtest: basic-busy-flip-before-cursor-atomic
[263.048452] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.072s)
[263.665233] [096/161] (794s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[264.418998] Starting subtest: basic-busy-flip-before-cursor-legacy
[265.492346] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.066s)
[266.116845] [097/161] (792s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[266.907585] Starting subtest: basic-flip-after-cursor-atomic
[267.940448] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.039s)
[268.577327] [098/161] (790s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[269.348710] Starting subtest: basic-flip-after-cursor-legacy
[270.379137] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[271.013925] [099/161] (787s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[271.780094] Starting subtest: basic-flip-after-cursor-varying-size
[272.831846] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.048s)
[273.495666] [100/161] (785s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[274.291626] Starting subtest: basic-flip-before-cursor-atomic
[275.337895] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.044s)
[275.983722] [101/161] (783s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[276.755602] Starting subtest: basic-flip-before-cursor-legacy
[277.803962] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.052s)
[278.436798] [102/161] (781s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[279.216092] Starting subtest: basic-flip-before-cursor-varying-size
[280.272778] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.051s)
[280.926934] [103/161] (778s left) kms_dsc (dsc-basic)
[281.731311] Subtest dsc-basic: SKIP (0.000s)
[281.944674] [104/161] (777s left) kms_flip (basic-flip-vs-dpms)
[282.789770] Starting subtest: basic-flip-vs-dpms
[282.793140] Starting dynamic subtest: C-HDMI-A2
[285.527204] Dynamic subtest C-HDMI-A2: SUCCESS (2.730s)
[285.532231] Subtest basic-flip-vs-dpms: SUCCESS (2.814s)
[286.234541] [105/161] (773s left) kms_flip (basic-flip-vs-modeset)
[287.012887] Starting subtest: basic-flip-vs-modeset
[287.033753] Starting dynamic subtest: C-HDMI-A2
[289.851797] Dynamic subtest C-HDMI-A2: SUCCESS (2.810s)
[289.863702] Subtest basic-flip-vs-modeset: SUCCESS (2.836s)
[290.541687] [106/161] (769s left) kms_flip (basic-flip-vs-wf_vblank)
[291.344262] Starting subtest: basic-flip-vs-wf_vblank
[291.363527] Starting dynamic subtest: C-HDMI-A2
[294.145209] Dynamic subtest C-HDMI-A2: SUCCESS (2.780s)
[294.154614] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.808s)
[294.490948] [107/161] (766s left) kms_flip (basic-plain-flip)
[295.238639] Starting subtest: basic-plain-flip
[295.258415] Starting dynamic subtest: C-HDMI-A2
[297.759980] Dynamic subtest C-HDMI-A2: SUCCESS (2.507s)
[297.772629] Subtest basic-plain-flip: SUCCESS (2.533s)
[298.141917] [108/161] (762s left) kms_force_connector_basic (force-connector-state)
[298.563169] Starting subtest: force-connector-state
[299.577157] Subtest force-connector-state: SUCCESS (1.012s)
[301.215768] [109/161] (759s left) kms_force_connector_basic (force-edid)
[301.677701] Starting subtest: force-edid
[301.802320] Subtest force-edid: SUCCESS (0.134s)
[302.760257] [110/161] (758s left) kms_force_connector_basic (force-load-detect)
[303.191757] Starting subtest: force-load-detect
[303.196634] Subtest force-load-detect: SKIP (0.000s)
[303.865915] [111/161] (757s left) kms_force_connector_basic (prune-stale-modes)
[304.276563] Starting subtest: prune-stale-modes
[304.384385] Subtest prune-stale-modes: SUCCESS (0.097s)
[305.327235] [112/161] (756s left) kms_frontbuffer_tracking (basic)
[306.203476] Starting subtest: basic
[311.259588] Subtest basic: SUCCESS (5.052s)
[311.534992] [113/161] (750s left) kms_hdmi_inject (inject-audio)
[311.936237] Starting subtest: inject-audio
[312.595812] Subtest inject-audio: SUCCESS (0.668s)
[313.390359] [114/161] (748s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[314.236313] Starting subtest: compare-crc-sanitycheck-xr24
[314.245370] Starting dynamic subtest: pipe-C-HDMI-A-2
[314.838509] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.582s)
[314.850165] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.607s)
[315.584781] [115/161] (746s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[316.602238] Starting subtest: compare-crc-sanitycheck-nv12
[316.605185] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.610087] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[316.615210] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[316.886544] [116/161] (745s left) kms_pipe_crc_basic (hang-read-crc)
[317.681663] Starting subtest: hang-read-crc
[317.701176] Starting dynamic subtest: pipe-C-HDMI-A-2
[319.341415] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.646s)
[319.351170] Subtest hang-read-crc: SUCCESS (1.665s)
[320.106427] [117/161] (742s left) kms_pipe_crc_basic (nonblocking-crc)
[320.906230] Starting subtest: nonblocking-crc
[320.925954] Starting dynamic subtest: pipe-C-HDMI-A-2
[321.670468] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.743s)
[321.674767] Subtest nonblocking-crc: SUCCESS (0.760s)
[322.310820] [118/161] (740s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[323.107675] Starting subtest: nonblocking-crc-frame-sequence
[323.110984] Starting dynamic subtest: pipe-C-HDMI-A-2
[323.843590] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.736s)
[323.846576] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.745s)
[324.503638] [119/161] (738s left) kms_pipe_crc_basic (read-crc)
[325.316408] Starting subtest: read-crc
[325.319210] Starting dynamic subtest: pipe-C-HDMI-A-2
[326.024175] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.698s)
[326.026225] Subtest read-crc: SUCCESS (0.717s)
[326.678250] [120/161] (736s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[327.459602] Starting subtest: read-crc-frame-sequence
[327.472641] Starting dynamic subtest: pipe-C-HDMI-A-2
[328.206290] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.727s)
[328.208290] Subtest read-crc-frame-sequence: SUCCESS (0.742s)
[328.826734] [121/161] (734s left) kms_pm_backlight (basic-brightness)
[329.622289] Subtest basic-brightness: SKIP (0.000s)
[329.878734] [122/161] (733s left) kms_pm_rpm (basic-pci-d3-state)
[332.334205] Starting subtest: basic-pci-d3-state
[332.705165] Subtest basic-pci-d3-state: SUCCESS (0.363s)
[333.223179] [123/161] (730s left) kms_pm_rpm (basic-rte)
[333.487760] Starting subtest: basic-rte
[335.930656] Subtest basic-rte: SUCCESS (2.434s)
[337.100300] [124/161] (727s left) kms_psr (psr-primary-page-flip)
[337.891061] Subtest psr-primary-page-flip: SKIP (0.000s)
[338.126812] [125/161] (726s left) kms_psr (psr-cursor-plane-move)
[338.937679] Subtest psr-cursor-plane-move: SKIP (0.000s)
[339.158517] [126/161] (725s left) kms_psr (psr-sprite-plane-onoff)
[339.951622] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[340.179550] [127/161] (724s left) kms_psr (psr-primary-mmap-gtt)
[340.992937] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[341.231334] [128/161] (723s left) kms_setmode (basic-clone-single-crtc)
[341.509527] Starting subtest: basic-clone-single-crtc
[341.518692] Subtest basic-clone-single-crtc: SKIP (0.000s)
[341.769044] [129/161] (723s left) i915_pm_rps (basic-api)
[342.057803] Starting subtest: basic-api
[342.077142] Subtest basic-api: SUCCESS (0.015s)
[342.349670] [130/161] (723s left) prime_self_import (basic-llseek-bad)
[342.608978] Starting subtest: basic-llseek-bad
[342.615905] Subtest basic-llseek-bad: SUCCESS (0.009s)
[342.944575] [131/161] (722s left) prime_self_import (basic-llseek-size)
[343.201204] Starting subtest: basic-llseek-size
[343.213139] Subtest basic-llseek-size: SUCCESS (0.018s)
[343.473734] [132/161] (722s left) prime_self_import (basic-with_fd_dup)
[343.737697] Starting subtest: basic-with_fd_dup
[343.758286] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[344.030126] [133/161] (722s left) prime_self_import (basic-with_one_bo)
[344.303189] Starting subtest: basic-with_one_bo
[344.317700] Subtest basic-with_one_bo: SUCCESS (0.016s)
[344.577835] [134/161] (721s left) prime_self_import (basic-with_one_bo_two_files)
[344.841522] Starting subtest: basic-with_one_bo_two_files
[344.855834] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[345.126640] [135/161] (721s left) prime_self_import (basic-with_two_bos)
[345.385796] Starting subtest: basic-with_two_bos
[345.411504] Subtest basic-with_two_bos: SUCCESS (0.026s)
[345.675279] [136/161] (721s left) prime_vgem (basic-fence-flip)
[345.981720] Starting subtest: basic-fence-flip
[346.897617] Subtest basic-fence-flip: SKIP (0.893s)
[347.194318] [137/161] (719s left) prime_vgem (basic-fence-mmap)
[347.502446] Starting subtest: basic-fence-mmap
[347.633285] Subtest basic-fence-mmap: SUCCESS (0.132s)
[347.925498] [138/161] (719s left) prime_vgem (basic-fence-read)
[348.236176] Starting subtest: basic-fence-read
[348.505583] Subtest basic-fence-read: SUCCESS (0.270s)
[348.793245] [139/161] (718s left) prime_vgem (basic-gtt)
[349.112872] Starting subtest: basic-gtt
[349.166386] Subtest basic-gtt: SUCCESS (0.048s)
[349.453195] [140/161] (718s left) prime_vgem (basic-read)
[349.754981] Starting subtest: basic-read
[349.880970] Subtest basic-read: SUCCESS (0.114s)
[350.162649] [141/161] (717s left) prime_vgem (basic-write)
[350.465433] Starting subtest: basic-write
[350.625665] Subtest basic-write: SUCCESS (0.157s)
[350.919870] [142/161] (717s left) vgem_basic (setversion)
[351.206357] Starting subtest: setversion
[351.212066] Subtest setversion: SUCCESS (0.000s)
[351.452305] [143/161] (716s left) vgem_basic (create)
[351.722204] Starting subtest: create
[351.726646] Subtest create: SUCCESS (0.002s)
[351.977971] [144/161] (716s left) vgem_basic (debugfs)
[352.266221] Starting subtest: debugfs
[352.269173] Subtest debugfs: SUCCESS (0.002s)
[352.505558] [145/161] (716s left) vgem_basic (dmabuf-export)
[352.774700] Starting subtest: dmabuf-export
[352.789594] Subtest dmabuf-export: SUCCESS (0.011s)
[353.043614] [146/161] (715s left) vgem_basic (dmabuf-fence)
[353.322182] Starting subtest: dmabuf-fence
[353.325122] Subtest dmabuf-fence: SUCCESS (0.002s)
[353.582659] [147/161] (715s left) vgem_basic (dmabuf-fence-before)
[353.863214] Starting subtest: dmabuf-fence-before
[353.865687] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[354.098516] [148/161] (715s left) vgem_basic (dmabuf-mmap)
[354.374219] Starting subtest: dmabuf-mmap
[354.428100] Subtest dmabuf-mmap: SUCCESS (0.052s)
[354.671220] [149/161] (714s left) vgem_basic (mmap)
[354.965237] Starting subtest: mmap
[354.996695] Subtest mmap: SUCCESS (0.034s)
[355.241373] [150/161] (714s left) vgem_basic (second-client)
[355.536159] Starting subtest: second-client
[355.566757] Subtest second-client: SUCCESS (0.035s)
[355.800745] [151/161] (714s left) vgem_basic (sysfs)
[356.073375] Starting subtest: sysfs
[356.074991] Subtest sysfs: SUCCESS (0.003s)
[356.317334] [152/161] (713s left) core_hotunplug (unbind-rebind)
[356.813546] Starting subtest: unbind-rebind
[362.942865] Subtest unbind-rebind: SUCCESS (6.128s)
[363.223293] [153/161] (707s left) vgem_basic (unload)
[363.507315] Starting subtest: unload
[392.860996] Subtest unload: SUCCESS (29.351s)
[393.270496] [154/161] (677s left) i915_module_load (reload)
[393.537508] Starting subtest: reload
[401.207400] Subtest reload: SUCCESS (7.673s)
[401.692201] [155/161] (669s left) gem_lmem_swapping (basic)
[402.433380] Subtest basic: SKIP (0.000s)
[402.975519] [156/161] (668s left) gem_lmem_swapping (parallel-random-engines)
[403.380142] Subtest parallel-random-engines: SKIP (0.000s)
[403.601449] [157/161] (668s left) gem_lmem_swapping (random-engines)
[403.895153] Subtest random-engines: SKIP (0.000s)
[404.130497] [158/161] (667s left) gem_lmem_swapping (verify-random)
[404.427261] Subtest verify-random: SKIP (0.000s)
[404.648782] [159/161] (667s left) i915_pm_rpm (module-reload)
[407.369485] Starting subtest: module-reload
[426.396407] Subtest module-reload: SUCCESS (19.030s)
[426.542793] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[426.549638] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[426.558807] [160/161] (645s left) i915_selftest (live)
[426.847803] Starting subtest: live
[426.852332] Starting dynamic subtest: sanitycheck
[431.545844] Dynamic subtest sanitycheck: SUCCESS (4.691s)
[431.604946] Starting dynamic subtest: uncore
[436.013209] Dynamic subtest uncore: SUCCESS (4.456s)
[436.047948] Starting dynamic subtest: workarounds
[441.115193] Dynamic subtest workarounds: SUCCESS (5.070s)
[441.162811] Starting dynamic subtest: gt_engines
[446.222902] Dynamic subtest gt_engines: SUCCESS (5.090s)
[446.260697] Starting dynamic subtest: gt_timelines
[478.411524] Dynamic subtest gt_timelines: SUCCESS (32.177s)
[478.459116] Starting dynamic subtest: gt_contexts
[483.131521] Dynamic subtest gt_contexts: SUCCESS (4.714s)
[483.173296] Starting dynamic subtest: gt_lrc
[491.262415] Dynamic subtest gt_lrc: SUCCESS (8.118s)
[491.310162] Starting dynamic subtest: gt_mocs
[495.917382] Dynamic subtest gt_mocs: SUCCESS (4.639s)
[495.973571] Starting dynamic subtest: gt_pm
[501.741345] Dynamic subtest gt_pm: SUCCESS (5.812s)
[501.797859] Starting dynamic subtest: gt_heartbeat
[506.446206] Dynamic subtest gt_heartbeat: SUCCESS (4.689s)
[506.483522] Starting dynamic subtest: gt_tlb
[511.329560] Dynamic subtest gt_tlb: SUCCESS (4.878s)
[511.391718] Starting dynamic subtest: requests
[522.626853] Dynamic subtest requests: SUCCESS (11.283s)
[522.711929] Starting dynamic subtest: migrate
[531.173837] Dynamic subtest migrate: SUCCESS (8.536s)
[531.216896] Starting dynamic subtest: active
[535.839796] Dynamic subtest active: SUCCESS (4.654s)
[535.872363] Starting dynamic subtest: objects
[542.715801] Dynamic subtest objects: SUCCESS (6.865s)
[542.759235] Starting dynamic subtest: mman
[554.655203] Dynamic subtest mman: SUCCESS (11.923s)
[554.696994] Starting dynamic subtest: dmabuf
[559.526038] Dynamic subtest dmabuf: SUCCESS (4.862s)
[559.571511] Starting dynamic subtest: vma
[564.027909] Dynamic subtest vma: SUCCESS (4.491s)
[564.062236] Starting dynamic subtest: coherency
[573.704148] Dynamic subtest coherency: SUCCESS (9.658s)
[573.763066] Starting dynamic subtest: gtt
[585.900092] Dynamic subtest gtt: SUCCESS (12.178s)
[585.940685] Starting dynamic subtest: gem
[591.508193] Dynamic subtest gem: SUCCESS (5.598s)
[591.556107] Starting dynamic subtest: evict
[603.272460] Dynamic subtest evict: SUCCESS (11.745s)
[603.313295] Starting dynamic subtest: hugepages
[608.328268] Dynamic subtest hugepages: SUCCESS (5.050s)
[608.370747] Starting dynamic subtest: gem_contexts
[638.416985] Dynamic subtest gem_contexts: SUCCESS (30.075s)
[638.476303] Starting dynamic subtest: client
[643.137863] Dynamic subtest client: SUCCESS (4.663s)
[643.338067] Starting dynamic subtest: gem_migrate
[648.014419] Dynamic subtest gem_migrate: SUCCESS (4.858s)
[648.051769] Starting dynamic subtest: reset
[661.409395] Dynamic subtest reset: SUCCESS (13.370s)
[661.443081] Starting dynamic subtest: memory_region
[666.107223] Dynamic subtest memory_region: SUCCESS (4.682s)
[666.173625] Starting dynamic subtest: hangcheck
[694.337737] Dynamic subtest hangcheck: SUCCESS (28.221s)
[694.383280] Starting dynamic subtest: execlists
[705.489204] Dynamic subtest execlists: SUCCESS (11.139s)
[705.554287] Starting dynamic subtest: ring_submission
[710.283771] Dynamic subtest ring_submission: SUCCESS (4.787s)
[710.337778] Starting dynamic subtest: perf
[715.219332] Dynamic subtest perf: SUCCESS (4.923s)
[715.268213] Starting dynamic subtest: slpc
[719.815725] Dynamic subtest slpc: SUCCESS (4.585s)
[719.856194] Starting dynamic subtest: guc
[724.548260] Dynamic subtest guc: SUCCESS (4.721s)
[724.608287] Starting dynamic subtest: guc_multi_lrc
[729.270624] Dynamic subtest guc_multi_lrc: SUCCESS (4.709s)
[729.297177] Starting dynamic subtest: guc_hang
[734.029206] Dynamic subtest guc_hang: SUCCESS (4.750s)
[734.064170] Starting dynamic subtest: late_gt_pm
[738.739473] Dynamic subtest late_gt_pm: SUCCESS (4.702s)
[738.748226] Subtest live: SUCCESS (311.892s)
[738.955123] [161/161] (333s left) dmabuf (all-tests)
[739.312630] Starting subtest: all-tests
[739.317698] Starting dynamic subtest: sanitycheck
[739.379446] Dynamic subtest sanitycheck: SUCCESS (0.064s)
[739.457562] Starting dynamic subtest: dma_fence
[739.689970] Dynamic subtest dma_fence: SUCCESS (0.299s)
[739.729529] Starting dynamic subtest: dma_fence_chain
[764.845199] Dynamic subtest dma_fence_chain: SUCCESS (25.144s)
[764.884947] Starting dynamic subtest: dma_fence_unwrap
[764.946827] Dynamic subtest dma_fence_unwrap: SUCCESS (0.092s)
[764.991552] Starting dynamic subtest: dma_resv
[765.062822] Dynamic subtest dma_resv: SUCCESS (0.102s)
[765.067597] Subtest all-tests: SUCCESS (25.758s)
[765.213901] Closing watchdogs
Done.