[55.490014] Initializing watchdogs
[55.490057]   /dev/watchdog0
[55.494609] [001/164] (960s left) i915_module_load (load)
[55.530615] Starting subtest: load
[57.475778] Subtest load: SUCCESS (1.945s)
[57.492142] [002/164] (958s left) core_auth (basic-auth)
[57.559037] Starting subtest: basic-auth
[57.560659] Subtest basic-auth: SUCCESS (0.001s)
[57.628216] [003/164] (958s left) debugfs_test (read_all_entries)
[57.662116] Starting subtest: read_all_entries
[57.793015] Subtest read_all_entries: SUCCESS (0.130s)
[58.044571] [004/164] (957s left) debugfs_test (basic-hwmon)
[58.080082] Starting subtest: basic-hwmon
[58.081420] Subtest basic-hwmon: SKIP (0.000s)
[58.325826] [005/164] (957s left) fbdev (eof)
[58.359074] Starting subtest: eof
[58.360074] Subtest eof: SUCCESS (0.000s)
[58.406218] [006/164] (957s left) fbdev (info)
[58.430950] Starting subtest: info
[58.431860] Subtest info: SUCCESS (0.000s)
[58.491948] [007/164] (957s left) fbdev (nullptr)
[58.525087] Starting subtest: nullptr
[58.526075] Subtest nullptr: SUCCESS (0.000s)
[58.573346] [008/164] (957s left) fbdev (read)
[58.608205] Starting subtest: read
[61.122377] Subtest read: SUCCESS (2.514s)
[61.174227] [009/164] (954s left) fbdev (write)
[61.208177] Starting subtest: write
[63.074140] Subtest write: SUCCESS (1.857s)
[63.123834] [010/164] (952s left) gem_basic (bad-close)
[63.151933] Starting subtest: bad-close
[63.153431] Subtest bad-close: SUCCESS (0.000s)
[63.207100] [011/164] (952s left) gem_basic (create-close)
[63.234168] Starting subtest: create-close
[63.235644] Subtest create-close: SUCCESS (0.000s)
[63.311788] [012/164] (952s left) gem_basic (create-fd-close)
[63.343944] Starting subtest: create-fd-close
[63.345562] Subtest create-fd-close: SUCCESS (0.000s)
[63.427448] [013/164] (952s left) gem_busy (busy@all-engines)
[63.460255] Starting subtest: busy
[63.461069] Starting dynamic subtest: all-engines
[63.481409] Dynamic subtest all-engines: SUCCESS (0.021s)
[63.482193] Subtest busy: SUCCESS (0.022s)
[63.813019] [014/164] (952s left) gem_close_race (basic-process)
[63.853884] Starting subtest: basic-process
[63.870258] Subtest basic-process: SUCCESS (0.016s)
[64.047154] [015/164] (952s left) gem_close_race (basic-threads)
[64.080829] Starting subtest: basic-threads
[65.304887] Subtest basic-threads: SUCCESS (1.224s)
[65.477845] [016/164] (950s left) gem_ctx_create (basic)
[65.511170] Starting subtest: basic
[65.511894] Subtest basic: SUCCESS (0.000s)
[65.679439] [017/164] (950s left) gem_ctx_create (basic-files)
[65.710564] Starting subtest: basic-files
[67.718933] Subtest basic-files: SUCCESS (2.009s)
[67.898725] [018/164] (948s left) gem_ctx_exec (basic)
[67.952154] Starting subtest: basic
[67.952998] Subtest basic: SUCCESS (0.002s)
[68.044294] [019/164] (948s left) gem_exec_basic (basic)
[68.075128] Starting subtest: basic
[68.075826] Starting dynamic subtest: rcs0-smem
[68.076580] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[68.079924] Starting dynamic subtest: bcs0-smem
[68.080671] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[68.083969] Starting dynamic subtest: vcs0-smem
[68.084684] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[68.087828] Starting dynamic subtest: vcs1-smem
[68.088544] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[68.091844] Starting dynamic subtest: vecs0-smem
[68.092586] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[68.093267] Subtest basic: SUCCESS (0.003s)
[68.242303] [020/164] (947s left) gem_exec_create (basic)
[68.271352] Starting subtest: basic
[68.272065] Starting dynamic subtest: smem
[70.359599] Dynamic subtest smem: SUCCESS (2.088s)
[70.360956] Subtest basic: SUCCESS (2.088s)
[70.529848] [021/164] (945s left) gem_exec_fence (basic-busy)
[70.693103] Starting subtest: basic-busy
[70.694235] Starting dynamic subtest: rcs0
[70.750854] Dynamic subtest rcs0: SUCCESS (0.067s)
[70.756153] Starting dynamic subtest: bcs0
[70.799239] Dynamic subtest bcs0: SUCCESS (0.047s)
[70.807771] Starting dynamic subtest: vcs0
[70.851071] Dynamic subtest vcs0: SUCCESS (0.052s)
[70.862132] Starting dynamic subtest: vcs1
[70.903349] Dynamic subtest vcs1: SUCCESS (0.052s)
[70.914840] Starting dynamic subtest: vecs0
[70.950045] Dynamic subtest vecs0: SUCCESS (0.047s)
[70.951724] Subtest basic-busy: SUCCESS (0.266s)
[71.444193] [022/164] (944s left) gem_exec_fence (basic-wait)
[71.606296] Starting subtest: basic-wait
[71.607902] Starting dynamic subtest: rcs0
[71.665113] Dynamic subtest rcs0: SUCCESS (0.068s)
[71.674045] Starting dynamic subtest: bcs0
[71.712693] Dynamic subtest bcs0: SUCCESS (0.047s)
[71.723912] Starting dynamic subtest: vcs0
[71.759812] Dynamic subtest vcs0: SUCCESS (0.047s)
[71.771102] Starting dynamic subtest: vcs1
[71.805939] Dynamic subtest vcs1: SUCCESS (0.046s)
[71.817356] Starting dynamic subtest: vecs0
[71.851660] Dynamic subtest vecs0: SUCCESS (0.046s)
[71.853740] Subtest basic-wait: SUCCESS (0.255s)
[72.315166] [023/164] (943s left) gem_exec_fence (basic-await)
[72.477000] Starting subtest: basic-await
[72.477928] Starting dynamic subtest: rcs0
[72.540225] Dynamic subtest rcs0: SUCCESS (0.071s)
[72.549383] Starting dynamic subtest: bcs0
[72.611675] Dynamic subtest bcs0: SUCCESS (0.071s)
[72.618990] Starting dynamic subtest: vcs0
[72.684258] Dynamic subtest vcs0: SUCCESS (0.072s)
[72.692599] Starting dynamic subtest: vcs1
[72.756985] Dynamic subtest vcs1: SUCCESS (0.072s)
[72.765541] Starting dynamic subtest: vecs0
[72.828857] Dynamic subtest vecs0: SUCCESS (0.072s)
[72.830637] Subtest basic-await: SUCCESS (0.360s)
[73.298852] [024/164] (942s left) gem_exec_fence (nb-await)
[73.462743] Starting subtest: nb-await
[73.463675] Starting dynamic subtest: rcs0
[73.511070] Dynamic subtest rcs0: SUCCESS (0.057s)
[73.518848] Starting dynamic subtest: bcs0
[73.571921] Dynamic subtest bcs0: SUCCESS (0.061s)
[73.582822] Starting dynamic subtest: vcs0
[73.632195] Dynamic subtest vcs0: SUCCESS (0.060s)
[73.643771] Starting dynamic subtest: vcs1
[73.693182] Dynamic subtest vcs1: SUCCESS (0.061s)
[73.704491] Starting dynamic subtest: vecs0
[73.753551] Dynamic subtest vecs0: SUCCESS (0.060s)
[73.755117] Subtest nb-await: SUCCESS (0.300s)
[74.215321] [025/164] (942s left) gem_exec_gttfill (basic)
[74.255901] Starting subtest: basic
[76.355781] Subtest basic: SUCCESS (2.100s)
[76.524883] [026/164] (939s left) gem_exec_parallel (engines)
[76.588656] Starting subtest: engines
[76.589400] Starting dynamic subtest: basic
[77.891623] Dynamic subtest basic: SUCCESS (1.303s)
[77.902079] Starting dynamic subtest: contexts
[79.564937] Dynamic subtest contexts: SUCCESS (1.665s)
[79.568891] Starting dynamic subtest: fds
[81.428617] Dynamic subtest fds: SUCCESS (1.872s)
[81.433411] Starting dynamic subtest: userptr
[82.709373] Dynamic subtest userptr: SUCCESS (1.281s)
[82.710755] Subtest engines: SUCCESS (6.121s)
[82.886842] [027/164] (933s left) gem_exec_store (basic)
[82.918426] Starting subtest: basic
[82.992156] Subtest basic: SUCCESS (0.072s)
[83.168070] [028/164] (933s left) gem_flink_basic (bad-flink)
[83.197199] Starting subtest: bad-flink
[83.197925] Subtest bad-flink: SUCCESS (0.000s)
[83.259260] [029/164] (933s left) gem_flink_basic (bad-open)
[83.289336] Starting subtest: bad-open
[83.290133] Subtest bad-open: SUCCESS (0.000s)
[83.342327] [030/164] (932s left) gem_flink_basic (basic)
[83.367833] Starting subtest: basic
[83.368636] Subtest basic: SUCCESS (0.000s)
[83.455464] [031/164] (932s left) gem_flink_basic (double-flink)
[83.484806] Starting subtest: double-flink
[83.485519] Subtest double-flink: SUCCESS (0.000s)
[83.581058] [032/164] (932s left) gem_flink_basic (flink-lifetime)
[83.607887] Starting subtest: flink-lifetime
[83.608839] Subtest flink-lifetime: SUCCESS (0.001s)
[83.678251] [033/164] (932s left) gem_huc_copy (huc-copy)
[83.707531] Starting subtest: huc-copy
[83.709062] Subtest huc-copy: SUCCESS (0.002s)
[83.797634] [034/164] (932s left) gem_linear_blits (basic)
[83.876425] Starting subtest: basic
[83.880130] Subtest basic: SUCCESS (0.004s)
[83.990955] [035/164] (932s left) gem_mmap (basic)
[84.058801] Starting subtest: basic
[84.061980] Subtest basic: SUCCESS (0.000s)
[84.147246] [036/164] (932s left) gem_mmap_gtt (basic)
[84.174690] Starting subtest: basic
[84.175458] Subtest basic: SUCCESS (0.000s)
[84.216217] [037/164] (932s left) gem_render_linear_blits (basic)
[84.244574] Starting subtest: basic
[84.259804] Subtest basic: SUCCESS (0.015s)
[84.315189] [038/164] (932s left) gem_render_tiled_blits (basic)
[84.343082] Starting subtest: basic
[84.361460] Subtest basic: SUCCESS (0.018s)
[84.437146] [039/164] (931s left) gem_ringfill (basic-all)
[84.749076] Starting subtest: basic-all
[85.871474] Subtest basic-all: SUCCESS (1.114s)
[85.963250] [040/164] (930s left) gem_softpin (allocator-basic)
[85.992934] Starting subtest: allocator-basic
[86.036822] Subtest allocator-basic: SUCCESS (0.044s)
[86.129927] [041/164] (930s left) gem_softpin (allocator-basic-reserve)
[86.157471] Starting subtest: allocator-basic-reserve
[86.208508] Subtest allocator-basic-reserve: SUCCESS (0.051s)
[86.313763] [042/164] (930s left) gem_softpin (safe-alignment)
[86.343595] Starting subtest: safe-alignment
[86.350258] Subtest safe-alignment: SUCCESS (0.007s)
[86.450466] [043/164] (929s left) gem_sync (basic-all)
[86.486067] Starting subtest: basic-all
[88.964178] Subtest basic-all: SUCCESS (2.478s)
[89.131908] [044/164] (927s left) gem_sync (basic-each)
[89.169406] Starting subtest: basic-each
[91.345487] Subtest basic-each: SUCCESS (2.175s)
[91.513332] [045/164] (924s left) gem_tiled_blits (basic)
[91.586501] Starting subtest: basic
[91.595689] Subtest basic: SUCCESS (0.009s)
[91.695070] [046/164] (924s left) gem_tiled_fence_blits (basic)
[91.813256] Starting subtest: basic
[91.831828] Subtest basic: SUCCESS (0.019s)
[91.935270] [047/164] (924s left) gem_tiled_pread_basic
[92.035391] [048/164] (924s left) gem_wait (busy@all-engines)
[92.068954] Starting subtest: busy
[92.069817] Starting dynamic subtest: all-engines
[92.618605] Dynamic subtest all-engines: SUCCESS (0.549s)
[92.620331] Subtest busy: SUCCESS (0.549s)
[92.815785] [049/164] (923s left) gem_wait (wait@all-engines)
[92.849945] Starting subtest: wait
[92.850852] Starting dynamic subtest: all-engines
[93.902499] Dynamic subtest all-engines: SUCCESS (1.048s)
[93.903751] Subtest wait: SUCCESS (1.048s)
[94.098232] [050/164] (922s left) i915_getparams_basic (basic-eu-total)
[94.125486] Starting subtest: basic-eu-total
[94.126998] Subtest basic-eu-total: SUCCESS (0.000s)
[94.177199] [051/164] (922s left) i915_getparams_basic (basic-subslice-total)
[94.205023] Starting subtest: basic-subslice-total
[94.206486] Subtest basic-subslice-total: SUCCESS (0.000s)
[94.260049] [052/164] (922s left) i915_hangman (error-state-basic)
[94.296283] Starting subtest: error-state-basic
[94.385692] Subtest error-state-basic: SUCCESS (0.090s)
[94.449110] [053/164] (922s left) i915_pciid
[94.545094] [054/164] (922s left) kms_addfb_basic (addfb25-4-tiled)
[94.757914] Starting subtest: addfb25-4-tiled
[94.758913] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[94.830781] [055/164] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[94.858405] Starting subtest: addfb25-bad-modifier
[94.859192] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[95.131322] [056/164] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[95.159262] Starting subtest: addfb25-framebuffer-vs-set-tiling
[95.159906] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[95.431162] [057/164] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[95.460535] Starting subtest: addfb25-modifier-no-flag
[95.461332] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[95.713504] [058/164] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[95.740565] Starting subtest: addfb25-x-tiled-legacy
[95.741369] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[95.997251] [059/164] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[96.027959] Starting subtest: addfb25-x-tiled-mismatch-legacy
[96.028811] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[96.299100] [060/164] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[96.507826] Starting subtest: addfb25-yf-tiled-legacy
[96.508458] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[96.582872] [061/164] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[96.795272] Starting subtest: addfb25-y-tiled-legacy
[96.796133] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[96.882928] [062/164] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[97.097527] Starting subtest: addfb25-y-tiled-small-legacy
[97.099083] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[97.183084] [063/164] (919s left) kms_addfb_basic (bad-pitch-0)
[97.213909] Starting subtest: bad-pitch-0
[97.214734] Subtest bad-pitch-0: SUCCESS (0.000s)
[97.483139] [064/164] (919s left) kms_addfb_basic (bad-pitch-1024)
[97.511549] Starting subtest: bad-pitch-1024
[97.512217] Subtest bad-pitch-1024: SUCCESS (0.000s)
[97.765760] [065/164] (918s left) kms_addfb_basic (bad-pitch-128)
[97.793623] Starting subtest: bad-pitch-128
[97.794286] Subtest bad-pitch-128: SUCCESS (0.000s)
[98.050233] [066/164] (918s left) kms_addfb_basic (bad-pitch-256)
[98.078177] Starting subtest: bad-pitch-256
[98.079096] Subtest bad-pitch-256: SUCCESS (0.000s)
[98.350734] [067/164] (918s left) kms_addfb_basic (bad-pitch-32)
[98.380071] Starting subtest: bad-pitch-32
[98.380987] Subtest bad-pitch-32: SUCCESS (0.000s)
[98.652394] [068/164] (918s left) kms_addfb_basic (bad-pitch-63)
[98.683260] Starting subtest: bad-pitch-63
[98.684127] Subtest bad-pitch-63: SUCCESS (0.000s)
[98.950828] [069/164] (917s left) kms_addfb_basic (bad-pitch-65536)
[98.984785] Starting subtest: bad-pitch-65536
[98.985533] Subtest bad-pitch-65536: SUCCESS (0.000s)
[99.249723] [070/164] (917s left) kms_addfb_basic (bad-pitch-999)
[99.278310] Starting subtest: bad-pitch-999
[99.279255] Subtest bad-pitch-999: SUCCESS (0.000s)
[99.549916] [071/164] (917s left) kms_addfb_basic (basic)
[99.583045] Starting subtest: basic
[99.583892] Subtest basic: SUCCESS (0.000s)
[99.866893] [072/164] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[99.894729] Starting subtest: basic-x-tiled-legacy
[99.895393] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[100.149227] [073/164] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[100.176858] Starting subtest: basic-y-tiled-legacy
[100.177545] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[100.450708] [074/164] (916s left) kms_addfb_basic (bo-too-small)
[100.667218] Starting subtest: bo-too-small
[100.668238] Subtest bo-too-small: SUCCESS (0.000s)
[100.749212] [075/164] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[100.967802] Starting subtest: bo-too-small-due-to-tiling
[100.968581] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[101.050665] [076/164] (915s left) kms_addfb_basic (clobberred-modifier)
[101.083771] Starting subtest: clobberred-modifier
[101.084597] Subtest clobberred-modifier: SUCCESS (0.000s)
[101.351393] [077/164] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[101.379514] Starting subtest: framebuffer-vs-set-tiling
[101.380164] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[101.649866] [078/164] (915s left) kms_addfb_basic (invalid-get-prop)
[101.677175] Starting subtest: invalid-get-prop
[101.677961] Subtest invalid-get-prop: SUCCESS (0.000s)
[101.966114] [079/164] (914s left) kms_addfb_basic (invalid-get-prop-any)
[101.992739] Starting subtest: invalid-get-prop-any
[101.993374] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[102.267118] [080/164] (914s left) kms_addfb_basic (invalid-set-prop)
[102.296790] Starting subtest: invalid-set-prop
[102.297587] Subtest invalid-set-prop: SUCCESS (0.000s)
[102.566242] [081/164] (914s left) kms_addfb_basic (invalid-set-prop-any)
[102.597141] Starting subtest: invalid-set-prop-any
[102.597934] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[102.850100] [082/164] (913s left) kms_addfb_basic (no-handle)
[102.878756] Starting subtest: no-handle
[102.879461] Subtest no-handle: SUCCESS (0.000s)
[103.154350] [083/164] (913s left) kms_addfb_basic (size-max)
[103.369830] Starting subtest: size-max
[103.371205] Subtest size-max: SUCCESS (0.000s)
[103.451231] [084/164] (913s left) kms_addfb_basic (small-bo)
[103.667559] Starting subtest: small-bo
[103.668617] Subtest small-bo: SUCCESS (0.000s)
[103.751295] [085/164] (913s left) kms_addfb_basic (tile-pitch-mismatch)
[103.779094] Starting subtest: tile-pitch-mismatch
[103.779795] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[104.033496] [086/164] (912s left) kms_addfb_basic (too-high)
[104.248142] Starting subtest: too-high
[104.249052] Subtest too-high: SUCCESS (0.000s)
[104.333176] [087/164] (912s left) kms_addfb_basic (too-wide)
[104.552630] Starting subtest: too-wide
[104.553632] Subtest too-wide: SUCCESS (0.000s)
[104.634233] [088/164] (912s left) kms_addfb_basic (unused-handle)
[104.665931] Starting subtest: unused-handle
[104.666885] Subtest unused-handle: SUCCESS (0.000s)
[104.933672] [089/164] (911s left) kms_addfb_basic (unused-modifier)
[104.960489] Starting subtest: unused-modifier
[104.961218] Subtest unused-modifier: SUCCESS (0.000s)
[105.233085] [090/164] (911s left) kms_addfb_basic (unused-offsets)
[105.267858] Starting subtest: unused-offsets
[105.268678] Subtest unused-offsets: SUCCESS (0.000s)
[105.533758] [091/164] (911s left) kms_addfb_basic (unused-pitches)
[105.562871] Starting subtest: unused-pitches
[105.563717] Subtest unused-pitches: SUCCESS (0.000s)
[105.834899] [092/164] (911s left) kms_busy (basic)
[106.049079] Starting subtest: basic
[106.050280] Starting dynamic subtest: flip
[106.609457] Dynamic subtest flip: SUCCESS (0.559s)
[106.614031] Starting dynamic subtest: modeset
[107.385885] Dynamic subtest modeset: SUCCESS (0.776s)
[107.386715] Subtest basic: SUCCESS (1.337s)
[107.540954] [093/164] (909s left) kms_prop_blob (basic)
[107.570951] Starting subtest: basic
[107.571651] Subtest basic: SUCCESS (0.000s)
[107.626478] [094/164] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[107.838208] Starting subtest: basic-busy-flip-before-cursor-atomic
[107.839903] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[107.890621] [095/164] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[108.104804] Starting subtest: basic-busy-flip-before-cursor-legacy
[108.107047] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[108.159878] [096/164] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[108.374238] Starting subtest: basic-flip-after-cursor-atomic
[109.350132] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.976s)
[109.506251] [097/164] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[109.726108] Starting subtest: basic-flip-after-cursor-legacy
[110.715147] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.989s)
[110.877250] [098/164] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[111.099199] Starting subtest: basic-flip-after-cursor-varying-size
[112.065719] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.967s)
[112.232468] [099/164] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[112.447075] Starting subtest: basic-flip-before-cursor-atomic
[113.422456] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.975s)
[113.596555] [100/164] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[113.807222] Starting subtest: basic-flip-before-cursor-legacy
[114.786060] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.979s)
[114.962936] [101/164] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[115.179883] Starting subtest: basic-flip-before-cursor-varying-size
[116.166459] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.987s)
[116.339209] [102/164] (900s left) kms_flip (basic-flip-vs-dpms)
[116.488832] Starting subtest: basic-flip-vs-dpms
[116.490588] Starting dynamic subtest: A-DP1
[117.385729] Dynamic subtest A-DP1: SUCCESS (0.895s)
[117.391356] Starting dynamic subtest: B-DP1
[118.124405] Dynamic subtest B-DP1: SUCCESS (0.739s)
[118.129094] Starting dynamic subtest: C-DP1
[118.857055] Dynamic subtest C-DP1: SUCCESS (0.732s)
[118.861756] Starting dynamic subtest: D-DP1
[119.601977] Dynamic subtest D-DP1: SUCCESS (0.744s)
[119.603929] Subtest basic-flip-vs-dpms: SUCCESS (3.116s)
[119.767032] [103/164] (897s left) kms_flip (basic-flip-vs-modeset)
[119.903756] Starting subtest: basic-flip-vs-modeset
[119.905831] Starting dynamic subtest: A-DP1
[120.801670] Dynamic subtest A-DP1: SUCCESS (0.895s)
[120.807419] Starting dynamic subtest: B-DP1
[121.549915] Dynamic subtest B-DP1: SUCCESS (0.747s)
[121.555510] Starting dynamic subtest: C-DP1
[122.300334] Dynamic subtest C-DP1: SUCCESS (0.750s)
[122.306123] Starting dynamic subtest: D-DP1
[123.042209] Dynamic subtest D-DP1: SUCCESS (0.741s)
[123.043812] Subtest basic-flip-vs-modeset: SUCCESS (3.141s)
[123.206073] [104/164] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[123.345171] Starting subtest: basic-flip-vs-wf_vblank
[123.347595] Starting dynamic subtest: A-DP1
[124.408126] Dynamic subtest A-DP1: SUCCESS (1.060s)
[124.417251] Starting dynamic subtest: B-DP1
[125.424730] Dynamic subtest B-DP1: SUCCESS (1.013s)
[125.434732] Starting dynamic subtest: C-DP1
[126.457959] Dynamic subtest C-DP1: SUCCESS (1.032s)
[126.466847] Starting dynamic subtest: D-DP1
[127.472243] Dynamic subtest D-DP1: SUCCESS (1.012s)
[127.477142] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.133s)
[127.694285] [105/164] (889s left) kms_flip (basic-plain-flip)
[127.843333] Starting subtest: basic-plain-flip
[127.844149] Starting dynamic subtest: A-DP1
[128.619709] Dynamic subtest A-DP1: SUCCESS (0.774s)
[128.627882] Starting dynamic subtest: B-DP1
[129.351400] Dynamic subtest B-DP1: SUCCESS (0.729s)
[129.361325] Starting dynamic subtest: C-DP1
[130.099819] Dynamic subtest C-DP1: SUCCESS (0.745s)
[130.106926] Starting dynamic subtest: D-DP1
[130.830697] Dynamic subtest D-DP1: SUCCESS (0.729s)
[130.838207] Subtest basic-plain-flip: SUCCESS (2.996s)
[131.051575] [106/164] (886s left) kms_force_connector_basic (force-connector-state)
[131.289132] Starting subtest: force-connector-state
[131.987191] Subtest force-connector-state: SUCCESS (0.698s)
[132.668230] [107/164] (884s left) kms_force_connector_basic (force-edid)
[132.902055] Starting subtest: force-edid
[133.311453] Subtest force-edid: SUCCESS (0.409s)
[133.817331] [108/164] (883s left) kms_force_connector_basic (force-load-detect)
[134.064577] Starting subtest: force-load-detect
[134.066342] Subtest force-load-detect: SKIP (0.000s)
[134.455555] [109/164] (882s left) kms_force_connector_basic (prune-stale-modes)
[134.693554] Starting subtest: prune-stale-modes
[135.157939] Subtest prune-stale-modes: SUCCESS (0.465s)
[135.650668] [110/164] (881s left) kms_frontbuffer_tracking (basic)
[135.878695] Starting subtest: basic
[139.329138] Subtest basic: SUCCESS (3.451s)
[139.416536] [111/164] (877s left) kms_hdmi_inject (inject-audio)
[139.520048] Starting subtest: inject-audio
[140.045421] Subtest inject-audio: SUCCESS (0.525s)
[140.441511] [112/164] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[140.655915] Starting subtest: compare-crc-sanitycheck-xr24
[140.657150] Starting dynamic subtest: pipe-A-DP-1
[141.067884] Dynamic subtest pipe-A-DP-1: SUCCESS (0.412s)
[141.073707] Starting dynamic subtest: pipe-B-DP-1
[141.461122] Dynamic subtest pipe-B-DP-1: SUCCESS (0.393s)
[141.467740] Starting dynamic subtest: pipe-C-DP-1
[141.861631] Dynamic subtest pipe-C-DP-1: SUCCESS (0.399s)
[141.866790] Starting dynamic subtest: pipe-D-DP-1
[142.261908] Dynamic subtest pipe-D-DP-1: SUCCESS (0.399s)
[142.262733] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.607s)
[142.423877] [113/164] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[142.645711] Starting subtest: compare-crc-sanitycheck-nv12
[142.647248] Starting dynamic subtest: pipe-A-DP-1
[143.260263] Dynamic subtest pipe-A-DP-1: SUCCESS (0.613s)
[143.265200] Starting dynamic subtest: pipe-B-DP-1
[143.823759] Dynamic subtest pipe-B-DP-1: SUCCESS (0.561s)
[143.829662] Starting dynamic subtest: pipe-C-DP-1
[144.377741] Dynamic subtest pipe-C-DP-1: SUCCESS (0.553s)
[144.382706] Starting dynamic subtest: pipe-D-DP-1
[144.933326] Dynamic subtest pipe-D-DP-1: SUCCESS (0.554s)
[144.934070] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.287s)
[145.092390] [114/164] (872s left) kms_pipe_crc_basic (hang-read-crc)
[145.312040] Starting subtest: hang-read-crc
[145.312766] Starting dynamic subtest: pipe-A-DP-1
[146.484421] Dynamic subtest pipe-A-DP-1: SUCCESS (1.169s)
[146.489675] Starting dynamic subtest: pipe-B-DP-1
[147.583236] Dynamic subtest pipe-B-DP-1: SUCCESS (1.098s)
[147.588317] Starting dynamic subtest: pipe-C-DP-1
[148.682113] Dynamic subtest pipe-C-DP-1: SUCCESS (1.099s)
[148.689712] Starting dynamic subtest: pipe-D-DP-1
[149.791412] Dynamic subtest pipe-D-DP-1: SUCCESS (1.109s)
[149.792082] Subtest hang-read-crc: SUCCESS (4.480s)
[149.934832] [115/164] (867s left) kms_pipe_crc_basic (nonblocking-crc)
[150.161472] Starting subtest: nonblocking-crc
[150.162468] Starting dynamic subtest: pipe-A-DP-1
[150.792756] Dynamic subtest pipe-A-DP-1: SUCCESS (0.630s)
[150.797862] Starting dynamic subtest: pipe-B-DP-1
[151.368290] Dynamic subtest pipe-B-DP-1: SUCCESS (0.575s)
[151.373070] Starting dynamic subtest: pipe-C-DP-1
[151.944490] Dynamic subtest pipe-C-DP-1: SUCCESS (0.574s)
[151.949854] Starting dynamic subtest: pipe-D-DP-1
[152.521234] Dynamic subtest pipe-D-DP-1: SUCCESS (0.575s)
[152.522211] Subtest nonblocking-crc: SUCCESS (2.360s)
[152.663941] [116/164] (864s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[152.885355] Starting subtest: nonblocking-crc-frame-sequence
[152.886211] Starting dynamic subtest: pipe-A-DP-1
[153.502231] Dynamic subtest pipe-A-DP-1: SUCCESS (0.616s)
[153.508781] Starting dynamic subtest: pipe-B-DP-1
[154.061877] Dynamic subtest pipe-B-DP-1: SUCCESS (0.557s)
[154.066886] Starting dynamic subtest: pipe-C-DP-1
[154.644250] Dynamic subtest pipe-C-DP-1: SUCCESS (0.576s)
[154.649459] Starting dynamic subtest: pipe-D-DP-1
[155.221020] Dynamic subtest pipe-D-DP-1: SUCCESS (0.578s)
[155.221983] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.333s)
[155.373259] [117/164] (861s left) kms_pipe_crc_basic (read-crc)
[155.587808] Starting subtest: read-crc
[155.588862] Starting dynamic subtest: pipe-A-DP-1
[156.133326] Dynamic subtest pipe-A-DP-1: SUCCESS (0.545s)
[156.138365] Starting dynamic subtest: pipe-B-DP-1
[156.627945] Dynamic subtest pipe-B-DP-1: SUCCESS (0.493s)
[156.635347] Starting dynamic subtest: pipe-C-DP-1
[157.137979] Dynamic subtest pipe-C-DP-1: SUCCESS (0.509s)
[157.143227] Starting dynamic subtest: pipe-D-DP-1
[157.655025] Dynamic subtest pipe-D-DP-1: SUCCESS (0.515s)
[157.655824] Subtest read-crc: SUCCESS (2.068s)
[157.798503] [118/164] (859s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[158.013957] Starting subtest: read-crc-frame-sequence
[158.015148] Starting dynamic subtest: pipe-A-DP-1
[158.555140] Dynamic subtest pipe-A-DP-1: SUCCESS (0.540s)
[158.560149] Starting dynamic subtest: pipe-B-DP-1
[159.066344] Dynamic subtest pipe-B-DP-1: SUCCESS (0.510s)
[159.071604] Starting dynamic subtest: pipe-C-DP-1
[159.561650] Dynamic subtest pipe-C-DP-1: SUCCESS (0.494s)
[159.568706] Starting dynamic subtest: pipe-D-DP-1
[160.073123] Dynamic subtest pipe-D-DP-1: SUCCESS (0.510s)
[160.073941] Subtest read-crc-frame-sequence: SUCCESS (2.059s)
[160.213963] [119/164] (857s left) kms_pm_backlight (basic-brightness)
[160.435146] Subtest basic-brightness: SKIP (0.000s)
[160.467066] [120/164] (856s left) kms_psr (primary_page_flip)
[160.502478] Subtest primary_page_flip: SKIP (0.000s)
[160.536099] [121/164] (856s left) kms_psr (cursor_plane_move)
[160.564772] Subtest cursor_plane_move: SKIP (0.000s)
[160.584119] [122/164] (856s left) kms_psr (sprite_plane_onoff)
[160.610480] Subtest sprite_plane_onoff: SKIP (0.000s)
[160.633195] [123/164] (856s left) kms_psr (primary_mmap_gtt)
[160.660052] Subtest primary_mmap_gtt: SKIP (0.000s)
[160.684041] [124/164] (856s left) kms_setmode (basic-clone-single-crtc)
[160.709027] Starting subtest: basic-clone-single-crtc
[160.711019] Subtest basic-clone-single-crtc: SKIP (0.000s)
[160.780444] [125/164] (856s left) i915_pm_rpm (basic-pci-d3-state)
[162.328091] Starting subtest: basic-pci-d3-state
[165.586961] Subtest basic-pci-d3-state: SUCCESS (3.260s)
[165.808992] [126/164] (851s left) i915_pm_rpm (basic-rte)
[165.838336] Starting subtest: basic-rte
[167.900426] Subtest basic-rte: SUCCESS (2.059s)
[168.464275] [127/164] (848s left) i915_pm_rps (basic-api)
[168.498734] Starting subtest: basic-api
[168.499975] Subtest basic-api: SKIP (0.000s)
[168.567336] [128/164] (848s left) prime_self_import (basic-llseek-bad)
[168.598928] Starting subtest: basic-llseek-bad
[168.600694] Subtest basic-llseek-bad: SUCCESS (0.001s)
[168.683526] [129/164] (848s left) prime_self_import (basic-llseek-size)
[168.717373] Starting subtest: basic-llseek-size
[168.718978] Subtest basic-llseek-size: SUCCESS (0.002s)
[168.801362] [130/164] (848s left) prime_self_import (basic-with_fd_dup)
[168.826713] Starting subtest: basic-with_fd_dup
[168.828830] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[168.918043] [131/164] (848s left) prime_self_import (basic-with_one_bo)
[168.943648] Starting subtest: basic-with_one_bo
[168.945129] Subtest basic-with_one_bo: SUCCESS (0.002s)
[168.986701] [132/164] (848s left) prime_self_import (basic-with_one_bo_two_files)
[169.010959] Starting subtest: basic-with_one_bo_two_files
[169.012268] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[169.101263] [133/164] (848s left) prime_self_import (basic-with_two_bos)
[169.126737] Starting subtest: basic-with_two_bos
[169.128515] Subtest basic-with_two_bos: SUCCESS (0.001s)
[169.199754] [134/164] (848s left) prime_vgem (basic-fence-flip)
[169.232291] Starting subtest: basic-fence-flip
[169.813510] Subtest basic-fence-flip: SUCCESS (0.581s)
[169.903422] [135/164] (847s left) prime_vgem (basic-fence-mmap)
[169.949490] Starting subtest: basic-fence-mmap
[169.965400] Subtest basic-fence-mmap: SUCCESS (0.016s)
[170.049517] [136/164] (847s left) prime_vgem (basic-fence-read)
[170.082563] Starting subtest: basic-fence-read
[170.086466] Subtest basic-fence-read: SKIP (0.003s)
[170.168236] [137/164] (847s left) prime_vgem (basic-gtt)
[170.199253] Starting subtest: basic-gtt
[170.206496] Subtest basic-gtt: SUCCESS (0.007s)
[170.302710] [138/164] (847s left) prime_vgem (basic-read)
[170.350122] Starting subtest: basic-read
[170.352638] Subtest basic-read: SKIP (0.003s)
[170.434638] [139/164] (847s left) prime_vgem (basic-write)
[170.492525] Starting subtest: basic-write
[170.494116] Subtest basic-write: SKIP (0.003s)
[170.587018] [140/164] (846s left) vgem_basic (setversion)
[170.630907] Starting subtest: setversion
[170.632691] Subtest setversion: SUCCESS (0.000s)
[170.686446] [141/164] (846s left) vgem_basic (create)
[170.731033] Starting subtest: create
[170.731954] Subtest create: SUCCESS (0.000s)
[170.784447] [142/164] (846s left) vgem_basic (debugfs)
[170.814317] Starting subtest: debugfs
[170.815034] Subtest debugfs: SUCCESS (0.000s)
[170.866679] [143/164] (846s left) vgem_basic (dmabuf-export)
[170.897098] Starting subtest: dmabuf-export
[170.898558] Subtest dmabuf-export: SUCCESS (0.001s)
[170.969036] [144/164] (846s left) vgem_basic (dmabuf-fence)
[170.997247] Starting subtest: dmabuf-fence
[170.997980] Subtest dmabuf-fence: SUCCESS (0.000s)
[171.048380] [145/164] (846s left) vgem_basic (dmabuf-fence-before)
[171.080573] Starting subtest: dmabuf-fence-before
[171.081283] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[171.129531] [146/164] (846s left) vgem_basic (dmabuf-mmap)
[171.163914] Starting subtest: dmabuf-mmap
[171.169928] Subtest dmabuf-mmap: SUCCESS (0.007s)
[171.213584] [147/164] (846s left) vgem_basic (mmap)
[171.247815] Starting subtest: mmap
[171.251160] Subtest mmap: SUCCESS (0.004s)
[171.300163] [148/164] (846s left) vgem_basic (second-client)
[171.330634] Starting subtest: second-client
[171.365905] Subtest second-client: SUCCESS (0.033s)
[171.417512] [149/164] (846s left) vgem_basic (sysfs)
[171.447389] Starting subtest: sysfs
[171.448114] Subtest sysfs: SUCCESS (0.000s)
[171.500976] [150/164] (846s left) core_hotunplug (unbind-rebind)
[171.547256] Starting subtest: unbind-rebind
[175.736696] Subtest unbind-rebind: SUCCESS (4.189s)
[175.749504] [151/164] (841s left) vgem_basic (unload)
[175.782158] Starting subtest: unload
[204.732645] Subtest unload: SUCCESS (28.915s)
[204.776373] [152/164] (812s left) i915_module_load (reload)
[204.807686] Starting subtest: reload
[207.654517] Subtest reload: SUCCESS (2.846s)
[207.671507] [153/164] (809s left) gem_lmem_swapping (basic)
[207.707778] Subtest basic: SKIP (0.000s)
[207.726708] [154/164] (809s left) gem_lmem_swapping (parallel-random-engines)
[207.756188] Subtest parallel-random-engines: SKIP (0.000s)
[207.776865] [155/164] (809s left) gem_lmem_swapping (random-engines)
[207.807005] Subtest random-engines: SKIP (0.000s)
[207.826596] [156/164] (809s left) gem_lmem_swapping (verify-random)
[207.854700] Subtest verify-random: SKIP (0.000s)
[207.876811] [157/164] (809s left) i915_pm_rpm (module-reload)
[209.538633] Starting subtest: module-reload
[221.839541] Subtest module-reload: SUCCESS (12.295s)
[221.888460] [158/164] (795s left) i915_selftest (live)
[221.937137] Starting subtest: live
[221.938109] Starting dynamic subtest: sanitycheck
[223.594056] Dynamic subtest sanitycheck: SUCCESS (1.648s)
[223.598104] Starting dynamic subtest: uncore
[225.271940] Dynamic subtest uncore: SUCCESS (1.680s)
[225.276049] Starting dynamic subtest: workarounds
[227.900283] Dynamic subtest workarounds: SUCCESS (2.624s)
[227.904091] Starting dynamic subtest: gt_engines
[230.140749] Dynamic subtest gt_engines: SUCCESS (2.239s)
[230.144724] Starting dynamic subtest: gt_timelines
[240.732786] Dynamic subtest gt_timelines: SUCCESS (10.590s)
[240.736738] Starting dynamic subtest: gt_contexts
[242.467818] Dynamic subtest gt_contexts: SUCCESS (1.734s)
[242.471631] Starting dynamic subtest: gt_lrc
[247.115816] Dynamic subtest gt_lrc: SUCCESS (4.646s)
[247.120062] Starting dynamic subtest: gt_mocs
[249.334426] Dynamic subtest gt_mocs: SUCCESS (2.217s)
[249.338319] Starting dynamic subtest: gt_pm
[251.900304] Dynamic subtest gt_pm: SUCCESS (2.565s)
[251.903879] Starting dynamic subtest: gt_heartbeat
[253.713643] Dynamic subtest gt_heartbeat: SUCCESS (1.812s)
[253.717632] Starting dynamic subtest: gt_tlb
[256.940721] Dynamic subtest gt_tlb: SUCCESS (3.226s)
[256.944757] Starting dynamic subtest: requests
[266.643926] Dynamic subtest requests: SUCCESS (9.701s)
[266.649499] Starting dynamic subtest: migrate
[271.039559] Dynamic subtest migrate: SUCCESS (4.394s)
[271.044984] Starting dynamic subtest: active
[272.695372] Dynamic subtest active: SUCCESS (1.655s)
[272.699710] Starting dynamic subtest: objects
[274.797384] Dynamic subtest objects: SUCCESS (2.101s)
[274.801113] Starting dynamic subtest: mman
[280.078178] Dynamic subtest mman: SUCCESS (5.280s)
[280.082074] Starting dynamic subtest: dmabuf
[281.780688] Dynamic subtest dmabuf: SUCCESS (1.701s)
[281.785970] Starting dynamic subtest: vma
[283.485967] Dynamic subtest vma: SUCCESS (1.705s)
[283.489610] Starting dynamic subtest: coherency
[287.455609] Dynamic subtest coherency: SUCCESS (3.967s)
[287.461066] Starting dynamic subtest: gtt
[296.595609] Dynamic subtest gtt: SUCCESS (9.139s)
[296.599667] Starting dynamic subtest: gem
[298.418920] Dynamic subtest gem: SUCCESS (1.822s)
[298.422833] Starting dynamic subtest: evict
[301.595285] Dynamic subtest evict: SUCCESS (3.175s)
[301.600130] Starting dynamic subtest: hugepages
[309.729496] Dynamic subtest hugepages: SUCCESS (8.133s)
[309.733572] Starting dynamic subtest: gem_contexts
[326.462330] Dynamic subtest gem_contexts: SUCCESS (16.732s)
[326.467925] Starting dynamic subtest: client
[328.175696] Dynamic subtest client: SUCCESS (1.712s)
[328.181050] Starting dynamic subtest: gem_migrate
[329.830914] Dynamic subtest gem_migrate: SUCCESS (1.654s)
[329.836771] Starting dynamic subtest: reset
[335.245438] Dynamic subtest reset: SUCCESS (5.414s)
[335.251136] Starting dynamic subtest: memory_region
[336.896402] Dynamic subtest memory_region: SUCCESS (1.650s)
[336.900250] Starting dynamic subtest: hangcheck
[355.983650] Dynamic subtest hangcheck: SUCCESS (19.086s)
[355.987538] Starting dynamic subtest: execlists
[357.614432] Dynamic subtest execlists: SUCCESS (1.630s)
[357.620166] Starting dynamic subtest: ring_submission
[359.282260] Dynamic subtest ring_submission: SUCCESS (1.667s)
[359.286104] Starting dynamic subtest: perf
[360.990717] Dynamic subtest perf: SUCCESS (1.707s)
[360.996832] Starting dynamic subtest: slpc
[369.251610] Dynamic subtest slpc: SUCCESS (8.260s)
[369.255501] Starting dynamic subtest: guc
[371.744641] Dynamic subtest guc: SUCCESS (2.492s)
[371.748446] Starting dynamic subtest: guc_multi_lrc
[373.429206] Dynamic subtest guc_multi_lrc: SUCCESS (1.683s)
[373.434353] Starting dynamic subtest: guc_hang
[375.775450] Dynamic subtest guc_hang: SUCCESS (2.345s)
[375.779593] Starting dynamic subtest: late_gt_pm
[377.472660] Dynamic subtest late_gt_pm: SUCCESS (1.696s)
[377.473909] Subtest live: SUCCESS (155.527s)
[377.490462] [159/164] (640s left) dmabuf (all-tests)
[377.529119] Starting subtest: all-tests
[377.531832] Starting dynamic subtest: sanitycheck
[377.591322] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[377.599636] Starting dynamic subtest: dma_fence
[377.765453] Dynamic subtest dma_fence: SUCCESS (0.172s)
[377.773904] Starting dynamic subtest: dma_fence_chain
[386.992434] Dynamic subtest dma_fence_chain: SUCCESS (9.225s)
[387.006333] Starting dynamic subtest: dma_fence_unwrap
[387.065386] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[387.072070] Starting dynamic subtest: dma_resv
[387.131626] Dynamic subtest dma_resv: SUCCESS (0.061s)
[387.133062] Subtest all-tests: SUCCESS (9.600s)
[387.146233] [160/164] (630s left) i915_suspend (basic-s2idle-without-i915)
[387.175380] Starting subtest: basic-s2idle-without-i915
[407.342095] Subtest basic-s2idle-without-i915: SUCCESS (5.434s)
[407.631300] [161/164] (624s left) i915_suspend (basic-s3-without-i915)
[407.662262] Starting subtest: basic-s3-without-i915
[427.911996] Subtest basic-s3-without-i915: SUCCESS (4.323s)
[428.202581] [162/164] (620s left) gem_exec_suspend (basic-s0)
[428.250616] Starting subtest: basic-S0
[428.251419] Starting dynamic subtest: smem
[446.261266] Dynamic subtest smem: SUCCESS (2.608s)
[446.262392] Subtest basic-S0: SUCCESS (2.608s)
[446.401715] [163/164] (617s left) gem_exec_suspend (basic-s3)
[446.440141] Starting subtest: basic-S3
[446.441327] Starting dynamic subtest: smem
[464.253815] Dynamic subtest smem: SUCCESS (2.566s)
[464.255341] Subtest basic-S3: SUCCESS (2.567s)
[464.398265] [164/164] (614s left) kms_pipe_crc_basic (suspend-read-crc)
[464.617281] Starting subtest: suspend-read-crc
[464.617975] Starting dynamic subtest: pipe-A-DP-1
[482.391596] Dynamic subtest pipe-A-DP-1: SUCCESS (2.396s)
[482.397292] Starting dynamic subtest: pipe-B-DP-1
[500.333110] Dynamic subtest pipe-B-DP-1: SUCCESS (2.253s)
[500.338715] Starting dynamic subtest: pipe-C-DP-1
[518.334530] Dynamic subtest pipe-C-DP-1: SUCCESS (2.288s)
[518.340458] Starting dynamic subtest: pipe-D-DP-1
[535.350037] Dynamic subtest pipe-D-DP-1: SUCCESS (2.280s)
[535.351026] Subtest suspend-read-crc: SUCCESS (9.221s)
[535.455577] Closing watchdogs
Done.