[51.023749] Initializing watchdogs
[51.023804]   /dev/watchdog0
[51.030042] [001/165] (960s left) i915_module_load (load)
[51.076714] Starting subtest: load
[53.201699] Subtest load: SUCCESS (2.126s)
[53.214467] [002/165] (958s left) core_auth (basic-auth)
[53.280176] Starting subtest: basic-auth
[53.282447] Subtest basic-auth: SUCCESS (0.000s)
[53.340092] [003/165] (958s left) debugfs_test (read_all_entries)
[53.381946] Starting subtest: read_all_entries
[53.505227] Subtest read_all_entries: SUCCESS (0.121s)
[53.790058] [004/165] (957s left) debugfs_test (basic-hwmon)
[53.853332] Starting subtest: basic-hwmon
[53.856971] Subtest basic-hwmon: SKIP (0.000s)
[54.230507] [005/165] (957s left) fbdev (eof)
[54.303308] Starting subtest: eof
[54.305700] Subtest eof: SUCCESS (0.001s)
[54.358282] [006/165] (957s left) fbdev (info)
[54.397778] Starting subtest: info
[54.399906] Subtest info: SUCCESS (0.000s)
[54.458879] [007/165] (957s left) fbdev (nullptr)
[54.501568] Starting subtest: nullptr
[54.503611] Subtest nullptr: SUCCESS (0.000s)
[54.564831] [008/165] (957s left) fbdev (read)
[54.618796] Starting subtest: read
[56.311617] Subtest read: SUCCESS (1.691s)
[56.351404] [009/165] (955s left) fbdev (write)
[56.402510] Starting subtest: write
[57.546355] Subtest write: SUCCESS (1.143s)
[57.607303] [010/165] (954s left) gem_basic (bad-close)
[57.666680] Starting subtest: bad-close
[57.671358] Subtest bad-close: SUCCESS (0.000s)
[57.730920] [011/165] (953s left) gem_basic (create-close)
[57.773950] Starting subtest: create-close
[57.778674] Subtest create-close: SUCCESS (0.000s)
[57.863834] [012/165] (953s left) gem_basic (create-fd-close)
[57.902995] Starting subtest: create-fd-close
[57.907700] Subtest create-fd-close: SUCCESS (0.000s)
[58.006701] [013/165] (953s left) gem_busy (busy@all-engines)
[58.063733] Starting subtest: busy
[58.066318] Starting dynamic subtest: all-engines
[58.088525] Dynamic subtest all-engines: SUCCESS (0.025s)
[58.090598] Subtest busy: SUCCESS (0.025s)
[58.417535] [014/165] (953s left) gem_close_race (basic-process)
[58.467534] Starting subtest: basic-process
[58.510371] Subtest basic-process: SUCCESS (0.042s)
[58.693226] [015/165] (953s left) gem_close_race (basic-threads)
[58.750656] Starting subtest: basic-threads
[59.988876] Subtest basic-threads: SUCCESS (1.237s)
[60.165958] [016/165] (951s left) gem_ctx_create (basic)
[60.208491] Starting subtest: basic
[60.210506] Subtest basic: SUCCESS (0.000s)
[60.388082] [017/165] (951s left) gem_ctx_create (basic-files)
[60.448205] Starting subtest: basic-files
[62.455119] Subtest basic-files: SUCCESS (2.008s)
[62.669081] [018/165] (949s left) gem_ctx_exec (basic)
[62.731601] Starting subtest: basic
[62.734608] Subtest basic: SUCCESS (0.002s)
[62.830860] [019/165] (949s left) gem_exec_basic (basic)
[62.871598] Starting subtest: basic
[62.874104] Starting dynamic subtest: rcs0-smem
[62.876145] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[62.880897] Starting dynamic subtest: bcs0-smem
[62.882903] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[62.889055] Starting dynamic subtest: vcs0-smem
[62.891096] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[62.899436] Starting dynamic subtest: vcs1-smem
[62.901485] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[62.909175] Starting dynamic subtest: vecs0-smem
[62.911602] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[62.914099] Subtest basic: SUCCESS (0.002s)
[63.050807] [020/165] (948s left) gem_exec_create (basic)
[63.116669] Starting subtest: basic
[63.118834] Starting dynamic subtest: smem
[65.198368] Dynamic subtest smem: SUCCESS (2.039s)
[65.201102] Subtest basic: SUCCESS (2.039s)
[65.337876] [021/165] (946s left) gem_exec_fence (basic-busy)
[65.507453] Starting subtest: basic-busy
[65.510419] Starting dynamic subtest: rcs0
[65.554615] Dynamic subtest rcs0: SUCCESS (0.048s)
[65.570824] Starting dynamic subtest: bcs0
[65.579289] Dynamic subtest bcs0: SUCCESS (0.025s)
[65.591131] Starting dynamic subtest: vcs0
[65.599090] Dynamic subtest vcs0: SUCCESS (0.020s)
[65.609050] Starting dynamic subtest: vcs1
[65.623257] Dynamic subtest vcs1: SUCCESS (0.024s)
[65.639035] Starting dynamic subtest: vecs0
[65.646826] Dynamic subtest vecs0: SUCCESS (0.022s)
[65.649449] Subtest basic-busy: SUCCESS (0.140s)
[66.133872] [022/165] (945s left) gem_exec_fence (basic-wait)
[66.304295] Starting subtest: basic-wait
[66.307122] Starting dynamic subtest: rcs0
[66.358210] Dynamic subtest rcs0: SUCCESS (0.055s)
[66.373697] Starting dynamic subtest: bcs0
[66.388311] Dynamic subtest bcs0: SUCCESS (0.030s)
[66.404111] Starting dynamic subtest: vcs0
[66.413854] Dynamic subtest vcs0: SUCCESS (0.026s)
[66.424915] Starting dynamic subtest: vcs1
[66.441705] Dynamic subtest vcs1: SUCCESS (0.028s)
[66.456709] Starting dynamic subtest: vecs0
[66.462849] Dynamic subtest vecs0: SUCCESS (0.021s)
[66.465785] Subtest basic-wait: SUCCESS (0.160s)
[66.918685] [023/165] (945s left) gem_exec_fence (basic-await)
[67.099961] Starting subtest: basic-await
[67.102525] Starting dynamic subtest: rcs0
[67.177774] Dynamic subtest rcs0: SUCCESS (0.078s)
[67.189690] Starting dynamic subtest: bcs0
[67.255432] Dynamic subtest bcs0: SUCCESS (0.077s)
[67.268385] Starting dynamic subtest: vcs0
[67.334438] Dynamic subtest vcs0: SUCCESS (0.079s)
[67.347244] Starting dynamic subtest: vcs1
[67.414646] Dynamic subtest vcs1: SUCCESS (0.080s)
[67.428029] Starting dynamic subtest: vecs0
[67.495614] Dynamic subtest vecs0: SUCCESS (0.081s)
[67.499163] Subtest basic-await: SUCCESS (0.397s)
[67.952512] [024/165] (944s left) gem_exec_fence (nb-await)
[68.127776] Starting subtest: nb-await
[68.131716] Starting dynamic subtest: rcs0
[68.194988] Dynamic subtest rcs0: SUCCESS (0.068s)
[68.210980] Starting dynamic subtest: bcs0
[68.256263] Dynamic subtest bcs0: SUCCESS (0.061s)
[68.270667] Starting dynamic subtest: vcs0
[68.316931] Dynamic subtest vcs0: SUCCESS (0.060s)
[68.331498] Starting dynamic subtest: vcs1
[68.378376] Dynamic subtest vcs1: SUCCESS (0.061s)
[68.392931] Starting dynamic subtest: vecs0
[68.439867] Dynamic subtest vecs0: SUCCESS (0.061s)
[68.443481] Subtest nb-await: SUCCESS (0.314s)
[68.884371] [025/165] (943s left) gem_exec_gttfill (basic)
[68.939555] Starting subtest: basic
[71.133107] Subtest basic: SUCCESS (2.193s)
[71.302699] [026/165] (940s left) gem_exec_parallel (engines)
[71.390989] Starting subtest: engines
[71.393313] Starting dynamic subtest: basic
[72.727842] Dynamic subtest basic: SUCCESS (1.339s)
[72.733782] Starting dynamic subtest: contexts
[74.403074] Dynamic subtest contexts: SUCCESS (1.674s)
[74.409577] Starting dynamic subtest: fds
[76.176571] Dynamic subtest fds: SUCCESS (1.774s)
[76.186528] Starting dynamic subtest: userptr
[77.464946] Dynamic subtest userptr: SUCCESS (1.289s)
[77.467395] Subtest engines: SUCCESS (6.076s)
[77.656121] [027/165] (934s left) gem_exec_store (basic)
[77.707650] Starting subtest: basic
[77.754240] Subtest basic: SUCCESS (0.051s)
[77.936389] [028/165] (934s left) gem_flink_basic (bad-flink)
[77.991699] Starting subtest: bad-flink
[77.993895] Subtest bad-flink: SUCCESS (0.000s)
[78.067624] [029/165] (934s left) gem_flink_basic (bad-open)
[78.114838] Starting subtest: bad-open
[78.117238] Subtest bad-open: SUCCESS (0.000s)
[78.182898] [030/165] (933s left) gem_flink_basic (basic)
[78.220476] Starting subtest: basic
[78.222685] Subtest basic: SUCCESS (0.000s)
[78.318995] [031/165] (933s left) gem_flink_basic (double-flink)
[78.371725] Starting subtest: double-flink
[78.373868] Subtest double-flink: SUCCESS (0.000s)
[78.449265] [032/165] (933s left) gem_flink_basic (flink-lifetime)
[78.503642] Starting subtest: flink-lifetime
[78.506135] Subtest flink-lifetime: SUCCESS (0.001s)
[78.599490] [033/165] (933s left) gem_huc_copy (huc-copy)
[78.646344] Starting subtest: huc-copy
[78.648814] Subtest huc-copy: SUCCESS (0.002s)
[78.745777] [034/165] (933s left) gem_linear_blits (basic)
[78.853980] Starting subtest: basic
[78.859635] Subtest basic: SUCCESS (0.005s)
[78.977348] [035/165] (933s left) gem_mmap (basic)
[79.072191] Starting subtest: basic
[79.081303] Subtest basic: SUCCESS (0.000s)
[79.151691] [036/165] (933s left) gem_mmap_gtt (basic)
[79.204336] Starting subtest: basic
[79.206165] Subtest basic: SUCCESS (0.000s)
[79.291730] [037/165] (933s left) gem_render_linear_blits (basic)
[79.345791] Starting subtest: basic
[79.363855] Subtest basic: SUCCESS (0.020s)
[79.393574] [038/165] (932s left) gem_render_tiled_blits (basic)
[79.435508] Starting subtest: basic
[79.454041] Subtest basic: SUCCESS (0.020s)
[79.515655] [039/165] (932s left) gem_ringfill (basic-all)
[79.734503] Starting subtest: basic-all
[80.843972] Subtest basic-all: SUCCESS (1.109s)
[80.951246] [040/165] (931s left) gem_softpin (allocator-basic)
[81.002364] Starting subtest: allocator-basic
[81.051613] Subtest allocator-basic: SUCCESS (0.050s)
[81.148199] [041/165] (931s left) gem_softpin (allocator-basic-reserve)
[81.189542] Starting subtest: allocator-basic-reserve
[81.244145] Subtest allocator-basic-reserve: SUCCESS (0.053s)
[81.354159] [042/165] (931s left) gem_softpin (safe-alignment)
[81.413115] Starting subtest: safe-alignment
[81.418424] Subtest safe-alignment: SUCCESS (0.008s)
[81.520240] [043/165] (930s left) gem_sync (basic-all)
[81.597269] Starting subtest: basic-all
[83.615833] Subtest basic-all: SUCCESS (2.033s)
[83.801881] [044/165] (928s left) gem_sync (basic-each)
[83.873068] Starting subtest: basic-each
[85.943778] Subtest basic-each: SUCCESS (2.085s)
[86.138871] [045/165] (926s left) gem_tiled_blits (basic)
[86.248418] Starting subtest: basic
[86.259436] Subtest basic: SUCCESS (0.011s)
[86.388040] [046/165] (926s left) gem_tiled_fence_blits (basic)
[86.561040] Starting subtest: basic
[86.573854] Subtest basic: SUCCESS (0.013s)
[86.698638] [047/165] (925s left) gem_tiled_pread_basic
[86.853183] [048/165] (925s left) gem_wait (busy@all-engines)
[86.929252] Starting subtest: busy
[86.931864] Starting dynamic subtest: all-engines
[87.446984] Dynamic subtest all-engines: SUCCESS (0.518s)
[87.449644] Subtest busy: SUCCESS (0.518s)
[87.659924] [049/165] (924s left) gem_wait (wait@all-engines)
[87.718369] Starting subtest: wait
[87.720995] Starting dynamic subtest: all-engines
[88.746855] Dynamic subtest all-engines: SUCCESS (1.028s)
[88.750231] Subtest wait: SUCCESS (1.029s)
[88.951311] [050/165] (923s left) i915_getparams_basic (basic-eu-total)
[88.989766] Starting subtest: basic-eu-total
[88.994756] Subtest basic-eu-total: SUCCESS (0.000s)
[89.068376] [051/165] (923s left) i915_getparams_basic (basic-subslice-total)
[89.108574] Starting subtest: basic-subslice-total
[89.113237] Subtest basic-subslice-total: SUCCESS (0.000s)
[89.184209] [052/165] (923s left) i915_hangman (error-state-basic)
[89.243144] Starting subtest: error-state-basic
[89.340787] Subtest error-state-basic: SUCCESS (0.099s)
[89.414392] [053/165] (923s left) i915_pciid
[89.535462] [054/165] (923s left) kms_addfb_basic (addfb25-4-tiled)
[89.837682] Starting subtest: addfb25-4-tiled
[89.840424] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[89.917147] [055/165] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[89.956533] Starting subtest: addfb25-bad-modifier
[89.958218] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[90.267696] [056/165] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[90.320289] Starting subtest: addfb25-framebuffer-vs-set-tiling
[90.322423] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[90.620166] [057/165] (922s left) kms_addfb_basic (addfb25-modifier-no-flag)
[90.680106] Starting subtest: addfb25-modifier-no-flag
[90.682260] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[90.988609] [058/165] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[91.048586] Starting subtest: addfb25-x-tiled-legacy
[91.050538] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[91.370172] [059/165] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[91.415132] Starting subtest: addfb25-x-tiled-mismatch-legacy
[91.416843] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[91.717301] [060/165] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[91.988264] Starting subtest: addfb25-yf-tiled-legacy
[91.990148] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[92.073661] [061/165] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[92.345609] Starting subtest: addfb25-y-tiled-legacy
[92.348263] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[92.435423] [062/165] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[92.704294] Starting subtest: addfb25-y-tiled-small-legacy
[92.706660] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[92.787942] [063/165] (920s left) kms_addfb_basic (bad-pitch-0)
[92.854108] Starting subtest: bad-pitch-0
[92.855845] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.167726] [064/165] (919s left) kms_addfb_basic (bad-pitch-1024)
[93.210882] Starting subtest: bad-pitch-1024
[93.212631] Subtest bad-pitch-1024: SUCCESS (0.000s)
[93.540383] [065/165] (919s left) kms_addfb_basic (bad-pitch-128)
[93.600448] Starting subtest: bad-pitch-128
[93.602535] Subtest bad-pitch-128: SUCCESS (0.000s)
[93.970763] [066/165] (919s left) kms_addfb_basic (bad-pitch-256)
[94.021803] Starting subtest: bad-pitch-256
[94.023751] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.355373] [067/165] (918s left) kms_addfb_basic (bad-pitch-32)
[94.407358] Starting subtest: bad-pitch-32
[94.409470] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.720434] [068/165] (918s left) kms_addfb_basic (bad-pitch-63)
[94.763810] Starting subtest: bad-pitch-63
[94.765781] Subtest bad-pitch-63: SUCCESS (0.000s)
[95.086824] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[95.129158] Starting subtest: bad-pitch-65536
[95.130985] Subtest bad-pitch-65536: SUCCESS (0.000s)
[95.437124] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[95.481601] Starting subtest: bad-pitch-999
[95.483289] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.855606] [071/165] (917s left) kms_addfb_basic (basic)
[95.896278] Starting subtest: basic
[95.897980] Subtest basic: SUCCESS (0.000s)
[96.221119] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.280298] Starting subtest: basic-x-tiled-legacy
[96.285176] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[96.587648] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[96.637584] Starting subtest: basic-y-tiled-legacy
[96.639632] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[96.967849] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[97.240314] Starting subtest: bo-too-small
[97.242734] Subtest bo-too-small: SUCCESS (0.000s)
[97.321243] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[97.601261] Starting subtest: bo-too-small-due-to-tiling
[97.603592] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[97.687752] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[97.743037] Starting subtest: clobberred-modifier
[97.744901] Subtest clobberred-modifier: SUCCESS (0.000s)
[98.053456] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[98.105076] Starting subtest: framebuffer-vs-set-tiling
[98.107099] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[98.419414] [078/165] (914s left) kms_addfb_basic (invalid-get-prop)
[98.470979] Starting subtest: invalid-get-prop
[98.473436] Subtest invalid-get-prop: SUCCESS (0.000s)
[98.768625] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[98.820520] Starting subtest: invalid-get-prop-any
[98.822427] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[99.254567] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[99.297906] Starting subtest: invalid-set-prop
[99.299511] Subtest invalid-set-prop: SUCCESS (0.000s)
[99.651407] [081/165] (913s left) kms_addfb_basic (invalid-set-prop-any)
[99.699466] Starting subtest: invalid-set-prop-any
[99.701438] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[100.036915] [082/165] (913s left) kms_addfb_basic (no-handle)
[100.088091] Starting subtest: no-handle
[100.090197] Subtest no-handle: SUCCESS (0.000s)
[100.385568] [083/165] (913s left) kms_addfb_basic (size-max)
[100.673322] Starting subtest: size-max
[100.675357] Subtest size-max: SUCCESS (0.000s)
[100.753395] [084/165] (912s left) kms_addfb_basic (small-bo)
[101.028308] Starting subtest: small-bo
[101.030718] Subtest small-bo: SUCCESS (0.000s)
[101.119753] [085/165] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[101.170581] Starting subtest: tile-pitch-mismatch
[101.172670] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[101.468958] [086/165] (912s left) kms_addfb_basic (too-high)
[101.735751] Starting subtest: too-high
[101.738222] Subtest too-high: SUCCESS (0.000s)
[101.818361] [087/165] (911s left) kms_addfb_basic (too-wide)
[102.129920] Starting subtest: too-wide
[102.132224] Subtest too-wide: SUCCESS (0.000s)
[102.225826] [088/165] (911s left) kms_addfb_basic (unused-handle)
[102.283714] Starting subtest: unused-handle
[102.285334] Subtest unused-handle: SUCCESS (0.000s)
[102.704483] [089/165] (910s left) kms_addfb_basic (unused-modifier)
[102.749700] Starting subtest: unused-modifier
[102.751772] Subtest unused-modifier: SUCCESS (0.000s)
[103.070724] [090/165] (910s left) kms_addfb_basic (unused-offsets)
[103.127143] Starting subtest: unused-offsets
[103.129037] Subtest unused-offsets: SUCCESS (0.000s)
[103.435826] [091/165] (910s left) kms_addfb_basic (unused-pitches)
[103.497181] Starting subtest: unused-pitches
[103.499152] Subtest unused-pitches: SUCCESS (0.000s)
[103.821191] [092/165] (909s left) kms_busy (basic)
[104.099272] Starting subtest: basic
[104.101534] Starting dynamic subtest: flip
[104.708364] Dynamic subtest flip: SUCCESS (0.607s)
[104.713658] Starting dynamic subtest: modeset
[105.607828] Dynamic subtest modeset: SUCCESS (0.900s)
[105.609793] Subtest basic: SUCCESS (1.508s)
[105.807347] [093/165] (907s left) kms_prop_blob (basic)
[105.844629] Starting subtest: basic
[105.846464] Subtest basic: SUCCESS (0.000s)
[105.903364] [094/165] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[106.161293] Starting subtest: basic-busy-flip-before-cursor-atomic
[106.165754] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[106.227405] [095/165] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[106.497480] Starting subtest: basic-busy-flip-before-cursor-legacy
[106.502172] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[106.573786] [096/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.848284] Starting subtest: basic-flip-after-cursor-atomic
[107.847044] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.997s)
[108.033914] [097/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[108.301759] Starting subtest: basic-flip-after-cursor-legacy
[109.300987] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[109.499338] [098/165] (904s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[109.765966] Starting subtest: basic-flip-after-cursor-varying-size
[110.770917] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.002s)
[110.964358] [099/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[111.243037] Starting subtest: basic-flip-before-cursor-atomic
[112.235568] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.992s)
[112.419446] [100/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[112.696932] Starting subtest: basic-flip-before-cursor-legacy
[113.686948] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.991s)
[113.883386] [101/165] (899s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[114.163784] Starting subtest: basic-flip-before-cursor-varying-size
[115.151820] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.989s)
[115.342850] [102/165] (898s left) kms_dsc (dsc-basic)
[115.623592] Subtest dsc-basic: SKIP (0.000s)
[115.653141] [103/165] (898s left) kms_flip (basic-flip-vs-dpms)
[115.937034] Starting subtest: basic-flip-vs-dpms
[115.939496] Starting dynamic subtest: A-DP2
[116.715230] Dynamic subtest A-DP2: SUCCESS (0.776s)
[116.728523] Starting dynamic subtest: B-DP2
[117.550551] Dynamic subtest B-DP2: SUCCESS (0.833s)
[117.557700] Starting dynamic subtest: C-DP2
[118.371524] Dynamic subtest C-DP2: SUCCESS (0.820s)
[118.377324] Starting dynamic subtest: D-DP2
[119.190074] Dynamic subtest D-DP2: SUCCESS (0.819s)
[119.195182] Subtest basic-flip-vs-dpms: SUCCESS (3.258s)
[119.396055] [104/165] (894s left) kms_flip (basic-flip-vs-modeset)
[119.673483] Starting subtest: basic-flip-vs-modeset
[119.678372] Starting dynamic subtest: A-DP2
[120.459912] Dynamic subtest A-DP2: SUCCESS (0.784s)
[120.466333] Starting dynamic subtest: B-DP2
[121.268301] Dynamic subtest B-DP2: SUCCESS (0.807s)
[121.274010] Starting dynamic subtest: C-DP2
[122.087512] Dynamic subtest C-DP2: SUCCESS (0.819s)
[122.093603] Starting dynamic subtest: D-DP2
[122.902769] Dynamic subtest D-DP2: SUCCESS (0.814s)
[122.907280] Subtest basic-flip-vs-modeset: SUCCESS (3.234s)
[123.106484] [105/165] (890s left) kms_flip (basic-flip-vs-wf_vblank)
[123.374483] Starting subtest: basic-flip-vs-wf_vblank
[123.379380] Starting dynamic subtest: A-DP2
[124.464535] Dynamic subtest A-DP2: SUCCESS (1.086s)
[124.480539] Starting dynamic subtest: B-DP2
[125.515549] Dynamic subtest B-DP2: SUCCESS (1.049s)
[125.532957] Starting dynamic subtest: C-DP2
[126.560047] Dynamic subtest C-DP2: SUCCESS (1.042s)
[126.571080] Starting dynamic subtest: D-DP2
[127.612523] Dynamic subtest D-DP2: SUCCESS (1.050s)
[127.622982] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.249s)
[127.883061] [106/165] (886s left) kms_flip (basic-plain-flip)
[128.153041] Starting subtest: basic-plain-flip
[128.155591] Starting dynamic subtest: A-DP2
[128.969230] Dynamic subtest A-DP2: SUCCESS (0.813s)
[128.985064] Starting dynamic subtest: B-DP2
[129.732624] Dynamic subtest B-DP2: SUCCESS (0.761s)
[129.747179] Starting dynamic subtest: C-DP2
[130.502905] Dynamic subtest C-DP2: SUCCESS (0.764s)
[130.515078] Starting dynamic subtest: D-DP2
[131.266958] Dynamic subtest D-DP2: SUCCESS (0.765s)
[131.276722] Subtest basic-plain-flip: SUCCESS (3.125s)
[131.512770] [107/165] (882s left) kms_force_connector_basic (force-connector-state)
[131.736180] Starting subtest: force-connector-state
[132.152396] Subtest force-connector-state: SUCCESS (0.417s)
[132.944174] [108/165] (881s left) kms_force_connector_basic (force-edid)
[133.170643] Starting subtest: force-edid
[133.186667] Subtest force-edid: SUCCESS (0.019s)
[133.780902] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[134.008744] Starting subtest: force-load-detect
[134.012474] Subtest force-load-detect: SKIP (0.000s)
[134.546823] [110/165] (879s left) kms_force_connector_basic (prune-stale-modes)
[134.784363] Starting subtest: prune-stale-modes
[134.803343] Subtest prune-stale-modes: SUCCESS (0.019s)
[135.399490] [111/165] (878s left) kms_frontbuffer_tracking (basic)
[135.677064] Starting subtest: basic
[139.134198] Subtest basic: SUCCESS (3.461s)
[139.252612] [112/165] (874s left) kms_hdmi_inject (inject-audio)
[139.386759] Starting subtest: inject-audio
[139.485137] Subtest inject-audio: SUCCESS (0.097s)
[139.895564] [113/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[140.162322] Starting subtest: compare-crc-sanitycheck-xr24
[140.164613] Starting dynamic subtest: pipe-A-DP-2
[140.600236] Dynamic subtest pipe-A-DP-2: SUCCESS (0.436s)
[140.606777] Starting dynamic subtest: pipe-B-DP-2
[141.033645] Dynamic subtest pipe-B-DP-2: SUCCESS (0.430s)
[141.040818] Starting dynamic subtest: pipe-C-DP-2
[141.448987] Dynamic subtest pipe-C-DP-2: SUCCESS (0.415s)
[141.455126] Starting dynamic subtest: pipe-D-DP-2
[141.868214] Dynamic subtest pipe-D-DP-2: SUCCESS (0.418s)
[141.870424] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.706s)
[142.055042] [114/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[142.384253] Starting subtest: compare-crc-sanitycheck-nv12
[142.386475] Starting dynamic subtest: pipe-A-DP-2
[142.934896] Dynamic subtest pipe-A-DP-2: SUCCESS (0.552s)
[142.941494] Starting dynamic subtest: pipe-B-DP-2
[143.453820] Dynamic subtest pipe-B-DP-2: SUCCESS (0.517s)
[143.460124] Starting dynamic subtest: pipe-C-DP-2
[144.001621] Dynamic subtest pipe-C-DP-2: SUCCESS (0.546s)
[144.008196] Starting dynamic subtest: pipe-D-DP-2
[144.552364] Dynamic subtest pipe-D-DP-2: SUCCESS (0.548s)
[144.554675] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.169s)
[144.742516] [115/165] (869s left) kms_pipe_crc_basic (hang-read-crc)
[145.128170] Starting subtest: hang-read-crc
[145.130793] Starting dynamic subtest: pipe-A-DP-2
[146.385455] Dynamic subtest pipe-A-DP-2: SUCCESS (1.257s)
[146.391788] Starting dynamic subtest: pipe-B-DP-2
[147.566707] Dynamic subtest pipe-B-DP-2: SUCCESS (1.178s)
[147.573225] Starting dynamic subtest: pipe-C-DP-2
[148.755144] Dynamic subtest pipe-C-DP-2: SUCCESS (1.186s)
[148.763396] Starting dynamic subtest: pipe-D-DP-2
[149.929354] Dynamic subtest pipe-D-DP-2: SUCCESS (1.173s)
[149.932199] Subtest hang-read-crc: SUCCESS (4.802s)
[150.097268] [116/165] (864s left) kms_pipe_crc_basic (nonblocking-crc)
[150.386353] Starting subtest: nonblocking-crc
[150.388673] Starting dynamic subtest: pipe-A-DP-2
[151.033091] Dynamic subtest pipe-A-DP-2: SUCCESS (0.646s)
[151.045232] Starting dynamic subtest: pipe-B-DP-2
[151.664754] Dynamic subtest pipe-B-DP-2: SUCCESS (0.629s)
[151.671539] Starting dynamic subtest: pipe-C-DP-2
[152.266426] Dynamic subtest pipe-C-DP-2: SUCCESS (0.600s)
[152.273678] Starting dynamic subtest: pipe-D-DP-2
[152.859053] Dynamic subtest pipe-D-DP-2: SUCCESS (0.592s)
[152.861834] Subtest nonblocking-crc: SUCCESS (2.475s)
[153.030776] [117/165] (861s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[153.433645] Starting subtest: nonblocking-crc-frame-sequence
[153.435939] Starting dynamic subtest: pipe-A-DP-2
[154.067626] Dynamic subtest pipe-A-DP-2: SUCCESS (0.633s)
[154.074835] Starting dynamic subtest: pipe-B-DP-2
[154.697162] Dynamic subtest pipe-B-DP-2: SUCCESS (0.628s)
[154.703756] Starting dynamic subtest: pipe-C-DP-2
[155.293333] Dynamic subtest pipe-C-DP-2: SUCCESS (0.595s)
[155.299830] Starting dynamic subtest: pipe-D-DP-2
[155.909531] Dynamic subtest pipe-D-DP-2: SUCCESS (0.614s)
[155.912120] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.479s)
[156.086062] [118/165] (858s left) kms_pipe_crc_basic (read-crc)
[156.365698] Starting subtest: read-crc
[156.367795] Starting dynamic subtest: pipe-A-DP-2
[156.928072] Dynamic subtest pipe-A-DP-2: SUCCESS (0.562s)
[156.934980] Starting dynamic subtest: pipe-B-DP-2
[157.471924] Dynamic subtest pipe-B-DP-2: SUCCESS (0.543s)
[157.478855] Starting dynamic subtest: pipe-C-DP-2
[158.017393] Dynamic subtest pipe-C-DP-2: SUCCESS (0.542s)
[158.023697] Starting dynamic subtest: pipe-D-DP-2
[158.563083] Dynamic subtest pipe-D-DP-2: SUCCESS (0.545s)
[158.565576] Subtest read-crc: SUCCESS (2.200s)
[158.731759] [119/165] (855s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[159.006541] Starting subtest: read-crc-frame-sequence
[159.009088] Starting dynamic subtest: pipe-A-DP-2
[159.598264] Dynamic subtest pipe-A-DP-2: SUCCESS (0.590s)
[159.605050] Starting dynamic subtest: pipe-B-DP-2
[160.161833] Dynamic subtest pipe-B-DP-2: SUCCESS (0.561s)
[160.168250] Starting dynamic subtest: pipe-C-DP-2
[160.709129] Dynamic subtest pipe-C-DP-2: SUCCESS (0.545s)
[160.715888] Starting dynamic subtest: pipe-D-DP-2
[161.257049] Dynamic subtest pipe-D-DP-2: SUCCESS (0.547s)
[161.259816] Subtest read-crc-frame-sequence: SUCCESS (2.251s)
[161.438761] [120/165] (852s left) kms_pm_backlight (basic-brightness)
[161.708398] Subtest basic-brightness: SKIP (0.000s)
[161.749784] [121/165] (852s left) kms_pm_rpm (basic-pci-d3-state)
[163.585631] Starting subtest: basic-pci-d3-state
[164.021566] Subtest basic-pci-d3-state: SUCCESS (0.434s)
[164.259013] [122/165] (850s left) kms_pm_rpm (basic-rte)
[164.295199] Starting subtest: basic-rte
[166.475414] Subtest basic-rte: SUCCESS (2.179s)
[167.416392] [123/165] (846s left) kms_psr (psr-primary-page-flip)
[167.690299] Subtest psr-primary-page-flip: SKIP (0.000s)
[167.706934] [124/165] (846s left) kms_psr (psr-cursor-plane-move)
[167.979244] Subtest psr-cursor-plane-move: SKIP (0.000s)
[168.009142] [125/165] (846s left) kms_psr (psr-sprite-plane-onoff)
[168.328473] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[168.356416] [126/165] (846s left) kms_psr (psr-primary-mmap-gtt)
[168.638788] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[168.655901] [127/165] (845s left) kms_setmode (basic-clone-single-crtc)
[168.702911] Starting subtest: basic-clone-single-crtc
[168.708140] Subtest basic-clone-single-crtc: SKIP (0.000s)
[168.782781] [128/165] (845s left) i915_pm_rps (basic-api)
[168.829615] Starting subtest: basic-api
[168.831881] Subtest basic-api: SUCCESS (0.001s)
[168.912980] [129/165] (845s left) prime_self_import (basic-llseek-bad)
[168.955859] Starting subtest: basic-llseek-bad
[168.960097] Subtest basic-llseek-bad: SUCCESS (0.001s)
[169.051988] [130/165] (845s left) prime_self_import (basic-llseek-size)
[169.104667] Starting subtest: basic-llseek-size
[169.109194] Subtest basic-llseek-size: SUCCESS (0.001s)
[169.200894] [131/165] (845s left) prime_self_import (basic-with_fd_dup)
[169.253296] Starting subtest: basic-with_fd_dup
[169.257681] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[169.351513] [132/165] (845s left) prime_self_import (basic-with_one_bo)
[169.397085] Starting subtest: basic-with_one_bo
[169.401217] Subtest basic-with_one_bo: SUCCESS (0.002s)
[169.489344] [133/165] (845s left) prime_self_import (basic-with_one_bo_two_files)
[169.534697] Starting subtest: basic-with_one_bo_two_files
[169.538499] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[169.611995] [134/165] (845s left) prime_self_import (basic-with_two_bos)
[169.659951] Starting subtest: basic-with_two_bos
[169.664181] Subtest basic-with_two_bos: SUCCESS (0.001s)
[169.750953] [135/165] (844s left) prime_vgem (basic-fence-flip)
[169.803048] Starting subtest: basic-fence-flip
[170.482068] Subtest basic-fence-flip: SUCCESS (0.681s)
[170.579462] [136/165] (844s left) prime_vgem (basic-fence-mmap)
[170.641878] Starting subtest: basic-fence-mmap
[170.663417] Subtest basic-fence-mmap: SUCCESS (0.024s)
[170.770770] [137/165] (843s left) prime_vgem (basic-fence-read)
[170.840313] Starting subtest: basic-fence-read
[170.847223] Subtest basic-fence-read: SKIP (0.005s)
[170.947598] [138/165] (843s left) prime_vgem (basic-gtt)
[171.002377] Starting subtest: basic-gtt
[171.008856] Subtest basic-gtt: SUCCESS (0.008s)
[171.115291] [139/165] (843s left) prime_vgem (basic-read)
[171.171300] Starting subtest: basic-read
[171.175857] Subtest basic-read: SKIP (0.004s)
[171.268791] [140/165] (843s left) prime_vgem (basic-write)
[171.337711] Starting subtest: basic-write
[171.343108] Subtest basic-write: SKIP (0.004s)
[171.453238] [141/165] (843s left) vgem_basic (setversion)
[171.516049] Starting subtest: setversion
[171.519836] Subtest setversion: SUCCESS (0.000s)
[171.578443] [142/165] (843s left) vgem_basic (create)
[171.633488] Starting subtest: create
[171.635153] Subtest create: SUCCESS (0.000s)
[171.695162] [143/165] (843s left) vgem_basic (debugfs)
[171.750681] Starting subtest: debugfs
[171.753422] Subtest debugfs: SUCCESS (0.001s)
[171.809383] [144/165] (843s left) vgem_basic (dmabuf-export)
[171.850246] Starting subtest: dmabuf-export
[171.854614] Subtest dmabuf-export: SUCCESS (0.002s)
[171.964707] [145/165] (842s left) vgem_basic (dmabuf-fence)
[172.034848] Starting subtest: dmabuf-fence
[172.037361] Subtest dmabuf-fence: SUCCESS (0.001s)
[172.097716] [146/165] (842s left) vgem_basic (dmabuf-fence-before)
[172.149906] Starting subtest: dmabuf-fence-before
[172.152148] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[172.215758] [147/165] (842s left) vgem_basic (dmabuf-mmap)
[172.267146] Starting subtest: dmabuf-mmap
[172.274838] Subtest dmabuf-mmap: SUCCESS (0.010s)
[172.322854] [148/165] (842s left) vgem_basic (mmap)
[172.383977] Starting subtest: mmap
[172.388688] Subtest mmap: SUCCESS (0.006s)
[172.439466] [149/165] (842s left) vgem_basic (second-client)
[172.485742] Starting subtest: second-client
[172.517931] Subtest second-client: SUCCESS (0.034s)
[172.576371] [150/165] (842s left) vgem_basic (sysfs)
[172.617642] Starting subtest: sysfs
[172.619301] Subtest sysfs: SUCCESS (0.000s)
[172.678435] [151/165] (842s left) core_hotunplug (unbind-rebind)
[172.748300] Starting subtest: unbind-rebind
[176.889201] Subtest unbind-rebind: SUCCESS (4.140s)
[176.913349] [152/165] (838s left) vgem_basic (unload)
[176.961544] Starting subtest: unload
[205.932819] Subtest unload: SUCCESS (28.920s)
[205.990619] [153/165] (809s left) i915_module_load (reload)
[206.044523] Starting subtest: reload
[208.917849] Subtest reload: SUCCESS (2.874s)
[208.931273] [154/165] (806s left) gem_lmem_swapping (basic)
[208.977451] Subtest basic: SKIP (0.000s)
[209.016140] [155/165] (806s left) gem_lmem_swapping (parallel-random-engines)
[209.077625] Subtest parallel-random-engines: SKIP (0.000s)
[209.093938] [156/165] (806s left) gem_lmem_swapping (random-engines)
[209.150128] Subtest random-engines: SKIP (0.000s)
[209.176832] [157/165] (805s left) gem_lmem_swapping (verify-random)
[209.217577] Subtest verify-random: SKIP (0.000s)
[209.245239] [158/165] (805s left) i915_pm_rpm (module-reload)
[211.290435] Starting subtest: module-reload
[219.994539] Subtest module-reload: SUCCESS (8.708s)
[220.020644] [159/165] (795s left) i915_selftest (live)
[220.064201] Starting subtest: live
[220.066074] Starting dynamic subtest: sanitycheck
[221.721881] Dynamic subtest sanitycheck: SUCCESS (1.658s)
[221.730078] Starting dynamic subtest: uncore
[223.397166] Dynamic subtest uncore: SUCCESS (1.673s)
[223.406148] Starting dynamic subtest: workarounds
[225.331865] Dynamic subtest workarounds: SUCCESS (1.933s)
[225.341252] Starting dynamic subtest: gt_engines
[227.592956] Dynamic subtest gt_engines: SUCCESS (2.259s)
[227.602745] Starting dynamic subtest: gt_timelines
[235.444086] Dynamic subtest gt_timelines: SUCCESS (7.849s)
[235.454158] Starting dynamic subtest: gt_contexts
[237.201127] Dynamic subtest gt_contexts: SUCCESS (1.755s)
[237.210404] Starting dynamic subtest: gt_lrc
[241.717220] Dynamic subtest gt_lrc: SUCCESS (4.514s)
[241.728035] Starting dynamic subtest: gt_mocs
[243.499164] Dynamic subtest gt_mocs: SUCCESS (1.780s)
[243.508664] Starting dynamic subtest: gt_pm
[263.224918] Dynamic subtest gt_pm: SUCCESS (19.722s)
[263.232236] Starting dynamic subtest: gt_heartbeat
[265.027051] Dynamic subtest gt_heartbeat: SUCCESS (1.802s)
[265.037081] Starting dynamic subtest: gt_tlb
[268.134920] Dynamic subtest gt_tlb: SUCCESS (3.106s)
[268.143835] Starting dynamic subtest: requests
[277.045791] Dynamic subtest requests: SUCCESS (8.909s)
[277.056503] Starting dynamic subtest: migrate
[282.124074] Dynamic subtest migrate: SUCCESS (5.076s)
[282.133550] Starting dynamic subtest: active
[283.821074] Dynamic subtest active: SUCCESS (1.695s)
[283.832668] Starting dynamic subtest: objects
[285.970999] Dynamic subtest objects: SUCCESS (2.148s)
[285.980306] Starting dynamic subtest: mman
[291.426982] Dynamic subtest mman: SUCCESS (5.454s)
[291.437084] Starting dynamic subtest: dmabuf
[293.145069] Dynamic subtest dmabuf: SUCCESS (1.716s)
[293.154426] Starting dynamic subtest: vma
[294.874985] Dynamic subtest vma: SUCCESS (1.728s)
[294.884065] Starting dynamic subtest: coherency
[298.520901] Dynamic subtest coherency: SUCCESS (3.644s)
[298.530621] Starting dynamic subtest: gtt
[307.751455] Dynamic subtest gtt: SUCCESS (9.228s)
[307.763528] Starting dynamic subtest: gem
[309.556097] Dynamic subtest gem: SUCCESS (1.803s)
[309.565672] Starting dynamic subtest: evict
[311.942935] Dynamic subtest evict: SUCCESS (2.385s)
[311.952641] Starting dynamic subtest: hugepages
[320.116662] Dynamic subtest hugepages: SUCCESS (8.172s)
[320.126958] Starting dynamic subtest: gem_contexts
[334.941119] Dynamic subtest gem_contexts: SUCCESS (14.822s)
[334.950538] Starting dynamic subtest: client
[336.656081] Dynamic subtest client: SUCCESS (1.713s)
[336.666566] Starting dynamic subtest: gem_migrate
[338.407777] Dynamic subtest gem_migrate: SUCCESS (1.749s)
[338.413988] Starting dynamic subtest: reset
[342.653786] Dynamic subtest reset: SUCCESS (4.245s)
[342.660569] Starting dynamic subtest: memory_region
[344.358068] Dynamic subtest memory_region: SUCCESS (1.702s)
[344.363903] Starting dynamic subtest: hangcheck
[374.682238] Dynamic subtest hangcheck: SUCCESS (30.322s)
[374.691345] Starting dynamic subtest: execlists
[387.978068] Dynamic subtest execlists: SUCCESS (13.294s)
[387.988987] Starting dynamic subtest: ring_submission
[389.687269] Dynamic subtest ring_submission: SUCCESS (1.706s)
[389.696779] Starting dynamic subtest: perf
[391.472055] Dynamic subtest perf: SUCCESS (1.783s)
[391.481517] Starting dynamic subtest: slpc
[393.192245] Dynamic subtest slpc: SUCCESS (1.718s)
[393.200122] Starting dynamic subtest: guc
[394.907225] Dynamic subtest guc: SUCCESS (1.713s)
[394.916326] Starting dynamic subtest: guc_multi_lrc
[396.588126] Dynamic subtest guc_multi_lrc: SUCCESS (1.679s)
[396.597321] Starting dynamic subtest: guc_hang
[398.259820] Dynamic subtest guc_hang: SUCCESS (1.670s)
[398.268839] Starting dynamic subtest: late_gt_pm
[399.983702] Dynamic subtest late_gt_pm: SUCCESS (1.722s)
[399.986647] Subtest live: SUCCESS (179.921s)
[400.006037] [160/165] (615s left) dmabuf (all-tests)
[400.048281] Starting subtest: all-tests
[400.050503] Starting dynamic subtest: sanitycheck
[400.112190] Dynamic subtest sanitycheck: SUCCESS (0.064s)
[400.129754] Starting dynamic subtest: dma_fence
[400.289776] Dynamic subtest dma_fence: SUCCESS (0.176s)
[400.303874] Starting dynamic subtest: dma_fence_chain
[410.467179] Dynamic subtest dma_fence_chain: SUCCESS (10.175s)
[410.477585] Starting dynamic subtest: dma_fence_unwrap
[410.543094] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[410.558802] Starting dynamic subtest: dma_resv
[410.614544] Dynamic subtest dma_resv: SUCCESS (0.070s)
[410.618200] Subtest all-tests: SUCCESS (10.568s)
[410.648400] [161/165] (604s left) i915_suspend (basic-s2idle-without-i915)
[410.696642] Starting subtest: basic-s2idle-without-i915
[431.330394] Subtest basic-s2idle-without-i915: SUCCESS (7.452s)
[431.643267] [162/165] (596s left) i915_suspend (basic-s3-without-i915)
[431.682753] Starting subtest: basic-s3-without-i915
[453.849713] Subtest basic-s3-without-i915: SUCCESS (4.946s)
[454.038482] [163/165] (591s left) gem_exec_suspend (basic-s0)
[454.089356] Starting subtest: basic-S0
[454.091721] Starting dynamic subtest: smem
[472.081012] Dynamic subtest smem: SUCCESS (3.884s)
[472.083600] Subtest basic-S0: SUCCESS (3.885s)
[472.235419] [164/165] (587s left) gem_exec_suspend (basic-s3)
[472.291427] Starting subtest: basic-S3
[472.294110] Starting dynamic subtest: smem
[492.451934] Dynamic subtest smem: SUCCESS (3.329s)
[492.454760] Subtest basic-S3: SUCCESS (3.330s)
[492.612160] [165/165] (584s left) kms_pipe_crc_basic (suspend-read-crc)
[492.875167] Starting subtest: suspend-read-crc
[492.877673] Starting dynamic subtest: pipe-A-DP-2
[513.736122] Dynamic subtest pipe-A-DP-2: SUCCESS (3.582s)
[513.744131] Starting dynamic subtest: pipe-B-DP-2
[534.651629] Dynamic subtest pipe-B-DP-2: SUCCESS (3.443s)
[534.660187] Starting dynamic subtest: pipe-C-DP-2
[555.682425] Dynamic subtest pipe-C-DP-2: SUCCESS (3.495s)
[555.693233] Starting dynamic subtest: pipe-D-DP-2
[576.662640] Dynamic subtest pipe-D-DP-2: SUCCESS (3.466s)
[576.665173] Subtest suspend-read-crc: SUCCESS (13.994s)
[576.796706] Closing watchdogs
Done.