[33.903095] Initializing watchdogs
[33.903135]   /dev/watchdog0
[33.906714] [001/165] (960s left) i915_module_load (load)
[33.934042] Starting subtest: load
[35.849677] Subtest load: SUCCESS (1.915s)
[35.857471] [002/165] (958s left) core_auth (basic-auth)
[35.902312] Starting subtest: basic-auth
[35.903534] Subtest basic-auth: SUCCESS (0.000s)
[35.986358] [003/165] (958s left) debugfs_test (read_all_entries)
[36.013048] Starting subtest: read_all_entries
[36.151497] Subtest read_all_entries: SUCCESS (0.138s)
[36.401655] [004/165] (958s left) debugfs_test (basic-hwmon)
[36.430994] Starting subtest: basic-hwmon
[36.435518] Subtest basic-hwmon: SKIP (0.000s)
[36.686261] [005/165] (957s left) fbdev (eof)
[36.733672] Starting subtest: eof
[36.734814] Subtest eof: SUCCESS (0.000s)
[36.781786] [006/165] (957s left) fbdev (info)
[36.816471] Starting subtest: info
[36.817371] Subtest info: SUCCESS (0.000s)
[36.882147] [007/165] (957s left) fbdev (nullptr)
[36.916771] Starting subtest: nullptr
[36.917700] Subtest nullptr: SUCCESS (0.000s)
[36.963804] [008/165] (957s left) fbdev (read)
[36.999926] Starting subtest: read
[39.524096] Subtest read: SUCCESS (2.515s)
[39.564794] [009/165] (954s left) fbdev (write)
[39.600060] Starting subtest: write
[41.473075] Subtest write: SUCCESS (1.864s)
[41.514992] [010/165] (952s left) gem_basic (bad-close)
[41.540510] Starting subtest: bad-close
[41.541906] Subtest bad-close: SUCCESS (0.000s)
[41.600963] [011/165] (952s left) gem_basic (create-close)
[41.629985] Starting subtest: create-close
[41.631448] Subtest create-close: SUCCESS (0.000s)
[41.701258] [012/165] (952s left) gem_basic (create-fd-close)
[41.730910] Starting subtest: create-fd-close
[41.732502] Subtest create-fd-close: SUCCESS (0.000s)
[41.824259] [013/165] (952s left) gem_busy (busy@all-engines)
[41.865372] Starting subtest: busy
[41.866297] Starting dynamic subtest: all-engines
[41.884216] Dynamic subtest all-engines: SUCCESS (0.022s)
[41.885289] Subtest busy: SUCCESS (0.022s)
[42.203231] [014/165] (952s left) gem_close_race (basic-process)
[42.235906] Starting subtest: basic-process
[42.275186] Subtest basic-process: SUCCESS (0.039s)
[42.462601] [015/165] (952s left) gem_close_race (basic-threads)
[42.498504] Starting subtest: basic-threads
[43.730165] Subtest basic-threads: SUCCESS (1.231s)
[43.902820] [016/165] (950s left) gem_ctx_create (basic)
[43.934971] Starting subtest: basic
[43.935963] Subtest basic: SUCCESS (0.000s)
[44.103812] [017/165] (950s left) gem_ctx_create (basic-files)
[44.135530] Starting subtest: basic-files
[46.145876] Subtest basic-files: SUCCESS (2.011s)
[46.558073] [018/165] (948s left) gem_ctx_exec (basic)
[46.588630] Starting subtest: basic
[46.590442] Subtest basic: SUCCESS (0.001s)
[46.688283] [019/165] (947s left) gem_exec_basic (basic)
[46.728195] Starting subtest: basic
[46.729145] Starting dynamic subtest: rcs0-smem
[46.730023] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[46.734870] Starting dynamic subtest: bcs0-smem
[46.735873] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[46.740511] Starting dynamic subtest: vcs0-smem
[46.741223] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.745067] Starting dynamic subtest: vcs1-smem
[46.745855] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[46.749262] Starting dynamic subtest: vecs0-smem
[46.749932] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[46.750670] Subtest basic: SUCCESS (0.002s)
[46.886300] [020/165] (947s left) gem_exec_create (basic)
[46.932280] Starting subtest: basic
[46.933143] Starting dynamic subtest: smem
[49.008458] Dynamic subtest smem: SUCCESS (2.088s)
[49.009900] Subtest basic: SUCCESS (2.089s)
[49.190437] [021/165] (945s left) gem_exec_fence (basic-busy)
[49.362133] Starting subtest: basic-busy
[49.363330] Starting dynamic subtest: rcs0
[49.406684] Dynamic subtest rcs0: SUCCESS (0.052s)
[49.415128] Starting dynamic subtest: bcs0
[49.453156] Dynamic subtest bcs0: SUCCESS (0.047s)
[49.460330] Starting dynamic subtest: vcs0
[49.508410] Dynamic subtest vcs0: SUCCESS (0.055s)
[49.517335] Starting dynamic subtest: vcs1
[49.555352] Dynamic subtest vcs1: SUCCESS (0.047s)
[49.567484] Starting dynamic subtest: vecs0
[49.604051] Dynamic subtest vecs0: SUCCESS (0.048s)
[49.605894] Subtest basic-busy: SUCCESS (0.250s)
[50.095298] [022/165] (944s left) gem_exec_fence (basic-wait)
[50.247316] Starting subtest: basic-wait
[50.248530] Starting dynamic subtest: rcs0
[50.305712] Dynamic subtest rcs0: SUCCESS (0.067s)
[50.313831] Starting dynamic subtest: bcs0
[50.353163] Dynamic subtest bcs0: SUCCESS (0.047s)
[50.365672] Starting dynamic subtest: vcs0
[50.399931] Dynamic subtest vcs0: SUCCESS (0.047s)
[50.411977] Starting dynamic subtest: vcs1
[50.446966] Dynamic subtest vcs1: SUCCESS (0.047s)
[50.459203] Starting dynamic subtest: vecs0
[50.494094] Dynamic subtest vecs0: SUCCESS (0.047s)
[50.495885] Subtest basic-wait: SUCCESS (0.256s)
[50.956233] [023/165] (943s left) gem_exec_fence (basic-await)
[51.113881] Starting subtest: basic-await
[51.114801] Starting dynamic subtest: rcs0
[51.176789] Dynamic subtest rcs0: SUCCESS (0.072s)
[51.183116] Starting dynamic subtest: bcs0
[51.247556] Dynamic subtest bcs0: SUCCESS (0.070s)
[51.253995] Starting dynamic subtest: vcs0
[51.318161] Dynamic subtest vcs0: SUCCESS (0.070s)
[51.326575] Starting dynamic subtest: vcs1
[51.391187] Dynamic subtest vcs1: SUCCESS (0.073s)
[51.400027] Starting dynamic subtest: vecs0
[51.464500] Dynamic subtest vecs0: SUCCESS (0.072s)
[51.466220] Subtest basic-await: SUCCESS (0.359s)
[51.923228] [024/165] (942s left) gem_exec_fence (nb-await)
[52.084659] Starting subtest: nb-await
[52.085760] Starting dynamic subtest: rcs0
[52.134464] Dynamic subtest rcs0: SUCCESS (0.058s)
[52.143132] Starting dynamic subtest: bcs0
[52.193504] Dynamic subtest bcs0: SUCCESS (0.059s)
[52.205964] Starting dynamic subtest: vcs0
[52.255079] Dynamic subtest vcs0: SUCCESS (0.061s)
[52.261047] Starting dynamic subtest: vcs1
[52.313794] Dynamic subtest vcs1: SUCCESS (0.058s)
[52.325115] Starting dynamic subtest: vecs0
[52.374292] Dynamic subtest vecs0: SUCCESS (0.060s)
[52.376324] Subtest nb-await: SUCCESS (0.298s)
[52.842969] [025/165] (941s left) gem_exec_gttfill (basic)
[52.878996] Starting subtest: basic
[54.978421] Subtest basic: SUCCESS (2.099s)
[55.150090] [026/165] (939s left) gem_exec_parallel (engines)
[55.211364] Starting subtest: engines
[55.212144] Starting dynamic subtest: basic
[56.518441] Dynamic subtest basic: SUCCESS (1.306s)
[56.525172] Starting dynamic subtest: contexts
[58.154703] Dynamic subtest contexts: SUCCESS (1.627s)
[58.158696] Starting dynamic subtest: fds
[59.997095] Dynamic subtest fds: SUCCESS (1.851s)
[60.001515] Starting dynamic subtest: userptr
[61.273361] Dynamic subtest userptr: SUCCESS (1.275s)
[61.275081] Subtest engines: SUCCESS (6.061s)
[61.463181] [027/165] (933s left) gem_exec_store (basic)
[61.495859] Starting subtest: basic
[61.553483] Subtest basic: SUCCESS (0.056s)
[61.722266] [028/165] (932s left) gem_flink_basic (bad-flink)
[61.749136] Starting subtest: bad-flink
[61.749935] Subtest bad-flink: SUCCESS (0.000s)
[61.804751] [029/165] (932s left) gem_flink_basic (bad-open)
[61.833738] Starting subtest: bad-open
[61.834554] Subtest bad-open: SUCCESS (0.000s)
[61.884712] [030/165] (932s left) gem_flink_basic (basic)
[61.916311] Starting subtest: basic
[61.917029] Subtest basic: SUCCESS (0.000s)
[61.988681] [031/165] (932s left) gem_flink_basic (double-flink)
[62.023501] Starting subtest: double-flink
[62.024308] Subtest double-flink: SUCCESS (0.000s)
[62.104231] [032/165] (932s left) gem_flink_basic (flink-lifetime)
[62.131196] Starting subtest: flink-lifetime
[62.132177] Subtest flink-lifetime: SUCCESS (0.001s)
[62.221139] [033/165] (932s left) gem_huc_copy (huc-copy)
[62.248698] Starting subtest: huc-copy
[62.250356] Subtest huc-copy: SUCCESS (0.002s)
[62.358779] [034/165] (932s left) gem_linear_blits (basic)
[62.448016] Starting subtest: basic
[62.451241] Subtest basic: SUCCESS (0.003s)
[62.568744] [035/165] (932s left) gem_mmap (basic)
[62.634595] Starting subtest: basic
[62.638688] Subtest basic: SUCCESS (0.000s)
[62.722222] [036/165] (932s left) gem_mmap_gtt (basic)
[62.764015] Starting subtest: basic
[62.764998] Subtest basic: SUCCESS (0.000s)
[62.808688] [037/165] (931s left) gem_render_linear_blits (basic)
[62.845142] Starting subtest: basic
[62.858976] Subtest basic: SUCCESS (0.014s)
[62.928428] [038/165] (931s left) gem_render_tiled_blits (basic)
[62.959275] Starting subtest: basic
[62.977191] Subtest basic: SUCCESS (0.018s)
[63.040581] [039/165] (931s left) gem_ringfill (basic-all)
[63.354460] Starting subtest: basic-all
[64.491090] Subtest basic-all: SUCCESS (1.129s)
[64.582305] [040/165] (930s left) gem_softpin (allocator-basic)
[64.613788] Starting subtest: allocator-basic
[64.657187] Subtest allocator-basic: SUCCESS (0.043s)
[64.772370] [041/165] (930s left) gem_softpin (allocator-basic-reserve)
[64.803916] Starting subtest: allocator-basic-reserve
[64.848930] Subtest allocator-basic-reserve: SUCCESS (0.047s)
[64.956537] [042/165] (929s left) gem_softpin (safe-alignment)
[64.991444] Starting subtest: safe-alignment
[64.998346] Subtest safe-alignment: SUCCESS (0.006s)
[65.089352] [043/165] (929s left) gem_sync (basic-all)
[65.126356] Starting subtest: basic-all
[67.501736] Subtest basic-all: SUCCESS (2.374s)
[67.673697] [044/165] (927s left) gem_sync (basic-each)
[67.709203] Starting subtest: basic-each
[70.015071] Subtest basic-each: SUCCESS (2.306s)
[70.190713] [045/165] (924s left) gem_tiled_blits (basic)
[70.274608] Starting subtest: basic
[70.283863] Subtest basic: SUCCESS (0.009s)
[70.402901] [046/165] (924s left) gem_tiled_fence_blits (basic)
[70.514205] Starting subtest: basic
[70.533230] Subtest basic: SUCCESS (0.019s)
[70.631485] [047/165] (924s left) gem_tiled_pread_basic
[70.723977] [048/165] (924s left) gem_wait (busy@all-engines)
[70.758775] Starting subtest: busy
[70.759416] Starting dynamic subtest: all-engines
[71.307660] Dynamic subtest all-engines: SUCCESS (0.548s)
[71.309092] Subtest busy: SUCCESS (0.548s)
[71.508270] [049/165] (923s left) gem_wait (wait@all-engines)
[71.539208] Starting subtest: wait
[71.539869] Starting dynamic subtest: all-engines
[72.593253] Dynamic subtest all-engines: SUCCESS (1.053s)
[72.598621] Subtest wait: SUCCESS (1.053s)
[72.790686] [050/165] (922s left) i915_getparams_basic (basic-eu-total)
[72.824096] Starting subtest: basic-eu-total
[72.825547] Subtest basic-eu-total: SUCCESS (0.000s)
[72.886944] [051/165] (922s left) i915_getparams_basic (basic-subslice-total)
[72.912980] Starting subtest: basic-subslice-total
[72.914512] Subtest basic-subslice-total: SUCCESS (0.000s)
[72.968330] [052/165] (921s left) i915_hangman (error-state-basic)
[73.008673] Starting subtest: error-state-basic
[73.098263] Subtest error-state-basic: SUCCESS (0.089s)
[73.154959] [053/165] (921s left) i915_pciid
[73.234284] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled)
[73.447366] Starting subtest: addfb25-4-tiled
[73.448276] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[73.523770] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[73.553279] Starting subtest: addfb25-bad-modifier
[73.554037] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[73.821283] [056/165] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[73.852325] Starting subtest: addfb25-framebuffer-vs-set-tiling
[73.853166] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[74.107804] [057/165] (920s left) kms_addfb_basic (addfb25-modifier-no-flag)
[74.139325] Starting subtest: addfb25-modifier-no-flag
[74.140121] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[74.407222] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[74.431917] Starting subtest: addfb25-x-tiled-legacy
[74.432701] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[74.691282] [059/165] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[74.718791] Starting subtest: addfb25-x-tiled-mismatch-legacy
[74.719640] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[74.973997] [060/165] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[75.186014] Starting subtest: addfb25-yf-tiled-legacy
[75.187178] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[75.256248] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[75.468497] Starting subtest: addfb25-y-tiled-legacy
[75.469335] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[75.541747] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[75.762970] Starting subtest: addfb25-y-tiled-small-legacy
[75.764078] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[75.841044] [063/165] (919s left) kms_addfb_basic (bad-pitch-0)
[75.870841] Starting subtest: bad-pitch-0
[75.871721] Subtest bad-pitch-0: SUCCESS (0.000s)
[76.123332] [064/165] (918s left) kms_addfb_basic (bad-pitch-1024)
[76.150204] Starting subtest: bad-pitch-1024
[76.151272] Subtest bad-pitch-1024: SUCCESS (0.000s)
[76.407360] [065/165] (918s left) kms_addfb_basic (bad-pitch-128)
[76.437123] Starting subtest: bad-pitch-128
[76.437999] Subtest bad-pitch-128: SUCCESS (0.000s)
[76.709010] [066/165] (918s left) kms_addfb_basic (bad-pitch-256)
[76.738556] Starting subtest: bad-pitch-256
[76.739392] Subtest bad-pitch-256: SUCCESS (0.000s)
[77.009201] [067/165] (918s left) kms_addfb_basic (bad-pitch-32)
[77.038774] Starting subtest: bad-pitch-32
[77.039633] Subtest bad-pitch-32: SUCCESS (0.000s)
[77.308124] [068/165] (917s left) kms_addfb_basic (bad-pitch-63)
[77.338717] Starting subtest: bad-pitch-63
[77.339518] Subtest bad-pitch-63: SUCCESS (0.000s)
[77.591342] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[77.620992] Starting subtest: bad-pitch-65536
[77.621801] Subtest bad-pitch-65536: SUCCESS (0.000s)
[77.892272] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[77.925997] Starting subtest: bad-pitch-999
[77.926772] Subtest bad-pitch-999: SUCCESS (0.000s)
[78.176164] [071/165] (916s left) kms_addfb_basic (basic)
[78.206126] Starting subtest: basic
[78.207178] Subtest basic: SUCCESS (0.000s)
[78.457722] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[78.490409] Starting subtest: basic-x-tiled-legacy
[78.491514] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[78.741784] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[78.773224] Starting subtest: basic-y-tiled-legacy
[78.773996] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.024393] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[79.236261] Starting subtest: bo-too-small
[79.237284] Subtest bo-too-small: SUCCESS (0.000s)
[79.324368] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[79.537980] Starting subtest: bo-too-small-due-to-tiling
[79.538871] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[79.626462] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[79.653897] Starting subtest: clobberred-modifier
[79.654756] Subtest clobberred-modifier: SUCCESS (0.000s)
[79.908299] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[79.934873] Starting subtest: framebuffer-vs-set-tiling
[79.935746] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.191629] [078/165] (915s left) kms_addfb_basic (invalid-get-prop)
[80.218606] Starting subtest: invalid-get-prop
[80.219436] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.476625] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[80.506412] Starting subtest: invalid-get-prop-any
[80.507374] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[80.760408] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[80.793163] Starting subtest: invalid-set-prop
[80.793934] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.059912] [081/165] (914s left) kms_addfb_basic (invalid-set-prop-any)
[81.091454] Starting subtest: invalid-set-prop-any
[81.092571] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.341097] [082/165] (913s left) kms_addfb_basic (no-handle)
[81.370723] Starting subtest: no-handle
[81.371429] Subtest no-handle: SUCCESS (0.000s)
[81.627363] [083/165] (913s left) kms_addfb_basic (size-max)
[81.845236] Starting subtest: size-max
[81.846676] Subtest size-max: SUCCESS (0.000s)
[81.924595] [084/165] (913s left) kms_addfb_basic (small-bo)
[82.137698] Starting subtest: small-bo
[82.138750] Subtest small-bo: SUCCESS (0.000s)
[82.208126] [085/165] (913s left) kms_addfb_basic (tile-pitch-mismatch)
[82.235527] Starting subtest: tile-pitch-mismatch
[82.236215] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[82.492201] [086/165] (912s left) kms_addfb_basic (too-high)
[82.711140] Starting subtest: too-high
[82.712244] Subtest too-high: SUCCESS (0.000s)
[82.773999] [087/165] (912s left) kms_addfb_basic (too-wide)
[82.989636] Starting subtest: too-wide
[82.990514] Subtest too-wide: SUCCESS (0.000s)
[83.083173] [088/165] (912s left) kms_addfb_basic (unused-handle)
[83.111207] Starting subtest: unused-handle
[83.111988] Subtest unused-handle: SUCCESS (0.000s)
[83.374504] [089/165] (911s left) kms_addfb_basic (unused-modifier)
[83.401191] Starting subtest: unused-modifier
[83.402052] Subtest unused-modifier: SUCCESS (0.000s)
[83.660818] [090/165] (911s left) kms_addfb_basic (unused-offsets)
[83.690054] Starting subtest: unused-offsets
[83.690810] Subtest unused-offsets: SUCCESS (0.000s)
[83.958839] [091/165] (911s left) kms_addfb_basic (unused-pitches)
[83.986958] Starting subtest: unused-pitches
[83.987833] Subtest unused-pitches: SUCCESS (0.000s)
[84.259218] [092/165] (911s left) kms_busy (basic)
[84.477263] Starting subtest: basic
[84.478244] Starting dynamic subtest: flip
[85.035065] Dynamic subtest flip: SUCCESS (0.558s)
[85.039629] Starting dynamic subtest: modeset
[85.805141] Dynamic subtest modeset: SUCCESS (0.770s)
[85.805968] Subtest basic: SUCCESS (1.329s)
[85.973492] [093/165] (909s left) kms_prop_blob (basic)
[86.012215] Starting subtest: basic
[86.013492] Subtest basic: SUCCESS (0.000s)
[86.067302] [094/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[86.288478] Starting subtest: basic-busy-flip-before-cursor-atomic
[86.290062] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[86.352219] [095/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[86.567469] Starting subtest: basic-busy-flip-before-cursor-legacy
[86.569317] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[86.636668] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.848690] Starting subtest: basic-flip-after-cursor-atomic
[87.826674] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.978s)
[87.984561] [097/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[88.196326] Starting subtest: basic-flip-after-cursor-legacy
[89.177087] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.981s)
[89.338047] [098/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[89.552448] Starting subtest: basic-flip-after-cursor-varying-size
[90.525889] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.974s)
[90.691026] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[90.903942] Starting subtest: basic-flip-before-cursor-atomic
[91.882154] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.978s)
[92.055231] [100/165] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[92.270199] Starting subtest: basic-flip-before-cursor-legacy
[93.255770] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.985s)
[93.407246] [101/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[93.619817] Starting subtest: basic-flip-before-cursor-varying-size
[94.608471] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.990s)
[94.777133] [102/165] (900s left) kms_dsc (dsc-basic)
[94.997542] Subtest dsc-basic: SKIP (0.000s)
[95.024399] [103/165] (900s left) kms_flip (basic-flip-vs-dpms)
[95.236275] Starting subtest: basic-flip-vs-dpms
[95.237152] Starting dynamic subtest: A-DP1
[96.134925] Dynamic subtest A-DP1: SUCCESS (0.897s)
[96.139270] Starting dynamic subtest: B-DP1
[96.877907] Dynamic subtest B-DP1: SUCCESS (0.743s)
[96.885345] Starting dynamic subtest: C-DP1
[97.623276] Dynamic subtest C-DP1: SUCCESS (0.745s)
[97.628452] Starting dynamic subtest: D-DP1
[98.372935] Dynamic subtest D-DP1: SUCCESS (0.750s)
[98.374845] Subtest basic-flip-vs-dpms: SUCCESS (3.140s)
[98.537850] [104/165] (896s left) kms_flip (basic-flip-vs-modeset)
[98.760457] Starting subtest: basic-flip-vs-modeset
[98.762314] Starting dynamic subtest: A-DP1
[99.656918] Dynamic subtest A-DP1: SUCCESS (0.894s)
[99.661658] Starting dynamic subtest: B-DP1
[100.400015] Dynamic subtest B-DP1: SUCCESS (0.742s)
[100.406749] Starting dynamic subtest: C-DP1
[101.150213] Dynamic subtest C-DP1: SUCCESS (0.751s)
[101.155261] Starting dynamic subtest: D-DP1
[101.902498] Dynamic subtest D-DP1: SUCCESS (0.752s)
[101.904232] Subtest basic-flip-vs-modeset: SUCCESS (3.145s)
[102.084978] [105/165] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[102.305506] Starting subtest: basic-flip-vs-wf_vblank
[102.307542] Starting dynamic subtest: A-DP1
[103.376429] Dynamic subtest A-DP1: SUCCESS (1.067s)
[103.383843] Starting dynamic subtest: B-DP1
[104.388173] Dynamic subtest B-DP1: SUCCESS (1.010s)
[104.397916] Starting dynamic subtest: C-DP1
[105.574883] Dynamic subtest C-DP1: SUCCESS (1.182s)
[105.580454] Starting dynamic subtest: D-DP1
[106.590707] Dynamic subtest D-DP1: SUCCESS (1.014s)
[106.594697] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.290s)
[106.807237] [106/165] (888s left) kms_flip (basic-plain-flip)
[107.021766] Starting subtest: basic-plain-flip
[107.023233] Starting dynamic subtest: A-DP1
[107.801153] Dynamic subtest A-DP1: SUCCESS (0.777s)
[107.813542] Starting dynamic subtest: B-DP1
[108.554728] Dynamic subtest B-DP1: SUCCESS (0.749s)
[108.563505] Starting dynamic subtest: C-DP1
[109.305983] Dynamic subtest C-DP1: SUCCESS (0.747s)
[109.312087] Starting dynamic subtest: D-DP1
[110.036594] Dynamic subtest D-DP1: SUCCESS (0.730s)
[110.041915] Subtest basic-plain-flip: SUCCESS (3.021s)
[110.255809] [107/165] (885s left) kms_force_connector_basic (force-connector-state)
[110.488892] Starting subtest: force-connector-state
[111.187703] Subtest force-connector-state: SUCCESS (0.699s)
[111.822355] [108/165] (883s left) kms_force_connector_basic (force-edid)
[112.053805] Starting subtest: force-edid
[112.459275] Subtest force-edid: SUCCESS (0.406s)
[112.959845] [109/165] (882s left) kms_force_connector_basic (force-load-detect)
[113.199905] Starting subtest: force-load-detect
[113.201787] Subtest force-load-detect: SKIP (0.000s)
[113.593487] [110/165] (881s left) kms_force_connector_basic (prune-stale-modes)
[113.824812] Starting subtest: prune-stale-modes
[114.294693] Subtest prune-stale-modes: SUCCESS (0.470s)
[114.793904] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[115.007698] Starting subtest: basic
[118.438091] Subtest basic: SUCCESS (3.432s)
[118.543397] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[118.647314] Starting subtest: inject-audio
[119.175407] Subtest inject-audio: SUCCESS (0.528s)
[119.570179] [113/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[119.784679] Starting subtest: compare-crc-sanitycheck-xr24
[119.785544] Starting dynamic subtest: pipe-A-DP-1
[120.211409] Dynamic subtest pipe-A-DP-1: SUCCESS (0.426s)
[120.218956] Starting dynamic subtest: pipe-B-DP-1
[120.610632] Dynamic subtest pipe-B-DP-1: SUCCESS (0.397s)
[120.615619] Starting dynamic subtest: pipe-C-DP-1
[121.010851] Dynamic subtest pipe-C-DP-1: SUCCESS (0.400s)
[121.016570] Starting dynamic subtest: pipe-D-DP-1
[121.411096] Dynamic subtest pipe-D-DP-1: SUCCESS (0.399s)
[121.411721] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.627s)
[121.566210] [114/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[121.779354] Starting subtest: compare-crc-sanitycheck-nv12
[121.780310] Starting dynamic subtest: pipe-A-DP-1
[122.367105] Dynamic subtest pipe-A-DP-1: SUCCESS (0.587s)
[122.373264] Starting dynamic subtest: pipe-B-DP-1
[122.918951] Dynamic subtest pipe-B-DP-1: SUCCESS (0.550s)
[122.925914] Starting dynamic subtest: pipe-C-DP-1
[123.466076] Dynamic subtest pipe-C-DP-1: SUCCESS (0.546s)
[123.470698] Starting dynamic subtest: pipe-D-DP-1
[124.015093] Dynamic subtest pipe-D-DP-1: SUCCESS (0.547s)
[124.015894] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.235s)
[124.167077] [115/165] (871s left) kms_pipe_crc_basic (hang-read-crc)
[124.392987] Starting subtest: hang-read-crc
[124.394125] Starting dynamic subtest: pipe-A-DP-1
[125.591760] Dynamic subtest pipe-A-DP-1: SUCCESS (1.201s)
[125.604044] Starting dynamic subtest: pipe-B-DP-1
[126.708211] Dynamic subtest pipe-B-DP-1: SUCCESS (1.116s)
[126.723576] Starting dynamic subtest: pipe-C-DP-1
[127.804092] Dynamic subtest pipe-C-DP-1: SUCCESS (1.094s)
[127.809153] Starting dynamic subtest: pipe-D-DP-1
[128.909811] Dynamic subtest pipe-D-DP-1: SUCCESS (1.104s)
[128.910711] Subtest hang-read-crc: SUCCESS (4.520s)
[129.053387] [116/165] (866s left) kms_pipe_crc_basic (nonblocking-crc)
[129.267508] Starting subtest: nonblocking-crc
[129.268436] Starting dynamic subtest: pipe-A-DP-1
[129.874093] Dynamic subtest pipe-A-DP-1: SUCCESS (0.607s)
[129.881029] Starting dynamic subtest: pipe-B-DP-1
[130.432797] Dynamic subtest pipe-B-DP-1: SUCCESS (0.557s)
[130.437702] Starting dynamic subtest: pipe-C-DP-1
[130.992525] Dynamic subtest pipe-C-DP-1: SUCCESS (0.559s)
[130.998069] Starting dynamic subtest: pipe-D-DP-1
[131.570864] Dynamic subtest pipe-D-DP-1: SUCCESS (0.576s)
[131.571656] Subtest nonblocking-crc: SUCCESS (2.304s)
[131.716372] [117/165] (863s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[131.932118] Starting subtest: nonblocking-crc-frame-sequence
[131.933079] Starting dynamic subtest: pipe-A-DP-1
[132.536269] Dynamic subtest pipe-A-DP-1: SUCCESS (0.603s)
[132.542746] Starting dynamic subtest: pipe-B-DP-1
[133.113743] Dynamic subtest pipe-B-DP-1: SUCCESS (0.575s)
[133.118704] Starting dynamic subtest: pipe-C-DP-1
[133.692592] Dynamic subtest pipe-C-DP-1: SUCCESS (0.578s)
[133.697378] Starting dynamic subtest: pipe-D-DP-1
[134.270419] Dynamic subtest pipe-D-DP-1: SUCCESS (0.576s)
[134.271370] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.337s)
[134.416659] [118/165] (861s left) kms_pipe_crc_basic (read-crc)
[134.637096] Starting subtest: read-crc
[134.637935] Starting dynamic subtest: pipe-A-DP-1
[135.204543] Dynamic subtest pipe-A-DP-1: SUCCESS (0.563s)
[135.209656] Starting dynamic subtest: pipe-B-DP-1
[135.707254] Dynamic subtest pipe-B-DP-1: SUCCESS (0.505s)
[135.712671] Starting dynamic subtest: pipe-C-DP-1
[136.217170] Dynamic subtest pipe-C-DP-1: SUCCESS (0.509s)
[136.222906] Starting dynamic subtest: pipe-D-DP-1
[136.728378] Dynamic subtest pipe-D-DP-1: SUCCESS (0.509s)
[136.729031] Subtest read-crc: SUCCESS (2.092s)
[136.872239] [119/165] (858s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[137.086467] Starting subtest: read-crc-frame-sequence
[137.087433] Starting dynamic subtest: pipe-A-DP-1
[137.622221] Dynamic subtest pipe-A-DP-1: SUCCESS (0.535s)
[137.627022] Starting dynamic subtest: pipe-B-DP-1
[138.127411] Dynamic subtest pipe-B-DP-1: SUCCESS (0.504s)
[138.133618] Starting dynamic subtest: pipe-C-DP-1
[138.634948] Dynamic subtest pipe-C-DP-1: SUCCESS (0.505s)
[138.639768] Starting dynamic subtest: pipe-D-DP-1
[139.131551] Dynamic subtest pipe-D-DP-1: SUCCESS (0.496s)
[139.132374] Subtest read-crc-frame-sequence: SUCCESS (2.045s)
[139.276152] [120/165] (856s left) kms_pm_backlight (basic-brightness)
[139.496345] Subtest basic-brightness: SKIP (0.000s)
[139.524834] [121/165] (856s left) kms_pm_rpm (basic-pci-d3-state)
[141.069208] Starting subtest: basic-pci-d3-state
[141.977382] Subtest basic-pci-d3-state: SUCCESS (0.908s)
[142.179574] [122/165] (853s left) kms_pm_rpm (basic-rte)
[142.206443] Starting subtest: basic-rte
[144.056115] Subtest basic-rte: SUCCESS (1.848s)
[144.621110] [123/165] (851s left) kms_psr (psr_primary_page_flip)
[144.840968] Subtest psr_primary_page_flip: SKIP (0.000s)
[144.872753] [124/165] (850s left) kms_psr (psr_cursor_plane_move)
[145.088767] Subtest psr_cursor_plane_move: SKIP (0.000s)
[145.105448] [125/165] (850s left) kms_psr (psr_sprite_plane_onoff)
[145.317085] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[145.338450] [126/165] (850s left) kms_psr (psr_primary_mmap_gtt)
[145.548788] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[145.572588] [127/165] (850s left) kms_setmode (basic-clone-single-crtc)
[145.605728] Starting subtest: basic-clone-single-crtc
[145.608021] Subtest basic-clone-single-crtc: SKIP (0.000s)
[145.667547] [128/165] (850s left) i915_pm_rps (basic-api)
[145.699550] Starting subtest: basic-api
[145.701287] Subtest basic-api: SKIP (0.000s)
[145.768943] [129/165] (850s left) prime_self_import (basic-llseek-bad)
[145.800613] Starting subtest: basic-llseek-bad
[145.802212] Subtest basic-llseek-bad: SUCCESS (0.001s)
[145.887729] [130/165] (849s left) prime_self_import (basic-llseek-size)
[145.913990] Starting subtest: basic-llseek-size
[145.916156] Subtest basic-llseek-size: SUCCESS (0.001s)
[146.004433] [131/165] (849s left) prime_self_import (basic-with_fd_dup)
[146.032533] Starting subtest: basic-with_fd_dup
[146.034066] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[146.100749] [132/165] (849s left) prime_self_import (basic-with_one_bo)
[146.127279] Starting subtest: basic-with_one_bo
[146.128734] Subtest basic-with_one_bo: SUCCESS (0.002s)
[146.173561] [133/165] (849s left) prime_self_import (basic-with_one_bo_two_files)
[146.200958] Starting subtest: basic-with_one_bo_two_files
[146.202559] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[146.269484] [134/165] (849s left) prime_self_import (basic-with_two_bos)
[146.295919] Starting subtest: basic-with_two_bos
[146.297912] Subtest basic-with_two_bos: SUCCESS (0.002s)
[146.369932] [135/165] (849s left) prime_vgem (basic-fence-flip)
[146.401085] Starting subtest: basic-fence-flip
[146.982304] Subtest basic-fence-flip: SUCCESS (0.581s)
[147.071177] [136/165] (848s left) prime_vgem (basic-fence-mmap)
[147.121696] Starting subtest: basic-fence-mmap
[147.137547] Subtest basic-fence-mmap: SUCCESS (0.018s)
[147.238199] [137/165] (848s left) prime_vgem (basic-fence-read)
[147.284973] Starting subtest: basic-fence-read
[147.288796] Subtest basic-fence-read: SKIP (0.003s)
[147.387492] [138/165] (848s left) prime_vgem (basic-gtt)
[147.449543] Starting subtest: basic-gtt
[147.453580] Subtest basic-gtt: SUCCESS (0.008s)
[147.555978] [139/165] (848s left) prime_vgem (basic-read)
[147.601783] Starting subtest: basic-read
[147.606081] Subtest basic-read: SKIP (0.004s)
[147.688753] [140/165] (848s left) prime_vgem (basic-write)
[147.735086] Starting subtest: basic-write
[147.739691] Subtest basic-write: SKIP (0.004s)
[147.856421] [141/165] (848s left) vgem_basic (setversion)
[147.899250] Starting subtest: setversion
[147.900801] Subtest setversion: SUCCESS (0.000s)
[147.954299] [142/165] (847s left) vgem_basic (create)
[147.999832] Starting subtest: create
[148.001156] Subtest create: SUCCESS (0.000s)
[148.053260] [143/165] (847s left) vgem_basic (debugfs)
[148.082773] Starting subtest: debugfs
[148.083559] Subtest debugfs: SUCCESS (0.000s)
[148.134277] [144/165] (847s left) vgem_basic (dmabuf-export)
[148.166269] Starting subtest: dmabuf-export
[148.167847] Subtest dmabuf-export: SUCCESS (0.001s)
[148.256756] [145/165] (847s left) vgem_basic (dmabuf-fence)
[148.299706] Starting subtest: dmabuf-fence
[148.300659] Subtest dmabuf-fence: SUCCESS (0.000s)
[148.353530] [146/165] (847s left) vgem_basic (dmabuf-fence-before)
[148.400473] Starting subtest: dmabuf-fence-before
[148.401647] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[148.457421] [147/165] (847s left) vgem_basic (dmabuf-mmap)
[148.499771] Starting subtest: dmabuf-mmap
[148.506074] Subtest dmabuf-mmap: SUCCESS (0.007s)
[148.551357] [148/165] (847s left) vgem_basic (mmap)
[148.582955] Starting subtest: mmap
[148.586302] Subtest mmap: SUCCESS (0.004s)
[148.633734] [149/165] (847s left) vgem_basic (second-client)
[148.665840] Starting subtest: second-client
[148.701105] Subtest second-client: SUCCESS (0.034s)
[148.753320] [150/165] (847s left) vgem_basic (sysfs)
[148.782762] Starting subtest: sysfs
[148.783625] Subtest sysfs: SUCCESS (0.000s)
[148.832886] [151/165] (847s left) core_hotunplug (unbind-rebind)
[148.882232] Starting subtest: unbind-rebind
[153.007029] Subtest unbind-rebind: SUCCESS (4.124s)
[153.026068] [152/165] (843s left) vgem_basic (unload)
[153.054571] Starting subtest: unload
[182.035684] Subtest unload: SUCCESS (28.946s)
[182.098986] [153/165] (813s left) i915_module_load (reload)
[182.127962] Starting subtest: reload
[184.979398] Subtest reload: SUCCESS (2.851s)
[184.993032] [154/165] (811s left) gem_lmem_swapping (basic)
[185.029261] Subtest basic: SKIP (0.000s)
[185.051587] [155/165] (811s left) gem_lmem_swapping (parallel-random-engines)
[185.081070] Subtest parallel-random-engines: SKIP (0.000s)
[185.101088] [156/165] (810s left) gem_lmem_swapping (random-engines)
[185.128513] Subtest random-engines: SKIP (0.000s)
[185.151268] [157/165] (810s left) gem_lmem_swapping (verify-random)
[185.182686] Subtest verify-random: SKIP (0.000s)
[185.204266] [158/165] (810s left) i915_pm_rpm (module-reload)
[186.864234] Starting subtest: module-reload
[194.850075] Subtest module-reload: SUCCESS (7.977s)
[194.863174] [159/165] (801s left) i915_selftest (live)
[194.897256] Starting subtest: live
[194.898229] Starting dynamic subtest: sanitycheck
[196.613389] Dynamic subtest sanitycheck: SUCCESS (1.707s)
[196.617122] Starting dynamic subtest: uncore
[198.299562] Dynamic subtest uncore: SUCCESS (1.685s)
[198.303099] Starting dynamic subtest: workarounds
[200.935431] Dynamic subtest workarounds: SUCCESS (2.635s)
[200.939261] Starting dynamic subtest: gt_engines
[203.113532] Dynamic subtest gt_engines: SUCCESS (2.181s)
[203.119770] Starting dynamic subtest: gt_timelines
[213.393600] Dynamic subtest gt_timelines: SUCCESS (10.275s)
[213.397404] Starting dynamic subtest: gt_contexts
[215.085422] Dynamic subtest gt_contexts: SUCCESS (1.691s)
[215.089269] Starting dynamic subtest: gt_lrc
[219.710485] Dynamic subtest gt_lrc: SUCCESS (4.624s)
[219.714156] Starting dynamic subtest: gt_mocs
[221.881375] Dynamic subtest gt_mocs: SUCCESS (2.170s)
[221.885066] Starting dynamic subtest: gt_pm
[224.459932] Dynamic subtest gt_pm: SUCCESS (2.577s)
[224.464809] Starting dynamic subtest: gt_heartbeat
[226.274766] Dynamic subtest gt_heartbeat: SUCCESS (1.813s)
[226.279039] Starting dynamic subtest: gt_tlb
[229.413298] Dynamic subtest gt_tlb: SUCCESS (3.138s)
[229.416690] Starting dynamic subtest: requests
[238.929451] Dynamic subtest requests: SUCCESS (9.514s)
[238.933028] Starting dynamic subtest: migrate
[243.783528] Dynamic subtest migrate: SUCCESS (4.853s)
[243.787281] Starting dynamic subtest: active
[245.425156] Dynamic subtest active: SUCCESS (1.641s)
[245.428776] Starting dynamic subtest: objects
[247.519311] Dynamic subtest objects: SUCCESS (2.093s)
[247.523204] Starting dynamic subtest: mman
[252.804473] Dynamic subtest mman: SUCCESS (5.284s)
[252.808296] Starting dynamic subtest: dmabuf
[254.503784] Dynamic subtest dmabuf: SUCCESS (1.698s)
[254.509041] Starting dynamic subtest: vma
[256.190733] Dynamic subtest vma: SUCCESS (1.686s)
[256.195855] Starting dynamic subtest: coherency
[260.321490] Dynamic subtest coherency: SUCCESS (4.130s)
[260.325160] Starting dynamic subtest: gtt
[269.399844] Dynamic subtest gtt: SUCCESS (9.077s)
[269.403676] Starting dynamic subtest: gem
[271.198227] Dynamic subtest gem: SUCCESS (1.797s)
[271.201866] Starting dynamic subtest: evict
[274.215413] Dynamic subtest evict: SUCCESS (3.016s)
[274.219252] Starting dynamic subtest: hugepages
[282.364895] Dynamic subtest hugepages: SUCCESS (8.149s)
[282.368739] Starting dynamic subtest: gem_contexts
[298.273571] Dynamic subtest gem_contexts: SUCCESS (15.907s)
[298.277462] Starting dynamic subtest: client
[299.965892] Dynamic subtest client: SUCCESS (1.691s)
[299.969877] Starting dynamic subtest: gem_migrate
[301.602790] Dynamic subtest gem_migrate: SUCCESS (1.636s)
[301.606757] Starting dynamic subtest: reset
[307.499564] Dynamic subtest reset: SUCCESS (5.896s)
[307.504789] Starting dynamic subtest: memory_region
[309.166467] Dynamic subtest memory_region: SUCCESS (1.666s)
[309.170310] Starting dynamic subtest: hangcheck
[328.055223] Dynamic subtest hangcheck: SUCCESS (18.888s)
[328.058760] Starting dynamic subtest: execlists
[329.692184] Dynamic subtest execlists: SUCCESS (1.636s)
[329.695802] Starting dynamic subtest: ring_submission
[331.351716] Dynamic subtest ring_submission: SUCCESS (1.658s)
[331.355712] Starting dynamic subtest: perf
[333.072583] Dynamic subtest perf: SUCCESS (1.720s)
[333.076368] Starting dynamic subtest: slpc
[341.349629] Dynamic subtest slpc: SUCCESS (8.276s)
[341.354978] Starting dynamic subtest: guc
[343.805104] Dynamic subtest guc: SUCCESS (2.454s)
[343.809776] Starting dynamic subtest: guc_multi_lrc
[345.524296] Dynamic subtest guc_multi_lrc: SUCCESS (1.718s)
[345.527967] Starting dynamic subtest: guc_hang
[347.787316] Dynamic subtest guc_hang: SUCCESS (2.262s)
[347.791055] Starting dynamic subtest: late_gt_pm
[349.487039] Dynamic subtest late_gt_pm: SUCCESS (1.698s)
[349.488470] Subtest live: SUCCESS (154.581s)
[349.501761] [160/165] (646s left) dmabuf (all-tests)
[349.538901] Starting subtest: all-tests
[349.539842] Starting dynamic subtest: sanitycheck
[349.601546] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[349.610043] Starting dynamic subtest: dma_fence
[349.773401] Dynamic subtest dma_fence: SUCCESS (0.170s)
[349.784455] Starting dynamic subtest: dma_fence_chain
[359.296319] Dynamic subtest dma_fence_chain: SUCCESS (9.520s)
[359.309759] Starting dynamic subtest: dma_fence_unwrap
[359.377546] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[359.387047] Starting dynamic subtest: dma_resv
[359.443583] Dynamic subtest dma_resv: SUCCESS (0.064s)
[359.450454] Subtest all-tests: SUCCESS (9.903s)
[359.468450] [161/165] (636s left) i915_suspend (basic-s2idle-without-i915)
[359.500722] Starting subtest: basic-s2idle-without-i915
[380.304951] Subtest basic-s2idle-without-i915: SUCCESS (5.644s)
[380.466245] [162/165] (630s left) i915_suspend (basic-s3-without-i915)
[380.499256] Starting subtest: basic-s3-without-i915
[400.893868] Subtest basic-s3-without-i915: SUCCESS (4.324s)
[401.063379] [163/165] (626s left) gem_exec_suspend (basic-s0)
[401.101029] Starting subtest: basic-S0
[401.102007] Starting dynamic subtest: smem
[419.080483] Dynamic subtest smem: SUCCESS (2.492s)
[419.082037] Subtest basic-S0: SUCCESS (2.493s)
[419.226700] [164/165] (623s left) gem_exec_suspend (basic-s3)
[419.258480] Starting subtest: basic-S3
[419.259397] Starting dynamic subtest: smem
[437.066380] Dynamic subtest smem: SUCCESS (2.465s)
[437.067754] Subtest basic-S3: SUCCESS (2.466s)
[437.199325] [165/165] (621s left) kms_pipe_crc_basic (suspend-read-crc)
[437.410343] Starting subtest: suspend-read-crc
[437.411472] Starting dynamic subtest: pipe-A-DP-1
[455.154389] Dynamic subtest pipe-A-DP-1: SUCCESS (2.219s)
[455.160871] Starting dynamic subtest: pipe-B-DP-1
[472.158574] Dynamic subtest pipe-B-DP-1: SUCCESS (2.270s)
[472.163688] Starting dynamic subtest: pipe-C-DP-1
[490.187187] Dynamic subtest pipe-C-DP-1: SUCCESS (2.242s)
[490.192846] Starting dynamic subtest: pipe-D-DP-1
[508.162940] Dynamic subtest pipe-D-DP-1: SUCCESS (2.212s)
[508.163716] Subtest suspend-read-crc: SUCCESS (8.948s)
[508.265234] Closing watchdogs
Done.