[73.896100] Initializing watchdogs
[73.897118]   /dev/watchdog0
[74.049460] [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
[74.081995] [001/161] (960s left) i915_module_load (load)
[75.339334] Starting subtest: load
[80.890665] Subtest load: SUCCESS (5.417s)
[81.322518] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[81.348461] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[81.382700] [002/161] (953s left) core_auth (basic-auth)
[81.895148] Starting subtest: basic-auth
[81.907415] Subtest basic-auth: SUCCESS (0.009s)
[82.249429] [003/161] (953s left) debugfs_test (read_all_entries)
[82.604159] Starting subtest: read_all_entries
[82.824650] Subtest read_all_entries: SUCCESS (0.220s)
[83.527540] [004/161] (952s left) debugfs_test (basic-hwmon)
[83.810695] Starting subtest: basic-hwmon
[83.815706] Subtest basic-hwmon: SKIP (0.000s)
[84.493475] [005/161] (951s left) debugfs_test (sysfs)
[84.772338] Starting subtest: sysfs
[85.191863] Subtest sysfs: SUCCESS (0.411s)
[85.932625] [006/161] (950s left) fbdev (eof)
[86.215006] Starting subtest: eof
[86.223766] Subtest eof: SUCCESS (0.004s)
[86.450651] [007/161] (949s left) fbdev (info)
[86.711602] Starting subtest: info
[86.713459] Subtest info: SUCCESS (0.000s)
[86.928370] [008/161] (949s left) fbdev (nullptr)
[87.196536] Starting subtest: nullptr
[87.200228] Subtest nullptr: SUCCESS (0.000s)
[87.418709] [009/161] (949s left) fbdev (read)
[87.737165] Starting subtest: read
[89.888791] Subtest read: SUCCESS (2.133s)
[90.122425] [010/161] (946s left) fbdev (write)
[90.389792] Starting subtest: write
[91.495381] Subtest write: SUCCESS (1.092s)
[91.721994] [011/161] (945s left) gem_basic (bad-close)
[91.981764] Starting subtest: bad-close
[91.986055] Subtest bad-close: SUCCESS (0.000s)
[92.188693] [012/161] (945s left) gem_basic (create-close)
[92.445220] Starting subtest: create-close
[92.452845] Subtest create-close: SUCCESS (0.001s)
[92.685483] [013/161] (944s left) gem_basic (create-fd-close)
[92.946057] Starting subtest: create-fd-close
[92.953695] Subtest create-fd-close: SUCCESS (0.001s)
[93.168654] [014/161] (944s left) gem_busy (busy@all-engines)
[93.482072] Starting subtest: busy
[93.487100] Starting dynamic subtest: all-engines
[93.688370] Dynamic subtest all-engines: SUCCESS (0.204s)
[93.691139] Subtest busy: SUCCESS (0.208s)
[94.226425] [015/161] (943s left) gem_close_race (basic-process)
[94.552293] Starting subtest: basic-process
[94.723213] Subtest basic-process: SUCCESS (0.174s)
[95.073140] [016/161] (942s left) gem_close_race (basic-threads)
[95.396300] Starting subtest: basic-threads
[96.660189] Subtest basic-threads: SUCCESS (1.264s)
[97.063164] [017/161] (941s left) gem_ctx_create (basic)
[97.374742] Starting subtest: basic
[97.376388] Subtest basic: SUCCESS (0.000s)
[97.743327] [018/161] (940s left) gem_ctx_create (basic-files)
[98.044503] Starting subtest: basic-files
[100.131869] Subtest basic-files: SUCCESS (2.082s)
[100.481404] [019/161] (938s left) gem_ctx_exec (basic)
[100.752934] Starting subtest: basic
[100.771856] Subtest basic: SUCCESS (0.015s)
[101.012708] [020/161] (937s left) gem_exec_basic (basic)
[101.307837] Starting subtest: basic
[101.310639] Starting dynamic subtest: rcs0-smem
[101.312883] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[101.360577] Starting dynamic subtest: bcs0-smem
[101.362206] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[101.385396] Starting dynamic subtest: vcs0-smem
[101.388901] Dynamic subtest vcs0-smem: SUCCESS (0.023s)
[101.419034] Starting dynamic subtest: vecs0-smem
[101.421975] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[101.424161] Subtest basic: SUCCESS (0.043s)
[101.710936] [021/161] (937s left) gem_exec_create (basic)
[102.016508] Starting subtest: basic
[102.020844] Starting dynamic subtest: smem
[104.121909] Dynamic subtest smem: SUCCESS (2.101s)
[104.124860] Subtest basic: SUCCESS (2.109s)
[104.475634] [022/161] (934s left) gem_exec_fence (basic-busy)
[104.957220] Starting subtest: basic-busy
[104.961071] Starting dynamic subtest: rcs0
[104.996435] Dynamic subtest rcs0: SUCCESS (0.042s)
[105.022572] Starting dynamic subtest: bcs0
[105.032529] Dynamic subtest bcs0: SUCCESS (0.036s)
[105.070830] Starting dynamic subtest: vcs0
[105.079377] Dynamic subtest vcs0: SUCCESS (0.044s)
[105.105999] Starting dynamic subtest: vecs0
[105.115086] Dynamic subtest vecs0: SUCCESS (0.034s)
[105.122279] Subtest basic-busy: SUCCESS (0.162s)
[106.121449] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[106.130712] [023/161] (933s left) gem_exec_fence (basic-wait)
[106.604070] Starting subtest: basic-wait
[106.607560] Starting dynamic subtest: rcs0
[106.630564] Dynamic subtest rcs0: SUCCESS (0.028s)
[106.657286] Starting dynamic subtest: bcs0
[106.669129] Dynamic subtest bcs0: SUCCESS (0.032s)
[106.716147] Starting dynamic subtest: vcs0
[106.720262] Dynamic subtest vcs0: SUCCESS (0.037s)
[106.744432] Starting dynamic subtest: vecs0
[106.754085] Dynamic subtest vecs0: SUCCESS (0.046s)
[106.755805] Subtest basic-wait: SUCCESS (0.151s)
[107.587682] [024/161] (931s left) gem_exec_fence (basic-await)
[108.067113] Starting subtest: basic-await
[108.071232] Starting dynamic subtest: rcs0
[108.301817] Dynamic subtest rcs0: SUCCESS (0.231s)
[108.326586] Starting dynamic subtest: bcs0
[108.534133] Dynamic subtest bcs0: SUCCESS (0.227s)
[108.559218] Starting dynamic subtest: vcs0
[108.762203] Dynamic subtest vcs0: SUCCESS (0.218s)
[108.789042] Starting dynamic subtest: vecs0
[109.000164] Dynamic subtest vecs0: SUCCESS (0.237s)
[109.003385] Subtest basic-await: SUCCESS (0.933s)
[109.840559] [025/161] (929s left) gem_exec_fence (nb-await)
[110.318064] Starting subtest: nb-await
[110.319841] Starting dynamic subtest: rcs0
[110.415000] Dynamic subtest rcs0: SUCCESS (0.092s)
[110.447477] Starting dynamic subtest: bcs0
[110.519564] Dynamic subtest bcs0: SUCCESS (0.095s)
[110.546877] Starting dynamic subtest: vcs0
[110.621560] Dynamic subtest vcs0: SUCCESS (0.102s)
[110.648773] Starting dynamic subtest: vecs0
[110.715487] Dynamic subtest vecs0: SUCCESS (0.099s)
[110.718884] Subtest nb-await: SUCCESS (0.394s)
[111.559395] [026/161] (928s left) gem_exec_gttfill (basic)
[111.869220] Starting subtest: basic
[113.812459] Subtest basic: SKIP (1.917s)
[114.189631] [027/161] (925s left) gem_exec_parallel (engines)
[114.680656] Starting subtest: engines
[114.682702] Starting dynamic subtest: basic
[120.897283] Dynamic subtest basic: SUCCESS (6.212s)
[120.926814] Starting dynamic subtest: contexts
[130.677440] Dynamic subtest contexts: SUCCESS (9.776s)
[130.704615] Starting dynamic subtest: fds
[141.468569] Dynamic subtest fds: SUCCESS (10.778s)
[141.529803] Starting dynamic subtest: userptr
[147.748760] Dynamic subtest userptr: SUCCESS (6.274s)
[147.752616] Subtest engines: SUCCESS (33.050s)
[148.188836] [028/161] (892s left) gem_exec_store (basic)
[148.523245] Starting subtest: basic
[148.613649] Subtest basic: SUCCESS (0.092s)
[149.022758] [029/161] (891s left) gem_flink_basic (bad-flink)
[149.284630] Starting subtest: bad-flink
[149.287943] Subtest bad-flink: SUCCESS (0.000s)
[149.529712] [030/161] (891s left) gem_flink_basic (bad-open)
[149.783745] Starting subtest: bad-open
[149.786611] Subtest bad-open: SUCCESS (0.000s)
[150.029901] [031/161] (890s left) gem_flink_basic (basic)
[150.285904] Starting subtest: basic
[150.289423] Subtest basic: SUCCESS (0.000s)
[150.544637] [032/161] (890s left) gem_flink_basic (double-flink)
[150.800817] Starting subtest: double-flink
[150.804603] Subtest double-flink: SUCCESS (0.000s)
[151.042940] [033/161] (890s left) gem_flink_basic (flink-lifetime)
[151.296523] Starting subtest: flink-lifetime
[151.308459] Subtest flink-lifetime: SUCCESS (0.010s)
[151.570842] [034/161] (889s left) gem_huc_copy (huc-copy)
[151.842349] Subtest huc-copy: SKIP (0.000s)
[152.053884] [035/161] (889s left) gem_linear_blits (basic)
[152.669631] Subtest basic: SKIP (0.000s)
[152.914382] [036/161] (889s left) gem_mmap (basic)
[153.340933] Starting subtest: basic
[153.353062] Subtest basic: SUCCESS (0.001s)
[153.585550] [037/161] (888s left) gem_mmap_gtt (basic)
[153.843437] Starting subtest: basic
[153.845778] Subtest basic: SUCCESS (0.004s)
[154.079246] [038/161] (888s left) gem_render_linear_blits (basic)
[154.359736] Starting subtest: basic
[154.493042] Subtest basic: SUCCESS (0.130s)
[154.700922] [039/161] (887s left) gem_render_tiled_blits (basic)
[154.971557] Starting subtest: basic
[155.136898] Subtest basic: SUCCESS (0.160s)
[155.353403] [040/161] (887s left) gem_ringfill (basic-all)
[155.875390] Starting subtest: basic-all
[157.326129] Subtest basic-all: SUCCESS (1.446s)
[157.575307] [041/161] (885s left) gem_softpin (allocator-basic)
[157.848687] Starting subtest: allocator-basic
[158.210468] Subtest allocator-basic: SUCCESS (0.357s)
[158.529995] [042/161] (884s left) gem_softpin (allocator-basic-reserve)
[158.796750] Starting subtest: allocator-basic-reserve
[159.162923] Subtest allocator-basic-reserve: SUCCESS (0.360s)
[159.446633] [043/161] (883s left) gem_softpin (safe-alignment)
[159.718672] Starting subtest: safe-alignment
[159.771195] Subtest safe-alignment: SUCCESS (0.055s)
[160.054465] [044/161] (883s left) gem_sync (basic-all)
[160.363338] Starting subtest: basic-all
[163.411833] Subtest basic-all: SUCCESS (3.048s)
[163.810852] [045/161] (879s left) gem_sync (basic-each)
[164.123088] Starting subtest: basic-each
[166.820916] Subtest basic-each: SUCCESS (2.697s)
[167.186390] [046/161] (876s left) gem_tiled_blits (basic)
[167.726155] Subtest basic: SKIP (0.000s)
[167.940886] [047/161] (876s left) gem_tiled_fence_blits (basic)
[168.616259] Starting subtest: basic
[168.689427] Subtest basic: SUCCESS (0.065s)
[168.987316] [048/161] (875s left) gem_tiled_pread_basic
[170.473580] [049/161] (873s left) gem_wait (busy@all-engines)
[170.819464] Starting subtest: busy
[170.822248] Starting dynamic subtest: all-engines
[171.356569] Dynamic subtest all-engines: SUCCESS (0.537s)
[171.362143] Subtest busy: SUCCESS (0.540s)
[171.845911] [050/161] (872s left) gem_wait (wait@all-engines)
[172.192954] Starting subtest: wait
[172.194745] Starting dynamic subtest: all-engines
[173.242531] Dynamic subtest all-engines: SUCCESS (1.046s)
[173.244157] Subtest wait: SUCCESS (1.050s)
[173.701551] [051/161] (871s left) i915_getparams_basic (basic-eu-total)
[173.946980] Starting subtest: basic-eu-total
[173.952687] Subtest basic-eu-total: SUCCESS (0.000s)
[174.186505] [052/161] (870s left) i915_getparams_basic (basic-subslice-total)
[174.444131] Starting subtest: basic-subslice-total
[174.448495] Subtest basic-subslice-total: SUCCESS (0.000s)
[174.681966] [053/161] (870s left) i915_hangman (error-state-basic)
[174.982284] Starting subtest: error-state-basic
[175.024218] Subtest error-state-basic: SUCCESS (0.045s)
[175.299619] [054/161] (870s left) i915_pciid
[175.813585] [055/161] (869s left) kms_addfb_basic (addfb25-4-tiled)
[176.527618] Starting subtest: addfb25-4-tiled
[176.529971] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[176.774866] [056/161] (869s left) kms_addfb_basic (addfb25-bad-modifier)
[177.514355] Starting subtest: addfb25-bad-modifier
[177.517138] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[177.773799] [057/161] (868s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[178.483155] Starting subtest: addfb25-framebuffer-vs-set-tiling
[178.487308] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.736815] [058/161] (867s left) kms_addfb_basic (addfb25-modifier-no-flag)
[179.471312] Starting subtest: addfb25-modifier-no-flag
[179.474865] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[179.737211] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[180.421285] Starting subtest: addfb25-x-tiled-legacy
[180.422903] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[180.667332] [060/161] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[181.343896] Starting subtest: addfb25-x-tiled-mismatch-legacy
[181.345931] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[181.582236] [061/161] (865s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[182.312989] Starting subtest: addfb25-yf-tiled-legacy
[182.317107] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[182.588824] [062/161] (864s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[183.283690] Starting subtest: addfb25-y-tiled-legacy
[183.290099] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s)
[183.553573] [063/161] (863s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[184.268637] Starting subtest: addfb25-y-tiled-small-legacy
[184.274411] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[184.535820] [064/161] (862s left) kms_addfb_basic (bad-pitch-0)
[184.797101] Starting subtest: bad-pitch-0
[184.799209] Subtest bad-pitch-0: SUCCESS (0.000s)
[185.476854] [065/161] (862s left) kms_addfb_basic (bad-pitch-1024)
[185.734245] Starting subtest: bad-pitch-1024
[185.736680] Subtest bad-pitch-1024: SUCCESS (0.000s)
[186.583557] [066/161] (861s left) kms_addfb_basic (bad-pitch-128)
[186.849733] Starting subtest: bad-pitch-128
[186.851596] Subtest bad-pitch-128: SUCCESS (0.000s)
[187.583365] [067/161] (860s left) kms_addfb_basic (bad-pitch-256)
[187.843509] Starting subtest: bad-pitch-256
[187.845949] Subtest bad-pitch-256: SUCCESS (0.000s)
[188.522886] [068/161] (859s left) kms_addfb_basic (bad-pitch-32)
[188.794560] Starting subtest: bad-pitch-32
[188.796088] Subtest bad-pitch-32: SUCCESS (0.000s)
[189.527080] [069/161] (858s left) kms_addfb_basic (bad-pitch-63)
[189.784687] Starting subtest: bad-pitch-63
[189.787939] Subtest bad-pitch-63: SUCCESS (0.000s)
[190.488164] [070/161] (858s left) kms_addfb_basic (bad-pitch-65536)
[190.741939] Starting subtest: bad-pitch-65536
[190.743771] Subtest bad-pitch-65536: SUCCESS (0.002s)
[191.446975] [071/161] (857s left) kms_addfb_basic (bad-pitch-999)
[191.699550] Starting subtest: bad-pitch-999
[191.701937] Subtest bad-pitch-999: SUCCESS (0.000s)
[192.396420] [072/161] (856s left) kms_addfb_basic (basic)
[192.649071] Starting subtest: basic
[192.650631] Subtest basic: SUCCESS (0.000s)
[193.331792] [073/161] (855s left) kms_addfb_basic (basic-x-tiled-legacy)
[193.593197] Starting subtest: basic-x-tiled-legacy
[193.598351] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[194.294484] [074/161] (854s left) kms_addfb_basic (basic-y-tiled-legacy)
[194.549219] Starting subtest: basic-y-tiled-legacy
[194.552149] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[195.264225] [075/161] (854s left) kms_addfb_basic (bo-too-small)
[195.976291] Starting subtest: bo-too-small
[195.978859] Subtest bo-too-small: SUCCESS (0.001s)
[196.228602] [076/161] (853s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[196.928579] Starting subtest: bo-too-small-due-to-tiling
[196.930971] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[197.180970] [077/161] (852s left) kms_addfb_basic (clobberred-modifier)
[197.437697] Starting subtest: clobberred-modifier
[197.440223] Subtest clobberred-modifier: SUCCESS (0.000s)
[198.130187] [078/161] (851s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[198.400968] Starting subtest: framebuffer-vs-set-tiling
[198.404857] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[199.130348] [079/161] (851s left) kms_addfb_basic (invalid-get-prop)
[199.398244] Starting subtest: invalid-get-prop
[199.399735] Subtest invalid-get-prop: SUCCESS (0.000s)
[200.124772] [080/161] (850s left) kms_addfb_basic (invalid-get-prop-any)
[200.392691] Starting subtest: invalid-get-prop-any
[200.395557] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[201.083730] [081/161] (849s left) kms_addfb_basic (invalid-set-prop)
[201.383899] Starting subtest: invalid-set-prop
[201.387240] Subtest invalid-set-prop: SUCCESS (0.000s)
[202.119758] [082/161] (848s left) kms_addfb_basic (invalid-set-prop-any)
[202.378800] Starting subtest: invalid-set-prop-any
[202.381356] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[203.097387] [083/161] (847s left) kms_addfb_basic (no-handle)
[203.358213] Starting subtest: no-handle
[203.361336] Subtest no-handle: SUCCESS (0.000s)
[204.047628] [084/161] (847s left) kms_addfb_basic (size-max)
[204.756940] Starting subtest: size-max
[204.759997] Subtest size-max: SUCCESS (0.000s)
[204.999164] [085/161] (846s left) kms_addfb_basic (small-bo)
[205.724607] Starting subtest: small-bo
[205.727322] Subtest small-bo: SUCCESS (0.000s)
[206.030911] [086/161] (845s left) kms_addfb_basic (tile-pitch-mismatch)
[206.290995] Starting subtest: tile-pitch-mismatch
[206.294224] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[207.045459] [087/161] (844s left) kms_addfb_basic (too-high)
[207.821430] Starting subtest: too-high
[207.823869] Subtest too-high: SUCCESS (0.008s)
[208.074904] [088/161] (843s left) kms_addfb_basic (too-wide)
[208.812867] Starting subtest: too-wide
[208.819749] Subtest too-wide: SUCCESS (0.002s)
[209.095524] [089/161] (843s left) kms_addfb_basic (unused-handle)
[209.349397] Starting subtest: unused-handle
[209.351924] Subtest unused-handle: SUCCESS (0.000s)
[210.087481] [090/161] (842s left) kms_addfb_basic (unused-modifier)
[210.351115] Starting subtest: unused-modifier
[210.352713] Subtest unused-modifier: SUCCESS (0.000s)
[211.116111] [091/161] (841s left) kms_addfb_basic (unused-offsets)
[211.396763] Starting subtest: unused-offsets
[211.402138] Subtest unused-offsets: SUCCESS (0.000s)
[212.081857] [092/161] (840s left) kms_addfb_basic (unused-pitches)
[212.335629] Starting subtest: unused-pitches
[212.337281] Subtest unused-pitches: SUCCESS (0.000s)
[213.079168] [093/161] (839s left) kms_busy (basic)
[213.811090] Starting subtest: basic
[213.815977] Starting dynamic subtest: flip
[214.766267] Dynamic subtest flip: SUCCESS (0.946s)
[214.840957] Starting dynamic subtest: modeset
[216.827283] Dynamic subtest modeset: SUCCESS (2.049s)
[216.842249] Subtest basic: SUCCESS (3.031s)
[217.555943] [094/161] (835s left) kms_prop_blob (basic)
[217.819132] Starting subtest: basic
[217.822336] Subtest basic: SUCCESS (0.000s)
[218.053528] [095/161] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[218.804179] Starting subtest: basic-busy-flip-before-cursor-atomic
[219.859593] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.061s)
[220.482759] [096/161] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[221.210894] Starting subtest: basic-busy-flip-before-cursor-legacy
[222.287615] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.070s)
[222.908968] [097/161] (830s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[223.629494] Starting subtest: basic-flip-after-cursor-atomic
[224.669212] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.036s)
[225.331141] [098/161] (828s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[226.075943] Starting subtest: basic-flip-after-cursor-legacy
[227.137189] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.054s)
[227.734589] [099/161] (826s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[228.489534] Starting subtest: basic-flip-after-cursor-varying-size
[229.522963] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[230.115119] [100/161] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[230.842587] Starting subtest: basic-flip-before-cursor-atomic
[231.896067] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.050s)
[232.509091] [101/161] (821s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[233.268725] Starting subtest: basic-flip-before-cursor-legacy
[234.320863] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.047s)
[234.931335] [102/161] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[235.701641] Starting subtest: basic-flip-before-cursor-varying-size
[236.748474] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s)
[237.340556] [103/161] (817s left) kms_dsc (dsc-basic)
[238.081985] Subtest dsc-basic: SKIP (0.000s)
[238.310580] [104/161] (816s left) kms_flip (basic-flip-vs-dpms)
[239.057979] Starting subtest: basic-flip-vs-dpms
[239.070585] Starting dynamic subtest: C-HDMI-A2
[241.570307] Dynamic subtest C-HDMI-A2: SUCCESS (2.502s)
[241.580568] Subtest basic-flip-vs-dpms: SUCCESS (2.521s)
[242.195350] [105/161] (813s left) kms_flip (basic-flip-vs-modeset)
[242.948461] Starting subtest: basic-flip-vs-modeset
[242.963519] Starting dynamic subtest: C-HDMI-A2
[245.515879] Dynamic subtest C-HDMI-A2: SUCCESS (2.560s)
[245.527498] Subtest basic-flip-vs-modeset: SUCCESS (2.583s)
[246.299914] [106/161] (809s left) kms_flip (basic-flip-vs-wf_vblank)
[247.154836] Starting subtest: basic-flip-vs-wf_vblank
[247.172447] Starting dynamic subtest: C-HDMI-A2
[249.949095] Dynamic subtest C-HDMI-A2: SUCCESS (2.772s)
[249.950673] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.798s)
[250.263482] [107/161] (805s left) kms_flip (basic-plain-flip)
[251.033268] Starting subtest: basic-plain-flip
[251.047206] Starting dynamic subtest: C-HDMI-A2
[253.546726] Dynamic subtest C-HDMI-A2: SUCCESS (2.498s)
[253.555511] Subtest basic-plain-flip: SUCCESS (2.525s)
[253.874417] [108/161] (802s left) kms_force_connector_basic (force-connector-state)
[254.303594] Starting subtest: force-connector-state
[255.233792] Subtest force-connector-state: SUCCESS (0.931s)
[256.803667] [109/161] (799s left) kms_force_connector_basic (force-edid)
[257.174364] Starting subtest: force-edid
[257.240344] Subtest force-edid: SUCCESS (0.069s)
[258.167226] [110/161] (798s left) kms_force_connector_basic (force-load-detect)
[258.577180] Starting subtest: force-load-detect
[258.583588] Subtest force-load-detect: SKIP (0.000s)
[259.227715] [111/161] (797s left) kms_force_connector_basic (prune-stale-modes)
[259.619488] Starting subtest: prune-stale-modes
[259.697461] Subtest prune-stale-modes: SUCCESS (0.072s)
[260.666671] [112/161] (795s left) kms_frontbuffer_tracking (basic)
[261.522707] Starting subtest: basic
[266.541427] Subtest basic: SUCCESS (5.020s)
[266.842760] [113/161] (790s left) kms_hdmi_inject (inject-audio)
[267.213984] Starting subtest: inject-audio
[267.885708] Subtest inject-audio: SUCCESS (0.667s)
[268.640307] [114/161] (788s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[269.415248] Starting subtest: compare-crc-sanitycheck-xr24
[269.423703] Starting dynamic subtest: pipe-C-HDMI-A-2
[269.990289] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.546s)
[270.001216] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.572s)
[270.596539] [115/161] (786s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[271.382836] Starting subtest: compare-crc-sanitycheck-nv12
[271.386809] Starting dynamic subtest: pipe-C-HDMI-A-2
[271.391514] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[271.397947] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[271.648693] [116/161] (785s left) kms_pipe_crc_basic (hang-read-crc)
[272.428317] Starting subtest: hang-read-crc
[272.441200] Starting dynamic subtest: pipe-C-HDMI-A-2
[274.105639] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.659s)
[274.109569] Subtest hang-read-crc: SUCCESS (1.671s)
[274.773956] [117/161] (782s left) kms_pipe_crc_basic (nonblocking-crc)
[275.521547] Starting subtest: nonblocking-crc
[275.524564] Starting dynamic subtest: pipe-C-HDMI-A-2
[276.248324] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.722s)
[276.274966] Subtest nonblocking-crc: SUCCESS (0.739s)
[276.914441] [118/161] (780s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[277.694926] Starting subtest: nonblocking-crc-frame-sequence
[277.696926] Starting dynamic subtest: pipe-C-HDMI-A-2
[278.409560] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.714s)
[278.410953] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.722s)
[279.026352] [119/161] (779s left) kms_pipe_crc_basic (read-crc)
[279.816999] Starting subtest: read-crc
[279.818580] Starting dynamic subtest: pipe-C-HDMI-A-2
[280.482409] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.663s)
[280.484529] Subtest read-crc: SUCCESS (0.673s)
[281.121764] [120/161] (777s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[281.921208] Starting subtest: read-crc-frame-sequence
[281.922714] Starting dynamic subtest: pipe-C-HDMI-A-2
[282.574347] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.655s)
[282.575985] Subtest read-crc-frame-sequence: SUCCESS (0.665s)
[283.166263] [121/161] (775s left) kms_pm_backlight (basic-brightness)
[283.951954] Subtest basic-brightness: SKIP (0.000s)
[284.163373] [122/161] (774s left) kms_pm_rpm (basic-pci-d3-state)
[286.545325] Starting subtest: basic-pci-d3-state
[286.898758] Subtest basic-pci-d3-state: SUCCESS (0.340s)
[287.409422] [123/161] (771s left) kms_pm_rpm (basic-rte)
[287.663122] Starting subtest: basic-rte
[290.143783] Subtest basic-rte: SUCCESS (2.464s)
[291.240215] [124/161] (767s left) kms_psr (psr-primary-page-flip)
[292.019482] Subtest psr-primary-page-flip: SKIP (0.000s)
[292.250553] [125/161] (766s left) kms_psr (psr-cursor-plane-move)
[292.979042] Subtest psr-cursor-plane-move: SKIP (0.000s)
[293.188836] [126/161] (766s left) kms_psr (psr-sprite-plane-onoff)
[293.945259] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[294.185188] [127/161] (765s left) kms_psr (psr-primary-mmap-gtt)
[294.969312] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[295.184171] [128/161] (764s left) kms_setmode (basic-clone-single-crtc)
[295.454174] Starting subtest: basic-clone-single-crtc
[295.461553] Subtest basic-clone-single-crtc: SKIP (0.000s)
[295.718323] [129/161] (764s left) i915_pm_rps (basic-api)
[295.999358] Starting subtest: basic-api
[296.013470] Subtest basic-api: SUCCESS (0.016s)
[296.317431] [130/161] (763s left) prime_self_import (basic-llseek-bad)
[296.572881] Starting subtest: basic-llseek-bad
[296.578096] Subtest basic-llseek-bad: SUCCESS (0.011s)
[296.837218] [131/161] (763s left) prime_self_import (basic-llseek-size)
[297.095638] Starting subtest: basic-llseek-size
[297.109226] Subtest basic-llseek-size: SUCCESS (0.023s)
[297.356811] [132/161] (763s left) prime_self_import (basic-with_fd_dup)
[297.610145] Starting subtest: basic-with_fd_dup
[297.639876] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[297.907139] [133/161] (762s left) prime_self_import (basic-with_one_bo)
[298.160430] Starting subtest: basic-with_one_bo
[298.187463] Subtest basic-with_one_bo: SUCCESS (0.026s)
[298.443178] [134/161] (762s left) prime_self_import (basic-with_one_bo_two_files)
[298.693231] Starting subtest: basic-with_one_bo_two_files
[298.717126] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[298.966329] [135/161] (762s left) prime_self_import (basic-with_two_bos)
[299.216328] Starting subtest: basic-with_two_bos
[299.230443] Subtest basic-with_two_bos: SUCCESS (0.013s)
[299.479808] [136/161] (761s left) prime_vgem (basic-fence-flip)
[299.788127] Starting subtest: basic-fence-flip
[300.671121] Subtest basic-fence-flip: SKIP (0.859s)
[300.955430] [137/161] (760s left) prime_vgem (basic-fence-mmap)
[301.262882] Starting subtest: basic-fence-mmap
[301.391183] Subtest basic-fence-mmap: SUCCESS (0.125s)
[301.646369] [138/161] (760s left) prime_vgem (basic-fence-read)
[301.943578] Starting subtest: basic-fence-read
[302.206450] Subtest basic-fence-read: SUCCESS (0.261s)
[302.476888] [139/161] (759s left) prime_vgem (basic-gtt)
[302.776527] Starting subtest: basic-gtt
[302.821706] Subtest basic-gtt: SUCCESS (0.048s)
[303.082708] [140/161] (759s left) prime_vgem (basic-read)
[303.384338] Starting subtest: basic-read
[303.504093] Subtest basic-read: SUCCESS (0.110s)
[303.767238] [141/161] (758s left) prime_vgem (basic-write)
[304.059335] Starting subtest: basic-write
[304.215516] Subtest basic-write: SUCCESS (0.157s)
[304.493476] [142/161] (758s left) vgem_basic (setversion)
[304.760579] Starting subtest: setversion
[304.765712] Subtest setversion: SUCCESS (0.000s)
[304.994224] [143/161] (757s left) vgem_basic (create)
[305.264406] Starting subtest: create
[305.266132] Subtest create: SUCCESS (0.002s)
[305.514873] [144/161] (757s left) vgem_basic (debugfs)
[305.773337] Starting subtest: debugfs
[305.777543] Subtest debugfs: SUCCESS (0.002s)
[306.026413] [145/161] (757s left) vgem_basic (dmabuf-export)
[306.337945] Starting subtest: dmabuf-export
[306.360803] Subtest dmabuf-export: SUCCESS (0.020s)
[306.633454] [146/161] (756s left) vgem_basic (dmabuf-fence)
[306.895537] Starting subtest: dmabuf-fence
[306.899920] Subtest dmabuf-fence: SUCCESS (0.003s)
[307.187774] [147/161] (756s left) vgem_basic (dmabuf-fence-before)
[307.473197] Starting subtest: dmabuf-fence-before
[307.475522] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[307.703801] [148/161] (756s left) vgem_basic (dmabuf-mmap)
[307.982427] Starting subtest: dmabuf-mmap
[308.023120] Subtest dmabuf-mmap: SUCCESS (0.043s)
[308.247751] [149/161] (755s left) vgem_basic (mmap)
[308.536898] Starting subtest: mmap
[308.565145] Subtest mmap: SUCCESS (0.032s)
[308.794607] [150/161] (755s left) vgem_basic (second-client)
[309.064582] Starting subtest: second-client
[309.105243] Subtest second-client: SUCCESS (0.031s)
[309.324579] [151/161] (755s left) vgem_basic (sysfs)
[309.595433] Starting subtest: sysfs
[309.598589] Subtest sysfs: SUCCESS (0.004s)
[309.832465] [152/161] (754s left) core_hotunplug (unbind-rebind)
[310.294217] Starting subtest: unbind-rebind
[316.853068] Subtest unbind-rebind: SUCCESS (6.548s)
[317.089326] [153/161] (747s left) vgem_basic (unload)
[317.355478] Starting subtest: unload
[346.637962] Subtest unload: SUCCESS (29.284s)
[347.020191] [154/161] (718s left) i915_module_load (reload)
[347.273581] Starting subtest: reload
[354.553913] Subtest reload: SUCCESS (7.272s)
[355.021118] [155/161] (710s left) gem_lmem_swapping (basic)
[355.743571] Subtest basic: SKIP (0.000s)
[356.108176] [156/161] (709s left) gem_lmem_swapping (parallel-random-engines)
[356.474141] Subtest parallel-random-engines: SKIP (0.000s)
[356.692403] [157/161] (709s left) gem_lmem_swapping (random-engines)
[356.976862] Subtest random-engines: SKIP (0.000s)
[357.200616] [158/161] (709s left) gem_lmem_swapping (verify-random)
[357.487497] Subtest verify-random: SKIP (0.000s)
[357.716152] [159/161] (708s left) i915_pm_rpm (module-reload)
[360.277522] Starting subtest: module-reload
[378.671515] Subtest module-reload: SUCCESS (18.392s)
[378.795318] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[378.801612] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[378.816752] [160/161] (687s left) i915_selftest (live)
[379.100401] Starting subtest: live
[379.110130] Starting dynamic subtest: sanitycheck
[383.628378] Dynamic subtest sanitycheck: SUCCESS (4.516s)
[383.679203] Starting dynamic subtest: uncore
[387.954506] Dynamic subtest uncore: SUCCESS (4.320s)
[387.989687] Starting dynamic subtest: workarounds
[392.937128] Dynamic subtest workarounds: SUCCESS (4.975s)
[392.961560] Starting dynamic subtest: gt_engines
[398.049241] Dynamic subtest gt_engines: SUCCESS (5.106s)
[398.086861] Starting dynamic subtest: gt_timelines
[429.334086] Dynamic subtest gt_timelines: SUCCESS (31.279s)
[429.377694] Starting dynamic subtest: gt_contexts
[434.079159] Dynamic subtest gt_contexts: SUCCESS (4.719s)
[434.122474] Starting dynamic subtest: gt_lrc
[441.629747] Dynamic subtest gt_lrc: SUCCESS (7.551s)
[441.671069] Starting dynamic subtest: gt_mocs
[446.033172] Dynamic subtest gt_mocs: SUCCESS (4.389s)
[446.057374] Starting dynamic subtest: gt_pm
[451.571481] Dynamic subtest gt_pm: SUCCESS (5.534s)
[451.607249] Starting dynamic subtest: gt_heartbeat
[455.802432] Dynamic subtest gt_heartbeat: SUCCESS (4.225s)
[455.837833] Starting dynamic subtest: gt_tlb
[460.453925] Dynamic subtest gt_tlb: SUCCESS (4.642s)
[460.490096] Starting dynamic subtest: requests
[471.099252] Dynamic subtest requests: SUCCESS (10.637s)
[471.123832] Starting dynamic subtest: migrate
[479.084503] Dynamic subtest migrate: SUCCESS (7.969s)
[479.135580] Starting dynamic subtest: active
[483.644550] Dynamic subtest active: SUCCESS (4.552s)
[483.679254] Starting dynamic subtest: objects
[489.716953] Dynamic subtest objects: SUCCESS (6.068s)
[489.748218] Starting dynamic subtest: mman
[502.432462] Dynamic subtest mman: SUCCESS (12.710s)
[502.465710] Starting dynamic subtest: dmabuf
[506.968113] Dynamic subtest dmabuf: SUCCESS (4.519s)
[507.019465] Starting dynamic subtest: vma
[511.251180] Dynamic subtest vma: SUCCESS (4.277s)
[511.278869] Starting dynamic subtest: coherency
[520.408226] Dynamic subtest coherency: SUCCESS (9.151s)
[520.485282] Starting dynamic subtest: gtt
[531.829537] Dynamic subtest gtt: SUCCESS (11.412s)
[531.915660] Starting dynamic subtest: gem
[537.352352] Dynamic subtest gem: SUCCESS (5.505s)
[537.400261] Starting dynamic subtest: evict
[548.430589] Dynamic subtest evict: SUCCESS (11.080s)
[548.468430] Starting dynamic subtest: hugepages
[553.200940] Dynamic subtest hugepages: SUCCESS (4.759s)
[553.231758] Starting dynamic subtest: gem_contexts
[582.467105] Dynamic subtest gem_contexts: SUCCESS (29.248s)
[582.493416] Starting dynamic subtest: client
[587.204925] Dynamic subtest client: SUCCESS (4.734s)
[587.265937] Starting dynamic subtest: gem_migrate
[591.639876] Dynamic subtest gem_migrate: SUCCESS (4.418s)
[591.664910] Starting dynamic subtest: reset
[603.265249] Dynamic subtest reset: SUCCESS (11.612s)
[603.321454] Starting dynamic subtest: memory_region
[607.824637] Dynamic subtest memory_region: SUCCESS (4.554s)
[607.879221] Starting dynamic subtest: hangcheck
[635.659352] Dynamic subtest hangcheck: SUCCESS (27.828s)
[635.714274] Starting dynamic subtest: execlists
[646.007125] Dynamic subtest execlists: SUCCESS (10.335s)
[646.036997] Starting dynamic subtest: ring_submission
[650.398776] Dynamic subtest ring_submission: SUCCESS (4.388s)
[650.437799] Starting dynamic subtest: perf
[655.187798] Dynamic subtest perf: SUCCESS (4.776s)
[655.223445] Starting dynamic subtest: slpc
[659.640461] Dynamic subtest slpc: SUCCESS (4.437s)
[659.669082] Starting dynamic subtest: guc
[664.075441] Dynamic subtest guc: SUCCESS (4.425s)
[664.100399] Starting dynamic subtest: guc_multi_lrc
[668.524645] Dynamic subtest guc_multi_lrc: SUCCESS (4.447s)
[668.567250] Starting dynamic subtest: guc_hang
[672.757130] Dynamic subtest guc_hang: SUCCESS (4.210s)
[672.784176] Starting dynamic subtest: late_gt_pm
[677.211407] Dynamic subtest late_gt_pm: SUCCESS (4.449s)
[677.216537] Subtest live: SUCCESS (298.095s)
[677.378623] [161/161] (389s left) dmabuf (all-tests)
[677.670992] Starting subtest: all-tests
[677.672961] Starting dynamic subtest: sanitycheck
[677.729111] Dynamic subtest sanitycheck: SUCCESS (0.058s)
[677.790148] Starting dynamic subtest: dma_fence
[678.066212] Dynamic subtest dma_fence: SUCCESS (0.322s)
[678.116848] Starting dynamic subtest: dma_fence_chain