[120.393586] Initializing watchdogs
[120.393952]   /dev/watchdog0
[120.458081] [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
[120.478452] [001/161] (960s left) i915_module_load (load)
[121.420256] Starting subtest: load
[126.618183] Subtest load: SUCCESS (5.197s)
[127.125450] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[127.147615] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[127.168782] [002/161] (954s left) core_auth (basic-auth)
[127.644154] Starting subtest: basic-auth
[127.660166] Subtest basic-auth: SUCCESS (0.009s)
[128.000170] [003/161] (953s left) debugfs_test (read_all_entries)
[128.392099] Starting subtest: read_all_entries
[128.691163] Subtest read_all_entries: SUCCESS (0.300s)
[129.381235] [004/161] (952s left) debugfs_test (basic-hwmon)
[129.670728] Starting subtest: basic-hwmon
[129.677967] Subtest basic-hwmon: SKIP (0.000s)
[130.352490] [005/161] (951s left) debugfs_test (sysfs)
[130.638043] Starting subtest: sysfs
[130.980837] Subtest sysfs: SUCCESS (0.343s)
[131.637386] [006/161] (950s left) fbdev (eof)
[131.967125] Starting subtest: eof
[131.970156] Subtest eof: SUCCESS (0.004s)
[132.207884] [007/161] (950s left) fbdev (info)
[132.448899] Starting subtest: info
[132.451891] Subtest info: SUCCESS (0.000s)
[132.656611] [008/161] (949s left) fbdev (nullptr)
[132.948471] Starting subtest: nullptr
[132.950408] Subtest nullptr: SUCCESS (0.002s)
[133.184655] [009/161] (949s left) fbdev (read)
[133.448053] Starting subtest: read
[135.521995] Subtest read: SUCCESS (2.068s)
[135.717681] [010/161] (947s left) fbdev (write)
[135.979592] Starting subtest: write
[137.079402] Subtest write: SUCCESS (1.096s)
[137.279773] [011/161] (945s left) gem_basic (bad-close)
[137.538303] Starting subtest: bad-close
[137.542885] Subtest bad-close: SUCCESS (0.000s)
[137.766895] [012/161] (945s left) gem_basic (create-close)
[138.024543] Starting subtest: create-close
[138.032364] Subtest create-close: SUCCESS (0.003s)
[138.272390] [013/161] (945s left) gem_basic (create-fd-close)
[138.536593] Starting subtest: create-fd-close
[138.542172] Subtest create-fd-close: SUCCESS (0.000s)
[138.780851] [014/161] (944s left) gem_busy (busy@all-engines)
[139.090615] Starting subtest: busy
[139.093061] Starting dynamic subtest: all-engines
[139.297664] Dynamic subtest all-engines: SUCCESS (0.207s)
[139.302191] Subtest busy: SUCCESS (0.211s)
[139.877131] [015/161] (943s left) gem_close_race (basic-process)
[140.192474] Starting subtest: basic-process
[140.334943] Subtest basic-process: SUCCESS (0.142s)
[140.707102] [016/161] (943s left) gem_close_race (basic-threads)
[141.034068] Starting subtest: basic-threads
[142.330915] Subtest basic-threads: SUCCESS (1.298s)
[142.716468] [017/161] (941s left) gem_ctx_create (basic)
[143.022587] Starting subtest: basic
[143.025305] Subtest basic: SUCCESS (0.000s)
[143.367543] [018/161] (941s left) gem_ctx_create (basic-files)
[143.675447] Starting subtest: basic-files
[145.748076] Subtest basic-files: SUCCESS (2.074s)
[146.096936] [019/161] (938s left) gem_ctx_exec (basic)
[146.355516] Starting subtest: basic
[146.374188] Subtest basic: SUCCESS (0.017s)
[146.602477] [020/161] (938s left) gem_exec_basic (basic)
[146.908234] Starting subtest: basic
[146.911109] Starting dynamic subtest: rcs0-smem
[146.913913] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[146.967600] Starting dynamic subtest: bcs0-smem
[146.971590] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[146.996485] Starting dynamic subtest: vcs0-smem
[146.998585] Dynamic subtest vcs0-smem: SUCCESS (0.022s)
[147.034912] Starting dynamic subtest: vecs0-smem
[147.037933] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[147.041864] Subtest basic: SUCCESS (0.046s)
[147.311948] [021/161] (937s left) gem_exec_create (basic)
[147.630639] Starting subtest: basic
[147.634247] Starting dynamic subtest: smem
[149.739124] Dynamic subtest smem: SUCCESS (2.104s)
[149.741901] Subtest basic: SUCCESS (2.106s)
[150.097368] [022/161] (934s left) gem_exec_fence (basic-busy)
[150.572902] Starting subtest: basic-busy
[150.575195] Starting dynamic subtest: rcs0
[150.603143] Dynamic subtest rcs0: SUCCESS (0.026s)
[150.635610] Starting dynamic subtest: bcs0
[150.640828] Dynamic subtest bcs0: SUCCESS (0.037s)
[150.664882] Starting dynamic subtest: vcs0
[150.678550] Dynamic subtest vcs0: SUCCESS (0.038s)
[150.707920] Starting dynamic subtest: vecs0
[150.720798] Dynamic subtest vecs0: SUCCESS (0.035s)
[150.722516] Subtest basic-busy: SUCCESS (0.147s)
[151.712664] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[151.725865] [023/161] (933s left) gem_exec_fence (basic-wait)
[152.200635] Starting subtest: basic-wait
[152.204071] Starting dynamic subtest: rcs0
[152.241540] Dynamic subtest rcs0: SUCCESS (0.040s)
[152.267779] Starting dynamic subtest: bcs0
[152.287293] Dynamic subtest bcs0: SUCCESS (0.043s)
[152.319052] Starting dynamic subtest: vcs0
[152.331484] Dynamic subtest vcs0: SUCCESS (0.036s)
[152.360165] Starting dynamic subtest: vecs0
[152.370646] Dynamic subtest vecs0: SUCCESS (0.040s)
[152.372689] Subtest basic-wait: SUCCESS (0.173s)
[153.191549] [024/161] (932s left) gem_exec_fence (basic-await)
[153.672962] Starting subtest: basic-await
[153.677147] Starting dynamic subtest: rcs0
[153.901510] Dynamic subtest rcs0: SUCCESS (0.222s)
[153.928056] Starting dynamic subtest: bcs0
[154.119242] Dynamic subtest bcs0: SUCCESS (0.214s)
[154.145301] Starting dynamic subtest: vcs0
[154.396178] Dynamic subtest vcs0: SUCCESS (0.275s)
[154.422438] Starting dynamic subtest: vecs0
[154.629543] Dynamic subtest vecs0: SUCCESS (0.226s)
[154.631483] Subtest basic-await: SUCCESS (0.954s)
[155.481191] [025/161] (930s left) gem_exec_fence (nb-await)
[155.963906] Starting subtest: nb-await
[155.965849] Starting dynamic subtest: rcs0
[156.058692] Dynamic subtest rcs0: SUCCESS (0.090s)
[156.091251] Starting dynamic subtest: bcs0
[156.167717] Dynamic subtest bcs0: SUCCESS (0.098s)
[156.194679] Starting dynamic subtest: vcs0
[156.265093] Dynamic subtest vcs0: SUCCESS (0.102s)
[156.299137] Starting dynamic subtest: vecs0
[156.365552] Dynamic subtest vecs0: SUCCESS (0.100s)
[156.367643] Subtest nb-await: SUCCESS (0.402s)
[157.206635] [026/161] (928s left) gem_exec_gttfill (basic)
[157.520104] Starting subtest: basic
[159.497389] Subtest basic: SKIP (1.928s)
[159.868286] [027/161] (926s left) gem_exec_parallel (engines)
[160.359885] Starting subtest: engines
[160.364136] Starting dynamic subtest: basic
[166.464902] Dynamic subtest basic: SUCCESS (6.108s)
[166.512304] Starting dynamic subtest: contexts
[176.336633] Dynamic subtest contexts: SUCCESS (9.861s)
[176.374675] Starting dynamic subtest: fds
[187.346252] Dynamic subtest fds: SUCCESS (11.013s)
[187.378729] Starting dynamic subtest: userptr
[193.475536] Dynamic subtest userptr: SUCCESS (6.127s)
[193.477237] Subtest engines: SUCCESS (33.117s)
[193.935442] [028/161] (892s left) gem_exec_store (basic)
[194.261191] Starting subtest: basic
[194.349655] Subtest basic: SUCCESS (0.086s)
[194.747826] [029/161] (891s left) gem_flink_basic (bad-flink)
[195.009394] Starting subtest: bad-flink
[195.011666] Subtest bad-flink: SUCCESS (0.000s)
[195.247393] [030/161] (891s left) gem_flink_basic (bad-open)
[195.499250] Starting subtest: bad-open
[195.503932] Subtest bad-open: SUCCESS (0.000s)
[195.737732] [031/161] (891s left) gem_flink_basic (basic)
[195.998710] Starting subtest: basic
[196.000636] Subtest basic: SUCCESS (0.000s)
[196.233218] [032/161] (890s left) gem_flink_basic (double-flink)
[196.492796] Starting subtest: double-flink
[196.494579] Subtest double-flink: SUCCESS (0.000s)
[196.731657] [033/161] (890s left) gem_flink_basic (flink-lifetime)
[196.980117] Starting subtest: flink-lifetime
[196.987501] Subtest flink-lifetime: SUCCESS (0.006s)
[197.240931] [034/161] (890s left) gem_huc_copy (huc-copy)
[197.512062] Subtest huc-copy: SKIP (0.000s)
[197.717987] [035/161] (889s left) gem_linear_blits (basic)
[198.314550] Subtest basic: SKIP (0.000s)
[198.551395] [036/161] (889s left) gem_mmap (basic)
[198.994675] Starting subtest: basic
[199.016223] Subtest basic: SUCCESS (0.002s)
[199.234637] [037/161] (888s left) gem_mmap_gtt (basic)
[199.492163] Starting subtest: basic
[199.495697] Subtest basic: SUCCESS (0.003s)
[199.743453] [038/161] (888s left) gem_render_linear_blits (basic)
[200.017061] Starting subtest: basic
[200.146223] Subtest basic: SUCCESS (0.120s)
[200.361583] [039/161] (888s left) gem_render_tiled_blits (basic)
[200.622287] Starting subtest: basic
[200.774984] Subtest basic: SUCCESS (0.142s)
[200.992706] [040/161] (887s left) gem_ringfill (basic-all)
[201.492505] Starting subtest: basic-all
[202.883160] Subtest basic-all: SUCCESS (1.381s)
[203.115475] [041/161] (885s left) gem_softpin (allocator-basic)
[203.379107] Starting subtest: allocator-basic
[203.759723] Subtest allocator-basic: SUCCESS (0.370s)
[204.033419] [042/161] (884s left) gem_softpin (allocator-basic-reserve)
[204.303869] Starting subtest: allocator-basic-reserve
[204.679677] Subtest allocator-basic-reserve: SUCCESS (0.361s)
[204.952571] [043/161] (884s left) gem_softpin (safe-alignment)
[205.221457] Starting subtest: safe-alignment
[205.280654] Subtest safe-alignment: SUCCESS (0.052s)
[205.536999] [044/161] (883s left) gem_sync (basic-all)
[205.857143] Starting subtest: basic-all
[209.122788] Subtest basic-all: SUCCESS (3.265s)
[209.511241] [045/161] (880s left) gem_sync (basic-each)
[209.816573] Starting subtest: basic-each
[212.442281] Subtest basic-each: SUCCESS (2.624s)
[212.810541] [046/161] (876s left) gem_tiled_blits (basic)
[213.333343] Subtest basic: SKIP (0.000s)
[213.548600] [047/161] (876s left) gem_tiled_fence_blits (basic)
[214.225915] Starting subtest: basic
[214.288995] Subtest basic: SUCCESS (0.066s)
[214.598906] [048/161] (875s left) gem_tiled_pread_basic
[216.082432] [049/161] (874s left) gem_wait (busy@all-engines)
[216.434781] Starting subtest: busy
[216.437236] Starting dynamic subtest: all-engines
[216.967157] Dynamic subtest all-engines: SUCCESS (0.531s)
[216.970147] Subtest busy: SUCCESS (0.532s)
[217.424539] [050/161] (873s left) gem_wait (wait@all-engines)
[217.767444] Starting subtest: wait
[217.770324] Starting dynamic subtest: all-engines
[218.806900] Dynamic subtest all-engines: SUCCESS (1.045s)
[218.808621] Subtest wait: SUCCESS (1.048s)
[219.331370] [051/161] (871s left) i915_getparams_basic (basic-eu-total)
[219.576216] Starting subtest: basic-eu-total
[219.579262] Subtest basic-eu-total: SUCCESS (0.000s)
[219.824759] [052/161] (871s left) i915_getparams_basic (basic-subslice-total)
[220.080426] Starting subtest: basic-subslice-total
[220.083495] Subtest basic-subslice-total: SUCCESS (0.000s)
[220.322976] [053/161] (870s left) i915_hangman (error-state-basic)
[220.617034] Starting subtest: error-state-basic
[220.647383] Subtest error-state-basic: SUCCESS (0.023s)
[220.929289] [054/161] (870s left) i915_pciid
[221.417473] [055/161] (870s left) kms_addfb_basic (addfb25-4-tiled)
[222.140609] Starting subtest: addfb25-4-tiled
[222.143874] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[222.395117] [056/161] (869s left) kms_addfb_basic (addfb25-bad-modifier)
[223.233491] Starting subtest: addfb25-bad-modifier
[223.236840] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[223.509237] [057/161] (868s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[224.208324] Starting subtest: addfb25-framebuffer-vs-set-tiling
[224.212251] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[224.459299] [058/161] (867s left) kms_addfb_basic (addfb25-modifier-no-flag)
[225.185847] Starting subtest: addfb25-modifier-no-flag
[225.191234] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[225.460466] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[226.197221] Starting subtest: addfb25-x-tiled-legacy
[226.198784] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[226.433999] [060/161] (866s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[227.149158] Starting subtest: addfb25-x-tiled-mismatch-legacy
[227.152381] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s)
[227.407796] [061/161] (865s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[228.094732] Starting subtest: addfb25-yf-tiled-legacy
[228.097908] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[228.343722] [062/161] (864s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[229.085524] Starting subtest: addfb25-y-tiled-legacy
[229.087584] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[229.318860] [063/161] (863s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[230.072945] Starting subtest: addfb25-y-tiled-small-legacy
[230.076517] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[230.332139] [064/161] (863s left) kms_addfb_basic (bad-pitch-0)
[230.594611] Starting subtest: bad-pitch-0
[230.597678] Subtest bad-pitch-0: SUCCESS (0.000s)
[231.315336] [065/161] (862s left) kms_addfb_basic (bad-pitch-1024)
[231.572557] Starting subtest: bad-pitch-1024
[231.576217] Subtest bad-pitch-1024: SUCCESS (0.000s)
[232.291756] [066/161] (861s left) kms_addfb_basic (bad-pitch-128)
[232.553227] Starting subtest: bad-pitch-128
[232.556565] Subtest bad-pitch-128: SUCCESS (0.000s)
[233.248309] [067/161] (860s left) kms_addfb_basic (bad-pitch-256)
[233.507992] Starting subtest: bad-pitch-256
[233.512156] Subtest bad-pitch-256: SUCCESS (0.000s)
[234.215421] [068/161] (859s left) kms_addfb_basic (bad-pitch-32)
[234.474691] Starting subtest: bad-pitch-32
[234.477563] Subtest bad-pitch-32: SUCCESS (0.000s)
[235.231728] [069/161] (859s left) kms_addfb_basic (bad-pitch-63)
[235.488371] Starting subtest: bad-pitch-63
[235.491937] Subtest bad-pitch-63: SUCCESS (0.000s)
[236.208333] [070/161] (858s left) kms_addfb_basic (bad-pitch-65536)
[236.466242] Starting subtest: bad-pitch-65536
[236.469441] Subtest bad-pitch-65536: SUCCESS (0.002s)
[237.190129] [071/161] (857s left) kms_addfb_basic (bad-pitch-999)
[237.450694] Starting subtest: bad-pitch-999
[237.455361] Subtest bad-pitch-999: SUCCESS (0.000s)
[238.255715] [072/161] (856s left) kms_addfb_basic (basic)
[238.518715] Starting subtest: basic
[238.520923] Subtest basic: SUCCESS (0.000s)
[239.240856] [073/161] (855s left) kms_addfb_basic (basic-x-tiled-legacy)
[239.496679] Starting subtest: basic-x-tiled-legacy
[239.498864] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[240.208972] [074/161] (855s left) kms_addfb_basic (basic-y-tiled-legacy)
[240.466154] Starting subtest: basic-y-tiled-legacy
[240.467939] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[241.206413] [075/161] (854s left) kms_addfb_basic (bo-too-small)
[241.890922] Starting subtest: bo-too-small
[241.892998] Subtest bo-too-small: SUCCESS (0.001s)
[242.133713] [076/161] (853s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[242.872738] Starting subtest: bo-too-small-due-to-tiling
[242.876325] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[243.122976] [077/161] (852s left) kms_addfb_basic (clobberred-modifier)
[243.375367] Starting subtest: clobberred-modifier
[243.377172] Subtest clobberred-modifier: SUCCESS (0.000s)
[244.084477] [078/161] (851s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[244.345931] Starting subtest: framebuffer-vs-set-tiling
[244.347573] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[245.032623] [079/161] (851s left) kms_addfb_basic (invalid-get-prop)
[245.294402] Starting subtest: invalid-get-prop
[245.297547] Subtest invalid-get-prop: SUCCESS (0.002s)
[246.008701] [080/161] (850s left) kms_addfb_basic (invalid-get-prop-any)
[246.266444] Starting subtest: invalid-get-prop-any
[246.271123] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[246.979185] [081/161] (849s left) kms_addfb_basic (invalid-set-prop)
[247.233673] Starting subtest: invalid-set-prop
[247.235919] Subtest invalid-set-prop: SUCCESS (0.000s)
[247.926559] [082/161] (848s left) kms_addfb_basic (invalid-set-prop-any)
[248.194228] Starting subtest: invalid-set-prop-any
[248.196879] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[249.053265] [083/161] (847s left) kms_addfb_basic (no-handle)
[249.326730] Starting subtest: no-handle
[249.329538] Subtest no-handle: SUCCESS (0.000s)
[250.257461] [084/161] (846s left) kms_addfb_basic (size-max)
[251.031847] Starting subtest: size-max
[251.035920] Subtest size-max: SUCCESS (0.000s)
[251.272730] [085/161] (846s left) kms_addfb_basic (small-bo)
[252.017869] Starting subtest: small-bo
[252.021128] Subtest small-bo: SUCCESS (0.000s)
[252.254848] [086/161] (845s left) kms_addfb_basic (tile-pitch-mismatch)
[252.527419] Starting subtest: tile-pitch-mismatch
[252.528932] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[253.327501] [087/161] (844s left) kms_addfb_basic (too-high)
[254.044809] Starting subtest: too-high
[254.058164] Subtest too-high: SUCCESS (0.008s)
[254.306966] [088/161] (843s left) kms_addfb_basic (too-wide)
[255.018245] Starting subtest: too-wide
[255.020145] Subtest too-wide: SUCCESS (0.000s)
[255.254313] [089/161] (842s left) kms_addfb_basic (unused-handle)
[255.510259] Starting subtest: unused-handle
[255.511688] Subtest unused-handle: SUCCESS (0.000s)
[256.213673] [090/161] (842s left) kms_addfb_basic (unused-modifier)
[256.470051] Starting subtest: unused-modifier
[256.471507] Subtest unused-modifier: SUCCESS (0.000s)
[257.184991] [091/161] (841s left) kms_addfb_basic (unused-offsets)
[257.441405] Starting subtest: unused-offsets
[257.444288] Subtest unused-offsets: SUCCESS (0.000s)
[258.168431] [092/161] (840s left) kms_addfb_basic (unused-pitches)
[258.427728] Starting subtest: unused-pitches
[258.429843] Subtest unused-pitches: SUCCESS (0.000s)
[259.174851] [093/161] (839s left) kms_busy (basic)
[259.887985] Starting subtest: basic
[259.889524] Starting dynamic subtest: flip
[260.831140] Dynamic subtest flip: SUCCESS (0.939s)
[260.875145] Starting dynamic subtest: modeset
[262.769128] Dynamic subtest modeset: SUCCESS (1.936s)
[262.774231] Subtest basic: SUCCESS (2.883s)
[263.473531] [094/161] (835s left) kms_prop_blob (basic)
[263.729928] Starting subtest: basic
[263.733055] Subtest basic: SUCCESS (0.000s)
[263.961331] [095/161] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[264.693541] Starting subtest: basic-busy-flip-before-cursor-atomic
[265.748500] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.058s)
[266.349636] [096/161] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[267.120096] Starting subtest: basic-busy-flip-before-cursor-legacy
[268.189262] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.064s)
[268.796519] [097/161] (830s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[269.574648] Starting subtest: basic-flip-after-cursor-atomic
[270.635349] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.043s)
[271.276273] [098/161] (828s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[272.022973] Starting subtest: basic-flip-after-cursor-legacy
[273.072457] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.039s)
[273.657092] [099/161] (826s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[274.406064] Starting subtest: basic-flip-after-cursor-varying-size
[275.454245] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.044s)
[276.055395] [100/161] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[276.802148] Starting subtest: basic-flip-before-cursor-atomic
[277.855915] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.048s)
[278.459254] [101/161] (822s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[279.217106] Starting subtest: basic-flip-before-cursor-legacy
[280.255386] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.034s)
[280.958257] [102/161] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[281.850102] Starting subtest: basic-flip-before-cursor-varying-size
[283.001134] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.130s)
[283.686933] [103/161] (817s left) kms_dsc (dsc-basic)
[284.437226] Subtest dsc-basic: SKIP (0.000s)
[284.650620] [104/161] (816s left) kms_flip (basic-flip-vs-dpms)
[285.370489] Starting subtest: basic-flip-vs-dpms
[285.387285] Starting dynamic subtest: C-HDMI-A2
[288.335336] Dynamic subtest C-HDMI-A2: SUCCESS (2.934s)
[288.340245] Subtest basic-flip-vs-dpms: SUCCESS (2.959s)
[289.013356] [105/161] (812s left) kms_flip (basic-flip-vs-modeset)
[289.760061] Starting subtest: basic-flip-vs-modeset
[289.775407] Starting dynamic subtest: C-HDMI-A2
[292.274476] Dynamic subtest C-HDMI-A2: SUCCESS (2.493s)
[292.277717] Subtest basic-flip-vs-modeset: SUCCESS (2.512s)
[292.925856] [106/161] (808s left) kms_flip (basic-flip-vs-wf_vblank)
[293.635213] Starting subtest: basic-flip-vs-wf_vblank
[293.639151] Starting dynamic subtest: C-HDMI-A2
[296.587782] Dynamic subtest C-HDMI-A2: SUCCESS (2.947s)
[296.590548] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.966s)
[296.918544] [107/161] (804s left) kms_flip (basic-plain-flip)
[297.662513] Starting subtest: basic-plain-flip
[297.677172] Starting dynamic subtest: C-HDMI-A2
[300.282219] Dynamic subtest C-HDMI-A2: SUCCESS (2.603s)
[300.284732] Subtest basic-plain-flip: SUCCESS (2.619s)
[300.590470] [108/161] (801s left) kms_force_connector_basic (force-connector-state)
[301.002257] Starting subtest: force-connector-state
[301.947050] Subtest force-connector-state: SUCCESS (0.941s)
[303.486752] [109/161] (798s left) kms_force_connector_basic (force-edid)
[303.897514] Starting subtest: force-edid
[303.971509] Subtest force-edid: SUCCESS (0.079s)
[304.897995] [110/161] (797s left) kms_force_connector_basic (force-load-detect)
[305.314334] Starting subtest: force-load-detect
[305.320671] Subtest force-load-detect: SKIP (0.000s)
[305.977751] [111/161] (796s left) kms_force_connector_basic (prune-stale-modes)
[306.410484] Starting subtest: prune-stale-modes
[306.555123] Subtest prune-stale-modes: SUCCESS (0.141s)
[307.532664] [112/161] (795s left) kms_frontbuffer_tracking (basic)
[308.338223] Starting subtest: basic
[313.353650] Subtest basic: SUCCESS (5.015s)
[313.636425] [113/161] (789s left) kms_hdmi_inject (inject-audio)
[314.012568] Starting subtest: inject-audio
[314.685991] Subtest inject-audio: SUCCESS (0.676s)
[315.473178] [114/161] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[316.284552] Starting subtest: compare-crc-sanitycheck-xr24
[316.305595] Starting dynamic subtest: pipe-C-HDMI-A-2
[317.131169] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.800s)
[317.133189] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.837s)
[317.826538] [115/161] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[318.563347] Starting subtest: compare-crc-sanitycheck-nv12
[318.573809] Starting dynamic subtest: pipe-C-HDMI-A-2
[318.577756] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[318.584146] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s)
[318.831227] [116/161] (784s left) kms_pipe_crc_basic (hang-read-crc)
[319.606110] Starting subtest: hang-read-crc
[319.614893] Starting dynamic subtest: pipe-C-HDMI-A-2
[321.239270] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.621s)
[321.249957] Subtest hang-read-crc: SUCCESS (1.639s)
[321.848997] [117/161] (781s left) kms_pipe_crc_basic (nonblocking-crc)
[322.577750] Starting subtest: nonblocking-crc
[322.588336] Starting dynamic subtest: pipe-C-HDMI-A-2
[323.314594] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.723s)
[323.316221] Subtest nonblocking-crc: SUCCESS (0.735s)
[323.946839] [118/161] (779s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[324.695107] Starting subtest: nonblocking-crc-frame-sequence
[324.696588] Starting dynamic subtest: pipe-C-HDMI-A-2
[325.405670] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.712s)
[325.409057] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.722s)
[326.051438] [119/161] (778s left) kms_pipe_crc_basic (read-crc)
[326.845701] Starting subtest: read-crc
[326.847908] Starting dynamic subtest: pipe-C-HDMI-A-2
[327.592129] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.743s)
[327.595238] Subtest read-crc: SUCCESS (0.753s)
[328.209941] [120/161] (776s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[328.947746] Starting subtest: read-crc-frame-sequence
[328.953089] Starting dynamic subtest: pipe-C-HDMI-A-2
[329.622472] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.663s)
[329.623961] Subtest read-crc-frame-sequence: SUCCESS (0.682s)
[330.244499] [121/161] (774s left) kms_pm_backlight (basic-brightness)
[330.986517] Subtest basic-brightness: SKIP (0.000s)
[331.215052] [122/161] (773s left) kms_pm_rpm (basic-pci-d3-state)
[333.522584] Starting subtest: basic-pci-d3-state
[333.873300] Subtest basic-pci-d3-state: SUCCESS (0.348s)
[334.405351] [123/161] (770s left) kms_pm_rpm (basic-rte)
[334.659735] Starting subtest: basic-rte
[337.122454] Subtest basic-rte: SUCCESS (2.455s)
[338.205189] [124/161] (766s left) kms_psr (psr-primary-page-flip)
[338.998422] Subtest psr-primary-page-flip: SKIP (0.000s)
[339.218797] [125/161] (766s left) kms_psr (psr-cursor-plane-move)
[340.015872] Subtest psr-cursor-plane-move: SKIP (0.000s)
[340.225953] [126/161] (765s left) kms_psr (psr-sprite-plane-onoff)
[340.960343] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[341.178552] [127/161] (764s left) kms_psr (psr-primary-mmap-gtt)
[341.989757] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[342.219805] [128/161] (763s left) kms_setmode (basic-clone-single-crtc)
[342.486121] Starting subtest: basic-clone-single-crtc
[342.496389] Subtest basic-clone-single-crtc: SKIP (0.000s)
[342.741463] [129/161] (763s left) i915_pm_rps (basic-api)
[343.081616] Starting subtest: basic-api
[343.099881] Subtest basic-api: SUCCESS (0.021s)
[343.366765] [130/161] (762s left) prime_self_import (basic-llseek-bad)
[343.628053] Starting subtest: basic-llseek-bad
[343.632493] Subtest basic-llseek-bad: SUCCESS (0.010s)
[343.892733] [131/161] (762s left) prime_self_import (basic-llseek-size)
[344.146681] Starting subtest: basic-llseek-size
[344.162057] Subtest basic-llseek-size: SUCCESS (0.020s)
[344.419722] [132/161] (762s left) prime_self_import (basic-with_fd_dup)
[344.678724] Starting subtest: basic-with_fd_dup
[344.695189] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[344.947190] [133/161] (761s left) prime_self_import (basic-with_one_bo)
[345.205991] Starting subtest: basic-with_one_bo
[345.217826] Subtest basic-with_one_bo: SUCCESS (0.019s)
[345.473913] [134/161] (761s left) prime_self_import (basic-with_one_bo_two_files)
[345.727414] Starting subtest: basic-with_one_bo_two_files
[345.749978] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[345.992456] [135/161] (761s left) prime_self_import (basic-with_two_bos)
[346.241982] Starting subtest: basic-with_two_bos
[346.256417] Subtest basic-with_two_bos: SUCCESS (0.013s)
[346.507048] [136/161] (760s left) prime_vgem (basic-fence-flip)
[346.802388] Starting subtest: basic-fence-flip
[347.618974] Subtest basic-fence-flip: SKIP (0.816s)
[347.918984] [137/161] (759s left) prime_vgem (basic-fence-mmap)
[348.223263] Starting subtest: basic-fence-mmap
[348.353585] Subtest basic-fence-mmap: SUCCESS (0.127s)
[348.616473] [138/161] (759s left) prime_vgem (basic-fence-read)
[348.926359] Starting subtest: basic-fence-read
[349.190187] Subtest basic-fence-read: SUCCESS (0.260s)
[349.463410] [139/161] (758s left) prime_vgem (basic-gtt)
[349.747363] Starting subtest: basic-gtt
[349.805919] Subtest basic-gtt: SUCCESS (0.052s)
[350.064542] [140/161] (758s left) prime_vgem (basic-read)
[350.344215] Starting subtest: basic-read
[350.462335] Subtest basic-read: SUCCESS (0.111s)
[350.730187] [141/161] (757s left) prime_vgem (basic-write)
[351.034791] Starting subtest: basic-write
[351.195330] Subtest basic-write: SUCCESS (0.159s)
[351.455448] [142/161] (757s left) vgem_basic (setversion)
[351.737975] Starting subtest: setversion
[351.742660] Subtest setversion: SUCCESS (0.000s)
[351.964337] [143/161] (756s left) vgem_basic (create)
[352.232637] Starting subtest: create
[352.234318] Subtest create: SUCCESS (0.002s)
[352.479776] [144/161] (756s left) vgem_basic (debugfs)
[352.759683] Starting subtest: debugfs
[352.770354] Subtest debugfs: SUCCESS (0.004s)
[353.000839] [145/161] (756s left) vgem_basic (dmabuf-export)
[353.275754] Starting subtest: dmabuf-export
[353.298623] Subtest dmabuf-export: SUCCESS (0.018s)
[353.551259] [146/161] (755s left) vgem_basic (dmabuf-fence)
[353.808948] Starting subtest: dmabuf-fence
[353.812526] Subtest dmabuf-fence: SUCCESS (0.002s)
[354.052818] [147/161] (755s left) vgem_basic (dmabuf-fence-before)
[354.334602] Starting subtest: dmabuf-fence-before
[354.341065] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[354.591139] [148/161] (755s left) vgem_basic (dmabuf-mmap)
[354.865572] Starting subtest: dmabuf-mmap
[354.908307] Subtest dmabuf-mmap: SUCCESS (0.047s)
[355.135293] [149/161] (754s left) vgem_basic (mmap)
[355.408683] Starting subtest: mmap
[355.440129] Subtest mmap: SUCCESS (0.031s)
[355.669498] [150/161] (754s left) vgem_basic (second-client)
[355.942203] Starting subtest: second-client
[355.981341] Subtest second-client: SUCCESS (0.029s)
[356.212768] [151/161] (754s left) vgem_basic (sysfs)
[356.502098] Starting subtest: sysfs
[356.504809] Subtest sysfs: SUCCESS (0.002s)
[356.736600] [152/161] (753s left) core_hotunplug (unbind-rebind)
[357.194675] Starting subtest: unbind-rebind
[363.092642] Subtest unbind-rebind: SUCCESS (5.899s)
[363.341555] [153/161] (747s left) vgem_basic (unload)
[363.618619] Starting subtest: unload
[392.926809] Subtest unload: SUCCESS (29.301s)
[393.328550] [154/161] (717s left) i915_module_load (reload)
[393.582567] Starting subtest: reload
[400.903104] Subtest reload: SUCCESS (7.313s)
[401.362113] [155/161] (710s left) gem_lmem_swapping (basic)
[402.024097] Subtest basic: SKIP (0.000s)
[402.410147] [156/161] (709s left) gem_lmem_swapping (parallel-random-engines)
[402.708387] Subtest parallel-random-engines: SKIP (0.000s)
[402.954861] [157/161] (709s left) gem_lmem_swapping (random-engines)
[403.243674] Subtest random-engines: SKIP (0.000s)
[403.458737] [158/161] (708s left) gem_lmem_swapping (verify-random)
[403.752783] Subtest verify-random: SKIP (0.000s)
[403.973895] [159/161] (708s left) i915_pm_rpm (module-reload)
[406.616090] Starting subtest: module-reload
[426.088415] Subtest module-reload: SUCCESS (19.471s)
[426.213320] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[426.219271] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[426.237494] [160/161] (686s left) i915_selftest (live)
[426.537386] Starting subtest: live
[426.540393] Starting dynamic subtest: sanitycheck
[430.833872] Dynamic subtest sanitycheck: SUCCESS (4.298s)
[430.876989] Starting dynamic subtest: uncore
[435.280429] Dynamic subtest uncore: SUCCESS (4.439s)
[435.307703] Starting dynamic subtest: workarounds
[439.839074] Dynamic subtest workarounds: SUCCESS (4.552s)
[439.889864] Starting dynamic subtest: gt_engines
[444.730508] Dynamic subtest gt_engines: SUCCESS (4.877s)
[444.798271] Starting dynamic subtest: gt_timelines
[476.503136] Dynamic subtest gt_timelines: SUCCESS (31.763s)
[476.550767] Starting dynamic subtest: gt_contexts
[481.116462] Dynamic subtest gt_contexts: SUCCESS (4.594s)
[481.167121] Starting dynamic subtest: gt_lrc
[488.807257] Dynamic subtest gt_lrc: SUCCESS (7.687s)
[488.857192] Starting dynamic subtest: gt_mocs
[493.164864] Dynamic subtest gt_mocs: SUCCESS (4.351s)
[493.220981] Starting dynamic subtest: gt_pm
[498.878125] Dynamic subtest gt_pm: SUCCESS (5.695s)
[498.919356] Starting dynamic subtest: gt_heartbeat
[503.402712] Dynamic subtest gt_heartbeat: SUCCESS (4.521s)
[503.465458] Starting dynamic subtest: gt_tlb
[508.443258] Dynamic subtest gt_tlb: SUCCESS (5.027s)
[508.480645] Starting dynamic subtest: requests
[519.400396] Dynamic subtest requests: SUCCESS (10.946s)
[519.448665] Starting dynamic subtest: migrate
[527.405420] Dynamic subtest migrate: SUCCESS (7.990s)
[527.447485] Starting dynamic subtest: active
[531.805896] Dynamic subtest active: SUCCESS (4.387s)
[531.840198] Starting dynamic subtest: objects
[537.653457] Dynamic subtest objects: SUCCESS (5.842s)
[537.681096] Starting dynamic subtest: mman
[549.036110] Dynamic subtest mman: SUCCESS (11.351s)
[549.067595] Starting dynamic subtest: dmabuf
[553.453343] Dynamic subtest dmabuf: SUCCESS (4.413s)
[553.485341] Starting dynamic subtest: vma
[557.749980] Dynamic subtest vma: SUCCESS (4.288s)
[557.794495] Starting dynamic subtest: coherency
[568.628199] Dynamic subtest coherency: SUCCESS (10.823s)
[568.686314] Starting dynamic subtest: gtt
[580.048601] Dynamic subtest gtt: SUCCESS (11.407s)
[580.108567] Starting dynamic subtest: gem
[585.626486] Dynamic subtest gem: SUCCESS (5.562s)
[585.676311] Starting dynamic subtest: evict
[596.796996] Dynamic subtest evict: SUCCESS (11.156s)
[596.831977] Starting dynamic subtest: hugepages
[601.667111] Dynamic subtest hugepages: SUCCESS (4.859s)
[601.695970] Starting dynamic subtest: gem_contexts
[631.245690] Dynamic subtest gem_contexts: SUCCESS (29.572s)
[631.277338] Starting dynamic subtest: client
[636.118193] Dynamic subtest client: SUCCESS (4.857s)
[636.182723] Starting dynamic subtest: gem_migrate
[640.443554] Dynamic subtest gem_migrate: SUCCESS (4.308s)
[640.473374] Starting dynamic subtest: reset
[652.321416] Dynamic subtest reset: SUCCESS (11.877s)
[652.354786] Starting dynamic subtest: memory_region
[656.730885] Dynamic subtest memory_region: SUCCESS (4.393s)
[656.782467] Starting dynamic subtest: hangcheck
[684.651219] Dynamic subtest hangcheck: SUCCESS (27.900s)
[684.682668] Starting dynamic subtest: execlists
[695.358043] Dynamic subtest execlists: SUCCESS (10.699s)
[695.412310] Starting dynamic subtest: ring_submission
[699.615397] Dynamic subtest ring_submission: SUCCESS (4.251s)
[699.651256] Starting dynamic subtest: perf
[704.604806] Dynamic subtest perf: SUCCESS (4.985s)
[704.642263] Starting dynamic subtest: slpc
[709.078123] Dynamic subtest slpc: SUCCESS (4.457s)
[709.145361] Starting dynamic subtest: guc
[713.386429] Dynamic subtest guc: SUCCESS (4.299s)
[713.441711] Starting dynamic subtest: guc_multi_lrc
[717.706075] Dynamic subtest guc_multi_lrc: SUCCESS (4.303s)
[717.759969] Starting dynamic subtest: guc_hang
[722.045541] Dynamic subtest guc_hang: SUCCESS (4.340s)
[722.077182] Starting dynamic subtest: late_gt_pm
[726.624526] Dynamic subtest late_gt_pm: SUCCESS (4.565s)
[726.626888] Subtest live: SUCCESS (300.091s)
[726.790132] [161/161] (386s left) dmabuf (all-tests)
[727.086126] Starting subtest: all-tests
[727.087921] Starting dynamic subtest: sanitycheck
[727.155861] Dynamic subtest sanitycheck: SUCCESS (0.077s)
[727.193696] Starting dynamic subtest: dma_fence
[727.484357] Dynamic subtest dma_fence: SUCCESS (0.322s)
[727.528734] Starting dynamic subtest: dma_fence_chain