[30.060104] Initializing watchdogs
[30.060149]   /dev/watchdog0
[30.063539] [001/165] (960s left) i915_module_load (load)
[30.093984] Starting subtest: load
[30.647664] Subtest load: SUCCESS (0.553s)
[30.655880] [002/165] (959s left) core_auth (basic-auth)
[30.700450] Starting subtest: basic-auth
[30.702163] Subtest basic-auth: SUCCESS (0.001s)
[30.756016] [003/165] (959s left) debugfs_test (read_all_entries)
[30.789136] Starting subtest: read_all_entries
[30.832694] Subtest read_all_entries: SUCCESS (0.042s)
[30.939518] [004/165] (959s left) debugfs_test (basic-hwmon)
[30.987506] Starting subtest: basic-hwmon
[30.988905] Subtest basic-hwmon: SKIP (0.000s)
[31.088032] [005/165] (959s left) fbdev (eof)
[31.130270] Starting subtest: eof
[31.130927] Subtest eof: SUCCESS (0.000s)
[31.189651] [006/165] (959s left) fbdev (info)
[31.231565] Starting subtest: info
[31.232250] Subtest info: SUCCESS (0.000s)
[31.304464] [007/165] (959s left) fbdev (nullptr)
[31.363795] Starting subtest: nullptr
[31.364596] Subtest nullptr: SUCCESS (0.000s)
[31.420572] [008/165] (959s left) fbdev (read)
[31.480734] Starting subtest: read
[32.060060] Subtest read: SUCCESS (0.579s)
[32.089029] [009/165] (958s left) fbdev (write)
[32.130636] Starting subtest: write
[32.518830] Subtest write: SUCCESS (0.388s)
[32.557705] [010/165] (958s left) gem_basic (bad-close)
[32.590221] Starting subtest: bad-close
[32.591642] Subtest bad-close: SUCCESS (0.000s)
[32.653334] [011/165] (958s left) gem_basic (create-close)
[32.690216] Starting subtest: create-close
[32.691660] Subtest create-close: SUCCESS (0.000s)
[32.772690] [012/165] (957s left) gem_basic (create-fd-close)
[32.819991] Starting subtest: create-fd-close
[32.821471] Subtest create-fd-close: SUCCESS (0.000s)
[32.907205] [013/165] (957s left) gem_busy (busy@all-engines)
[32.959670] Starting subtest: busy
[32.960441] Starting dynamic subtest: all-engines
[32.977676] Dynamic subtest all-engines: SUCCESS (0.018s)
[32.978340] Subtest busy: SUCCESS (0.018s)
[33.342997] [014/165] (957s left) gem_close_race (basic-process)
[33.392913] Starting subtest: basic-process
[33.411038] Subtest basic-process: SUCCESS (0.018s)
[33.572213] [015/165] (957s left) gem_close_race (basic-threads)
[33.606155] Starting subtest: basic-threads
[34.789357] Subtest basic-threads: SUCCESS (1.183s)
[34.996793] [016/165] (955s left) gem_ctx_create (basic)
[35.070751] Starting subtest: basic
[35.071723] Subtest basic: SUCCESS (0.000s)
[35.241587] [017/165] (955s left) gem_ctx_create (basic-files)
[35.292626] Starting subtest: basic-files
[37.301198] Subtest basic-files: SUCCESS (2.009s)
[37.476191] [018/165] (953s left) gem_ctx_exec (basic)
[37.524835] Starting subtest: basic
[37.526172] Subtest basic: SUCCESS (0.002s)
[37.622659] [019/165] (953s left) gem_exec_basic (basic)
[37.670146] Starting subtest: basic
[37.670867] Starting dynamic subtest: rcs0-smem
[37.671595] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[37.674542] Starting dynamic subtest: bcs0-smem
[37.675292] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[37.678334] Starting dynamic subtest: vcs0-smem
[37.679047] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[37.681964] Starting dynamic subtest: vecs0-smem
[37.682675] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[37.683331] Subtest basic: SUCCESS (0.001s)
[37.860311] [020/165] (953s left) gem_exec_create (basic)
[37.910830] Starting subtest: basic
[37.911583] Starting dynamic subtest: smem
[39.965208] Dynamic subtest smem: SUCCESS (2.054s)
[39.966083] Subtest basic: SUCCESS (2.054s)
[40.156520] [021/165] (950s left) gem_exec_fence (basic-busy)
[40.323221] Starting subtest: basic-busy
[40.324598] Starting dynamic subtest: rcs0
[40.370329] Dynamic subtest rcs0: SUCCESS (0.047s)
[40.384334] Starting dynamic subtest: bcs0
[40.401289] Dynamic subtest bcs0: SUCCESS (0.030s)
[40.413974] Starting dynamic subtest: vcs0
[40.437176] Dynamic subtest vcs0: SUCCESS (0.036s)
[40.450060] Starting dynamic subtest: vecs0
[40.470616] Dynamic subtest vecs0: SUCCESS (0.033s)
[40.472628] Subtest basic-busy: SUCCESS (0.147s)
[40.957195] [022/165] (949s left) gem_exec_fence (basic-wait)
[41.142672] Starting subtest: basic-wait
[41.144083] Starting dynamic subtest: rcs0
[41.202523] Dynamic subtest rcs0: SUCCESS (0.059s)
[41.209201] Starting dynamic subtest: bcs0
[41.232298] Dynamic subtest bcs0: SUCCESS (0.030s)
[41.246877] Starting dynamic subtest: vcs0
[41.276280] Dynamic subtest vcs0: SUCCESS (0.043s)
[41.289963] Starting dynamic subtest: vecs0
[41.302532] Dynamic subtest vecs0: SUCCESS (0.026s)
[41.304282] Subtest basic-wait: SUCCESS (0.160s)
[41.776161] [023/165] (949s left) gem_exec_fence (basic-await)
[41.953237] Starting subtest: basic-await
[41.954505] Starting dynamic subtest: rcs0
[42.028670] Dynamic subtest rcs0: SUCCESS (0.075s)
[42.040290] Starting dynamic subtest: bcs0
[42.106239] Dynamic subtest bcs0: SUCCESS (0.077s)
[42.120260] Starting dynamic subtest: vcs0
[42.187745] Dynamic subtest vcs0: SUCCESS (0.081s)
[42.202441] Starting dynamic subtest: vecs0
[42.269571] Dynamic subtest vecs0: SUCCESS (0.081s)
[42.271485] Subtest basic-await: SUCCESS (0.316s)
[42.724543] [024/165] (948s left) gem_exec_fence (nb-await)
[42.891655] Starting subtest: nb-await
[42.892954] Starting dynamic subtest: rcs0
[42.953321] Dynamic subtest rcs0: SUCCESS (0.061s)
[42.967058] Starting dynamic subtest: bcs0
[43.016711] Dynamic subtest bcs0: SUCCESS (0.063s)
[43.031234] Starting dynamic subtest: vcs0
[43.080378] Dynamic subtest vcs0: SUCCESS (0.063s)
[43.094786] Starting dynamic subtest: vecs0
[43.144341] Dynamic subtest vecs0: SUCCESS (0.063s)
[43.146121] Subtest nb-await: SUCCESS (0.253s)
[43.609405] [025/165] (947s left) gem_exec_gttfill (basic)
[43.660256] Starting subtest: basic
[45.687115] Subtest basic: SUCCESS (2.027s)
[45.863227] [026/165] (945s left) gem_exec_parallel (engines)
[45.943717] Starting subtest: engines
[45.944545] Starting dynamic subtest: basic
[47.230633] Dynamic subtest basic: SUCCESS (1.287s)
[47.234552] Starting dynamic subtest: contexts
[48.946511] Dynamic subtest contexts: SUCCESS (1.715s)
[48.950386] Starting dynamic subtest: fds
[50.683115] Dynamic subtest fds: SUCCESS (1.736s)
[50.694310] Starting dynamic subtest: userptr
[51.973799] Dynamic subtest userptr: SUCCESS (1.291s)
[51.974778] Subtest engines: SUCCESS (6.030s)
[52.168925] [027/165] (938s left) gem_exec_store (basic)
[52.214388] Starting subtest: basic
[52.260929] Subtest basic: SUCCESS (0.046s)
[52.457421] [028/165] (938s left) gem_flink_basic (bad-flink)
[52.501798] Starting subtest: bad-flink
[52.502557] Subtest bad-flink: SUCCESS (0.000s)
[52.573349] [029/165] (938s left) gem_flink_basic (bad-open)
[52.609129] Starting subtest: bad-open
[52.609859] Subtest bad-open: SUCCESS (0.000s)
[52.668258] [030/165] (938s left) gem_flink_basic (basic)
[52.710847] Starting subtest: basic
[52.711581] Subtest basic: SUCCESS (0.000s)
[52.792483] [031/165] (938s left) gem_flink_basic (double-flink)
[52.835980] Starting subtest: double-flink
[52.836735] Subtest double-flink: SUCCESS (0.000s)
[52.926136] [032/165] (938s left) gem_flink_basic (flink-lifetime)
[52.969181] Starting subtest: flink-lifetime
[52.969863] Subtest flink-lifetime: SUCCESS (0.001s)
[53.061276] [033/165] (938s left) gem_huc_copy (huc-copy)
[53.106491] Starting subtest: huc-copy
[53.107799] Subtest huc-copy: SKIP (0.000s)
[53.209637] [034/165] (937s left) gem_linear_blits (basic)
[53.300786] Starting subtest: basic
[53.304090] Subtest basic: SUCCESS (0.003s)
[53.422102] [035/165] (937s left) gem_mmap (basic)
[53.495494] Starting subtest: basic
[53.499016] Subtest basic: SUCCESS (0.000s)
[53.571605] [036/165] (937s left) gem_mmap_gtt (basic)
[53.614774] Starting subtest: basic
[53.615536] Subtest basic: SUCCESS (0.000s)
[53.676492] [037/165] (937s left) gem_render_linear_blits (basic)
[53.714020] Starting subtest: basic
[53.740061] Subtest basic: SUCCESS (0.026s)
[53.832848] [038/165] (937s left) gem_render_tiled_blits (basic)
[53.875206] Starting subtest: basic
[53.890538] Subtest basic: SUCCESS (0.015s)
[53.948015] [039/165] (937s left) gem_ringfill (basic-all)
[54.114778] Starting subtest: basic-all
[55.217213] Subtest basic-all: SUCCESS (1.103s)
[55.341455] [040/165] (935s left) gem_softpin (allocator-basic)
[55.391615] Starting subtest: allocator-basic
[55.439632] Subtest allocator-basic: SUCCESS (0.048s)
[55.544097] [041/165] (935s left) gem_softpin (allocator-basic-reserve)
[55.589977] Starting subtest: allocator-basic-reserve
[55.639666] Subtest allocator-basic-reserve: SUCCESS (0.050s)
[55.744135] [042/165] (935s left) gem_softpin (safe-alignment)
[55.787938] Starting subtest: safe-alignment
[55.793907] Subtest safe-alignment: SUCCESS (0.006s)
[55.894082] [043/165] (935s left) gem_sync (basic-all)
[55.943777] Starting subtest: basic-all
[58.066990] Subtest basic-all: SUCCESS (2.124s)
[58.261443] [044/165] (933s left) gem_sync (basic-each)
[58.303634] Starting subtest: basic-each
[60.362069] Subtest basic-each: SUCCESS (2.059s)
[60.564997] [045/165] (930s left) gem_tiled_blits (basic)
[60.658085] Starting subtest: basic
[60.666946] Subtest basic: SUCCESS (0.009s)
[60.786207] [046/165] (930s left) gem_tiled_fence_blits (basic)
[60.910668] Starting subtest: basic
[60.930987] Subtest basic: SUCCESS (0.020s)
[61.060215] [047/165] (930s left) gem_tiled_pread_basic
[61.175354] [048/165] (930s left) gem_wait (busy@all-engines)
[61.220134] Starting subtest: busy
[61.221097] Starting dynamic subtest: all-engines
[61.735085] Dynamic subtest all-engines: SUCCESS (0.515s)
[61.735887] Subtest busy: SUCCESS (0.515s)
[61.921793] [049/165] (929s left) gem_wait (wait@all-engines)
[61.967028] Starting subtest: wait
[61.967868] Starting dynamic subtest: all-engines
[63.004428] Dynamic subtest all-engines: SUCCESS (1.036s)
[63.006420] Subtest wait: SUCCESS (1.037s)
[63.204381] [050/165] (928s left) i915_getparams_basic (basic-eu-total)
[63.240593] Starting subtest: basic-eu-total
[63.242253] Subtest basic-eu-total: SUCCESS (0.000s)
[63.303708] [051/165] (928s left) i915_getparams_basic (basic-subslice-total)
[63.344807] Starting subtest: basic-subslice-total
[63.346503] Subtest basic-subslice-total: SUCCESS (0.000s)
[63.401588] [052/165] (928s left) i915_hangman (error-state-basic)
[63.457908] Starting subtest: error-state-basic
[63.462548] Subtest error-state-basic: SUCCESS (0.004s)
[63.560408] [053/165] (928s left) i915_pciid
[63.662708] [054/165] (927s left) kms_addfb_basic (addfb25-4-tiled)
[63.742212] Starting subtest: addfb25-4-tiled
[63.742952] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[63.835557] [055/165] (927s left) kms_addfb_basic (addfb25-bad-modifier)
[63.869228] Starting subtest: addfb25-bad-modifier
[63.869947] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[63.995286] [056/165] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[64.037645] Starting subtest: addfb25-framebuffer-vs-set-tiling
[64.038564] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[64.160321] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag)
[64.203620] Starting subtest: addfb25-modifier-no-flag
[64.204380] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[64.327778] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[64.371727] Starting subtest: addfb25-x-tiled-legacy
[64.372398] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[64.495197] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[64.538090] Starting subtest: addfb25-x-tiled-mismatch-legacy
[64.538803] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[64.654269] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[64.731757] Starting subtest: addfb25-yf-tiled-legacy
[64.732501] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[64.827504] [061/165] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[64.897048] Starting subtest: addfb25-y-tiled-legacy
[64.897792] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[64.996203] [062/165] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[65.072906] Starting subtest: addfb25-y-tiled-small-legacy
[65.073589] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[65.158382] [063/165] (926s left) kms_addfb_basic (bad-pitch-0)
[65.201926] Starting subtest: bad-pitch-0
[65.202777] Subtest bad-pitch-0: SUCCESS (0.000s)
[65.327961] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024)
[65.362415] Starting subtest: bad-pitch-1024
[65.363081] Subtest bad-pitch-1024: SUCCESS (0.000s)
[65.477287] [065/165] (926s left) kms_addfb_basic (bad-pitch-128)
[65.521726] Starting subtest: bad-pitch-128
[65.522429] Subtest bad-pitch-128: SUCCESS (0.000s)
[65.644557] [066/165] (926s left) kms_addfb_basic (bad-pitch-256)
[65.688787] Starting subtest: bad-pitch-256
[65.689611] Subtest bad-pitch-256: SUCCESS (0.000s)
[65.818833] [067/165] (926s left) kms_addfb_basic (bad-pitch-32)
[65.858875] Starting subtest: bad-pitch-32
[65.859583] Subtest bad-pitch-32: SUCCESS (0.000s)
[65.977134] [068/165] (925s left) kms_addfb_basic (bad-pitch-63)
[66.022073] Starting subtest: bad-pitch-63
[66.022791] Subtest bad-pitch-63: SUCCESS (0.000s)
[66.145585] [069/165] (925s left) kms_addfb_basic (bad-pitch-65536)
[66.190420] Starting subtest: bad-pitch-65536
[66.191133] Subtest bad-pitch-65536: SUCCESS (0.000s)
[66.313238] [070/165] (925s left) kms_addfb_basic (bad-pitch-999)
[66.357330] Starting subtest: bad-pitch-999
[66.358073] Subtest bad-pitch-999: SUCCESS (0.000s)
[66.466970] [071/165] (925s left) kms_addfb_basic (basic)
[66.504490] Starting subtest: basic
[66.505363] Subtest basic: SUCCESS (0.000s)
[66.627639] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy)
[66.672732] Starting subtest: basic-x-tiled-legacy
[66.673579] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[66.791409] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy)
[66.836596] Starting subtest: basic-y-tiled-legacy
[66.837332] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[66.946215] [074/165] (925s left) kms_addfb_basic (bo-too-small)
[67.026806] Starting subtest: bo-too-small
[67.027482] Subtest bo-too-small: SUCCESS (0.000s)
[67.107071] [075/165] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[67.175558] Starting subtest: bo-too-small-due-to-tiling
[67.176438] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[67.261722] [076/165] (924s left) kms_addfb_basic (clobberred-modifier)
[67.297137] Starting subtest: clobberred-modifier
[67.298089] Subtest clobberred-modifier: SUCCESS (0.000s)
[67.404334] [077/165] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[67.449323] Starting subtest: framebuffer-vs-set-tiling
[67.450101] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[67.560318] [078/165] (924s left) kms_addfb_basic (invalid-get-prop)
[67.609474] Starting subtest: invalid-get-prop
[67.610156] Subtest invalid-get-prop: SUCCESS (0.000s)
[67.745294] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any)
[67.777158] Starting subtest: invalid-get-prop-any
[67.777817] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[67.894339] [080/165] (924s left) kms_addfb_basic (invalid-set-prop)
[67.937793] Starting subtest: invalid-set-prop
[67.938447] Subtest invalid-set-prop: SUCCESS (0.000s)
[68.061309] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any)
[68.095292] Starting subtest: invalid-set-prop-any
[68.095965] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[68.209935] [082/165] (924s left) kms_addfb_basic (no-handle)
[68.244985] Starting subtest: no-handle
[68.245720] Subtest no-handle: SUCCESS (0.000s)
[68.360234] [083/165] (923s left) kms_addfb_basic (size-max)
[68.437582] Starting subtest: size-max
[68.438250] Subtest size-max: SUCCESS (0.000s)
[68.522945] [084/165] (923s left) kms_addfb_basic (small-bo)
[68.589637] Starting subtest: small-bo
[68.590316] Subtest small-bo: SUCCESS (0.000s)
[68.695323] [085/165] (923s left) kms_addfb_basic (tile-pitch-mismatch)
[68.731047] Starting subtest: tile-pitch-mismatch
[68.731819] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[68.862831] [086/165] (923s left) kms_addfb_basic (too-high)
[68.939603] Starting subtest: too-high
[68.940285] Subtest too-high: SUCCESS (0.000s)
[69.029417] [087/165] (923s left) kms_addfb_basic (too-wide)
[69.106514] Starting subtest: too-wide
[69.107181] Subtest too-wide: SUCCESS (0.000s)
[69.213428] [088/165] (923s left) kms_addfb_basic (unused-handle)
[69.256742] Starting subtest: unused-handle
[69.257525] Subtest unused-handle: SUCCESS (0.000s)
[69.378150] [089/165] (922s left) kms_addfb_basic (unused-modifier)
[69.413657] Starting subtest: unused-modifier
[69.414510] Subtest unused-modifier: SUCCESS (0.000s)
[69.523718] [090/165] (922s left) kms_addfb_basic (unused-offsets)
[69.568471] Starting subtest: unused-offsets
[69.569345] Subtest unused-offsets: SUCCESS (0.000s)
[69.696366] [091/165] (922s left) kms_addfb_basic (unused-pitches)
[69.747143] Starting subtest: unused-pitches
[69.747887] Subtest unused-pitches: SUCCESS (0.000s)
[69.859588] [092/165] (922s left) kms_busy (basic)
[69.938657] Starting subtest: basic
[69.939401] Starting dynamic subtest: flip
[70.512061] Dynamic subtest flip: SUCCESS (0.572s)
[70.519444] Starting dynamic subtest: modeset
[71.223652] Dynamic subtest modeset: SUCCESS (0.711s)
[71.224795] Subtest basic: SUCCESS (1.284s)
[71.390411] [093/165] (921s left) kms_prop_blob (basic)
[71.430478] Starting subtest: basic
[71.431145] Subtest basic: SUCCESS (0.000s)
[71.508070] [094/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[71.577664] Starting subtest: basic-busy-flip-before-cursor-atomic
[71.578948] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[71.660271] [095/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[71.728583] Starting subtest: basic-busy-flip-before-cursor-legacy
[71.730036] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[71.802681] [096/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[71.878078] Starting subtest: basic-flip-after-cursor-atomic
[72.839037] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.961s)
[72.987082] [097/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[73.057520] Starting subtest: basic-flip-after-cursor-legacy
[74.039455] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.981s)
[74.182171] [098/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[74.254633] Starting subtest: basic-flip-after-cursor-varying-size
[75.215858] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.960s)
[75.370733] [099/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[75.441307] Starting subtest: basic-flip-before-cursor-atomic
[76.422436] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.980s)
[76.571200] [100/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[76.639550] Starting subtest: basic-flip-before-cursor-legacy
[77.605328] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.965s)
[77.757519] [101/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[77.825712] Starting subtest: basic-flip-before-cursor-varying-size
[78.809889] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.984s)
[78.964076] [102/165] (913s left) kms_dsc (dsc-basic)
[79.035074] Starting subtest: dsc-basic
[79.036481] Subtest dsc-basic: SKIP (0.000s)
[79.115778] [103/165] (913s left) kms_flip (basic-flip-vs-dpms)
[79.185949] Starting subtest: basic-flip-vs-dpms
[79.186729] Starting dynamic subtest: A-HDMI-A1
[80.092593] Dynamic subtest A-HDMI-A1: SUCCESS (0.906s)
[80.102382] Starting dynamic subtest: B-HDMI-A1
[80.963601] Dynamic subtest B-HDMI-A1: SUCCESS (0.869s)
[80.971207] Starting dynamic subtest: C-HDMI-A1
[81.826633] Dynamic subtest C-HDMI-A1: SUCCESS (0.861s)
[81.827710] Subtest basic-flip-vs-dpms: SUCCESS (2.643s)
[81.959921] [104/165] (910s left) kms_flip (basic-flip-vs-modeset)
[82.024631] Starting subtest: basic-flip-vs-modeset
[82.025443] Starting dynamic subtest: A-HDMI-A1
[82.965834] Dynamic subtest A-HDMI-A1: SUCCESS (0.940s)
[82.971860] Starting dynamic subtest: B-HDMI-A1
[83.858936] Dynamic subtest B-HDMI-A1: SUCCESS (0.892s)
[83.865603] Starting dynamic subtest: C-HDMI-A1
[84.738994] Dynamic subtest C-HDMI-A1: SUCCESS (0.878s)
[84.742229] Subtest basic-flip-vs-modeset: SUCCESS (2.717s)
[84.867390] [105/165] (907s left) kms_flip (basic-flip-vs-wf_vblank)
[84.931622] Starting subtest: basic-flip-vs-wf_vblank
[84.932346] Starting dynamic subtest: A-HDMI-A1
[86.106980] Dynamic subtest A-HDMI-A1: SUCCESS (1.174s)
[86.116168] Starting dynamic subtest: B-HDMI-A1
[87.256833] Dynamic subtest B-HDMI-A1: SUCCESS (1.147s)
[87.264854] Starting dynamic subtest: C-HDMI-A1
[88.412653] Dynamic subtest C-HDMI-A1: SUCCESS (1.153s)
[88.418370] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.485s)
[88.596096] [106/165] (904s left) kms_flip (basic-plain-flip)
[88.668794] Starting subtest: basic-plain-flip
[88.669597] Starting dynamic subtest: A-HDMI-A1
[89.570936] Dynamic subtest A-HDMI-A1: SUCCESS (0.901s)
[89.578921] Starting dynamic subtest: B-HDMI-A1
[90.420457] Dynamic subtest B-HDMI-A1: SUCCESS (0.846s)
[90.427627] Starting dynamic subtest: C-HDMI-A1
[91.291186] Dynamic subtest C-HDMI-A1: SUCCESS (0.868s)
[91.295146] Subtest basic-plain-flip: SUCCESS (2.628s)
[91.508058] [107/165] (901s left) kms_force_connector_basic (force-connector-state)
[91.635033] Starting subtest: force-connector-state
[91.968031] Subtest force-connector-state: SUCCESS (0.332s)
[92.230946] [108/165] (900s left) kms_force_connector_basic (force-edid)
[92.353038] Starting subtest: force-edid
[92.490921] Subtest force-edid: SUCCESS (0.138s)
[92.664983] [109/165] (900s left) kms_force_connector_basic (force-load-detect)
[92.791105] Starting subtest: force-load-detect
[92.792531] Subtest force-load-detect: SKIP (0.000s)
[92.970250] [110/165] (899s left) kms_force_connector_basic (prune-stale-modes)
[93.097148] Starting subtest: prune-stale-modes
[93.233839] Subtest prune-stale-modes: SUCCESS (0.138s)
[93.416273] [111/165] (899s left) kms_frontbuffer_tracking (basic)
[93.493346] Starting subtest: basic
[96.308289] Subtest basic: SUCCESS (2.816s)
[96.423566] [112/165] (896s left) kms_hdmi_inject (inject-audio)
[96.531483] Starting subtest: inject-audio
[96.661101] Subtest inject-audio: SUCCESS (0.129s)
[96.846704] [113/165] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[96.922173] Starting subtest: compare-crc-sanitycheck-xr24
[96.922901] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.347266] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.422s)
[97.356351] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.718654] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.368s)
[97.727307] Starting dynamic subtest: pipe-C-HDMI-A-1
[98.094722] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.372s)
[98.095662] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.173s)
[98.247894] [114/165] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[98.314933] Starting subtest: compare-crc-sanitycheck-nv12
[98.315666] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.809183] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.493s)
[98.817720] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.222451] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.410s)
[99.232589] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.641299] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.414s)
[99.642267] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.326s)
[99.809904] [115/165] (893s left) kms_pipe_crc_basic (hang-read-crc)
[99.876329] Starting subtest: hang-read-crc
[99.877066] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.959179] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.082s)
[100.967620] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.865459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.903s)
[101.873861] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.831748] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.963s)
[102.832817] Subtest hang-read-crc: SUCCESS (2.956s)
[102.954086] [116/165] (890s left) kms_pipe_crc_basic (nonblocking-crc)
[103.029106] Starting subtest: nonblocking-crc
[103.029974] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.653498] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.622s)
[103.661769] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.210038] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.553s)
[104.218330] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.752965] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.538s)
[104.753989] Subtest nonblocking-crc: SUCCESS (1.723s)
[104.877313] [117/165] (888s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[104.954183] Starting subtest: nonblocking-crc-frame-sequence
[104.954919] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.590682] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.635s)
[105.597329] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.127889] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.534s)
[106.137115] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.669023] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.537s)
[106.669992] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.715s)
[106.791950] [118/165] (886s left) kms_pipe_crc_basic (read-crc)
[106.863994] Starting subtest: read-crc
[106.864869] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.441224] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.575s)
[107.449726] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.911459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.467s)
[107.920710] Starting dynamic subtest: pipe-C-HDMI-A-1
[108.410516] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.494s)
[108.411697] Subtest read-crc: SUCCESS (1.545s)
[108.533843] [119/165] (884s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[108.601115] Starting subtest: read-crc-frame-sequence
[108.601908] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.177413] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.575s)
[109.182337] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.645949] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.465s)
[109.654191] Starting dynamic subtest: pipe-C-HDMI-A-1
[110.119512] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.472s)
[110.120618] Subtest read-crc-frame-sequence: SUCCESS (1.519s)
[110.243729] [120/165] (882s left) kms_pm_backlight (basic-brightness)
[110.313117] Subtest basic-brightness: SKIP (0.000s)
[110.332899] [121/165] (882s left) kms_pm_rpm (basic-pci-d3-state)
[111.732678] Starting subtest: basic-pci-d3-state
[112.150313] Subtest basic-pci-d3-state: SUCCESS (0.417s)
[112.407481] [122/165] (880s left) kms_pm_rpm (basic-rte)
[112.441501] Starting subtest: basic-rte
[114.069057] Subtest basic-rte: SUCCESS (1.625s)
[114.783944] [123/165] (878s left) kms_psr (primary_page_flip)
[114.829005] Subtest primary_page_flip: SKIP (0.000s)
[114.857244] [124/165] (878s left) kms_psr (cursor_plane_move)
[114.899128] Subtest cursor_plane_move: SKIP (0.000s)
[114.921199] [125/165] (878s left) kms_psr (sprite_plane_onoff)
[114.954687] Subtest sprite_plane_onoff: SKIP (0.000s)
[114.970164] [126/165] (878s left) kms_psr (primary_mmap_gtt)
[115.005241] Subtest primary_mmap_gtt: SKIP (0.000s)
[115.019847] [127/165] (878s left) kms_setmode (basic-clone-single-crtc)
[115.055108] Starting subtest: basic-clone-single-crtc
[115.057340] Subtest basic-clone-single-crtc: SKIP (0.000s)
[115.130056] [128/165] (878s left) i915_pm_rps (basic-api)
[115.173393] Starting subtest: basic-api
[115.187825] Subtest basic-api: SUCCESS (0.014s)
[115.279686] [129/165] (877s left) prime_self_import (basic-llseek-bad)
[115.320960] Starting subtest: basic-llseek-bad
[115.322373] Subtest basic-llseek-bad: SUCCESS (0.001s)
[115.413794] [130/165] (877s left) prime_self_import (basic-llseek-size)
[115.446033] Starting subtest: basic-llseek-size
[115.447400] Subtest basic-llseek-size: SUCCESS (0.001s)
[115.547843] [131/165] (877s left) prime_self_import (basic-with_fd_dup)
[115.585060] Starting subtest: basic-with_fd_dup
[115.586454] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[115.682386] [132/165] (877s left) prime_self_import (basic-with_one_bo)
[115.714542] Starting subtest: basic-with_one_bo
[115.715981] Subtest basic-with_one_bo: SUCCESS (0.001s)
[115.781281] [133/165] (877s left) prime_self_import (basic-with_one_bo_two_files)
[115.812035] Starting subtest: basic-with_one_bo_two_files
[115.813472] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[115.915484] [134/165] (877s left) prime_self_import (basic-with_two_bos)
[115.957251] Starting subtest: basic-with_two_bos
[115.958954] Subtest basic-with_two_bos: SUCCESS (0.001s)
[116.046322] [135/165] (877s left) prime_vgem (basic-fence-flip)
[116.100752] Starting subtest: basic-fence-flip
[116.516420] Subtest basic-fence-flip: SUCCESS (0.415s)
[116.614170] [136/165] (876s left) prime_vgem (basic-fence-mmap)
[116.670180] Starting subtest: basic-fence-mmap
[116.686834] Subtest basic-fence-mmap: SUCCESS (0.017s)
[116.780335] [137/165] (876s left) prime_vgem (basic-fence-read)
[116.833939] Starting subtest: basic-fence-read
[116.837720] Subtest basic-fence-read: SKIP (0.003s)
[116.924036] [138/165] (876s left) prime_vgem (basic-gtt)
[117.006985] Starting subtest: basic-gtt
[117.017929] Subtest basic-gtt: SUCCESS (0.011s)
[117.114074] [139/165] (876s left) prime_vgem (basic-read)
[117.185231] Starting subtest: basic-read
[117.191445] Subtest basic-read: SKIP (0.006s)
[117.299469] [140/165] (876s left) prime_vgem (basic-write)
[117.368569] Starting subtest: basic-write
[117.376285] Subtest basic-write: SKIP (0.007s)
[117.472747] [141/165] (875s left) vgem_basic (setversion)
[117.516157] Starting subtest: setversion
[117.518032] Subtest setversion: SUCCESS (0.000s)
[117.581667] [142/165] (875s left) vgem_basic (create)
[117.632734] Starting subtest: create
[117.633663] Subtest create: SUCCESS (0.000s)
[117.693894] [143/165] (875s left) vgem_basic (debugfs)
[117.749172] Starting subtest: debugfs
[117.750105] Subtest debugfs: SUCCESS (0.000s)
[117.810504] [144/165] (875s left) vgem_basic (dmabuf-export)
[117.865227] Starting subtest: dmabuf-export
[117.876170] Subtest dmabuf-export: SUCCESS (0.010s)
[117.963594] [145/165] (875s left) vgem_basic (dmabuf-fence)
[118.015597] Starting subtest: dmabuf-fence
[118.016533] Subtest dmabuf-fence: SUCCESS (0.000s)
[118.078142] [146/165] (875s left) vgem_basic (dmabuf-fence-before)
[118.132727] Starting subtest: dmabuf-fence-before
[118.133966] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[118.198068] [147/165] (875s left) vgem_basic (dmabuf-mmap)
[118.249038] Starting subtest: dmabuf-mmap
[118.255993] Subtest dmabuf-mmap: SUCCESS (0.008s)
[118.302650] [148/165] (875s left) vgem_basic (mmap)
[118.349076] Starting subtest: mmap
[118.353026] Subtest mmap: SUCCESS (0.005s)
[118.403541] [149/165] (875s left) vgem_basic (second-client)
[118.448577] Starting subtest: second-client
[118.484370] Subtest second-client: SUCCESS (0.034s)
[118.546764] [150/165] (875s left) vgem_basic (sysfs)
[118.599420] Starting subtest: sysfs
[118.600476] Subtest sysfs: SUCCESS (0.000s)
[118.661235] [151/165] (874s left) core_hotunplug (unbind-rebind)
[118.714864] Starting subtest: unbind-rebind
[121.588376] Subtest unbind-rebind: SUCCESS (2.873s)
[121.605084] [152/165] (872s left) vgem_basic (unload)
[121.638362] Starting subtest: unload
[150.546480] Subtest unload: SUCCESS (28.907s)
[150.652915] [153/165] (843s left) i915_module_load (reload)
[150.687101] Starting subtest: reload
[152.008688] Subtest reload: SUCCESS (1.320s)
[152.016294] [154/165] (841s left) gem_lmem_swapping (basic)
[152.058079] Subtest basic: SKIP (0.000s)
[152.079489] [155/165] (841s left) gem_lmem_swapping (parallel-random-engines)
[152.108631] Subtest parallel-random-engines: SKIP (0.000s)
[152.130996] [156/165] (841s left) gem_lmem_swapping (random-engines)
[152.164079] Subtest random-engines: SKIP (0.000s)
[152.183225] [157/165] (841s left) gem_lmem_swapping (verify-random)
[152.222524] Subtest verify-random: SKIP (0.000s)
[152.248196] [158/165] (841s left) i915_pm_rpm (module-reload)
[154.001456] Starting subtest: module-reload
[159.565042] Subtest module-reload: SUCCESS (5.562s)
[159.584472] [159/165] (834s left) i915_selftest (live)
[159.626996] Starting subtest: live
[159.627817] Starting dynamic subtest: sanitycheck
[160.091128] Dynamic subtest sanitycheck: SUCCESS (0.462s)
[160.103761] Starting dynamic subtest: uncore
[160.584066] Dynamic subtest uncore: SUCCESS (0.490s)
[160.591907] Starting dynamic subtest: workarounds
[161.253263] Dynamic subtest workarounds: SUCCESS (0.666s)
[161.260997] Starting dynamic subtest: gt_engines
[162.171962] Dynamic subtest gt_engines: SUCCESS (0.916s)
[162.182556] Starting dynamic subtest: gt_timelines
[167.641349] Dynamic subtest gt_timelines: SUCCESS (5.463s)
[167.649277] Starting dynamic subtest: gt_contexts
[168.180911] Dynamic subtest gt_contexts: SUCCESS (0.541s)
[168.190772] Starting dynamic subtest: gt_lrc
[170.967725] Dynamic subtest gt_lrc: SUCCESS (2.784s)
[170.978311] Starting dynamic subtest: gt_mocs
[171.520048] Dynamic subtest gt_mocs: SUCCESS (0.549s)
[171.527485] Starting dynamic subtest: gt_pm
[183.107036] Dynamic subtest gt_pm: SUCCESS (11.585s)
[183.114837] Starting dynamic subtest: gt_heartbeat
[183.641207] Dynamic subtest gt_heartbeat: SUCCESS (0.532s)
[183.648186] Starting dynamic subtest: gt_tlb
[185.342705] Dynamic subtest gt_tlb: SUCCESS (1.700s)
[185.352944] Starting dynamic subtest: requests
[192.073151] Dynamic subtest requests: SUCCESS (6.728s)
[192.081206] Starting dynamic subtest: migrate
[195.245332] Dynamic subtest migrate: SUCCESS (3.170s)
[195.252037] Starting dynamic subtest: active
[195.721492] Dynamic subtest active: SUCCESS (0.474s)
[195.731016] Starting dynamic subtest: objects
[196.638051] Dynamic subtest objects: SUCCESS (0.914s)
[196.650455] Starting dynamic subtest: mman
[200.398405] Dynamic subtest mman: SUCCESS (3.758s)
[200.407875] Starting dynamic subtest: dmabuf
[200.929535] Dynamic subtest dmabuf: SUCCESS (0.529s)
[200.940319] Starting dynamic subtest: vma
[201.435986] Dynamic subtest vma: SUCCESS (0.503s)
[201.446546] Starting dynamic subtest: coherency
[202.538997] Dynamic subtest coherency: SUCCESS (1.100s)
[202.546579] Starting dynamic subtest: gtt
[210.238853] Dynamic subtest gtt: SUCCESS (7.698s)
[210.247855] Starting dynamic subtest: gem
[210.823930] Dynamic subtest gem: SUCCESS (0.581s)
[210.832115] Starting dynamic subtest: evict
[211.823960] Dynamic subtest evict: SUCCESS (0.998s)
[211.837274] Starting dynamic subtest: hugepages
[218.793566] Dynamic subtest hugepages: SUCCESS (6.966s)
[218.804044] Starting dynamic subtest: gem_contexts
[230.065565] Dynamic subtest gem_contexts: SUCCESS (11.269s)
[230.075183] Starting dynamic subtest: client
[230.559908] Dynamic subtest client: SUCCESS (0.492s)
[230.572461] Starting dynamic subtest: gem_migrate
[231.026862] Dynamic subtest gem_migrate: SUCCESS (0.464s)
[231.037783] Starting dynamic subtest: reset
[234.719390] Dynamic subtest reset: SUCCESS (3.682s)
[234.725280] Starting dynamic subtest: memory_region
[235.163351] Dynamic subtest memory_region: SUCCESS (0.443s)
[235.169262] Starting dynamic subtest: hangcheck
[258.682652] Dynamic subtest hangcheck: SUCCESS (23.524s)
[258.689733] Starting dynamic subtest: execlists
[266.618776] Dynamic subtest execlists: SUCCESS (7.934s)
[266.628252] Starting dynamic subtest: ring_submission
[267.065796] Dynamic subtest ring_submission: SUCCESS (0.445s)
[267.077354] Starting dynamic subtest: perf
[267.588698] Dynamic subtest perf: SUCCESS (0.520s)
[267.596626] Starting dynamic subtest: slpc
[268.052429] Dynamic subtest slpc: SUCCESS (0.462s)
[268.061813] Starting dynamic subtest: guc
[268.532777] Dynamic subtest guc: SUCCESS (0.478s)
[268.542069] Starting dynamic subtest: guc_multi_lrc
[268.994741] Dynamic subtest guc_multi_lrc: SUCCESS (0.460s)
[269.007519] Starting dynamic subtest: guc_hang
[269.462250] Dynamic subtest guc_hang: SUCCESS (0.465s)
[269.473082] Starting dynamic subtest: late_gt_pm
[269.938884] Dynamic subtest late_gt_pm: SUCCESS (0.474s)
[269.940745] Subtest live: SUCCESS (110.312s)
[269.960036] [160/165] (723s left) dmabuf (all-tests)
[269.996334] Starting subtest: all-tests
[269.997903] Starting dynamic subtest: sanitycheck
[270.056533] Dynamic subtest sanitycheck: SUCCESS (0.059s)
[270.072774] Starting dynamic subtest: dma_fence
[270.238352] Dynamic subtest dma_fence: SUCCESS (0.180s)
[270.254288] Starting dynamic subtest: dma_fence_chain
[279.803565] Dynamic subtest dma_fence_chain: SUCCESS (9.563s)
[279.810879] Starting dynamic subtest: dma_fence_unwrap
[279.876132] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[279.886378] Starting dynamic subtest: dma_resv
[279.950155] Dynamic subtest dma_resv: SUCCESS (0.072s)
[279.951928] Subtest all-tests: SUCCESS (9.954s)
[279.981899] [161/165] (713s left) i915_suspend (basic-s2idle-without-i915)
[280.018941] Starting subtest: basic-s2idle-without-i915
[296.624889] Subtest basic-s2idle-without-i915: SUCCESS (2.425s)
[302.736791] [162/165] (711s left) i915_suspend (basic-s3-without-i915)
[302.783893] Starting subtest: basic-s3-without-i915
[330.638788] Subtest basic-s3-without-i915: SUCCESS (16.314s)
[336.312536] [163/165] (694s left) gem_exec_suspend (basic-s0)
[336.355947] Starting subtest: basic-S0
[336.356662] Starting dynamic subtest: smem
[353.844313] Dynamic subtest smem: SUCCESS (4.031s)
[353.845021] Subtest basic-S0: SUCCESS (4.031s)
[358.870678] [164/165] (690s left) gem_exec_suspend (basic-s3)
[358.909913] Starting subtest: basic-S3
[358.910736] Starting dynamic subtest: smem
[381.741332] Dynamic subtest smem: SUCCESS (17.448s)
[381.742111] Subtest basic-S3: SUCCESS (17.449s)
[386.258854] [165/165] (673s left) kms_pipe_crc_basic (suspend-read-crc)
[386.323913] Starting subtest: suspend-read-crc
[386.324810] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.890719] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.405s)
[420.895644] Starting dynamic subtest: pipe-B-HDMI-A-1
[447.867646] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.402s)
[447.873716] Starting dynamic subtest: pipe-C-HDMI-A-1
[469.860954] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.403s)
[469.861669] Subtest suspend-read-crc: SUCCESS (19.213s)
[474.931677] Closing watchdogs
Done.