[31.528165] Initializing watchdogs
[31.528209]   /dev/watchdog0
[31.531838] [001/165] (960s left) i915_module_load (load)
[31.558489] Starting subtest: load
[33.549013] Subtest load: SUCCESS (1.990s)
[33.560075] [002/165] (958s left) core_auth (basic-auth)
[33.623153] Starting subtest: basic-auth
[33.624465] Subtest basic-auth: SUCCESS (0.001s)
[33.684752] [003/165] (958s left) debugfs_test (read_all_entries)
[33.715520] Starting subtest: read_all_entries
[33.850435] Subtest read_all_entries: SUCCESS (0.135s)
[34.102248] [004/165] (957s left) debugfs_test (basic-hwmon)
[34.130194] Starting subtest: basic-hwmon
[34.131903] Subtest basic-hwmon: SKIP (0.000s)
[34.384700] [005/165] (957s left) fbdev (eof)
[34.416296] Starting subtest: eof
[34.417326] Subtest eof: SUCCESS (0.000s)
[34.467118] [006/165] (957s left) fbdev (info)
[34.492254] Starting subtest: info
[34.493047] Subtest info: SUCCESS (0.000s)
[34.549185] [007/165] (957s left) fbdev (nullptr)
[34.582051] Starting subtest: nullptr
[34.582956] Subtest nullptr: SUCCESS (0.000s)
[34.631931] [008/165] (957s left) fbdev (read)
[34.665626] Starting subtest: read
[37.169784] Subtest read: SUCCESS (2.504s)
[37.214272] [009/165] (954s left) fbdev (write)
[37.249249] Starting subtest: write
[39.106894] Subtest write: SUCCESS (1.848s)
[39.147343] [010/165] (952s left) gem_basic (bad-close)
[39.173707] Starting subtest: bad-close
[39.175324] Subtest bad-close: SUCCESS (0.000s)
[39.234291] [011/165] (952s left) gem_basic (create-close)
[39.264485] Starting subtest: create-close
[39.265969] Subtest create-close: SUCCESS (0.000s)
[39.351376] [012/165] (952s left) gem_basic (create-fd-close)
[39.377806] Starting subtest: create-fd-close
[39.379133] Subtest create-fd-close: SUCCESS (0.000s)
[39.450132] [013/165] (952s left) gem_busy (busy@all-engines)
[39.482648] Starting subtest: busy
[39.483661] Starting dynamic subtest: all-engines
[39.503150] Dynamic subtest all-engines: SUCCESS (0.021s)
[39.503823] Subtest busy: SUCCESS (0.021s)
[39.836674] [014/165] (952s left) gem_close_race (basic-process)
[39.868437] Starting subtest: basic-process
[39.913805] Subtest basic-process: SUCCESS (0.044s)
[40.083357] [015/165] (952s left) gem_close_race (basic-threads)
[40.113075] Starting subtest: basic-threads
[41.330428] Subtest basic-threads: SUCCESS (1.217s)
[41.505100] [016/165] (950s left) gem_ctx_create (basic)
[41.540204] Starting subtest: basic
[41.540957] Subtest basic: SUCCESS (0.000s)
[41.697380] [017/165] (950s left) gem_ctx_create (basic-files)
[41.727969] Starting subtest: basic-files
[43.737039] Subtest basic-files: SUCCESS (2.009s)
[44.018259] [018/165] (948s left) gem_ctx_exec (basic)
[44.049557] Starting subtest: basic
[44.051059] Subtest basic: SUCCESS (0.002s)
[44.136642] [019/165] (948s left) gem_exec_basic (basic)
[44.170547] Starting subtest: basic
[44.171340] Starting dynamic subtest: rcs0-smem
[44.172062] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[44.175437] Starting dynamic subtest: bcs0-smem
[44.176187] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[44.181194] Starting dynamic subtest: vcs0-smem
[44.182152] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[44.188210] Starting dynamic subtest: vcs1-smem
[44.189485] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[44.195053] Starting dynamic subtest: vecs0-smem
[44.196103] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[44.196914] Subtest basic: SUCCESS (0.002s)
[44.354030] [020/165] (947s left) gem_exec_create (basic)
[44.387178] Starting subtest: basic
[44.387962] Starting dynamic subtest: smem
[46.477258] Dynamic subtest smem: SUCCESS (2.090s)
[46.478765] Subtest basic: SUCCESS (2.090s)
[46.653911] [021/165] (945s left) gem_exec_fence (basic-busy)
[46.809942] Starting subtest: basic-busy
[46.811417] Starting dynamic subtest: rcs0
[46.850292] Dynamic subtest rcs0: SUCCESS (0.049s)
[46.857437] Starting dynamic subtest: bcs0
[46.903244] Dynamic subtest bcs0: SUCCESS (0.053s)
[46.915107] Starting dynamic subtest: vcs0
[46.950139] Dynamic subtest vcs0: SUCCESS (0.047s)
[46.954100] Starting dynamic subtest: vcs1
[46.997170] Dynamic subtest vcs1: SUCCESS (0.046s)
[47.004435] Starting dynamic subtest: vecs0
[47.050253] Dynamic subtest vecs0: SUCCESS (0.053s)
[47.052046] Subtest basic-busy: SUCCESS (0.249s)
[47.538160] [022/165] (944s left) gem_exec_fence (basic-wait)
[47.706988] Starting subtest: basic-wait
[47.708444] Starting dynamic subtest: rcs0
[47.768808] Dynamic subtest rcs0: SUCCESS (0.070s)
[47.779349] Starting dynamic subtest: bcs0
[47.816826] Dynamic subtest bcs0: SUCCESS (0.047s)
[47.828643] Starting dynamic subtest: vcs0
[47.863831] Dynamic subtest vcs0: SUCCESS (0.047s)
[47.874834] Starting dynamic subtest: vcs1
[47.909897] Dynamic subtest vcs1: SUCCESS (0.046s)
[47.920773] Starting dynamic subtest: vecs0
[47.961195] Dynamic subtest vecs0: SUCCESS (0.051s)
[47.963174] Subtest basic-wait: SUCCESS (0.263s)
[48.420205] [023/165] (943s left) gem_exec_fence (basic-await)
[48.576842] Starting subtest: basic-await
[48.577931] Starting dynamic subtest: rcs0
[48.639289] Dynamic subtest rcs0: SUCCESS (0.071s)
[48.646432] Starting dynamic subtest: bcs0
[48.712049] Dynamic subtest bcs0: SUCCESS (0.072s)
[48.719508] Starting dynamic subtest: vcs0
[48.784683] Dynamic subtest vcs0: SUCCESS (0.072s)
[48.792687] Starting dynamic subtest: vcs1
[48.856091] Dynamic subtest vcs1: SUCCESS (0.071s)
[48.863245] Starting dynamic subtest: vecs0
[48.927769] Dynamic subtest vecs0: SUCCESS (0.071s)
[48.929661] Subtest basic-await: SUCCESS (0.360s)
[49.407223] [024/165] (942s left) gem_exec_fence (nb-await)
[49.565914] Starting subtest: nb-await
[49.566932] Starting dynamic subtest: rcs0
[49.614125] Dynamic subtest rcs0: SUCCESS (0.057s)
[49.620152] Starting dynamic subtest: bcs0
[49.670600] Dynamic subtest bcs0: SUCCESS (0.056s)
[49.681729] Starting dynamic subtest: vcs0
[49.731276] Dynamic subtest vcs0: SUCCESS (0.060s)
[49.737212] Starting dynamic subtest: vcs1
[49.788608] Dynamic subtest vcs1: SUCCESS (0.057s)
[49.800672] Starting dynamic subtest: vecs0
[49.848802] Dynamic subtest vecs0: SUCCESS (0.060s)
[49.850698] Subtest nb-await: SUCCESS (0.292s)
[50.322771] [025/165] (941s left) gem_exec_gttfill (basic)
[50.365666] Starting subtest: basic
[52.478390] Subtest basic: SUCCESS (2.113s)
[52.656410] [026/165] (939s left) gem_exec_parallel (engines)
[52.726740] Starting subtest: engines
[52.727479] Starting dynamic subtest: basic
[54.038326] Dynamic subtest basic: SUCCESS (1.311s)
[54.046368] Starting dynamic subtest: contexts
[55.688983] Dynamic subtest contexts: SUCCESS (1.642s)
[55.696063] Starting dynamic subtest: fds
[57.514110] Dynamic subtest fds: SUCCESS (1.834s)
[57.519838] Starting dynamic subtest: userptr
[58.803657] Dynamic subtest userptr: SUCCESS (1.289s)
[58.805364] Subtest engines: SUCCESS (6.076s)
[58.977193] [027/165] (933s left) gem_exec_store (basic)
[59.014285] Starting subtest: basic
[59.095497] Subtest basic: SUCCESS (0.080s)
[59.270488] [028/165] (933s left) gem_flink_basic (bad-flink)
[59.303109] Starting subtest: bad-flink
[59.304028] Subtest bad-flink: SUCCESS (0.000s)
[59.369194] [029/165] (932s left) gem_flink_basic (bad-open)
[59.398970] Starting subtest: bad-open
[59.399780] Subtest bad-open: SUCCESS (0.000s)
[59.449792] [030/165] (932s left) gem_flink_basic (basic)
[59.476599] Starting subtest: basic
[59.477377] Subtest basic: SUCCESS (0.000s)
[59.553267] [031/165] (932s left) gem_flink_basic (double-flink)
[59.577331] Starting subtest: double-flink
[59.578117] Subtest double-flink: SUCCESS (0.000s)
[59.655896] [032/165] (932s left) gem_flink_basic (flink-lifetime)
[59.685278] Starting subtest: flink-lifetime
[59.686068] Subtest flink-lifetime: SUCCESS (0.001s)
[59.771662] [033/165] (932s left) gem_huc_copy (huc-copy)
[59.809084] Starting subtest: huc-copy
[59.810861] Subtest huc-copy: SUCCESS (0.002s)
[59.921110] [034/165] (932s left) gem_linear_blits (basic)
[60.001138] Starting subtest: basic
[60.004742] Subtest basic: SUCCESS (0.004s)
[60.117377] [035/165] (932s left) gem_mmap (basic)
[60.185782] Starting subtest: basic
[60.189463] Subtest basic: SUCCESS (0.000s)
[60.272035] [036/165] (932s left) gem_mmap_gtt (basic)
[60.298358] Starting subtest: basic
[60.299117] Subtest basic: SUCCESS (0.000s)
[60.339765] [037/165] (932s left) gem_render_linear_blits (basic)
[60.372460] Starting subtest: basic
[60.385423] Subtest basic: SUCCESS (0.013s)
[60.459970] [038/165] (931s left) gem_render_tiled_blits (basic)
[60.490365] Starting subtest: basic
[60.507607] Subtest basic: SUCCESS (0.017s)
[60.573844] [039/165] (931s left) gem_ringfill (basic-all)
[60.891059] Starting subtest: basic-all
[62.021874] Subtest basic-all: SUCCESS (1.122s)
[62.106260] [040/165] (930s left) gem_softpin (allocator-basic)
[62.143830] Starting subtest: allocator-basic
[62.187693] Subtest allocator-basic: SUCCESS (0.044s)
[62.287363] [041/165] (930s left) gem_softpin (allocator-basic-reserve)
[62.319401] Starting subtest: allocator-basic-reserve
[62.363712] Subtest allocator-basic-reserve: SUCCESS (0.044s)
[62.473720] [042/165] (929s left) gem_softpin (safe-alignment)
[62.509154] Starting subtest: safe-alignment
[62.515107] Subtest safe-alignment: SUCCESS (0.006s)
[62.621538] [043/165] (929s left) gem_sync (basic-all)
[62.657222] Starting subtest: basic-all
[65.074549] Subtest basic-all: SUCCESS (2.418s)
[65.256214] [044/165] (927s left) gem_sync (basic-each)
[65.290675] Starting subtest: basic-each
[67.450685] Subtest basic-each: SUCCESS (2.161s)
[67.623853] [045/165] (924s left) gem_tiled_blits (basic)
[67.701311] Starting subtest: basic
[67.710434] Subtest basic: SUCCESS (0.009s)
[67.815242] [046/165] (924s left) gem_tiled_fence_blits (basic)
[67.930375] Starting subtest: basic
[67.949413] Subtest basic: SUCCESS (0.019s)
[68.044281] [047/165] (924s left) gem_tiled_pread_basic
[68.140900] [048/165] (924s left) gem_wait (busy@all-engines)
[68.177956] Starting subtest: busy
[68.178822] Starting dynamic subtest: all-engines
[68.726997] Dynamic subtest all-engines: SUCCESS (0.548s)
[68.728825] Subtest busy: SUCCESS (0.548s)
[68.923720] [049/165] (923s left) gem_wait (wait@all-engines)
[68.965514] Starting subtest: wait
[68.966422] Starting dynamic subtest: all-engines
[70.012894] Dynamic subtest all-engines: SUCCESS (1.046s)
[70.014783] Subtest wait: SUCCESS (1.047s)
[70.205747] [050/165] (922s left) i915_getparams_basic (basic-eu-total)
[70.235885] Starting subtest: basic-eu-total
[70.237438] Subtest basic-eu-total: SUCCESS (0.000s)
[70.305365] [051/165] (922s left) i915_getparams_basic (basic-subslice-total)
[70.344573] Starting subtest: basic-subslice-total
[70.346151] Subtest basic-subslice-total: SUCCESS (0.000s)
[70.405025] [052/165] (922s left) i915_hangman (error-state-basic)
[70.449189] Starting subtest: error-state-basic
[70.535902] Subtest error-state-basic: SUCCESS (0.087s)
[70.605209] [053/165] (921s left) i915_pciid
[70.688308] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled)
[70.908713] Starting subtest: addfb25-4-tiled
[70.910314] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[70.989315] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[71.019678] Starting subtest: addfb25-bad-modifier
[71.020525] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[71.271078] [056/165] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[71.298864] Starting subtest: addfb25-framebuffer-vs-set-tiling
[71.299717] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.554638] [057/165] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.586981] Starting subtest: addfb25-modifier-no-flag
[71.587844] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.839381] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.872218] Starting subtest: addfb25-x-tiled-legacy
[71.873031] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[72.140522] [059/165] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[72.171197] Starting subtest: addfb25-x-tiled-mismatch-legacy
[72.172076] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[72.422683] [060/165] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[72.636742] Starting subtest: addfb25-yf-tiled-legacy
[72.637554] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[72.727451] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.943254] Starting subtest: addfb25-y-tiled-legacy
[72.944622] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[73.024948] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[73.239798] Starting subtest: addfb25-y-tiled-small-legacy
[73.240685] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[73.305421] [063/165] (919s left) kms_addfb_basic (bad-pitch-0)
[73.331777] Starting subtest: bad-pitch-0
[73.332655] Subtest bad-pitch-0: SUCCESS (0.000s)
[73.591049] [064/165] (919s left) kms_addfb_basic (bad-pitch-1024)
[73.619430] Starting subtest: bad-pitch-1024
[73.620268] Subtest bad-pitch-1024: SUCCESS (0.000s)
[73.872410] [065/165] (918s left) kms_addfb_basic (bad-pitch-128)
[73.901073] Starting subtest: bad-pitch-128
[73.901975] Subtest bad-pitch-128: SUCCESS (0.000s)
[74.159063] [066/165] (918s left) kms_addfb_basic (bad-pitch-256)
[74.196373] Starting subtest: bad-pitch-256
[74.197145] Subtest bad-pitch-256: SUCCESS (0.000s)
[74.457118] [067/165] (918s left) kms_addfb_basic (bad-pitch-32)
[74.485282] Starting subtest: bad-pitch-32
[74.486060] Subtest bad-pitch-32: SUCCESS (0.000s)
[74.739754] [068/165] (917s left) kms_addfb_basic (bad-pitch-63)
[74.768543] Starting subtest: bad-pitch-63
[74.769329] Subtest bad-pitch-63: SUCCESS (0.000s)
[75.022566] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[75.052973] Starting subtest: bad-pitch-65536
[75.053677] Subtest bad-pitch-65536: SUCCESS (0.000s)
[75.324744] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[75.358976] Starting subtest: bad-pitch-999
[75.359805] Subtest bad-pitch-999: SUCCESS (0.000s)
[75.623748] [071/165] (917s left) kms_addfb_basic (basic)
[75.652899] Starting subtest: basic
[75.653732] Subtest basic: SUCCESS (0.000s)
[75.907548] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[75.937492] Starting subtest: basic-x-tiled-legacy
[75.938340] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[76.188675] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[76.220141] Starting subtest: basic-y-tiled-legacy
[76.220939] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[76.473797] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[76.688144] Starting subtest: bo-too-small
[76.688993] Subtest bo-too-small: SUCCESS (0.000s)
[76.756917] [075/165] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[76.975287] Starting subtest: bo-too-small-due-to-tiling
[76.976224] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[77.058355] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[77.089193] Starting subtest: clobberred-modifier
[77.090052] Subtest clobberred-modifier: SUCCESS (0.000s)
[77.340563] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[77.367583] Starting subtest: framebuffer-vs-set-tiling
[77.368517] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.641884] [078/165] (915s left) kms_addfb_basic (invalid-get-prop)
[77.670691] Starting subtest: invalid-get-prop
[77.671507] Subtest invalid-get-prop: SUCCESS (0.000s)
[77.926417] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[77.955368] Starting subtest: invalid-get-prop-any
[77.956229] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.207265] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[78.244316] Starting subtest: invalid-set-prop
[78.245175] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.490810] [081/165] (914s left) kms_addfb_basic (invalid-set-prop-any)
[78.528453] Starting subtest: invalid-set-prop-any
[78.529244] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[78.791567] [082/165] (914s left) kms_addfb_basic (no-handle)
[78.819764] Starting subtest: no-handle
[78.820704] Subtest no-handle: SUCCESS (0.000s)
[79.073304] [083/165] (913s left) kms_addfb_basic (size-max)
[79.288501] Starting subtest: size-max
[79.289474] Subtest size-max: SUCCESS (0.000s)
[79.370896] [084/165] (913s left) kms_addfb_basic (small-bo)
[79.586290] Starting subtest: small-bo
[79.587292] Subtest small-bo: SUCCESS (0.000s)
[79.657689] [085/165] (913s left) kms_addfb_basic (tile-pitch-mismatch)
[79.687330] Starting subtest: tile-pitch-mismatch
[79.692946] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[79.941925] [086/165] (912s left) kms_addfb_basic (too-high)
[80.159016] Starting subtest: too-high
[80.159928] Subtest too-high: SUCCESS (0.000s)
[80.242152] [087/165] (912s left) kms_addfb_basic (too-wide)
[80.459687] Starting subtest: too-wide
[80.460567] Subtest too-wide: SUCCESS (0.000s)
[80.539687] [088/165] (912s left) kms_addfb_basic (unused-handle)
[80.566787] Starting subtest: unused-handle
[80.567734] Subtest unused-handle: SUCCESS (0.000s)
[80.841756] [089/165] (912s left) kms_addfb_basic (unused-modifier)
[80.876717] Starting subtest: unused-modifier
[80.877447] Subtest unused-modifier: SUCCESS (0.000s)
[81.123087] [090/165] (911s left) kms_addfb_basic (unused-offsets)
[81.156929] Starting subtest: unused-offsets
[81.157771] Subtest unused-offsets: SUCCESS (0.000s)
[81.423989] [091/165] (911s left) kms_addfb_basic (unused-pitches)
[81.451922] Starting subtest: unused-pitches
[81.452728] Subtest unused-pitches: SUCCESS (0.000s)
[81.724296] [092/165] (911s left) kms_busy (basic)
[81.942685] Starting subtest: basic
[81.943954] Starting dynamic subtest: flip
[82.497211] Dynamic subtest flip: SUCCESS (0.554s)
[82.501903] Starting dynamic subtest: modeset
[83.266769] Dynamic subtest modeset: SUCCESS (0.769s)
[83.267624] Subtest basic: SUCCESS (1.324s)
[83.432636] [093/165] (909s left) kms_prop_blob (basic)
[83.461577] Starting subtest: basic
[83.462379] Subtest basic: SUCCESS (0.000s)
[83.529203] [094/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[83.749114] Starting subtest: basic-busy-flip-before-cursor-atomic
[83.750600] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[83.817614] [095/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[84.032064] Starting subtest: basic-busy-flip-before-cursor-legacy
[84.034546] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[84.093702] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[84.306940] Starting subtest: basic-flip-after-cursor-atomic
[85.298437] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.992s)
[85.471094] [097/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[85.684137] Starting subtest: basic-flip-after-cursor-legacy
[86.662421] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.978s)
[86.826581] [098/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[87.045932] Starting subtest: basic-flip-after-cursor-varying-size
[88.011324] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.965s)
[88.169346] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[88.382445] Starting subtest: basic-flip-before-cursor-atomic
[89.353379] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.971s)
[89.526743] [100/165] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[89.749349] Starting subtest: basic-flip-before-cursor-legacy
[90.730838] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.982s)
[90.899039] [101/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[91.115206] Starting subtest: basic-flip-before-cursor-varying-size
[92.112867] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.990s)
[92.274894] [102/165] (900s left) kms_dsc (dsc-basic)
[92.493069] Subtest dsc-basic: SKIP (0.000s)
[92.526691] [103/165] (900s left) kms_flip (basic-flip-vs-dpms)
[92.748115] Starting subtest: basic-flip-vs-dpms
[92.750066] Starting dynamic subtest: A-DP1
[93.645509] Dynamic subtest A-DP1: SUCCESS (0.896s)
[93.652610] Starting dynamic subtest: B-DP1
[94.397154] Dynamic subtest B-DP1: SUCCESS (0.751s)
[94.402038] Starting dynamic subtest: C-DP1
[95.143940] Dynamic subtest C-DP1: SUCCESS (0.747s)
[95.148642] Starting dynamic subtest: D-DP1
[95.891625] Dynamic subtest D-DP1: SUCCESS (0.747s)
[95.893335] Subtest basic-flip-vs-dpms: SUCCESS (3.147s)
[96.067739] [104/165] (897s left) kms_flip (basic-flip-vs-modeset)
[96.290415] Starting subtest: basic-flip-vs-modeset
[96.292411] Starting dynamic subtest: A-DP1
[97.184471] Dynamic subtest A-DP1: SUCCESS (0.893s)
[97.191705] Starting dynamic subtest: B-DP1
[97.928817] Dynamic subtest B-DP1: SUCCESS (0.744s)
[97.933647] Starting dynamic subtest: C-DP1
[98.673959] Dynamic subtest C-DP1: SUCCESS (0.745s)
[98.678600] Starting dynamic subtest: D-DP1
[99.417474] Dynamic subtest D-DP1: SUCCESS (0.742s)
[99.418259] Subtest basic-flip-vs-modeset: SUCCESS (3.129s)
[99.586906] [105/165] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[99.798334] Starting subtest: basic-flip-vs-wf_vblank
[99.799117] Starting dynamic subtest: A-DP1
[101.033612] Dynamic subtest A-DP1: SUCCESS (1.234s)
[101.041016] Starting dynamic subtest: B-DP1
[102.047546] Dynamic subtest B-DP1: SUCCESS (1.013s)
[102.055692] Starting dynamic subtest: C-DP1
[103.229266] Dynamic subtest C-DP1: SUCCESS (1.180s)
[103.239246] Starting dynamic subtest: D-DP1
[104.263469] Dynamic subtest D-DP1: SUCCESS (1.028s)
[104.267144] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.470s)
[104.480814] [106/165] (888s left) kms_flip (basic-plain-flip)
[104.698036] Starting subtest: basic-plain-flip
[104.699818] Starting dynamic subtest: A-DP1
[105.473268] Dynamic subtest A-DP1: SUCCESS (0.772s)
[105.485569] Starting dynamic subtest: B-DP1
[106.207489] Dynamic subtest B-DP1: SUCCESS (0.727s)
[106.215791] Starting dynamic subtest: C-DP1
[106.952403] Dynamic subtest C-DP1: SUCCESS (0.744s)
[106.959245] Starting dynamic subtest: D-DP1
[107.682405] Dynamic subtest D-DP1: SUCCESS (0.725s)
[107.684655] Subtest basic-plain-flip: SUCCESS (2.986s)
[107.896812] [107/165] (885s left) kms_force_connector_basic (force-connector-state)
[108.142443] Starting subtest: force-connector-state
[108.842484] Subtest force-connector-state: SUCCESS (0.701s)
[109.482907] [108/165] (883s left) kms_force_connector_basic (force-edid)
[109.717797] Starting subtest: force-edid
[110.124892] Subtest force-edid: SUCCESS (0.407s)
[110.630417] [109/165] (882s left) kms_force_connector_basic (force-load-detect)
[110.866135] Starting subtest: force-load-detect
[110.867916] Subtest force-load-detect: SKIP (0.000s)
[111.246007] [110/165] (881s left) kms_force_connector_basic (prune-stale-modes)
[111.483029] Starting subtest: prune-stale-modes
[111.953405] Subtest prune-stale-modes: SUCCESS (0.470s)
[112.446982] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[112.666215] Starting subtest: basic
[116.108801] Subtest basic: SUCCESS (3.442s)
[116.214716] [112/165] (876s left) kms_hdmi_inject (inject-audio)
[116.314293] Starting subtest: inject-audio
[116.843667] Subtest inject-audio: SUCCESS (0.530s)
[117.238555] [113/165] (875s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[117.449960] Starting subtest: compare-crc-sanitycheck-xr24
[117.450764] Starting dynamic subtest: pipe-A-DP-1
[117.859962] Dynamic subtest pipe-A-DP-1: SUCCESS (0.409s)
[117.866541] Starting dynamic subtest: pipe-B-DP-1
[118.260659] Dynamic subtest pipe-B-DP-1: SUCCESS (0.398s)
[118.265876] Starting dynamic subtest: pipe-C-DP-1
[118.659294] Dynamic subtest pipe-C-DP-1: SUCCESS (0.399s)
[118.664210] Starting dynamic subtest: pipe-D-DP-1
[119.057907] Dynamic subtest pipe-D-DP-1: SUCCESS (0.397s)
[119.058681] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.608s)
[119.216244] [114/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[119.433300] Starting subtest: compare-crc-sanitycheck-nv12
[119.434326] Starting dynamic subtest: pipe-A-DP-1
[120.022362] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s)
[120.027089] Starting dynamic subtest: pipe-B-DP-1
[120.568403] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s)
[120.574029] Starting dynamic subtest: pipe-C-DP-1
[121.124652] Dynamic subtest pipe-C-DP-1: SUCCESS (0.555s)
[121.129295] Starting dynamic subtest: pipe-D-DP-1
[121.681653] Dynamic subtest pipe-D-DP-1: SUCCESS (0.555s)
[121.682611] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.248s)
[121.848102] [115/165] (871s left) kms_pipe_crc_basic (hang-read-crc)
[122.070462] Starting subtest: hang-read-crc
[122.071375] Starting dynamic subtest: pipe-A-DP-1
[123.273823] Dynamic subtest pipe-A-DP-1: SUCCESS (1.202s)
[123.279359] Starting dynamic subtest: pipe-B-DP-1
[124.377463] Dynamic subtest pipe-B-DP-1: SUCCESS (1.102s)
[124.384641] Starting dynamic subtest: pipe-C-DP-1
[125.481981] Dynamic subtest pipe-C-DP-1: SUCCESS (1.104s)
[125.488888] Starting dynamic subtest: pipe-D-DP-1
[126.602121] Dynamic subtest pipe-D-DP-1: SUCCESS (1.118s)
[126.602866] Subtest hang-read-crc: SUCCESS (4.531s)
[126.747376] [116/165] (866s left) kms_pipe_crc_basic (nonblocking-crc)
[126.966502] Starting subtest: nonblocking-crc
[126.967370] Starting dynamic subtest: pipe-A-DP-1
[127.582666] Dynamic subtest pipe-A-DP-1: SUCCESS (0.616s)
[127.588365] Starting dynamic subtest: pipe-B-DP-1
[128.142996] Dynamic subtest pipe-B-DP-1: SUCCESS (0.559s)
[128.147696] Starting dynamic subtest: pipe-C-DP-1
[128.721108] Dynamic subtest pipe-C-DP-1: SUCCESS (0.577s)
[128.726026] Starting dynamic subtest: pipe-D-DP-1
[129.299992] Dynamic subtest pipe-D-DP-1: SUCCESS (0.577s)
[129.300783] Subtest nonblocking-crc: SUCCESS (2.334s)
[129.445043] [117/165] (863s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[129.659614] Starting subtest: nonblocking-crc-frame-sequence
[129.660625] Starting dynamic subtest: pipe-A-DP-1
[130.261840] Dynamic subtest pipe-A-DP-1: SUCCESS (0.601s)
[130.266648] Starting dynamic subtest: pipe-B-DP-1
[130.837426] Dynamic subtest pipe-B-DP-1: SUCCESS (0.574s)
[130.842493] Starting dynamic subtest: pipe-C-DP-1
[131.413604] Dynamic subtest pipe-C-DP-1: SUCCESS (0.575s)
[131.419888] Starting dynamic subtest: pipe-D-DP-1
[131.976680] Dynamic subtest pipe-D-DP-1: SUCCESS (0.562s)
[131.977507] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.318s)
[132.120889] [118/165] (861s left) kms_pipe_crc_basic (read-crc)
[132.331483] Starting subtest: read-crc
[132.332467] Starting dynamic subtest: pipe-A-DP-1
[132.855698] Dynamic subtest pipe-A-DP-1: SUCCESS (0.523s)
[132.860695] Starting dynamic subtest: pipe-B-DP-1
[133.362236] Dynamic subtest pipe-B-DP-1: SUCCESS (0.506s)
[133.367125] Starting dynamic subtest: pipe-C-DP-1
[133.873490] Dynamic subtest pipe-C-DP-1: SUCCESS (0.510s)
[133.879596] Starting dynamic subtest: pipe-D-DP-1
[134.368748] Dynamic subtest pipe-D-DP-1: SUCCESS (0.493s)
[134.369723] Subtest read-crc: SUCCESS (2.038s)
[134.513333] [119/165] (858s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[134.731518] Starting subtest: read-crc-frame-sequence
[134.732547] Starting dynamic subtest: pipe-A-DP-1
[135.279203] Dynamic subtest pipe-A-DP-1: SUCCESS (0.547s)
[135.284134] Starting dynamic subtest: pipe-B-DP-1
[135.787194] Dynamic subtest pipe-B-DP-1: SUCCESS (0.507s)
[135.792516] Starting dynamic subtest: pipe-C-DP-1
[136.295825] Dynamic subtest pipe-C-DP-1: SUCCESS (0.507s)
[136.300673] Starting dynamic subtest: pipe-D-DP-1
[136.807645] Dynamic subtest pipe-D-DP-1: SUCCESS (0.510s)
[136.808483] Subtest read-crc-frame-sequence: SUCCESS (2.077s)
[136.952119] [120/165] (856s left) kms_pm_backlight (basic-brightness)
[137.167916] Subtest basic-brightness: SKIP (0.000s)
[137.202666] [121/165] (856s left) kms_pm_rpm (basic-pci-d3-state)
[138.740977] Starting subtest: basic-pci-d3-state
[139.632147] Subtest basic-pci-d3-state: SUCCESS (0.892s)
[139.850503] [122/165] (853s left) kms_pm_rpm (basic-rte)
[139.876528] Starting subtest: basic-rte
[141.748141] Subtest basic-rte: SUCCESS (1.870s)
[142.328248] [123/165] (850s left) kms_psr (psr_primary_page_flip)
[142.584785] [124/165] (850s left) kms_psr (psr_cursor_plane_move)
[142.813763] [125/165] (850s left) kms_psr (psr_sprite_plane_onoff)
[143.047824] [126/165] (850s left) kms_psr (psr_primary_mmap_gtt)
[143.280921] [127/165] (850s left) kms_setmode (basic-clone-single-crtc)
[143.314179] Starting subtest: basic-clone-single-crtc
[143.316834] Subtest basic-clone-single-crtc: SKIP (0.000s)
[143.379721] [128/165] (850s left) i915_pm_rps (basic-api)
[143.408093] Starting subtest: basic-api
[143.409831] Subtest basic-api: SKIP (0.000s)
[143.475559] [129/165] (849s left) prime_self_import (basic-llseek-bad)
[143.500532] Starting subtest: basic-llseek-bad
[143.502136] Subtest basic-llseek-bad: SUCCESS (0.001s)
[143.577448] [130/165] (849s left) prime_self_import (basic-llseek-size)
[143.600742] Starting subtest: basic-llseek-size
[143.602060] Subtest basic-llseek-size: SUCCESS (0.001s)
[143.678150] [131/165] (849s left) prime_self_import (basic-with_fd_dup)
[143.703304] Starting subtest: basic-with_fd_dup
[143.704918] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[143.779262] [132/165] (849s left) prime_self_import (basic-with_one_bo)
[143.808504] Starting subtest: basic-with_one_bo
[143.810197] Subtest basic-with_one_bo: SUCCESS (0.002s)
[143.865799] [133/165] (849s left) prime_self_import (basic-with_one_bo_two_files)
[143.896338] Starting subtest: basic-with_one_bo_two_files
[143.898023] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[143.981065] [134/165] (849s left) prime_self_import (basic-with_two_bos)
[144.007857] Starting subtest: basic-with_two_bos
[144.009472] Subtest basic-with_two_bos: SUCCESS (0.001s)
[144.097128] [135/165] (849s left) prime_vgem (basic-fence-flip)
[144.154574] Starting subtest: basic-fence-flip
[144.724699] Subtest basic-fence-flip: SUCCESS (0.570s)
[144.813859] [136/165] (848s left) prime_vgem (basic-fence-mmap)
[144.843858] Starting subtest: basic-fence-mmap
[144.860096] Subtest basic-fence-mmap: SUCCESS (0.016s)
[144.945890] [137/165] (848s left) prime_vgem (basic-fence-read)
[144.976770] Starting subtest: basic-fence-read
[144.980790] Subtest basic-fence-read: SKIP (0.003s)
[145.079199] [138/165] (848s left) prime_vgem (basic-gtt)
[145.110054] Starting subtest: basic-gtt
[145.117703] Subtest basic-gtt: SUCCESS (0.008s)
[145.195135] [139/165] (848s left) prime_vgem (basic-read)
[145.227201] Starting subtest: basic-read
[145.230852] Subtest basic-read: SKIP (0.003s)
[145.313524] [140/165] (848s left) prime_vgem (basic-write)
[145.362503] Starting subtest: basic-write
[145.365814] Subtest basic-write: SKIP (0.004s)
[145.462430] [141/165] (848s left) vgem_basic (setversion)
[145.508574] Starting subtest: setversion
[145.510796] Subtest setversion: SUCCESS (0.000s)
[145.563082] [142/165] (847s left) vgem_basic (create)
[145.591843] Starting subtest: create
[145.592684] Subtest create: SUCCESS (0.000s)
[145.642455] [143/165] (847s left) vgem_basic (debugfs)
[145.675042] Starting subtest: debugfs
[145.675890] Subtest debugfs: SUCCESS (0.000s)
[145.726879] [144/165] (847s left) vgem_basic (dmabuf-export)
[145.758748] Starting subtest: dmabuf-export
[145.760485] Subtest dmabuf-export: SUCCESS (0.002s)
[145.828197] [145/165] (847s left) vgem_basic (dmabuf-fence)
[145.857995] Starting subtest: dmabuf-fence
[145.858763] Subtest dmabuf-fence: SUCCESS (0.000s)
[145.910489] [146/165] (847s left) vgem_basic (dmabuf-fence-before)
[145.941846] Starting subtest: dmabuf-fence-before
[145.942684] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[145.993301] [147/165] (847s left) vgem_basic (dmabuf-mmap)
[146.042517] Starting subtest: dmabuf-mmap
[146.048334] Subtest dmabuf-mmap: SUCCESS (0.007s)
[146.091330] [148/165] (847s left) vgem_basic (mmap)
[146.125488] Starting subtest: mmap
[146.128346] Subtest mmap: SUCCESS (0.004s)
[146.178581] [149/165] (847s left) vgem_basic (second-client)
[146.208361] Starting subtest: second-client
[146.242869] Subtest second-client: SUCCESS (0.034s)
[146.295575] [150/165] (847s left) vgem_basic (sysfs)
[146.342341] Starting subtest: sysfs
[146.343401] Subtest sysfs: SUCCESS (0.000s)
[146.394519] [151/165] (847s left) core_hotunplug (unbind-rebind)
[146.440983] Starting subtest: unbind-rebind
[150.563806] Subtest unbind-rebind: SUCCESS (4.122s)
[150.576637] [152/165] (843s left) vgem_basic (unload)
[150.606231] Starting subtest: unload
[179.519389] Subtest unload: SUCCESS (28.878s)
[179.570544] [153/165] (814s left) i915_module_load (reload)
[179.599512] Starting subtest: reload
[182.519816] Subtest reload: SUCCESS (2.920s)
[182.529593] [154/165] (811s left) gem_lmem_swapping (basic)
[182.564298] Subtest basic: SKIP (0.000s)
[182.592990] [155/165] (811s left) gem_lmem_swapping (parallel-random-engines)
[182.620645] Subtest parallel-random-engines: SKIP (0.000s)
[182.643100] [156/165] (811s left) gem_lmem_swapping (random-engines)
[182.673206] Subtest random-engines: SKIP (0.000s)
[182.691738] [157/165] (811s left) gem_lmem_swapping (verify-random)
[182.723593] Subtest verify-random: SKIP (0.000s)
[182.741422] [158/165] (810s left) i915_pm_rpm (module-reload)
[184.394178] Starting subtest: module-reload
[192.395955] Subtest module-reload: SUCCESS (7.994s)
[192.404501] [159/165] (801s left) i915_selftest (live)
[192.436493] Starting subtest: live
[192.437465] Starting dynamic subtest: sanitycheck
[194.083789] Dynamic subtest sanitycheck: SUCCESS (1.637s)
[194.087757] Starting dynamic subtest: uncore
[195.765506] Dynamic subtest uncore: SUCCESS (1.681s)
[195.769156] Starting dynamic subtest: workarounds
[198.318269] Dynamic subtest workarounds: SUCCESS (2.552s)
[198.321950] Starting dynamic subtest: gt_engines
[200.498846] Dynamic subtest gt_engines: SUCCESS (2.184s)
[200.503290] Starting dynamic subtest: gt_timelines
[210.634348] Dynamic subtest gt_timelines: SUCCESS (10.130s)
[210.638043] Starting dynamic subtest: gt_contexts
[212.320215] Dynamic subtest gt_contexts: SUCCESS (1.685s)
[212.323827] Starting dynamic subtest: gt_lrc
[216.976258] Dynamic subtest gt_lrc: SUCCESS (4.655s)
[216.979956] Starting dynamic subtest: gt_mocs
[219.150324] Dynamic subtest gt_mocs: SUCCESS (2.173s)
[219.153812] Starting dynamic subtest: gt_pm
[221.746318] Dynamic subtest gt_pm: SUCCESS (2.595s)
[221.750014] Starting dynamic subtest: gt_heartbeat
[223.583597] Dynamic subtest gt_heartbeat: SUCCESS (1.836s)
[223.587282] Starting dynamic subtest: gt_tlb
[226.763581] Dynamic subtest gt_tlb: SUCCESS (3.179s)
[226.767264] Starting dynamic subtest: requests
[236.329264] Dynamic subtest requests: SUCCESS (9.565s)
[236.332809] Starting dynamic subtest: migrate
[241.224379] Dynamic subtest migrate: SUCCESS (4.894s)
[241.228814] Starting dynamic subtest: active
[242.879681] Dynamic subtest active: SUCCESS (1.653s)
[242.883525] Starting dynamic subtest: objects
[244.992139] Dynamic subtest objects: SUCCESS (2.118s)
[244.998478] Starting dynamic subtest: mman
[250.413208] Dynamic subtest mman: SUCCESS (5.414s)
[250.416821] Starting dynamic subtest: dmabuf
[252.165363] Dynamic subtest dmabuf: SUCCESS (1.751s)
[252.169255] Starting dynamic subtest: vma
[253.828174] Dynamic subtest vma: SUCCESS (1.670s)
[253.833660] Starting dynamic subtest: coherency
[257.520303] Dynamic subtest coherency: SUCCESS (3.682s)
[257.524058] Starting dynamic subtest: gtt
[266.561270] Dynamic subtest gtt: SUCCESS (9.040s)
[266.565157] Starting dynamic subtest: gem
[268.341323] Dynamic subtest gem: SUCCESS (1.779s)
[268.345042] Starting dynamic subtest: evict
[271.311262] Dynamic subtest evict: SUCCESS (2.969s)
[271.315735] Starting dynamic subtest: hugepages
[279.420936] Dynamic subtest hugepages: SUCCESS (8.114s)
[279.424625] Starting dynamic subtest: gem_contexts
[295.437898] Dynamic subtest gem_contexts: SUCCESS (16.010s)
[295.441636] Starting dynamic subtest: client
[297.136480] Dynamic subtest client: SUCCESS (1.697s)
[297.140283] Starting dynamic subtest: gem_migrate
[298.788679] Dynamic subtest gem_migrate: SUCCESS (1.651s)
[298.792597] Starting dynamic subtest: reset
[304.553253] Dynamic subtest reset: SUCCESS (5.764s)
[304.556937] Starting dynamic subtest: memory_region
[306.190879] Dynamic subtest memory_region: SUCCESS (1.636s)
[306.194609] Starting dynamic subtest: hangcheck
[325.252615] Dynamic subtest hangcheck: SUCCESS (19.061s)
[325.256374] Starting dynamic subtest: execlists
[326.867103] Dynamic subtest execlists: SUCCESS (1.614s)
[326.872677] Starting dynamic subtest: ring_submission
[328.487363] Dynamic subtest ring_submission: SUCCESS (1.619s)
[328.491267] Starting dynamic subtest: perf
[330.207918] Dynamic subtest perf: SUCCESS (1.719s)
[330.211678] Starting dynamic subtest: slpc
[338.460174] Dynamic subtest slpc: SUCCESS (8.251s)
[338.464707] Starting dynamic subtest: guc
[340.960747] Dynamic subtest guc: SUCCESS (2.497s)
[340.964723] Starting dynamic subtest: guc_multi_lrc
[342.672447] Dynamic subtest guc_multi_lrc: SUCCESS (1.712s)
[342.677012] Starting dynamic subtest: guc_hang
[344.937999] Dynamic subtest guc_hang: SUCCESS (2.264s)
[344.941989] Starting dynamic subtest: late_gt_pm
[346.632484] Dynamic subtest late_gt_pm: SUCCESS (1.693s)
[346.633606] Subtest live: SUCCESS (154.187s)
[346.646606] [160/165] (647s left) dmabuf (all-tests)
[346.683154] Starting subtest: all-tests
[346.684196] Starting dynamic subtest: sanitycheck
[346.752308] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[346.765374] Starting dynamic subtest: dma_fence
[346.925413] Dynamic subtest dma_fence: SUCCESS (0.171s)
[346.932916] Starting dynamic subtest: dma_fence_chain
[356.206625] Dynamic subtest dma_fence_chain: SUCCESS (9.279s)
[356.214289] Starting dynamic subtest: dma_fence_unwrap
[356.275304] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[356.286593] Starting dynamic subtest: dma_resv
[356.339337] Dynamic subtest dma_resv: SUCCESS (0.062s)
[356.341211] Subtest all-tests: SUCCESS (9.656s)
[356.358709] [161/165] (637s left) i915_suspend (basic-s2idle-without-i915)
[356.386341] Starting subtest: basic-s2idle-without-i915
[377.258213] Subtest basic-s2idle-without-i915: SUCCESS (5.606s)
[377.414513] [162/165] (631s left) i915_suspend (basic-s3-without-i915)
[377.439314] Starting subtest: basic-s3-without-i915
[397.825742] Subtest basic-s3-without-i915: SUCCESS (4.394s)
[397.994734] [163/165] (627s left) gem_exec_suspend (basic-s0)
[398.029274] Starting subtest: basic-S0
[398.029997] Starting dynamic subtest: smem
[416.020779] Dynamic subtest smem: SUCCESS (2.458s)
[416.021897] Subtest basic-S0: SUCCESS (2.458s)
[416.172395] [164/165] (624s left) gem_exec_suspend (basic-s3)
[416.203843] Starting subtest: basic-S3
[416.204624] Starting dynamic subtest: smem
[434.006422] Dynamic subtest smem: SUCCESS (2.470s)
[434.008038] Subtest basic-S3: SUCCESS (2.471s)
[434.158171] [165/165] (621s left) kms_pipe_crc_basic (suspend-read-crc)
[434.373601] Starting subtest: suspend-read-crc
[434.374505] Starting dynamic subtest: pipe-A-DP-1
[452.144632] Dynamic subtest pipe-A-DP-1: SUCCESS (2.306s)
[452.150129] Starting dynamic subtest: pipe-B-DP-1
[470.071034] Dynamic subtest pipe-B-DP-1: SUCCESS (2.163s)
[470.076396] Starting dynamic subtest: pipe-C-DP-1
[487.080382] Dynamic subtest pipe-C-DP-1: SUCCESS (2.210s)
[487.087869] Starting dynamic subtest: pipe-D-DP-1
[504.114073] Dynamic subtest pipe-D-DP-1: SUCCESS (2.224s)
[504.115045] Subtest suspend-read-crc: SUCCESS (8.908s)
[504.214458] Closing watchdogs
Done.