[29.801181] Initializing watchdogs
[29.801227]   /dev/watchdog0
[29.806503] [001/165] (960s left) i915_module_load (load)
[29.857592] Starting subtest: load
[31.995143] Subtest load: SUCCESS (2.139s)
[32.018437] [002/165] (958s left) core_auth (basic-auth)
[32.065481] Starting subtest: basic-auth
[32.067056] Subtest basic-auth: SUCCESS (0.001s)
[32.128794] [003/165] (958s left) debugfs_test (read_all_entries)
[32.168789] Starting subtest: read_all_entries
[32.298171] Subtest read_all_entries: SUCCESS (0.129s)
[32.586778] [004/165] (957s left) debugfs_test (basic-hwmon)
[32.634976] Starting subtest: basic-hwmon
[32.638667] Subtest basic-hwmon: SKIP (0.000s)
[32.956887] [005/165] (957s left) fbdev (eof)
[33.011620] Starting subtest: eof
[33.014188] Subtest eof: SUCCESS (0.000s)
[33.071414] [006/165] (957s left) fbdev (info)
[33.125422] Starting subtest: info
[33.127586] Subtest info: SUCCESS (0.000s)
[33.188178] [007/165] (957s left) fbdev (nullptr)
[33.244952] Starting subtest: nullptr
[33.247455] Subtest nullptr: SUCCESS (0.000s)
[33.306393] [008/165] (957s left) fbdev (read)
[33.360948] Starting subtest: read
[35.042389] Subtest read: SUCCESS (1.679s)
[35.099429] [009/165] (955s left) fbdev (write)
[35.163088] Starting subtest: write
[36.312580] Subtest write: SUCCESS (1.149s)
[36.363245] [010/165] (954s left) gem_basic (bad-close)
[36.410540] Starting subtest: bad-close
[36.415235] Subtest bad-close: SUCCESS (0.000s)
[36.472110] [011/165] (954s left) gem_basic (create-close)
[36.514381] Starting subtest: create-close
[36.518478] Subtest create-close: SUCCESS (0.000s)
[36.610382] [012/165] (953s left) gem_basic (create-fd-close)
[36.664231] Starting subtest: create-fd-close
[36.668847] Subtest create-fd-close: SUCCESS (0.000s)
[36.759940] [013/165] (953s left) gem_busy (busy@all-engines)
[36.820260] Starting subtest: busy
[36.822642] Starting dynamic subtest: all-engines
[36.842857] Dynamic subtest all-engines: SUCCESS (0.023s)
[36.845444] Subtest busy: SUCCESS (0.023s)
[37.193949] [014/165] (953s left) gem_close_race (basic-process)
[37.245577] Starting subtest: basic-process
[37.284539] Subtest basic-process: SUCCESS (0.038s)
[37.459557] [015/165] (953s left) gem_close_race (basic-threads)
[37.529536] Starting subtest: basic-threads
[38.798427] Subtest basic-threads: SUCCESS (1.269s)
[38.978907] [016/165] (951s left) gem_ctx_create (basic)
[39.037337] Starting subtest: basic
[39.039984] Subtest basic: SUCCESS (0.000s)
[39.227270] [017/165] (951s left) gem_ctx_create (basic-files)
[39.288031] Starting subtest: basic-files
[41.294221] Subtest basic-files: SUCCESS (2.009s)
[41.476331] [018/165] (949s left) gem_ctx_exec (basic)
[41.517289] Starting subtest: basic
[41.519669] Subtest basic: SUCCESS (0.002s)
[41.632696] [019/165] (949s left) gem_exec_basic (basic)
[41.692083] Starting subtest: basic
[41.694536] Starting dynamic subtest: rcs0-smem
[41.696935] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[41.702125] Starting dynamic subtest: bcs0-smem
[41.704331] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[41.709676] Starting dynamic subtest: vcs0-smem
[41.711915] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[41.717355] Starting dynamic subtest: vcs1-smem
[41.719580] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[41.725121] Starting dynamic subtest: vecs0-smem
[41.727389] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[41.729634] Subtest basic: SUCCESS (0.002s)
[41.879714] [020/165] (948s left) gem_exec_create (basic)
[41.943451] Starting subtest: basic
[41.946207] Starting dynamic subtest: smem
[44.040776] Dynamic subtest smem: SUCCESS (2.054s)
[44.044204] Subtest basic: SUCCESS (2.054s)
[44.180669] [021/165] (946s left) gem_exec_fence (basic-busy)
[44.361437] Starting subtest: basic-busy
[44.364835] Starting dynamic subtest: rcs0
[44.411106] Dynamic subtest rcs0: SUCCESS (0.051s)
[44.426843] Starting dynamic subtest: bcs0
[44.440474] Dynamic subtest bcs0: SUCCESS (0.029s)
[44.453536] Starting dynamic subtest: vcs0
[44.475438] Dynamic subtest vcs0: SUCCESS (0.035s)
[44.491131] Starting dynamic subtest: vcs1
[44.511770] Dynamic subtest vcs1: SUCCESS (0.036s)
[44.526056] Starting dynamic subtest: vecs0
[44.537342] Dynamic subtest vecs0: SUCCESS (0.026s)
[44.540200] Subtest basic-busy: SUCCESS (0.178s)
[45.009372] [022/165] (945s left) gem_exec_fence (basic-wait)
[45.190062] Starting subtest: basic-wait
[45.193614] Starting dynamic subtest: rcs0
[45.239518] Dynamic subtest rcs0: SUCCESS (0.051s)
[45.254703] Starting dynamic subtest: bcs0
[45.275073] Dynamic subtest bcs0: SUCCESS (0.035s)
[45.289103] Starting dynamic subtest: vcs0
[45.301172] Dynamic subtest vcs0: SUCCESS (0.026s)
[45.312167] Starting dynamic subtest: vcs1
[45.329059] Dynamic subtest vcs1: SUCCESS (0.028s)
[45.340038] Starting dynamic subtest: vecs0
[45.353178] Dynamic subtest vecs0: SUCCESS (0.025s)
[45.355861] Subtest basic-wait: SUCCESS (0.165s)
[45.793570] [023/165] (945s left) gem_exec_fence (basic-await)
[45.953800] Starting subtest: basic-await
[45.956736] Starting dynamic subtest: rcs0
[46.031245] Dynamic subtest rcs0: SUCCESS (0.078s)
[46.040031] Starting dynamic subtest: bcs0
[46.105846] Dynamic subtest bcs0: SUCCESS (0.075s)
[46.114181] Starting dynamic subtest: vcs0
[46.178744] Dynamic subtest vcs0: SUCCESS (0.072s)
[46.191792] Starting dynamic subtest: vcs1
[46.258631] Dynamic subtest vcs1: SUCCESS (0.080s)
[46.272042] Starting dynamic subtest: vecs0
[46.339458] Dynamic subtest vecs0: SUCCESS (0.080s)
[46.342731] Subtest basic-await: SUCCESS (0.387s)
[46.777194] [024/165] (944s left) gem_exec_fence (nb-await)
[46.954496] Starting subtest: nb-await
[46.957471] Starting dynamic subtest: rcs0
[47.014831] Dynamic subtest rcs0: SUCCESS (0.061s)
[47.027050] Starting dynamic subtest: bcs0
[47.075267] Dynamic subtest bcs0: SUCCESS (0.060s)
[47.087571] Starting dynamic subtest: vcs0
[47.136912] Dynamic subtest vcs0: SUCCESS (0.061s)
[47.152287] Starting dynamic subtest: vcs1
[47.199129] Dynamic subtest vcs1: SUCCESS (0.062s)
[47.206865] Starting dynamic subtest: vecs0
[47.257370] Dynamic subtest vecs0: SUCCESS (0.058s)
[47.260954] Subtest nb-await: SUCCESS (0.304s)
[47.711332] [025/165] (943s left) gem_exec_gttfill (basic)
[47.781831] Starting subtest: basic
[50.015186] Subtest basic: SUCCESS (2.233s)
[50.179182] [026/165] (940s left) gem_exec_parallel (engines)
[50.287846] Starting subtest: engines
[50.290489] Starting dynamic subtest: basic
[51.611838] Dynamic subtest basic: SUCCESS (1.324s)
[51.617904] Starting dynamic subtest: contexts
[53.311140] Dynamic subtest contexts: SUCCESS (1.699s)
[53.318242] Starting dynamic subtest: fds
[55.113117] Dynamic subtest fds: SUCCESS (1.801s)
[55.123900] Starting dynamic subtest: userptr
[56.394580] Dynamic subtest userptr: SUCCESS (1.282s)
[56.397186] Subtest engines: SUCCESS (6.107s)
[56.584252] [027/165] (934s left) gem_exec_store (basic)
[56.637074] Starting subtest: basic
[56.695393] Subtest basic: SUCCESS (0.062s)
[56.871360] [028/165] (934s left) gem_flink_basic (bad-flink)
[56.929503] Starting subtest: bad-flink
[56.931814] Subtest bad-flink: SUCCESS (0.000s)
[56.994318] [029/165] (933s left) gem_flink_basic (bad-open)
[57.052705] Starting subtest: bad-open
[57.054943] Subtest bad-open: SUCCESS (0.000s)
[57.136337] [030/165] (933s left) gem_flink_basic (basic)
[57.197387] Starting subtest: basic
[57.199464] Subtest basic: SUCCESS (0.000s)
[57.279812] [031/165] (933s left) gem_flink_basic (double-flink)
[57.334118] Starting subtest: double-flink
[57.336054] Subtest double-flink: SUCCESS (0.000s)
[57.429900] [032/165] (933s left) gem_flink_basic (flink-lifetime)
[57.484818] Starting subtest: flink-lifetime
[57.487177] Subtest flink-lifetime: SUCCESS (0.001s)
[57.557486] [033/165] (933s left) gem_huc_copy (huc-copy)
[57.598866] Starting subtest: huc-copy
[57.601148] Subtest huc-copy: SUCCESS (0.002s)
[57.713757] [034/165] (933s left) gem_linear_blits (basic)
[57.824492] Starting subtest: basic
[57.830274] Subtest basic: SUCCESS (0.006s)
[57.959344] [035/165] (933s left) gem_mmap (basic)
[58.021156] Starting subtest: basic
[58.031446] Subtest basic: SUCCESS (0.000s)
[58.109486] [036/165] (932s left) gem_mmap_gtt (basic)
[58.164731] Starting subtest: basic
[58.166964] Subtest basic: SUCCESS (0.001s)
[58.253207] [037/165] (932s left) gem_render_linear_blits (basic)
[58.310855] Starting subtest: basic
[58.327249] Subtest basic: SUCCESS (0.018s)
[58.374896] [038/165] (932s left) gem_render_tiled_blits (basic)
[58.424368] Starting subtest: basic
[58.443402] Subtest basic: SUCCESS (0.019s)
[58.489526] [039/165] (932s left) gem_ringfill (basic-all)
[58.699827] Starting subtest: basic-all
[59.813963] Subtest basic-all: SUCCESS (1.114s)
[59.925175] [040/165] (931s left) gem_softpin (allocator-basic)
[59.962076] Starting subtest: allocator-basic
[60.013491] Subtest allocator-basic: SUCCESS (0.053s)
[60.112252] [041/165] (931s left) gem_softpin (allocator-basic-reserve)
[60.165402] Starting subtest: allocator-basic-reserve
[60.215500] Subtest allocator-basic-reserve: SUCCESS (0.052s)
[60.334557] [042/165] (930s left) gem_softpin (safe-alignment)
[60.393791] Starting subtest: safe-alignment
[60.401061] Subtest safe-alignment: SUCCESS (0.010s)
[60.511869] [043/165] (930s left) gem_sync (basic-all)
[60.590649] Starting subtest: basic-all
[62.639249] Subtest basic-all: SUCCESS (2.021s)
[62.779230] [044/165] (928s left) gem_sync (basic-each)
[62.853683] Starting subtest: basic-each
[64.915413] Subtest basic-each: SUCCESS (2.079s)
[65.113465] [045/165] (926s left) gem_tiled_blits (basic)
[65.218337] Starting subtest: basic
[65.228549] Subtest basic: SUCCESS (0.010s)
[65.346575] [046/165] (925s left) gem_tiled_fence_blits (basic)
[65.535395] Starting subtest: basic
[65.548419] Subtest basic: SUCCESS (0.013s)
[65.676702] [047/165] (925s left) gem_tiled_pread_basic
[65.853450] [048/165] (925s left) gem_wait (busy@all-engines)
[65.915218] Starting subtest: busy
[65.917686] Starting dynamic subtest: all-engines
[66.427852] Dynamic subtest all-engines: SUCCESS (0.513s)
[66.430791] Subtest busy: SUCCESS (0.513s)
[66.629234] [049/165] (924s left) gem_wait (wait@all-engines)
[66.694490] Starting subtest: wait
[66.697070] Starting dynamic subtest: all-engines
[67.740100] Dynamic subtest all-engines: SUCCESS (1.044s)
[67.743702] Subtest wait: SUCCESS (1.045s)
[67.961287] [050/165] (923s left) i915_getparams_basic (basic-eu-total)
[68.000272] Starting subtest: basic-eu-total
[68.005531] Subtest basic-eu-total: SUCCESS (0.000s)
[68.080370] [051/165] (923s left) i915_getparams_basic (basic-subslice-total)
[68.125170] Starting subtest: basic-subslice-total
[68.130135] Subtest basic-subslice-total: SUCCESS (0.000s)
[68.195520] [052/165] (923s left) i915_hangman (error-state-basic)
[68.250133] Starting subtest: error-state-basic
[68.345401] Subtest error-state-basic: SUCCESS (0.097s)
[68.428172] [053/165] (923s left) i915_pciid
[68.545569] [054/165] (922s left) kms_addfb_basic (addfb25-4-tiled)
[68.838940] Starting subtest: addfb25-4-tiled
[68.841801] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[68.927217] [055/165] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[68.973240] Starting subtest: addfb25-bad-modifier
[68.974947] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[69.272487] [056/165] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[69.318816] Starting subtest: addfb25-framebuffer-vs-set-tiling
[69.320895] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[69.624364] [057/165] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[69.673675] Starting subtest: addfb25-modifier-no-flag
[69.675657] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[69.979694] [058/165] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[70.018016] Starting subtest: addfb25-x-tiled-legacy
[70.020101] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[70.334343] [059/165] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[70.388547] Starting subtest: addfb25-x-tiled-mismatch-legacy
[70.390272] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[70.709321] [060/165] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[70.979233] Starting subtest: addfb25-yf-tiled-legacy
[70.981212] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[71.062419] [061/165] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.338280] Starting subtest: addfb25-y-tiled-legacy
[71.340628] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[71.429267] [062/165] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[71.728948] Starting subtest: addfb25-y-tiled-small-legacy
[71.731358] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[71.810299] [063/165] (919s left) kms_addfb_basic (bad-pitch-0)
[71.863450] Starting subtest: bad-pitch-0
[71.865352] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.228067] [064/165] (919s left) kms_addfb_basic (bad-pitch-1024)
[72.276053] Starting subtest: bad-pitch-1024
[72.277674] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.578463] [065/165] (919s left) kms_addfb_basic (bad-pitch-128)
[72.636309] Starting subtest: bad-pitch-128
[72.638549] Subtest bad-pitch-128: SUCCESS (0.000s)
[72.948122] [066/165] (918s left) kms_addfb_basic (bad-pitch-256)
[72.996282] Starting subtest: bad-pitch-256
[72.998080] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.294666] [067/165] (918s left) kms_addfb_basic (bad-pitch-32)
[73.348591] Starting subtest: bad-pitch-32
[73.350588] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.644151] [068/165] (918s left) kms_addfb_basic (bad-pitch-63)
[73.689088] Starting subtest: bad-pitch-63
[73.690996] Subtest bad-pitch-63: SUCCESS (0.000s)
[73.998531] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[74.052329] Starting subtest: bad-pitch-65536
[74.054256] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.361813] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[74.412316] Starting subtest: bad-pitch-999
[74.417132] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.707837] [071/165] (917s left) kms_addfb_basic (basic)
[74.744254] Starting subtest: basic
[74.746285] Subtest basic: SUCCESS (0.000s)
[75.161455] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[75.214761] Starting subtest: basic-x-tiled-legacy
[75.216702] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.509743] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.561529] Starting subtest: basic-y-tiled-legacy
[75.563315] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.883136] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[76.178366] Starting subtest: bo-too-small
[76.180874] Subtest bo-too-small: SUCCESS (0.000s)
[76.261455] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[76.536329] Starting subtest: bo-too-small-due-to-tiling
[76.538456] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[76.610050] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[76.670695] Starting subtest: clobberred-modifier
[76.672818] Subtest clobberred-modifier: SUCCESS (0.000s)
[76.978683] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[77.038013] Starting subtest: framebuffer-vs-set-tiling
[77.040100] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.347686] [078/165] (914s left) kms_addfb_basic (invalid-get-prop)
[77.404841] Starting subtest: invalid-get-prop
[77.406594] Subtest invalid-get-prop: SUCCESS (0.000s)
[77.710994] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[77.762625] Starting subtest: invalid-get-prop-any
[77.764497] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.096234] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[78.143783] Starting subtest: invalid-set-prop
[78.145899] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.453187] [081/165] (913s left) kms_addfb_basic (invalid-set-prop-any)
[78.503585] Starting subtest: invalid-set-prop-any
[78.505539] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[78.813545] [082/165] (913s left) kms_addfb_basic (no-handle)
[78.852857] Starting subtest: no-handle
[78.854722] Subtest no-handle: SUCCESS (0.000s)
[79.160867] [083/165] (913s left) kms_addfb_basic (size-max)
[79.424328] Starting subtest: size-max
[79.426571] Subtest size-max: SUCCESS (0.000s)
[79.513996] [084/165] (912s left) kms_addfb_basic (small-bo)
[79.781426] Starting subtest: small-bo
[79.783695] Subtest small-bo: SUCCESS (0.000s)
[79.862838] [085/165] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[79.910127] Starting subtest: tile-pitch-mismatch
[79.912214] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[80.206470] [086/165] (912s left) kms_addfb_basic (too-high)
[80.464910] Starting subtest: too-high
[80.466946] Subtest too-high: SUCCESS (0.000s)
[80.543697] [087/165] (911s left) kms_addfb_basic (too-wide)
[80.934885] Starting subtest: too-wide
[80.937210] Subtest too-wide: SUCCESS (0.000s)
[81.010214] [088/165] (911s left) kms_addfb_basic (unused-handle)
[81.054215] Starting subtest: unused-handle
[81.055884] Subtest unused-handle: SUCCESS (0.000s)
[81.353887] [089/165] (911s left) kms_addfb_basic (unused-modifier)
[81.411542] Starting subtest: unused-modifier
[81.413260] Subtest unused-modifier: SUCCESS (0.000s)
[81.710382] [090/165] (910s left) kms_addfb_basic (unused-offsets)
[81.761486] Starting subtest: unused-offsets
[81.763766] Subtest unused-offsets: SUCCESS (0.000s)
[82.095861] [091/165] (910s left) kms_addfb_basic (unused-pitches)
[82.155245] Starting subtest: unused-pitches
[82.157643] Subtest unused-pitches: SUCCESS (0.000s)
[82.455466] [092/165] (909s left) kms_busy (basic)
[82.756556] Starting subtest: basic
[82.758986] Starting dynamic subtest: flip
[83.332217] Dynamic subtest flip: SUCCESS (0.573s)
[83.338236] Starting dynamic subtest: modeset
[84.214819] Dynamic subtest modeset: SUCCESS (0.883s)
[84.216876] Subtest basic: SUCCESS (1.457s)
[84.437318] [093/165] (908s left) kms_prop_blob (basic)
[84.498955] Starting subtest: basic
[84.501135] Subtest basic: SUCCESS (0.000s)
[84.567348] [094/165] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[84.840494] Starting subtest: basic-busy-flip-before-cursor-atomic
[84.845023] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[84.918383] [095/165] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[85.181448] Starting subtest: basic-busy-flip-before-cursor-legacy
[85.186162] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[85.248910] [096/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[85.526476] Starting subtest: basic-flip-after-cursor-atomic
[86.524181] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.995s)
[86.723179] [097/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[86.986696] Starting subtest: basic-flip-after-cursor-legacy
[87.978753] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.989s)
[88.150445] [098/165] (904s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[88.431687] Starting subtest: basic-flip-after-cursor-varying-size
[89.427849] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.996s)
[89.608614] [099/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[89.884987] Starting subtest: basic-flip-before-cursor-atomic
[90.878670] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.990s)
[91.071487] [100/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[91.345037] Starting subtest: basic-flip-before-cursor-legacy
[92.343554] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.996s)
[92.535866] [101/165] (900s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[92.817498] Starting subtest: basic-flip-before-cursor-varying-size
[93.797200] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.982s)
[93.992569] [102/165] (898s left) kms_dsc (dsc-basic)
[94.280797] Subtest dsc-basic: SKIP (0.000s)
[94.303637] [103/165] (898s left) kms_flip (basic-flip-vs-dpms)
[94.582947] Starting subtest: basic-flip-vs-dpms
[94.585479] Starting dynamic subtest: A-DP2
[95.372322] Dynamic subtest A-DP2: SUCCESS (0.787s)
[95.379610] Starting dynamic subtest: B-DP2
[96.199694] Dynamic subtest B-DP2: SUCCESS (0.824s)
[96.205643] Starting dynamic subtest: C-DP2
[97.024619] Dynamic subtest C-DP2: SUCCESS (0.826s)
[97.031783] Starting dynamic subtest: D-DP2
[97.849182] Dynamic subtest D-DP2: SUCCESS (0.823s)
[97.851542] Subtest basic-flip-vs-dpms: SUCCESS (3.270s)
[98.047640] [104/165] (894s left) kms_flip (basic-flip-vs-modeset)
[98.384849] Starting subtest: basic-flip-vs-modeset
[98.387195] Starting dynamic subtest: A-DP2
[99.197741] Dynamic subtest A-DP2: SUCCESS (0.809s)
[99.203994] Starting dynamic subtest: B-DP2
[100.021495] Dynamic subtest B-DP2: SUCCESS (0.821s)
[100.027049] Starting dynamic subtest: C-DP2
[100.836169] Dynamic subtest C-DP2: SUCCESS (0.818s)
[100.842614] Starting dynamic subtest: D-DP2
[101.661147] Dynamic subtest D-DP2: SUCCESS (0.823s)
[101.665602] Subtest basic-flip-vs-modeset: SUCCESS (3.282s)
[101.835860] [105/165] (890s left) kms_flip (basic-flip-vs-wf_vblank)
[102.112121] Starting subtest: basic-flip-vs-wf_vblank
[102.116901] Starting dynamic subtest: A-DP2
[103.202524] Dynamic subtest A-DP2: SUCCESS (1.086s)
[103.218588] Starting dynamic subtest: B-DP2
[104.251029] Dynamic subtest B-DP2: SUCCESS (1.047s)
[104.266387] Starting dynamic subtest: C-DP2
[105.307432] Dynamic subtest C-DP2: SUCCESS (1.054s)
[105.323389] Starting dynamic subtest: D-DP2
[106.363274] Dynamic subtest D-DP2: SUCCESS (1.053s)
[106.373095] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.262s)
[106.612360] [106/165] (886s left) kms_flip (basic-plain-flip)
[106.887529] Starting subtest: basic-plain-flip
[106.890290] Starting dynamic subtest: A-DP2
[107.702900] Dynamic subtest A-DP2: SUCCESS (0.809s)
[107.717344] Starting dynamic subtest: B-DP2
[108.468703] Dynamic subtest B-DP2: SUCCESS (0.767s)
[108.483668] Starting dynamic subtest: C-DP2
[109.242282] Dynamic subtest C-DP2: SUCCESS (0.771s)
[109.258957] Starting dynamic subtest: D-DP2
[110.013885] Dynamic subtest D-DP2: SUCCESS (0.769s)
[110.023852] Subtest basic-plain-flip: SUCCESS (3.139s)
[110.285382] [107/165] (882s left) kms_force_connector_basic (force-connector-state)
[110.513938] Starting subtest: force-connector-state
[110.922338] Subtest force-connector-state: SUCCESS (0.410s)
[111.688385] [108/165] (881s left) kms_force_connector_basic (force-edid)
[111.891016] Starting subtest: force-edid
[111.908710] Subtest force-edid: SUCCESS (0.020s)
[112.488427] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[112.699934] Starting subtest: force-load-detect
[112.703841] Subtest force-load-detect: SKIP (0.000s)
[113.266224] [110/165] (879s left) kms_force_connector_basic (prune-stale-modes)
[113.495367] Starting subtest: prune-stale-modes
[113.510985] Subtest prune-stale-modes: SUCCESS (0.019s)
[114.091418] [111/165] (878s left) kms_frontbuffer_tracking (basic)
[114.362474] Starting subtest: basic
[117.794852] Subtest basic: SUCCESS (3.436s)
[117.913521] [112/165] (874s left) kms_hdmi_inject (inject-audio)
[118.064202] Starting subtest: inject-audio
[118.163578] Subtest inject-audio: SUCCESS (0.097s)
[118.550646] [113/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[118.825780] Starting subtest: compare-crc-sanitycheck-xr24
[118.827843] Starting dynamic subtest: pipe-A-DP-2
[119.270447] Dynamic subtest pipe-A-DP-2: SUCCESS (0.446s)
[119.277405] Starting dynamic subtest: pipe-B-DP-2
[119.689480] Dynamic subtest pipe-B-DP-2: SUCCESS (0.414s)
[119.695578] Starting dynamic subtest: pipe-C-DP-2
[120.107314] Dynamic subtest pipe-C-DP-2: SUCCESS (0.417s)
[120.114480] Starting dynamic subtest: pipe-D-DP-2
[120.529996] Dynamic subtest pipe-D-DP-2: SUCCESS (0.421s)
[120.532058] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.706s)
[120.733376] [114/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[121.010204] Starting subtest: compare-crc-sanitycheck-nv12
[121.012091] Starting dynamic subtest: pipe-A-DP-2
[121.561924] Dynamic subtest pipe-A-DP-2: SUCCESS (0.553s)
[121.569252] Starting dynamic subtest: pipe-B-DP-2
[122.086946] Dynamic subtest pipe-B-DP-2: SUCCESS (0.523s)
[122.093790] Starting dynamic subtest: pipe-C-DP-2
[122.616262] Dynamic subtest pipe-C-DP-2: SUCCESS (0.527s)
[122.625353] Starting dynamic subtest: pipe-D-DP-2
[123.149370] Dynamic subtest pipe-D-DP-2: SUCCESS (0.531s)
[123.152050] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.142s)
[123.332522] [115/165] (869s left) kms_pipe_crc_basic (hang-read-crc)
[123.599389] Starting subtest: hang-read-crc
[123.602250] Starting dynamic subtest: pipe-A-DP-2
[124.862676] Dynamic subtest pipe-A-DP-2: SUCCESS (1.263s)
[124.875331] Starting dynamic subtest: pipe-B-DP-2
[126.050315] Dynamic subtest pipe-B-DP-2: SUCCESS (1.188s)
[126.057317] Starting dynamic subtest: pipe-C-DP-2
[127.225222] Dynamic subtest pipe-C-DP-2: SUCCESS (1.171s)
[127.236521] Starting dynamic subtest: pipe-D-DP-2
[128.427715] Dynamic subtest pipe-D-DP-2: SUCCESS (1.200s)
[128.430073] Subtest hang-read-crc: SUCCESS (4.830s)
[128.596135] [116/165] (864s left) kms_pipe_crc_basic (nonblocking-crc)
[128.908808] Starting subtest: nonblocking-crc
[128.910810] Starting dynamic subtest: pipe-A-DP-2
[129.564426] Dynamic subtest pipe-A-DP-2: SUCCESS (0.655s)
[129.570916] Starting dynamic subtest: pipe-B-DP-2
[130.192778] Dynamic subtest pipe-B-DP-2: SUCCESS (0.627s)
[130.199497] Starting dynamic subtest: pipe-C-DP-2
[130.812069] Dynamic subtest pipe-C-DP-2: SUCCESS (0.616s)
[130.823766] Starting dynamic subtest: pipe-D-DP-2
[131.411439] Dynamic subtest pipe-D-DP-2: SUCCESS (0.599s)
[131.413909] Subtest nonblocking-crc: SUCCESS (2.505s)
[131.581359] [117/165] (861s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[131.863520] Starting subtest: nonblocking-crc-frame-sequence
[131.865869] Starting dynamic subtest: pipe-A-DP-2
[132.511357] Dynamic subtest pipe-A-DP-2: SUCCESS (0.650s)
[132.518279] Starting dynamic subtest: pipe-B-DP-2
[133.125057] Dynamic subtest pipe-B-DP-2: SUCCESS (0.609s)
[133.135810] Starting dynamic subtest: pipe-C-DP-2
[133.741414] Dynamic subtest pipe-C-DP-2: SUCCESS (0.617s)
[133.748533] Starting dynamic subtest: pipe-D-DP-2
[134.360778] Dynamic subtest pipe-D-DP-2: SUCCESS (0.616s)
[134.363288] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.500s)
[134.538643] [118/165] (858s left) kms_pipe_crc_basic (read-crc)
[134.847808] Starting subtest: read-crc
[134.850356] Starting dynamic subtest: pipe-A-DP-2
[135.437408] Dynamic subtest pipe-A-DP-2: SUCCESS (0.585s)
[135.445223] Starting dynamic subtest: pipe-B-DP-2
[135.999975] Dynamic subtest pipe-B-DP-2: SUCCESS (0.561s)
[136.006720] Starting dynamic subtest: pipe-C-DP-2
[136.545929] Dynamic subtest pipe-C-DP-2: SUCCESS (0.544s)
[136.552732] Starting dynamic subtest: pipe-D-DP-2
[137.094693] Dynamic subtest pipe-D-DP-2: SUCCESS (0.548s)
[137.097125] Subtest read-crc: SUCCESS (2.246s)
[137.265509] [119/165] (855s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[137.544862] Starting subtest: read-crc-frame-sequence
[137.547586] Starting dynamic subtest: pipe-A-DP-2
[138.115628] Dynamic subtest pipe-A-DP-2: SUCCESS (0.568s)
[138.122058] Starting dynamic subtest: pipe-B-DP-2
[138.677616] Dynamic subtest pipe-B-DP-2: SUCCESS (0.560s)
[138.688087] Starting dynamic subtest: pipe-C-DP-2
[139.230974] Dynamic subtest pipe-C-DP-2: SUCCESS (0.551s)
[139.237684] Starting dynamic subtest: pipe-D-DP-2
[139.764160] Dynamic subtest pipe-D-DP-2: SUCCESS (0.531s)
[139.766594] Subtest read-crc-frame-sequence: SUCCESS (2.217s)
[139.933687] [120/165] (853s left) kms_pm_backlight (basic-brightness)
[140.207799] Subtest basic-brightness: SKIP (0.000s)
[140.246632] [121/165] (852s left) kms_pm_rpm (basic-pci-d3-state)
[142.069895] Starting subtest: basic-pci-d3-state
[142.527768] Subtest basic-pci-d3-state: SUCCESS (0.456s)
[142.769440] [122/165] (850s left) kms_pm_rpm (basic-rte)
[142.818031] Starting subtest: basic-rte
[144.999778] Subtest basic-rte: SUCCESS (2.181s)
[145.885187] [123/165] (847s left) kms_psr (psr-primary-page-flip)
[146.172672] Subtest psr-primary-page-flip: SKIP (0.000s)
[146.189941] [124/165] (847s left) kms_psr (psr-cursor-plane-move)
[146.501179] Subtest psr-cursor-plane-move: SKIP (0.000s)
[146.525377] [125/165] (846s left) kms_psr (psr-sprite-plane-onoff)
[146.798362] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[146.830161] [126/165] (846s left) kms_psr (psr-primary-mmap-gtt)
[147.150674] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[147.174583] [127/165] (846s left) kms_setmode (basic-clone-single-crtc)
[147.215071] Starting subtest: basic-clone-single-crtc
[147.220832] Subtest basic-clone-single-crtc: SKIP (0.000s)
[147.295698] [128/165] (845s left) i915_pm_rps (basic-api)
[147.337210] Starting subtest: basic-api
[147.339324] Subtest basic-api: SUCCESS (0.002s)
[147.415912] [129/165] (845s left) prime_self_import (basic-llseek-bad)
[147.468628] Starting subtest: basic-llseek-bad
[147.472790] Subtest basic-llseek-bad: SUCCESS (0.001s)
[147.545718] [130/165] (845s left) prime_self_import (basic-llseek-size)
[147.599726] Starting subtest: basic-llseek-size
[147.603542] Subtest basic-llseek-size: SUCCESS (0.001s)
[147.702555] [131/165] (845s left) prime_self_import (basic-with_fd_dup)
[147.750634] Starting subtest: basic-with_fd_dup
[147.754943] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[147.860054] [132/165] (845s left) prime_self_import (basic-with_one_bo)
[147.895907] Starting subtest: basic-with_one_bo
[147.900434] Subtest basic-with_one_bo: SUCCESS (0.002s)
[147.954245] [133/165] (845s left) prime_self_import (basic-with_one_bo_two_files)
[147.998173] Starting subtest: basic-with_one_bo_two_files
[148.002179] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[148.102349] [134/165] (845s left) prime_self_import (basic-with_two_bos)
[148.148263] Starting subtest: basic-with_two_bos
[148.152396] Subtest basic-with_two_bos: SUCCESS (0.002s)
[148.250768] [135/165] (845s left) prime_vgem (basic-fence-flip)
[148.302155] Starting subtest: basic-fence-flip
[148.965565] Subtest basic-fence-flip: SUCCESS (0.662s)
[149.068169] [136/165] (844s left) prime_vgem (basic-fence-mmap)
[149.121519] Starting subtest: basic-fence-mmap
[149.157481] Subtest basic-fence-mmap: SUCCESS (0.036s)
[149.231254] [137/165] (844s left) prime_vgem (basic-fence-read)
[149.313836] Starting subtest: basic-fence-read
[149.322522] Subtest basic-fence-read: SKIP (0.006s)
[149.437628] [138/165] (844s left) prime_vgem (basic-gtt)
[149.506575] Starting subtest: basic-gtt
[149.516423] Subtest basic-gtt: SUCCESS (0.011s)
[149.613214] [139/165] (843s left) prime_vgem (basic-read)
[149.671142] Starting subtest: basic-read
[149.676537] Subtest basic-read: SKIP (0.003s)
[149.786845] [140/165] (843s left) prime_vgem (basic-write)
[149.836565] Starting subtest: basic-write
[149.844051] Subtest basic-write: SKIP (0.004s)
[149.953161] [141/165] (843s left) vgem_basic (setversion)
[150.000368] Starting subtest: setversion
[150.004073] Subtest setversion: SUCCESS (0.000s)
[150.064408] [142/165] (843s left) vgem_basic (create)
[150.136656] Starting subtest: create
[150.139418] Subtest create: SUCCESS (0.001s)
[150.199958] [143/165] (843s left) vgem_basic (debugfs)
[150.267059] Starting subtest: debugfs
[150.269097] Subtest debugfs: SUCCESS (0.000s)
[150.332520] [144/165] (843s left) vgem_basic (dmabuf-export)
[150.383892] Starting subtest: dmabuf-export
[150.397856] Subtest dmabuf-export: SUCCESS (0.013s)
[150.504274] [145/165] (843s left) vgem_basic (dmabuf-fence)
[150.567090] Starting subtest: dmabuf-fence
[150.568800] Subtest dmabuf-fence: SUCCESS (0.000s)
[150.626759] [146/165] (843s left) vgem_basic (dmabuf-fence-before)
[150.683673] Starting subtest: dmabuf-fence-before
[150.685775] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[150.750845] [147/165] (843s left) vgem_basic (dmabuf-mmap)
[150.817053] Starting subtest: dmabuf-mmap
[150.830247] Subtest dmabuf-mmap: SUCCESS (0.015s)
[150.898884] [148/165] (842s left) vgem_basic (mmap)
[150.951469] Starting subtest: mmap
[150.958570] Subtest mmap: SUCCESS (0.009s)
[151.009291] [149/165] (842s left) vgem_basic (second-client)
[151.067964] Starting subtest: second-client
[151.102356] Subtest second-client: SUCCESS (0.033s)
[151.168941] [150/165] (842s left) vgem_basic (sysfs)
[151.216637] Starting subtest: sysfs
[151.218228] Subtest sysfs: SUCCESS (0.000s)
[151.277491] [151/165] (842s left) core_hotunplug (unbind-rebind)
[151.348576] Starting subtest: unbind-rebind
[155.468050] Subtest unbind-rebind: SUCCESS (4.118s)
[155.487102] [152/165] (838s left) vgem_basic (unload)
[155.525109] Starting subtest: unload
[184.508753] Subtest unload: SUCCESS (28.932s)
[184.573355] [153/165] (809s left) i915_module_load (reload)
[184.628461] Starting subtest: reload
[187.553977] Subtest reload: SUCCESS (2.930s)
[187.586989] [154/165] (806s left) gem_lmem_swapping (basic)
[187.634081] Subtest basic: SKIP (0.000s)
[187.661903] [155/165] (806s left) gem_lmem_swapping (parallel-random-engines)
[187.703594] Subtest parallel-random-engines: SKIP (0.000s)
[187.732220] [156/165] (806s left) gem_lmem_swapping (random-engines)
[187.793397] Subtest random-engines: SKIP (0.000s)
[187.816412] [157/165] (806s left) gem_lmem_swapping (verify-random)
[187.878993] Subtest verify-random: SKIP (0.000s)
[187.899153] [158/165] (806s left) i915_pm_rpm (module-reload)
[189.930467] Starting subtest: module-reload
[198.737630] Subtest module-reload: SUCCESS (8.807s)
[198.761841] [159/165] (795s left) i915_selftest (live)
[198.823340] Starting subtest: live
[198.825322] Starting dynamic subtest: sanitycheck
[200.545092] Dynamic subtest sanitycheck: SUCCESS (1.721s)
[200.551261] Starting dynamic subtest: uncore
[202.257209] Dynamic subtest uncore: SUCCESS (1.710s)
[202.263439] Starting dynamic subtest: workarounds
[204.236656] Dynamic subtest workarounds: SUCCESS (1.977s)
[204.247464] Starting dynamic subtest: gt_engines
[206.469136] Dynamic subtest gt_engines: SUCCESS (2.231s)
[206.478680] Starting dynamic subtest: gt_timelines
[214.644731] Dynamic subtest gt_timelines: SUCCESS (8.174s)
[214.653943] Starting dynamic subtest: gt_contexts
[216.411147] Dynamic subtest gt_contexts: SUCCESS (1.764s)
[216.421021] Starting dynamic subtest: gt_lrc
[220.980282] Dynamic subtest gt_lrc: SUCCESS (4.567s)
[220.989829] Starting dynamic subtest: gt_mocs
[222.828205] Dynamic subtest gt_mocs: SUCCESS (1.846s)
[222.839403] Starting dynamic subtest: gt_pm
[242.616862] Dynamic subtest gt_pm: SUCCESS (19.787s)
[242.625556] Starting dynamic subtest: gt_heartbeat
[244.434191] Dynamic subtest gt_heartbeat: SUCCESS (1.815s)
[244.439934] Starting dynamic subtest: gt_tlb
[247.604986] Dynamic subtest gt_tlb: SUCCESS (3.169s)
[247.614566] Starting dynamic subtest: requests
[256.623978] Dynamic subtest requests: SUCCESS (9.017s)
[256.633705] Starting dynamic subtest: migrate
[261.717188] Dynamic subtest migrate: SUCCESS (5.091s)
[261.725579] Starting dynamic subtest: active
[263.458533] Dynamic subtest active: SUCCESS (1.739s)
[263.468878] Starting dynamic subtest: objects
[265.814397] Dynamic subtest objects: SUCCESS (2.355s)
[265.821546] Starting dynamic subtest: mman
[271.122869] Dynamic subtest mman: SUCCESS (5.306s)
[271.133943] Starting dynamic subtest: dmabuf
[272.908204] Dynamic subtest dmabuf: SUCCESS (1.783s)
[272.917387] Starting dynamic subtest: vma
[274.606337] Dynamic subtest vma: SUCCESS (1.696s)
[274.616546] Starting dynamic subtest: coherency
[278.048805] Dynamic subtest coherency: SUCCESS (3.440s)
[278.058769] Starting dynamic subtest: gtt
[287.430050] Dynamic subtest gtt: SUCCESS (9.379s)
[287.439206] Starting dynamic subtest: gem
[289.235049] Dynamic subtest gem: SUCCESS (1.803s)
[289.244866] Starting dynamic subtest: evict
[291.623212] Dynamic subtest evict: SUCCESS (2.386s)
[291.632921] Starting dynamic subtest: hugepages
[299.818232] Dynamic subtest hugepages: SUCCESS (8.193s)
[299.828247] Starting dynamic subtest: gem_contexts
[314.781695] Dynamic subtest gem_contexts: SUCCESS (14.960s)
[314.790907] Starting dynamic subtest: client
[316.506740] Dynamic subtest client: SUCCESS (1.725s)
[316.516291] Starting dynamic subtest: gem_migrate
[318.195181] Dynamic subtest gem_migrate: SUCCESS (1.686s)
[318.205623] Starting dynamic subtest: reset
[322.451193] Dynamic subtest reset: SUCCESS (4.254s)
[322.461513] Starting dynamic subtest: memory_region
[324.155246] Dynamic subtest memory_region: SUCCESS (1.702s)
[324.165088] Starting dynamic subtest: hangcheck
[354.533177] Dynamic subtest hangcheck: SUCCESS (30.376s)
[354.545183] Starting dynamic subtest: execlists
[367.994470] Dynamic subtest execlists: SUCCESS (13.458s)
[368.004052] Starting dynamic subtest: ring_submission
[369.694091] Dynamic subtest ring_submission: SUCCESS (1.699s)
[369.703175] Starting dynamic subtest: perf
[371.453074] Dynamic subtest perf: SUCCESS (1.757s)
[371.459048] Starting dynamic subtest: slpc
[373.174683] Dynamic subtest slpc: SUCCESS (1.719s)
[373.187809] Starting dynamic subtest: guc
[374.896051] Dynamic subtest guc: SUCCESS (1.720s)
[374.905133] Starting dynamic subtest: guc_multi_lrc
[376.599273] Dynamic subtest guc_multi_lrc: SUCCESS (1.701s)
[376.609588] Starting dynamic subtest: guc_hang
[378.315471] Dynamic subtest guc_hang: SUCCESS (1.714s)
[378.325291] Starting dynamic subtest: late_gt_pm
[380.024885] Dynamic subtest late_gt_pm: SUCCESS (1.706s)
[380.028543] Subtest live: SUCCESS (181.200s)
[380.053383] [160/165] (614s left) dmabuf (all-tests)
[380.101706] Starting subtest: all-tests
[380.103829] Starting dynamic subtest: sanitycheck
[380.164166] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[380.174592] Starting dynamic subtest: dma_fence
[380.341942] Dynamic subtest dma_fence: SUCCESS (0.176s)
[380.355627] Starting dynamic subtest: dma_fence_chain
[390.504380] Dynamic subtest dma_fence_chain: SUCCESS (10.161s)
[390.513301] Starting dynamic subtest: dma_fence_unwrap
[390.574992] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[390.591518] Starting dynamic subtest: dma_resv
[390.647837] Dynamic subtest dma_resv: SUCCESS (0.071s)
[390.651165] Subtest all-tests: SUCCESS (10.549s)
[390.682862] [161/165] (603s left) i915_suspend (basic-s2idle-without-i915)
[390.730141] Starting subtest: basic-s2idle-without-i915
[411.535974] Subtest basic-s2idle-without-i915: SUCCESS (7.607s)
[411.724178] [162/165] (595s left) i915_suspend (basic-s3-without-i915)
[411.789142] Starting subtest: basic-s3-without-i915
[433.993913] Subtest basic-s3-without-i915: SUCCESS (4.924s)
[434.185570] [163/165] (590s left) gem_exec_suspend (basic-s0)
[434.230998] Starting subtest: basic-S0
[434.232978] Starting dynamic subtest: smem
[452.224064] Dynamic subtest smem: SUCCESS (3.888s)
[452.227285] Subtest basic-S0: SUCCESS (3.888s)
[452.382749] [164/165] (586s left) gem_exec_suspend (basic-s3)
[452.432869] Starting subtest: basic-S3
[452.435673] Starting dynamic subtest: smem
[472.557458] Dynamic subtest smem: SUCCESS (3.380s)
[472.560137] Subtest basic-S3: SUCCESS (3.381s)
[472.716090] [165/165] (582s left) kms_pipe_crc_basic (suspend-read-crc)
[473.009688] Starting subtest: suspend-read-crc
[473.012691] Starting dynamic subtest: pipe-A-DP-2
[493.826081] Dynamic subtest pipe-A-DP-2: SUCCESS (3.526s)
[493.837120] Starting dynamic subtest: pipe-B-DP-2
[514.836108] Dynamic subtest pipe-B-DP-2: SUCCESS (3.550s)
[514.844403] Starting dynamic subtest: pipe-C-DP-2
[535.787127] Dynamic subtest pipe-C-DP-2: SUCCESS (3.482s)
[535.795229] Starting dynamic subtest: pipe-D-DP-2
[556.768166] Dynamic subtest pipe-D-DP-2: SUCCESS (3.403s)
[556.770720] Subtest suspend-read-crc: SUCCESS (13.969s)
[556.902426] Closing watchdogs
Done.