[93.259187] Initializing watchdogs
[93.259577]   /dev/watchdog0
[93.323705] [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
[93.347903] [001/161] (960s left) i915_module_load (load)
[94.234664] Starting subtest: load
[99.383075] Subtest load: SUCCESS (5.139s)
[99.782360] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[99.801384] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[99.826694] [002/161] (954s left) core_auth (basic-auth)
[100.262852] Starting subtest: basic-auth
[100.276115] Subtest basic-auth: SUCCESS (0.016s)
[100.742701] [003/161] (953s left) debugfs_test (read_all_entries)
[101.304894] Starting subtest: read_all_entries
[101.502571] Subtest read_all_entries: SUCCESS (0.201s)
[102.162603] [004/161] (952s left) debugfs_test (basic-hwmon)
[102.442822] Starting subtest: basic-hwmon
[102.449946] Subtest basic-hwmon: SKIP (0.000s)
[103.139598] [005/161] (951s left) debugfs_test (sysfs)
[103.416443] Starting subtest: sysfs
[103.826151] Subtest sysfs: SUCCESS (0.409s)
[104.542295] [006/161] (950s left) fbdev (eof)
[104.829281] Starting subtest: eof
[104.833199] Subtest eof: SUCCESS (0.005s)
[105.049789] [007/161] (950s left) fbdev (info)
[105.334128] Starting subtest: info
[105.335958] Subtest info: SUCCESS (0.000s)
[105.549471] [008/161] (949s left) fbdev (nullptr)
[105.823071] Starting subtest: nullptr
[105.824670] Subtest nullptr: SUCCESS (0.000s)
[106.031582] [009/161] (949s left) fbdev (read)
[106.290621] Starting subtest: read
[108.578503] Subtest read: SUCCESS (2.285s)
[108.783874] [010/161] (946s left) fbdev (write)
[109.052558] Starting subtest: write
[110.155936] Subtest write: SUCCESS (1.100s)
[110.372376] [011/161] (945s left) gem_basic (bad-close)
[110.641552] Starting subtest: bad-close
[110.648779] Subtest bad-close: SUCCESS (0.000s)
[110.871347] [012/161] (945s left) gem_basic (create-close)
[111.130196] Starting subtest: create-close
[111.137551] Subtest create-close: SUCCESS (0.001s)
[111.369833] [013/161] (944s left) gem_basic (create-fd-close)
[111.629259] Starting subtest: create-fd-close
[111.635689] Subtest create-fd-close: SUCCESS (0.001s)
[111.843411] [014/161] (944s left) gem_busy (busy@all-engines)
[112.156570] Starting subtest: busy
[112.161528] Starting dynamic subtest: all-engines
[112.366412] Dynamic subtest all-engines: SUCCESS (0.208s)
[112.368152] Subtest busy: SUCCESS (0.214s)
[112.936840] [015/161] (943s left) gem_close_race (basic-process)
[113.265531] Starting subtest: basic-process
[113.426827] Subtest basic-process: SUCCESS (0.162s)
[113.818665] [016/161] (942s left) gem_close_race (basic-threads)
[114.145262] Starting subtest: basic-threads
[115.397801] Subtest basic-threads: SUCCESS (1.251s)
[115.736547] [017/161] (941s left) gem_ctx_create (basic)
[116.042869] Starting subtest: basic
[116.044979] Subtest basic: SUCCESS (0.000s)
[116.379644] [018/161] (940s left) gem_ctx_create (basic-files)
[116.694197] Starting subtest: basic-files
[118.768166] Subtest basic-files: SUCCESS (2.074s)
[119.118094] [019/161] (938s left) gem_ctx_exec (basic)
[119.384412] Starting subtest: basic
[119.396381] Subtest basic: SUCCESS (0.014s)
[119.612720] [020/161] (937s left) gem_exec_basic (basic)
[119.904656] Starting subtest: basic
[119.909166] Starting dynamic subtest: rcs0-smem
[119.913884] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[119.949636] Starting dynamic subtest: bcs0-smem
[119.951539] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[119.987696] Starting dynamic subtest: vcs0-smem
[119.989857] Dynamic subtest vcs0-smem: SUCCESS (0.020s)
[120.032239] Starting dynamic subtest: vecs0-smem
[120.033773] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[120.035279] Subtest basic: SUCCESS (0.043s)
[120.311616] [021/161] (937s left) gem_exec_create (basic)
[120.624694] Starting subtest: basic
[120.627036] Starting dynamic subtest: smem
[122.720165] Dynamic subtest smem: SUCCESS (2.097s)
[122.722155] Subtest basic: SUCCESS (2.099s)
[123.067455] [022/161] (934s left) gem_exec_fence (basic-busy)
[123.562305] Starting subtest: basic-busy
[123.563826] Starting dynamic subtest: rcs0
[123.594107] Dynamic subtest rcs0: SUCCESS (0.032s)
[123.624468] Starting dynamic subtest: bcs0
[123.633745] Dynamic subtest bcs0: SUCCESS (0.034s)
[123.660189] Starting dynamic subtest: vcs0
[123.676374] Dynamic subtest vcs0: SUCCESS (0.041s)
[123.704626] Starting dynamic subtest: vecs0
[123.716173] Dynamic subtest vecs0: SUCCESS (0.036s)
[123.721216] Subtest basic-busy: SUCCESS (0.160s)
[124.718652] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[124.731893] [023/161] (933s left) gem_exec_fence (basic-wait)
[125.266599] Starting subtest: basic-wait
[125.269352] Starting dynamic subtest: rcs0
[125.311730] Dynamic subtest rcs0: SUCCESS (0.044s)
[125.352204] Starting dynamic subtest: bcs0
[125.355181] Dynamic subtest bcs0: SUCCESS (0.040s)
[125.380062] Starting dynamic subtest: vcs0
[125.399547] Dynamic subtest vcs0: SUCCESS (0.046s)
[125.430452] Starting dynamic subtest: vecs0
[125.442203] Dynamic subtest vecs0: SUCCESS (0.038s)
[125.445689] Subtest basic-wait: SUCCESS (0.177s)
[126.283651] [024/161] (931s left) gem_exec_fence (basic-await)
[126.763232] Starting subtest: basic-await
[126.768334] Starting dynamic subtest: rcs0
[126.981545] Dynamic subtest rcs0: SUCCESS (0.218s)
[127.020249] Starting dynamic subtest: bcs0
[127.217508] Dynamic subtest bcs0: SUCCESS (0.219s)
[127.242371] Starting dynamic subtest: vcs0
[127.459333] Dynamic subtest vcs0: SUCCESS (0.243s)
[127.489747] Starting dynamic subtest: vecs0
[127.682880] Dynamic subtest vecs0: SUCCESS (0.220s)
[127.685531] Subtest basic-await: SUCCESS (0.920s)
[128.519287] [025/161] (929s left) gem_exec_fence (nb-await)
[129.000515] Starting subtest: nb-await
[129.002321] Starting dynamic subtest: rcs0
[129.095477] Dynamic subtest rcs0: SUCCESS (0.096s)
[129.128859] Starting dynamic subtest: bcs0
[129.205690] Dynamic subtest bcs0: SUCCESS (0.097s)
[129.230695] Starting dynamic subtest: vcs0
[129.299271] Dynamic subtest vcs0: SUCCESS (0.101s)
[129.329937] Starting dynamic subtest: vecs0
[129.401123] Dynamic subtest vecs0: SUCCESS (0.096s)
[129.402726] Subtest nb-await: SUCCESS (0.397s)
[130.237218] [026/161] (928s left) gem_exec_gttfill (basic)
[130.551503] Starting subtest: basic
[132.531464] Subtest basic: SKIP (1.945s)
[132.954221] [027/161] (925s left) gem_exec_parallel (engines)
[133.456051] Starting subtest: engines
[133.459620] Starting dynamic subtest: basic
[139.558783] Dynamic subtest basic: SUCCESS (6.111s)
[139.602637] Starting dynamic subtest: contexts
[149.219036] Dynamic subtest contexts: SUCCESS (9.658s)
[149.246951] Starting dynamic subtest: fds
[160.331859] Dynamic subtest fds: SUCCESS (11.109s)
[160.364405] Starting dynamic subtest: userptr
[166.477981] Dynamic subtest userptr: SUCCESS (6.143s)
[166.480528] Subtest engines: SUCCESS (33.029s)
[166.894833] [028/161] (892s left) gem_exec_store (basic)
[167.215137] Starting subtest: basic
[167.288256] Subtest basic: SUCCESS (0.077s)
[167.678149] [029/161] (891s left) gem_flink_basic (bad-flink)
[167.945018] Starting subtest: bad-flink
[167.950592] Subtest bad-flink: SUCCESS (0.000s)
[168.177515] [030/161] (891s left) gem_flink_basic (bad-open)
[168.430937] Starting subtest: bad-open
[168.433527] Subtest bad-open: SUCCESS (0.000s)
[168.681393] [031/161] (890s left) gem_flink_basic (basic)
[168.941886] Starting subtest: basic
[168.945834] Subtest basic: SUCCESS (0.000s)
[169.206189] [032/161] (890s left) gem_flink_basic (double-flink)
[169.461073] Starting subtest: double-flink
[169.462769] Subtest double-flink: SUCCESS (0.001s)
[169.705532] [033/161] (890s left) gem_flink_basic (flink-lifetime)
[169.974717] Starting subtest: flink-lifetime
[169.988049] Subtest flink-lifetime: SUCCESS (0.015s)
[170.222363] [034/161] (889s left) gem_huc_copy (huc-copy)
[170.568684] Subtest huc-copy: SKIP (0.000s)
[170.784766] [035/161] (889s left) gem_linear_blits (basic)
[171.460704] Subtest basic: SKIP (0.000s)
[171.695619] [036/161] (888s left) gem_mmap (basic)
[172.136914] Starting subtest: basic
[172.149863] Subtest basic: SUCCESS (0.003s)
[172.397351] [037/161] (888s left) gem_mmap_gtt (basic)
[172.652929] Starting subtest: basic
[172.658364] Subtest basic: SUCCESS (0.004s)
[172.908126] [038/161] (888s left) gem_render_linear_blits (basic)
[173.191909] Starting subtest: basic
[173.335781] Subtest basic: SUCCESS (0.130s)
[173.531247] [039/161] (887s left) gem_render_tiled_blits (basic)
[173.801948] Starting subtest: basic
[173.956459] Subtest basic: SUCCESS (0.146s)
[174.161637] [040/161] (887s left) gem_ringfill (basic-all)
[174.673511] Starting subtest: basic-all
[176.123699] Subtest basic-all: SUCCESS (1.443s)
[176.376188] [041/161] (885s left) gem_softpin (allocator-basic)
[176.648312] Starting subtest: allocator-basic
[177.028469] Subtest allocator-basic: SUCCESS (0.358s)
[177.333572] [042/161] (884s left) gem_softpin (allocator-basic-reserve)
[177.610866] Starting subtest: allocator-basic-reserve
[177.989348] Subtest allocator-basic-reserve: SUCCESS (0.360s)
[178.277233] [043/161] (883s left) gem_softpin (safe-alignment)
[178.550210] Starting subtest: safe-alignment
[178.606192] Subtest safe-alignment: SUCCESS (0.056s)
[178.862749] [044/161] (883s left) gem_sync (basic-all)
[179.170528] Starting subtest: basic-all
[182.255644] Subtest basic-all: SUCCESS (3.081s)
[182.626650] [045/161] (879s left) gem_sync (basic-each)
[182.948889] Starting subtest: basic-each
[185.777853] Subtest basic-each: SUCCESS (2.834s)
[186.162691] [046/161] (876s left) gem_tiled_blits (basic)
[186.692066] Subtest basic: SKIP (0.000s)
[186.938883] [047/161] (875s left) gem_tiled_fence_blits (basic)
[187.608411] Starting subtest: basic
[187.667160] Subtest basic: SUCCESS (0.060s)
[187.968900] [048/161] (875s left) gem_tiled_pread_basic
[189.455394] [049/161] (873s left) gem_wait (busy@all-engines)
[189.813225] Starting subtest: busy
[189.816531] Starting dynamic subtest: all-engines
[190.346527] Dynamic subtest all-engines: SUCCESS (0.534s)
[190.348244] Subtest busy: SUCCESS (0.535s)
[190.812994] [050/161] (872s left) gem_wait (wait@all-engines)
[191.149869] Starting subtest: wait
[191.152171] Starting dynamic subtest: all-engines
[192.196426] Dynamic subtest all-engines: SUCCESS (1.041s)
[192.197950] Subtest wait: SUCCESS (1.043s)
[192.677463] [051/161] (870s left) i915_getparams_basic (basic-eu-total)
[192.930315] Starting subtest: basic-eu-total
[192.936170] Subtest basic-eu-total: SUCCESS (0.000s)
[193.172929] [052/161] (870s left) i915_getparams_basic (basic-subslice-total)
[193.429920] Starting subtest: basic-subslice-total
[193.433904] Subtest basic-subslice-total: SUCCESS (0.000s)
[193.700672] [053/161] (870s left) i915_hangman (error-state-basic)
[194.007236] Starting subtest: error-state-basic
[194.053211] Subtest error-state-basic: SUCCESS (0.048s)
[194.358941] [054/161] (869s left) i915_pciid
[194.866885] [055/161] (869s left) kms_addfb_basic (addfb25-4-tiled)
[195.612614] Starting subtest: addfb25-4-tiled
[195.614806] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[195.863705] [056/161] (868s left) kms_addfb_basic (addfb25-bad-modifier)
[196.588084] Starting subtest: addfb25-bad-modifier
[196.589694] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[196.856831] [057/161] (867s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[197.592820] Starting subtest: addfb25-framebuffer-vs-set-tiling
[197.595435] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[197.826582] [058/161] (867s left) kms_addfb_basic (addfb25-modifier-no-flag)
[198.550427] Starting subtest: addfb25-modifier-no-flag
[198.552717] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[198.798816] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[199.530664] Starting subtest: addfb25-x-tiled-legacy
[199.533630] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[199.779279] [060/161] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[200.591526] Starting subtest: addfb25-x-tiled-mismatch-legacy
[200.593934] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s)
[200.839395] [061/161] (864s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[201.550545] Starting subtest: addfb25-yf-tiled-legacy
[201.553150] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[201.793795] [062/161] (863s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[202.506305] Starting subtest: addfb25-y-tiled-legacy
[202.507983] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[202.747263] [063/161] (863s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[203.480694] Starting subtest: addfb25-y-tiled-small-legacy
[203.485615] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[203.736788] [064/161] (862s left) kms_addfb_basic (bad-pitch-0)
[203.992073] Starting subtest: bad-pitch-0
[203.994573] Subtest bad-pitch-0: SUCCESS (0.000s)
[204.665486] [065/161] (861s left) kms_addfb_basic (bad-pitch-1024)
[204.937245] Starting subtest: bad-pitch-1024
[204.940199] Subtest bad-pitch-1024: SUCCESS (0.000s)
[205.750382] [066/161] (860s left) kms_addfb_basic (bad-pitch-128)
[206.017616] Starting subtest: bad-pitch-128
[206.019324] Subtest bad-pitch-128: SUCCESS (0.000s)
[206.723859] [067/161] (859s left) kms_addfb_basic (bad-pitch-256)
[206.979358] Starting subtest: bad-pitch-256
[206.981874] Subtest bad-pitch-256: SUCCESS (0.000s)
[207.672523] [068/161] (859s left) kms_addfb_basic (bad-pitch-32)
[207.926510] Starting subtest: bad-pitch-32
[207.929080] Subtest bad-pitch-32: SUCCESS (0.000s)
[208.641726] [069/161] (858s left) kms_addfb_basic (bad-pitch-63)
[208.902339] Starting subtest: bad-pitch-63
[208.905909] Subtest bad-pitch-63: SUCCESS (0.000s)
[209.611477] [070/161] (857s left) kms_addfb_basic (bad-pitch-65536)
[209.875639] Starting subtest: bad-pitch-65536
[209.877988] Subtest bad-pitch-65536: SUCCESS (0.001s)
[210.560975] [071/161] (856s left) kms_addfb_basic (bad-pitch-999)
[210.819653] Starting subtest: bad-pitch-999
[210.821946] Subtest bad-pitch-999: SUCCESS (0.000s)
[211.481367] [072/161] (856s left) kms_addfb_basic (basic)
[211.749572] Starting subtest: basic
[211.751533] Subtest basic: SUCCESS (0.000s)
[212.464731] [073/161] (855s left) kms_addfb_basic (basic-x-tiled-legacy)
[212.728496] Starting subtest: basic-x-tiled-legacy
[212.731213] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[213.399627] [074/161] (854s left) kms_addfb_basic (basic-y-tiled-legacy)
[213.667679] Starting subtest: basic-y-tiled-legacy
[213.675515] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[214.402798] [075/161] (853s left) kms_addfb_basic (bo-too-small)
[215.217594] Starting subtest: bo-too-small
[215.219406] Subtest bo-too-small: SUCCESS (0.003s)
[215.474058] [076/161] (852s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[216.227892] Starting subtest: bo-too-small-due-to-tiling
[216.230683] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[216.476369] [077/161] (852s left) kms_addfb_basic (clobberred-modifier)
[216.738315] Starting subtest: clobberred-modifier
[216.741062] Subtest clobberred-modifier: SUCCESS (0.000s)
[217.454959] [078/161] (851s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[217.730457] Starting subtest: framebuffer-vs-set-tiling
[217.733943] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[218.405236] [079/161] (850s left) kms_addfb_basic (invalid-get-prop)
[218.669402] Starting subtest: invalid-get-prop
[218.672108] Subtest invalid-get-prop: SUCCESS (0.000s)
[219.368144] [080/161] (849s left) kms_addfb_basic (invalid-get-prop-any)
[219.635683] Starting subtest: invalid-get-prop-any
[219.637438] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[220.344455] [081/161] (849s left) kms_addfb_basic (invalid-set-prop)
[220.601900] Starting subtest: invalid-set-prop
[220.605346] Subtest invalid-set-prop: SUCCESS (0.000s)
[221.298114] [082/161] (848s left) kms_addfb_basic (invalid-set-prop-any)
[221.554489] Starting subtest: invalid-set-prop-any
[221.557273] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[222.245394] [083/161] (847s left) kms_addfb_basic (no-handle)
[222.500913] Starting subtest: no-handle
[222.502671] Subtest no-handle: SUCCESS (0.000s)
[223.199908] [084/161] (846s left) kms_addfb_basic (size-max)
[223.935711] Starting subtest: size-max
[223.938500] Subtest size-max: SUCCESS (0.003s)
[224.191977] [085/161] (845s left) kms_addfb_basic (small-bo)
[224.932496] Starting subtest: small-bo
[224.937120] Subtest small-bo: SUCCESS (0.000s)
[225.161581] [086/161] (845s left) kms_addfb_basic (tile-pitch-mismatch)
[225.423587] Starting subtest: tile-pitch-mismatch
[225.427263] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[226.122872] [087/161] (844s left) kms_addfb_basic (too-high)
[226.848095] Starting subtest: too-high
[226.849741] Subtest too-high: SUCCESS (0.005s)
[227.089386] [088/161] (843s left) kms_addfb_basic (too-wide)
[227.774696] Starting subtest: too-wide
[227.778889] Subtest too-wide: SUCCESS (0.000s)
[228.030725] [089/161] (842s left) kms_addfb_basic (unused-handle)
[228.287558] Starting subtest: unused-handle
[228.289983] Subtest unused-handle: SUCCESS (0.000s)
[229.009358] [090/161] (842s left) kms_addfb_basic (unused-modifier)
[229.273933] Starting subtest: unused-modifier
[229.276429] Subtest unused-modifier: SUCCESS (0.000s)
[230.085241] [091/161] (841s left) kms_addfb_basic (unused-offsets)
[230.348541] Starting subtest: unused-offsets
[230.351178] Subtest unused-offsets: SUCCESS (0.000s)
[231.051145] [092/161] (840s left) kms_addfb_basic (unused-pitches)
[231.319137] Starting subtest: unused-pitches
[231.322389] Subtest unused-pitches: SUCCESS (0.000s)
[232.025841] [093/161] (839s left) kms_busy (basic)
[232.780683] Starting subtest: basic
[232.793565] Starting dynamic subtest: flip
[233.721394] Dynamic subtest flip: SUCCESS (0.928s)
[233.765764] Starting dynamic subtest: modeset
[235.605552] Dynamic subtest modeset: SUCCESS (1.873s)
[235.609547] Subtest basic: SUCCESS (2.809s)
[236.337155] [094/161] (835s left) kms_prop_blob (basic)
[236.593455] Starting subtest: basic
[236.596309] Subtest basic: SUCCESS (0.000s)
[236.852636] [095/161] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[237.560585] Starting subtest: basic-busy-flip-before-cursor-atomic
[238.622952] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.060s)
[239.253751] [096/161] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[240.021342] Starting subtest: basic-busy-flip-before-cursor-legacy
[241.096480] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.070s)
[241.767402] [097/161] (830s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[242.490090] Starting subtest: basic-flip-after-cursor-atomic
[243.590274] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.051s)
[244.161668] [098/161] (828s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[244.899105] Starting subtest: basic-flip-after-cursor-legacy
[246.026056] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.126s)
[246.646552] [099/161] (826s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[247.382563] Starting subtest: basic-flip-after-cursor-varying-size
[248.424726] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[249.027773] [100/161] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[249.792039] Starting subtest: basic-flip-before-cursor-atomic
[250.832681] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.041s)
[251.431859] [101/161] (821s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[252.164128] Starting subtest: basic-flip-before-cursor-legacy
[253.217711] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.048s)
[253.822502] [102/161] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[254.582942] Starting subtest: basic-flip-before-cursor-varying-size
[255.628297] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s)
[256.244495] [103/161] (817s left) kms_dsc (dsc-basic)
[256.991593] Subtest dsc-basic: SKIP (0.000s)
[257.187426] [104/161] (816s left) kms_flip (basic-flip-vs-dpms)
[257.936923] Starting subtest: basic-flip-vs-dpms
[257.952897] Starting dynamic subtest: C-HDMI-A2
[260.637465] Dynamic subtest C-HDMI-A2: SUCCESS (2.678s)
[260.639312] Subtest basic-flip-vs-dpms: SUCCESS (2.701s)
[261.313366] [105/161] (812s left) kms_flip (basic-flip-vs-modeset)
[262.086297] Starting subtest: basic-flip-vs-modeset
[262.090874] Starting dynamic subtest: C-HDMI-A2
[264.904683] Dynamic subtest C-HDMI-A2: SUCCESS (2.807s)
[264.906512] Subtest basic-flip-vs-modeset: SUCCESS (2.826s)
[265.607970] [106/161] (808s left) kms_flip (basic-flip-vs-wf_vblank)
[266.388096] Starting subtest: basic-flip-vs-wf_vblank
[266.400917] Starting dynamic subtest: C-HDMI-A2
[269.325400] Dynamic subtest C-HDMI-A2: SUCCESS (2.919s)
[269.329664] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.941s)
[269.661591] [107/161] (804s left) kms_flip (basic-plain-flip)
[270.414437] Starting subtest: basic-plain-flip
[270.430270] Starting dynamic subtest: C-HDMI-A2
[272.957981] Dynamic subtest C-HDMI-A2: SUCCESS (2.517s)
[272.961310] Subtest basic-plain-flip: SUCCESS (2.539s)
[273.277234] [108/161] (801s left) kms_force_connector_basic (force-connector-state)
[273.684133] Starting subtest: force-connector-state
[274.599553] Subtest force-connector-state: SUCCESS (0.918s)
[276.562229] [109/161] (798s left) kms_force_connector_basic (force-edid)
[276.958269] Starting subtest: force-edid
[277.073718] Subtest force-edid: SUCCESS (0.114s)
[277.992650] [110/161] (797s left) kms_force_connector_basic (force-load-detect)
[278.423924] Starting subtest: force-load-detect
[278.426954] Subtest force-load-detect: SKIP (0.000s)
[279.054181] [111/161] (796s left) kms_force_connector_basic (prune-stale-modes)
[279.467684] Starting subtest: prune-stale-modes
[279.613991] Subtest prune-stale-modes: SUCCESS (0.152s)
[280.595660] [112/161] (794s left) kms_frontbuffer_tracking (basic)
[281.433232] Starting subtest: basic
[286.397131] Subtest basic: SUCCESS (4.962s)
[286.685781] [113/161] (788s left) kms_hdmi_inject (inject-audio)
[287.052829] Starting subtest: inject-audio
[287.617091] Subtest inject-audio: SUCCESS (0.564s)
[288.417218] [114/161] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[289.187095] Starting subtest: compare-crc-sanitycheck-xr24
[289.190937] Starting dynamic subtest: pipe-C-HDMI-A-2
[289.739211] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.539s)
[289.745175] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.554s)
[290.393287] [115/161] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[291.174276] Starting subtest: compare-crc-sanitycheck-nv12
[291.183150] Starting dynamic subtest: pipe-C-HDMI-A-2
[291.188542] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.004s)
[291.191525] Subtest compare-crc-sanitycheck-nv12: SKIP (0.022s)
[291.451055] [116/161] (784s left) kms_pipe_crc_basic (hang-read-crc)
[292.234160] Starting subtest: hang-read-crc
[292.239849] Starting dynamic subtest: pipe-C-HDMI-A-2
[293.893603] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.651s)
[293.902073] Subtest hang-read-crc: SUCCESS (1.671s)
[294.526981] [117/161] (781s left) kms_pipe_crc_basic (nonblocking-crc)
[295.214535] Starting subtest: nonblocking-crc
[295.218128] Starting dynamic subtest: pipe-C-HDMI-A-2
[295.942977] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.726s)
[295.945290] Subtest nonblocking-crc: SUCCESS (0.737s)
[296.758432] [118/161] (780s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[297.656314] Starting subtest: nonblocking-crc-frame-sequence
[297.660894] Starting dynamic subtest: pipe-C-HDMI-A-2
[298.440891] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.769s)
[298.449462] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.782s)
[299.146133] [119/161] (777s left) kms_pipe_crc_basic (read-crc)
[300.263838] Starting subtest: read-crc
[300.277843] Starting dynamic subtest: pipe-C-HDMI-A-2
[300.964831] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.670s)
[300.973533] Subtest read-crc: SUCCESS (0.684s)
[301.680502] [120/161] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[302.511341] Starting subtest: read-crc-frame-sequence
[302.515167] Starting dynamic subtest: pipe-C-HDMI-A-2
[303.256140] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.741s)
[303.260228] Subtest read-crc-frame-sequence: SUCCESS (0.759s)
[304.063914] [121/161] (773s left) kms_pm_backlight (basic-brightness)
[304.925970] Subtest basic-brightness: SKIP (0.000s)
[305.396135] [122/161] (772s left) kms_pm_rpm (basic-pci-d3-state)
[308.078460] Starting subtest: basic-pci-d3-state
[308.399600] Subtest basic-pci-d3-state: SUCCESS (0.323s)
[308.947896] [123/161] (769s left) kms_pm_rpm (basic-rte)
[309.255127] Starting subtest: basic-rte
[311.968925] Subtest basic-rte: SUCCESS (2.708s)
[313.104761] [124/161] (765s left) kms_psr (psr-primary-page-flip)
[313.884307] Subtest psr-primary-page-flip: SKIP (0.000s)
[314.117506] [125/161] (764s left) kms_psr (psr-cursor-plane-move)
[314.917341] Subtest psr-cursor-plane-move: SKIP (0.000s)
[315.166533] [126/161] (763s left) kms_psr (psr-sprite-plane-onoff)
[315.939658] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[316.156363] [127/161] (762s left) kms_psr (psr-primary-mmap-gtt)
[316.946131] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[317.155268] [128/161] (761s left) kms_setmode (basic-clone-single-crtc)
[317.428915] Starting subtest: basic-clone-single-crtc
[317.440797] Subtest basic-clone-single-crtc: SKIP (0.003s)
[317.709083] [129/161] (761s left) i915_pm_rps (basic-api)
[317.999245] Starting subtest: basic-api
[318.014860] Subtest basic-api: SUCCESS (0.018s)
[318.275713] [130/161] (761s left) prime_self_import (basic-llseek-bad)
[318.536946] Starting subtest: basic-llseek-bad
[318.542116] Subtest basic-llseek-bad: SUCCESS (0.010s)
[318.860896] [131/161] (760s left) prime_self_import (basic-llseek-size)
[319.117203] Starting subtest: basic-llseek-size
[319.140876] Subtest basic-llseek-size: SUCCESS (0.021s)
[319.412100] [132/161] (760s left) prime_self_import (basic-with_fd_dup)
[319.671576] Starting subtest: basic-with_fd_dup
[319.686311] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[319.973372] [133/161] (760s left) prime_self_import (basic-with_one_bo)
[320.229126] Starting subtest: basic-with_one_bo
[320.259229] Subtest basic-with_one_bo: SUCCESS (0.028s)
[320.531670] [134/161] (759s left) prime_self_import (basic-with_one_bo_two_files)
[320.798297] Starting subtest: basic-with_one_bo_two_files
[320.804051] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[321.063267] [135/161] (759s left) prime_self_import (basic-with_two_bos)
[321.318356] Starting subtest: basic-with_two_bos
[321.331468] Subtest basic-with_two_bos: SUCCESS (0.015s)
[321.592452] [136/161] (759s left) prime_vgem (basic-fence-flip)
[321.902227] Starting subtest: basic-fence-flip
[322.819362] Subtest basic-fence-flip: SKIP (0.918s)
[323.125798] [137/161] (757s left) prime_vgem (basic-fence-mmap)
[323.433066] Starting subtest: basic-fence-mmap
[323.567137] Subtest basic-fence-mmap: SUCCESS (0.132s)
[323.839695] [138/161] (757s left) prime_vgem (basic-fence-read)
[324.143222] Starting subtest: basic-fence-read
[324.409741] Subtest basic-fence-read: SUCCESS (0.261s)
[324.679050] [139/161] (756s left) prime_vgem (basic-gtt)
[324.972198] Starting subtest: basic-gtt
[325.021219] Subtest basic-gtt: SUCCESS (0.048s)
[325.303682] [140/161] (756s left) prime_vgem (basic-read)
[325.601487] Starting subtest: basic-read
[325.720409] Subtest basic-read: SUCCESS (0.108s)
[326.000232] [141/161] (755s left) prime_vgem (basic-write)
[326.309391] Starting subtest: basic-write
[326.471492] Subtest basic-write: SUCCESS (0.156s)
[326.754061] [142/161] (755s left) vgem_basic (setversion)
[327.036872] Starting subtest: setversion
[327.042181] Subtest setversion: SUCCESS (0.000s)
[327.275441] [143/161] (755s left) vgem_basic (create)
[327.546765] Starting subtest: create
[327.549149] Subtest create: SUCCESS (0.002s)
[327.801163] [144/161] (754s left) vgem_basic (debugfs)
[328.059946] Starting subtest: debugfs
[328.063563] Subtest debugfs: SUCCESS (0.002s)
[328.303746] [145/161] (754s left) vgem_basic (dmabuf-export)
[328.585957] Starting subtest: dmabuf-export
[328.603634] Subtest dmabuf-export: SUCCESS (0.020s)
[328.852212] [146/161] (754s left) vgem_basic (dmabuf-fence)
[329.131467] Starting subtest: dmabuf-fence
[329.138125] Subtest dmabuf-fence: SUCCESS (0.005s)
[329.374220] [147/161] (753s left) vgem_basic (dmabuf-fence-before)
[329.656048] Starting subtest: dmabuf-fence-before
[329.657649] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[329.896668] [148/161] (753s left) vgem_basic (dmabuf-mmap)
[330.181597] Starting subtest: dmabuf-mmap
[330.225127] Subtest dmabuf-mmap: SUCCESS (0.044s)
[330.522559] [149/161] (753s left) vgem_basic (mmap)
[330.794051] Starting subtest: mmap
[330.825607] Subtest mmap: SUCCESS (0.032s)
[331.072762] [150/161] (752s left) vgem_basic (second-client)
[331.345634] Starting subtest: second-client
[331.398599] Subtest second-client: SUCCESS (0.043s)
[331.630101] [151/161] (752s left) vgem_basic (sysfs)
[331.923800] Starting subtest: sysfs
[331.925965] Subtest sysfs: SUCCESS (0.002s)
[332.159751] [152/161] (752s left) core_hotunplug (unbind-rebind)
[332.611314] Starting subtest: unbind-rebind
[338.858589] Subtest unbind-rebind: SUCCESS (6.236s)
[339.108610] [153/161] (745s left) vgem_basic (unload)
[339.408850] Starting subtest: unload
[368.687308] Subtest unload: SUCCESS (29.271s)
[369.057818] [154/161] (715s left) i915_module_load (reload)
[369.322409] Starting subtest: reload
[377.328333] Subtest reload: SUCCESS (8.003s)
[377.738149] [155/161] (707s left) gem_lmem_swapping (basic)
[378.395077] Subtest basic: SKIP (0.000s)
[378.849159] [156/161] (706s left) gem_lmem_swapping (parallel-random-engines)
[379.268681] Subtest parallel-random-engines: SKIP (0.000s)
[379.508448] [157/161] (706s left) gem_lmem_swapping (random-engines)
[379.787490] Subtest random-engines: SKIP (0.000s)
[380.048869] [158/161] (705s left) gem_lmem_swapping (verify-random)
[380.322376] Subtest verify-random: SKIP (0.000s)
[380.532132] [159/161] (705s left) i915_pm_rpm (module-reload)
[383.223692] Starting subtest: module-reload
[402.501027] Subtest module-reload: SUCCESS (19.284s)
[402.625203] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[402.630803] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[402.642104] [160/161] (683s left) i915_selftest (live)
[402.927537] Starting subtest: live
[402.929987] Starting dynamic subtest: sanitycheck
[407.481094] Dynamic subtest sanitycheck: SUCCESS (4.542s)
[407.547143] Starting dynamic subtest: uncore
[412.115343] Dynamic subtest uncore: SUCCESS (4.628s)
[412.237286] Starting dynamic subtest: workarounds
[416.868566] Dynamic subtest workarounds: SUCCESS (4.738s)
[416.907343] Starting dynamic subtest: gt_engines
[421.900330] Dynamic subtest gt_engines: SUCCESS (5.021s)
[421.950386] Starting dynamic subtest: gt_timelines
[454.722403] Dynamic subtest gt_timelines: SUCCESS (32.811s)
[454.773200] Starting dynamic subtest: gt_contexts
[459.219391] Dynamic subtest gt_contexts: SUCCESS (4.484s)
[459.256701] Starting dynamic subtest: gt_lrc
[467.498496] Dynamic subtest gt_lrc: SUCCESS (8.263s)
[467.541608] Starting dynamic subtest: gt_mocs
[471.846141] Dynamic subtest gt_mocs: SUCCESS (4.339s)
[471.886904] Starting dynamic subtest: gt_pm
[477.352641] Dynamic subtest gt_pm: SUCCESS (5.491s)
[477.382347] Starting dynamic subtest: gt_heartbeat
[481.714506] Dynamic subtest gt_heartbeat: SUCCESS (4.354s)
[481.741710] Starting dynamic subtest: gt_tlb
[487.042400] Dynamic subtest gt_tlb: SUCCESS (5.319s)
[487.081377] Starting dynamic subtest: requests
[498.480436] Dynamic subtest requests: SUCCESS (11.415s)
[498.516693] Starting dynamic subtest: migrate
[506.476178] Dynamic subtest migrate: SUCCESS (7.991s)
[506.540190] Starting dynamic subtest: active
[511.036098] Dynamic subtest active: SUCCESS (4.556s)
[511.070167] Starting dynamic subtest: objects
[517.639421] Dynamic subtest objects: SUCCESS (6.593s)
[517.671563] Starting dynamic subtest: mman
[529.345594] Dynamic subtest mman: SUCCESS (11.687s)
[529.379638] Starting dynamic subtest: dmabuf
[533.867048] Dynamic subtest dmabuf: SUCCESS (4.514s)
[533.913267] Starting dynamic subtest: vma
[538.437676] Dynamic subtest vma: SUCCESS (4.548s)
[538.481626] Starting dynamic subtest: coherency
[551.408504] Dynamic subtest coherency: SUCCESS (12.960s)
[551.456656] Starting dynamic subtest: gtt
[563.376537] Dynamic subtest gtt: SUCCESS (11.963s)
[563.418728] Starting dynamic subtest: gem
[568.951787] Dynamic subtest gem: SUCCESS (5.565s)
[568.987281] Starting dynamic subtest: evict
[582.835063] Dynamic subtest evict: SUCCESS (13.863s)
[582.862178] Starting dynamic subtest: hugepages
[587.835109] Dynamic subtest hugepages: SUCCESS (4.994s)
[587.868638] Starting dynamic subtest: gem_contexts
[620.486822] Dynamic subtest gem_contexts: SUCCESS (32.643s)
[620.516995] Starting dynamic subtest: client
[625.316109] Dynamic subtest client: SUCCESS (4.817s)
[625.345451] Starting dynamic subtest: gem_migrate
[629.524171] Dynamic subtest gem_migrate: SUCCESS (4.195s)
[629.577093] Starting dynamic subtest: reset
[645.478132] Dynamic subtest reset: SUCCESS (15.945s)
[645.522625] Starting dynamic subtest: memory_region
[649.879224] Dynamic subtest memory_region: SUCCESS (4.394s)
[649.970220] Starting dynamic subtest: hangcheck
[677.919413] Dynamic subtest hangcheck: SUCCESS (28.031s)
[677.981403] Starting dynamic subtest: execlists
[688.873915] Dynamic subtest execlists: SUCCESS (10.944s)
[688.906032] Starting dynamic subtest: ring_submission
[693.146806] Dynamic subtest ring_submission: SUCCESS (4.257s)
[693.184235] Starting dynamic subtest: perf
[698.096143] Dynamic subtest perf: SUCCESS (4.928s)
[698.157162] Starting dynamic subtest: slpc
[702.619104] Dynamic subtest slpc: SUCCESS (4.513s)
[702.660646] Starting dynamic subtest: guc
[707.053354] Dynamic subtest guc: SUCCESS (4.412s)
[707.078939] Starting dynamic subtest: guc_multi_lrc
[711.906349] Dynamic subtest guc_multi_lrc: SUCCESS (4.849s)
[711.961868] Starting dynamic subtest: guc_hang
[716.323173] Dynamic subtest guc_hang: SUCCESS (4.404s)
[716.366241] Starting dynamic subtest: late_gt_pm
[720.849988] Dynamic subtest late_gt_pm: SUCCESS (4.513s)
[720.851755] Subtest live: SUCCESS (317.919s)
[721.032798] [161/161] (365s left) dmabuf (all-tests)
[721.310345] Starting subtest: all-tests
[721.326116] Starting dynamic subtest: sanitycheck
[721.411962] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[721.437666] Starting dynamic subtest: dma_fence
[721.756435] Dynamic subtest dma_fence: SUCCESS (0.344s)
[721.787106] Starting dynamic subtest: dma_fence_chain