[35.966435] Initializing watchdogs
[35.966473]   /dev/watchdog0
[35.970078] [001/165] (960s left) i915_module_load (load)
[36.000159] Starting subtest: load
[37.914211] Subtest load: SUCCESS (1.914s)
[37.923674] [002/165] (958s left) core_auth (basic-auth)
[37.972913] Starting subtest: basic-auth
[37.973854] Subtest basic-auth: SUCCESS (0.001s)
[38.050685] [003/165] (958s left) debugfs_test (read_all_entries)
[38.086200] Starting subtest: read_all_entries
[38.215229] Subtest read_all_entries: SUCCESS (0.129s)
[38.466586] [004/165] (958s left) debugfs_test (basic-hwmon)
[38.495790] Starting subtest: basic-hwmon
[38.497161] Subtest basic-hwmon: SKIP (0.000s)
[38.752814] [005/165] (957s left) fbdev (eof)
[38.798488] Starting subtest: eof
[38.799558] Subtest eof: SUCCESS (0.000s)
[38.846047] [006/165] (957s left) fbdev (info)
[38.871610] Starting subtest: info
[38.872376] Subtest info: SUCCESS (0.000s)
[38.933188] [007/165] (957s left) fbdev (nullptr)
[38.964207] Starting subtest: nullptr
[38.965048] Subtest nullptr: SUCCESS (0.000s)
[39.014780] [008/165] (957s left) fbdev (read)
[39.047653] Starting subtest: read
[41.563869] Subtest read: SUCCESS (2.507s)
[41.614923] [009/165] (954s left) fbdev (write)
[41.647964] Starting subtest: write
[43.511970] Subtest write: SUCCESS (1.855s)
[43.545446] [010/165] (953s left) gem_basic (bad-close)
[43.571538] Starting subtest: bad-close
[43.573260] Subtest bad-close: SUCCESS (0.000s)
[43.631712] [011/165] (952s left) gem_basic (create-close)
[43.659062] Starting subtest: create-close
[43.660538] Subtest create-close: SUCCESS (0.000s)
[43.734122] [012/165] (952s left) gem_basic (create-fd-close)
[43.764029] Starting subtest: create-fd-close
[43.765502] Subtest create-fd-close: SUCCESS (0.000s)
[43.835124] [013/165] (952s left) gem_busy (busy@all-engines)
[43.874214] Starting subtest: busy
[43.875355] Starting dynamic subtest: all-engines
[43.895744] Dynamic subtest all-engines: SUCCESS (0.022s)
[43.896505] Subtest busy: SUCCESS (0.022s)
[44.236126] [014/165] (952s left) gem_close_race (basic-process)
[44.278876] Starting subtest: basic-process
[44.321619] Subtest basic-process: SUCCESS (0.042s)
[44.485143] [015/165] (952s left) gem_close_race (basic-threads)
[44.520777] Starting subtest: basic-threads
[45.734111] Subtest basic-threads: SUCCESS (1.213s)
[45.903194] [016/165] (950s left) gem_ctx_create (basic)
[45.941727] Starting subtest: basic
[45.942655] Subtest basic: SUCCESS (0.000s)
[46.116980] [017/165] (950s left) gem_ctx_create (basic-files)
[46.148437] Starting subtest: basic-files
[48.236068] Subtest basic-files: SUCCESS (2.088s)
[48.617816] [018/165] (948s left) gem_ctx_exec (basic)
[48.646535] Starting subtest: basic
[48.648149] Subtest basic: SUCCESS (0.002s)
[48.742962] [019/165] (947s left) gem_exec_basic (basic)
[48.795236] Starting subtest: basic
[48.796126] Starting dynamic subtest: rcs0-smem
[48.797014] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[48.800544] Starting dynamic subtest: bcs0-smem
[48.801372] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[48.804588] Starting dynamic subtest: vcs0-smem
[48.805397] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[48.808717] Starting dynamic subtest: vcs1-smem
[48.809531] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[48.812718] Starting dynamic subtest: vecs0-smem
[48.813534] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[48.814337] Subtest basic: SUCCESS (0.002s)
[48.969203] [020/165] (947s left) gem_exec_create (basic)
[49.006417] Starting subtest: basic
[49.007269] Starting dynamic subtest: smem
[51.089673] Dynamic subtest smem: SUCCESS (2.087s)
[51.090879] Subtest basic: SUCCESS (2.087s)
[51.269980] [021/165] (945s left) gem_exec_fence (basic-busy)
[51.430588] Starting subtest: basic-busy
[51.432170] Starting dynamic subtest: rcs0
[51.480519] Dynamic subtest rcs0: SUCCESS (0.055s)
[51.489067] Starting dynamic subtest: bcs0
[51.525090] Dynamic subtest bcs0: SUCCESS (0.048s)
[51.536982] Starting dynamic subtest: vcs0
[51.573116] Dynamic subtest vcs0: SUCCESS (0.048s)
[51.584679] Starting dynamic subtest: vcs1
[51.619266] Dynamic subtest vcs1: SUCCESS (0.046s)
[51.623904] Starting dynamic subtest: vecs0
[51.670878] Dynamic subtest vecs0: SUCCESS (0.051s)
[51.673299] Subtest basic-busy: SUCCESS (0.249s)
[52.152194] [022/165] (944s left) gem_exec_fence (basic-wait)
[52.317157] Starting subtest: basic-wait
[52.318666] Starting dynamic subtest: rcs0
[52.364410] Dynamic subtest rcs0: SUCCESS (0.056s)
[52.371666] Starting dynamic subtest: bcs0
[52.409700] Dynamic subtest bcs0: SUCCESS (0.045s)
[52.422570] Starting dynamic subtest: vcs0
[52.457189] Dynamic subtest vcs0: SUCCESS (0.048s)
[52.469453] Starting dynamic subtest: vcs1
[52.505391] Dynamic subtest vcs1: SUCCESS (0.048s)
[52.517540] Starting dynamic subtest: vecs0
[52.553483] Dynamic subtest vecs0: SUCCESS (0.048s)
[52.555829] Subtest basic-wait: SUCCESS (0.245s)
[53.019648] [023/165] (943s left) gem_exec_fence (basic-await)
[53.178409] Starting subtest: basic-await
[53.179259] Starting dynamic subtest: rcs0
[53.242345] Dynamic subtest rcs0: SUCCESS (0.072s)
[53.248724] Starting dynamic subtest: bcs0
[53.312603] Dynamic subtest bcs0: SUCCESS (0.069s)
[53.321878] Starting dynamic subtest: vcs0
[53.385817] Dynamic subtest vcs0: SUCCESS (0.073s)
[53.393649] Starting dynamic subtest: vcs1
[53.456695] Dynamic subtest vcs1: SUCCESS (0.071s)
[53.465510] Starting dynamic subtest: vecs0
[53.529917] Dynamic subtest vecs0: SUCCESS (0.073s)
[53.531573] Subtest basic-await: SUCCESS (0.360s)
[54.007114] [024/165] (942s left) gem_exec_fence (nb-await)
[54.167085] Starting subtest: nb-await
[54.167964] Starting dynamic subtest: rcs0
[54.215633] Dynamic subtest rcs0: SUCCESS (0.057s)
[54.222979] Starting dynamic subtest: bcs0
[54.275868] Dynamic subtest bcs0: SUCCESS (0.059s)
[54.281139] Starting dynamic subtest: vcs0
[54.331280] Dynamic subtest vcs0: SUCCESS (0.055s)
[54.343183] Starting dynamic subtest: vcs1
[54.391913] Dynamic subtest vcs1: SUCCESS (0.060s)
[54.397914] Starting dynamic subtest: vecs0
[54.448862] Dynamic subtest vecs0: SUCCESS (0.057s)
[54.450861] Subtest nb-await: SUCCESS (0.291s)
[54.920656] [025/165] (941s left) gem_exec_gttfill (basic)
[54.960428] Starting subtest: basic
[57.068459] Subtest basic: SUCCESS (2.108s)
[57.231353] [026/165] (939s left) gem_exec_parallel (engines)
[57.316374] Starting subtest: engines
[57.317470] Starting dynamic subtest: basic
[58.630217] Dynamic subtest basic: SUCCESS (1.314s)
[58.639013] Starting dynamic subtest: contexts
[60.261549] Dynamic subtest contexts: SUCCESS (1.622s)
[60.265619] Starting dynamic subtest: fds
[62.080747] Dynamic subtest fds: SUCCESS (1.828s)
[62.085188] Starting dynamic subtest: userptr
[63.370076] Dynamic subtest userptr: SUCCESS (1.289s)
[63.371798] Subtest engines: SUCCESS (6.053s)
[63.539525] [027/165] (933s left) gem_exec_store (basic)
[63.571270] Starting subtest: basic
[63.647646] Subtest basic: SUCCESS (0.075s)
[63.821686] [028/165] (932s left) gem_flink_basic (bad-flink)
[63.854673] Starting subtest: bad-flink
[63.855495] Subtest bad-flink: SUCCESS (0.000s)
[63.917217] [029/165] (932s left) gem_flink_basic (bad-open)
[63.950868] Starting subtest: bad-open
[63.951679] Subtest bad-open: SUCCESS (0.000s)
[64.020883] [030/165] (932s left) gem_flink_basic (basic)
[64.049068] Starting subtest: basic
[64.049756] Subtest basic: SUCCESS (0.000s)
[64.117903] [031/165] (932s left) gem_flink_basic (double-flink)
[64.145331] Starting subtest: double-flink
[64.146227] Subtest double-flink: SUCCESS (0.000s)
[64.218283] [032/165] (932s left) gem_flink_basic (flink-lifetime)
[64.245682] Starting subtest: flink-lifetime
[64.246329] Subtest flink-lifetime: SUCCESS (0.001s)
[64.336184] [033/165] (932s left) gem_huc_copy (huc-copy)
[64.365982] Starting subtest: huc-copy
[64.367790] Subtest huc-copy: SUCCESS (0.002s)
[64.450512] [034/165] (932s left) gem_linear_blits (basic)
[64.538524] Starting subtest: basic
[64.541773] Subtest basic: SUCCESS (0.004s)
[64.647784] [035/165] (932s left) gem_mmap (basic)
[64.709556] Starting subtest: basic
[64.713481] Subtest basic: SUCCESS (0.000s)
[64.785288] [036/165] (932s left) gem_mmap_gtt (basic)
[64.813536] Starting subtest: basic
[64.814319] Subtest basic: SUCCESS (0.000s)
[64.874694] [037/165] (931s left) gem_render_linear_blits (basic)
[64.903105] Starting subtest: basic
[64.916975] Subtest basic: SUCCESS (0.014s)
[64.971236] [038/165] (931s left) gem_render_tiled_blits (basic)
[65.003268] Starting subtest: basic
[65.020486] Subtest basic: SUCCESS (0.017s)
[65.090948] [039/165] (931s left) gem_ringfill (basic-all)
[65.402336] Starting subtest: basic-all
[66.519767] Subtest basic-all: SUCCESS (1.109s)
[66.620251] [040/165] (930s left) gem_softpin (allocator-basic)
[66.647425] Starting subtest: allocator-basic
[66.691062] Subtest allocator-basic: SUCCESS (0.043s)
[66.790996] [041/165] (930s left) gem_softpin (allocator-basic-reserve)
[66.823146] Starting subtest: allocator-basic-reserve
[66.867625] Subtest allocator-basic-reserve: SUCCESS (0.045s)
[66.972436] [042/165] (929s left) gem_softpin (safe-alignment)
[67.005442] Starting subtest: safe-alignment
[67.011424] Subtest safe-alignment: SUCCESS (0.006s)
[67.102929] [043/165] (929s left) gem_sync (basic-all)
[67.137824] Starting subtest: basic-all
[69.533245] Subtest basic-all: SUCCESS (2.395s)
[69.705111] [044/165] (927s left) gem_sync (basic-each)
[69.739981] Starting subtest: basic-each
[71.930447] Subtest basic-each: SUCCESS (2.189s)
[72.101322] [045/165] (924s left) gem_tiled_blits (basic)
[72.181488] Starting subtest: basic
[72.190659] Subtest basic: SUCCESS (0.009s)
[72.334874] [046/165] (924s left) gem_tiled_fence_blits (basic)
[72.449036] Starting subtest: basic
[72.468646] Subtest basic: SUCCESS (0.020s)
[72.577378] [047/165] (924s left) gem_tiled_pread_basic
[72.671678] [048/165] (924s left) gem_wait (busy@all-engines)
[72.707314] Starting subtest: busy
[72.708139] Starting dynamic subtest: all-engines
[73.257466] Dynamic subtest all-engines: SUCCESS (0.548s)
[73.258625] Subtest busy: SUCCESS (0.549s)
[73.453474] [049/165] (923s left) gem_wait (wait@all-engines)
[73.487161] Starting subtest: wait
[73.488011] Starting dynamic subtest: all-engines
[74.537771] Dynamic subtest all-engines: SUCCESS (1.050s)
[74.542599] Subtest wait: SUCCESS (1.050s)
[74.738227] [050/165] (922s left) i915_getparams_basic (basic-eu-total)
[74.771905] Starting subtest: basic-eu-total
[74.773225] Subtest basic-eu-total: SUCCESS (0.000s)
[74.834080] [051/165] (922s left) i915_getparams_basic (basic-subslice-total)
[74.860640] Starting subtest: basic-subslice-total
[74.862156] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.916608] [052/165] (922s left) i915_hangman (error-state-basic)
[74.952562] Starting subtest: error-state-basic
[75.039306] Subtest error-state-basic: SUCCESS (0.087s)
[75.103028] [053/165] (921s left) i915_pciid
[75.183611] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled)
[75.398094] Starting subtest: addfb25-4-tiled
[75.398766] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[75.470329] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[75.499319] Starting subtest: addfb25-bad-modifier
[75.500168] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[75.752900] [056/165] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.784397] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.785187] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.036428] [057/165] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[76.062676] Starting subtest: addfb25-modifier-no-flag
[76.063458] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[76.335864] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.363792] Starting subtest: addfb25-x-tiled-legacy
[76.364523] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.620058] [059/165] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.646520] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.647166] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.905881] [060/165] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[77.118996] Starting subtest: addfb25-yf-tiled-legacy
[77.119790] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[77.191391] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[77.408956] Starting subtest: addfb25-y-tiled-legacy
[77.409805] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[77.490368] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.702469] Starting subtest: addfb25-y-tiled-small-legacy
[77.703744] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[77.772323] [063/165] (919s left) kms_addfb_basic (bad-pitch-0)
[77.801660] Starting subtest: bad-pitch-0
[77.802455] Subtest bad-pitch-0: SUCCESS (0.000s)
[78.054631] [064/165] (919s left) kms_addfb_basic (bad-pitch-1024)
[78.082438] Starting subtest: bad-pitch-1024
[78.083259] Subtest bad-pitch-1024: SUCCESS (0.000s)
[78.354815] [065/165] (918s left) kms_addfb_basic (bad-pitch-128)
[78.380697] Starting subtest: bad-pitch-128
[78.381511] Subtest bad-pitch-128: SUCCESS (0.000s)
[78.658776] [066/165] (918s left) kms_addfb_basic (bad-pitch-256)
[78.691972] Starting subtest: bad-pitch-256
[78.692871] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.955924] [067/165] (918s left) kms_addfb_basic (bad-pitch-32)
[78.988902] Starting subtest: bad-pitch-32
[78.989717] Subtest bad-pitch-32: SUCCESS (0.000s)
[79.255867] [068/165] (917s left) kms_addfb_basic (bad-pitch-63)
[79.286143] Starting subtest: bad-pitch-63
[79.286847] Subtest bad-pitch-63: SUCCESS (0.000s)
[79.540177] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[79.568683] Starting subtest: bad-pitch-65536
[79.569452] Subtest bad-pitch-65536: SUCCESS (0.000s)
[79.822756] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[79.850593] Starting subtest: bad-pitch-999
[79.851450] Subtest bad-pitch-999: SUCCESS (0.000s)
[80.123520] [071/165] (917s left) kms_addfb_basic (basic)
[80.157514] Starting subtest: basic
[80.158298] Subtest basic: SUCCESS (0.000s)
[80.423264] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[80.454140] Starting subtest: basic-x-tiled-legacy
[80.455036] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[80.707225] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[80.736057] Starting subtest: basic-y-tiled-legacy
[80.736748] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[80.988030] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[81.201279] Starting subtest: bo-too-small
[81.202594] Subtest bo-too-small: SUCCESS (0.000s)
[81.272844] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[81.491831] Starting subtest: bo-too-small-due-to-tiling
[81.493274] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[81.554538] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[81.586127] Starting subtest: clobberred-modifier
[81.586971] Subtest clobberred-modifier: SUCCESS (0.000s)
[81.857364] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.887790] Starting subtest: framebuffer-vs-set-tiling
[81.888467] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[82.154344] [078/165] (915s left) kms_addfb_basic (invalid-get-prop)
[82.182068] Starting subtest: invalid-get-prop
[82.182890] Subtest invalid-get-prop: SUCCESS (0.000s)
[82.456488] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[82.486792] Starting subtest: invalid-get-prop-any
[82.487454] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[82.756141] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[82.787075] Starting subtest: invalid-set-prop
[82.787955] Subtest invalid-set-prop: SUCCESS (0.000s)
[83.038211] [081/165] (914s left) kms_addfb_basic (invalid-set-prop-any)
[83.067373] Starting subtest: invalid-set-prop-any
[83.068310] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[83.322260] [082/165] (914s left) kms_addfb_basic (no-handle)
[83.350535] Starting subtest: no-handle
[83.351455] Subtest no-handle: SUCCESS (0.000s)
[83.605592] [083/165] (913s left) kms_addfb_basic (size-max)
[83.819089] Starting subtest: size-max
[83.820218] Subtest size-max: SUCCESS (0.000s)
[83.888767] [084/165] (913s left) kms_addfb_basic (small-bo)
[84.107520] Starting subtest: small-bo
[84.108516] Subtest small-bo: SUCCESS (0.000s)
[84.189666] [085/165] (913s left) kms_addfb_basic (tile-pitch-mismatch)
[84.218267] Starting subtest: tile-pitch-mismatch
[84.218958] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[84.471617] [086/165] (912s left) kms_addfb_basic (too-high)
[84.684612] Starting subtest: too-high
[84.685510] Subtest too-high: SUCCESS (0.000s)
[84.776764] [087/165] (912s left) kms_addfb_basic (too-wide)
[84.990473] Starting subtest: too-wide
[84.991466] Subtest too-wide: SUCCESS (0.000s)
[85.073249] [088/165] (912s left) kms_addfb_basic (unused-handle)
[85.099172] Starting subtest: unused-handle
[85.100280] Subtest unused-handle: SUCCESS (0.000s)
[85.374318] [089/165] (912s left) kms_addfb_basic (unused-modifier)
[85.403977] Starting subtest: unused-modifier
[85.404791] Subtest unused-modifier: SUCCESS (0.000s)
[85.654881] [090/165] (911s left) kms_addfb_basic (unused-offsets)
[85.680997] Starting subtest: unused-offsets
[85.681765] Subtest unused-offsets: SUCCESS (0.000s)
[85.939577] [091/165] (911s left) kms_addfb_basic (unused-pitches)
[85.972143] Starting subtest: unused-pitches
[85.973034] Subtest unused-pitches: SUCCESS (0.000s)
[86.241972] [092/165] (911s left) kms_busy (basic)
[86.463429] Starting subtest: basic
[86.464418] Starting dynamic subtest: flip
[87.012587] Dynamic subtest flip: SUCCESS (0.550s)
[87.017820] Starting dynamic subtest: modeset
[87.787606] Dynamic subtest modeset: SUCCESS (0.775s)
[87.788252] Subtest basic: SUCCESS (1.325s)
[87.949138] [093/165] (909s left) kms_prop_blob (basic)
[87.980183] Starting subtest: basic
[87.980976] Subtest basic: SUCCESS (0.000s)
[88.048847] [094/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[88.260332] Starting subtest: basic-busy-flip-before-cursor-atomic
[88.262766] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[88.331825] [095/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[88.545664] Starting subtest: basic-busy-flip-before-cursor-legacy
[88.547690] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[88.615385] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[88.832612] Starting subtest: basic-flip-after-cursor-atomic
[89.819290] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.987s)
[89.966050] [097/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[90.203563] Starting subtest: basic-flip-after-cursor-legacy
[91.194140] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.991s)
[91.360083] [098/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[91.570132] Starting subtest: basic-flip-after-cursor-varying-size
[92.531449] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.961s)
[92.700099] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[92.917445] Starting subtest: basic-flip-before-cursor-atomic
[93.902240] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.985s)
[94.066629] [100/165] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[94.282480] Starting subtest: basic-flip-before-cursor-legacy
[95.272482] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.990s)
[95.438825] [101/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[95.653341] Starting subtest: basic-flip-before-cursor-varying-size
[96.644380] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.992s)
[96.814257] [102/165] (900s left) kms_dsc (dsc-basic)
[97.038020] Subtest dsc-basic: SKIP (0.000s)
[97.063740] [103/165] (900s left) kms_flip (basic-flip-vs-dpms)
[97.202430] Starting subtest: basic-flip-vs-dpms
[97.203308] Starting dynamic subtest: A-DP1
[98.091859] Dynamic subtest A-DP1: SUCCESS (0.888s)
[98.096498] Starting dynamic subtest: B-DP1
[98.847203] Dynamic subtest B-DP1: SUCCESS (0.755s)
[98.851872] Starting dynamic subtest: C-DP1
[99.593872] Dynamic subtest C-DP1: SUCCESS (0.746s)
[99.598994] Starting dynamic subtest: D-DP1
[100.346098] Dynamic subtest D-DP1: SUCCESS (0.751s)
[100.346838] Subtest basic-flip-vs-dpms: SUCCESS (3.146s)
[100.513033] [104/165] (897s left) kms_flip (basic-flip-vs-modeset)
[100.659476] Starting subtest: basic-flip-vs-modeset
[100.660364] Starting dynamic subtest: A-DP1
[101.557762] Dynamic subtest A-DP1: SUCCESS (0.896s)
[101.563877] Starting dynamic subtest: B-DP1
[102.311834] Dynamic subtest B-DP1: SUCCESS (0.754s)
[102.316496] Starting dynamic subtest: C-DP1
[103.069150] Dynamic subtest C-DP1: SUCCESS (0.756s)
[103.073941] Starting dynamic subtest: D-DP1
[103.817115] Dynamic subtest D-DP1: SUCCESS (0.748s)
[103.818879] Subtest basic-flip-vs-modeset: SUCCESS (3.161s)
[104.004013] [105/165] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[104.151174] Starting subtest: basic-flip-vs-wf_vblank
[104.153307] Starting dynamic subtest: A-DP1
[105.220069] Dynamic subtest A-DP1: SUCCESS (1.066s)
[105.228458] Starting dynamic subtest: B-DP1
[106.236280] Dynamic subtest B-DP1: SUCCESS (1.012s)
[106.244784] Starting dynamic subtest: C-DP1
[107.255911] Dynamic subtest C-DP1: SUCCESS (1.018s)
[107.261850] Starting dynamic subtest: D-DP1
[108.272202] Dynamic subtest D-DP1: SUCCESS (1.015s)
[108.277165] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.126s)
[108.493022] [106/165] (889s left) kms_flip (basic-plain-flip)
[108.634478] Starting subtest: basic-plain-flip
[108.635219] Starting dynamic subtest: A-DP1
[109.419335] Dynamic subtest A-DP1: SUCCESS (0.782s)
[109.431333] Starting dynamic subtest: B-DP1
[110.156111] Dynamic subtest B-DP1: SUCCESS (0.732s)
[110.161332] Starting dynamic subtest: C-DP1
[110.887480] Dynamic subtest C-DP1: SUCCESS (0.729s)
[110.896315] Starting dynamic subtest: D-DP1
[111.620050] Dynamic subtest D-DP1: SUCCESS (0.729s)
[111.624460] Subtest basic-plain-flip: SUCCESS (2.991s)
[111.839156] [107/165] (885s left) kms_force_connector_basic (force-connector-state)
[112.079990] Starting subtest: force-connector-state
[112.774622] Subtest force-connector-state: SUCCESS (0.695s)
[113.432680] [108/165] (884s left) kms_force_connector_basic (force-edid)
[113.666916] Starting subtest: force-edid
[114.077233] Subtest force-edid: SUCCESS (0.410s)
[114.567687] [109/165] (883s left) kms_force_connector_basic (force-load-detect)
[114.801372] Starting subtest: force-load-detect
[114.802812] Subtest force-load-detect: SKIP (0.000s)
[115.184378] [110/165] (882s left) kms_force_connector_basic (prune-stale-modes)
[115.420800] Starting subtest: prune-stale-modes
[115.888023] Subtest prune-stale-modes: SUCCESS (0.467s)
[116.384546] [111/165] (881s left) kms_frontbuffer_tracking (basic)
[116.603145] Starting subtest: basic
[120.030998] Subtest basic: SUCCESS (3.429s)
[120.119242] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[120.222744] Starting subtest: inject-audio
[120.750544] Subtest inject-audio: SUCCESS (0.528s)
[121.142139] [113/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[121.355613] Starting subtest: compare-crc-sanitycheck-xr24
[121.356784] Starting dynamic subtest: pipe-A-DP-1
[121.784330] Dynamic subtest pipe-A-DP-1: SUCCESS (0.427s)
[121.789375] Starting dynamic subtest: pipe-B-DP-1
[122.183162] Dynamic subtest pipe-B-DP-1: SUCCESS (0.398s)
[122.188155] Starting dynamic subtest: pipe-C-DP-1
[122.584764] Dynamic subtest pipe-C-DP-1: SUCCESS (0.401s)
[122.589675] Starting dynamic subtest: pipe-D-DP-1
[122.987415] Dynamic subtest pipe-D-DP-1: SUCCESS (0.401s)
[122.988294] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.632s)
[123.147711] [114/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[123.366038] Starting subtest: compare-crc-sanitycheck-nv12
[123.367272] Starting dynamic subtest: pipe-A-DP-1
[123.948752] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s)
[123.953809] Starting dynamic subtest: pipe-B-DP-1
[124.489476] Dynamic subtest pipe-B-DP-1: SUCCESS (0.541s)
[124.496145] Starting dynamic subtest: pipe-C-DP-1
[125.048616] Dynamic subtest pipe-C-DP-1: SUCCESS (0.550s)
[125.053342] Starting dynamic subtest: pipe-D-DP-1
[125.604545] Dynamic subtest pipe-D-DP-1: SUCCESS (0.555s)
[125.605481] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.233s)
[125.760491] [115/165] (871s left) kms_pipe_crc_basic (hang-read-crc)
[125.970608] Starting subtest: hang-read-crc
[125.971620] Starting dynamic subtest: pipe-A-DP-1
[127.159984] Dynamic subtest pipe-A-DP-1: SUCCESS (1.189s)
[127.164725] Starting dynamic subtest: pipe-B-DP-1
[128.299263] Dynamic subtest pipe-B-DP-1: SUCCESS (1.116s)
[128.304301] Starting dynamic subtest: pipe-C-DP-1
[129.399845] Dynamic subtest pipe-C-DP-1: SUCCESS (1.122s)
[129.404606] Starting dynamic subtest: pipe-D-DP-1
[130.523308] Dynamic subtest pipe-D-DP-1: SUCCESS (1.122s)
[130.524145] Subtest hang-read-crc: SUCCESS (4.553s)
[130.668831] [116/165] (867s left) kms_pipe_crc_basic (nonblocking-crc)
[130.885263] Starting subtest: nonblocking-crc
[130.886110] Starting dynamic subtest: pipe-A-DP-1
[131.489252] Dynamic subtest pipe-A-DP-1: SUCCESS (0.603s)
[131.494299] Starting dynamic subtest: pipe-B-DP-1
[132.066153] Dynamic subtest pipe-B-DP-1: SUCCESS (0.576s)
[132.072343] Starting dynamic subtest: pipe-C-DP-1
[132.644316] Dynamic subtest pipe-C-DP-1: SUCCESS (0.577s)
[132.649242] Starting dynamic subtest: pipe-D-DP-1
[133.227223] Dynamic subtest pipe-D-DP-1: SUCCESS (0.581s)
[133.228134] Subtest nonblocking-crc: SUCCESS (2.342s)
[133.372056] [117/165] (864s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[133.589505] Starting subtest: nonblocking-crc-frame-sequence
[133.590524] Starting dynamic subtest: pipe-A-DP-1
[134.228311] Dynamic subtest pipe-A-DP-1: SUCCESS (0.639s)
[134.236988] Starting dynamic subtest: pipe-B-DP-1
[134.789823] Dynamic subtest pipe-B-DP-1: SUCCESS (0.560s)
[134.795658] Starting dynamic subtest: pipe-C-DP-1
[135.348812] Dynamic subtest pipe-C-DP-1: SUCCESS (0.558s)
[135.354734] Starting dynamic subtest: pipe-D-DP-1
[135.928113] Dynamic subtest pipe-D-DP-1: SUCCESS (0.578s)
[135.928944] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.339s)
[136.074450] [118/165] (861s left) kms_pipe_crc_basic (read-crc)
[136.292443] Starting subtest: read-crc
[136.293533] Starting dynamic subtest: pipe-A-DP-1
[136.860033] Dynamic subtest pipe-A-DP-1: SUCCESS (0.567s)
[136.865216] Starting dynamic subtest: pipe-B-DP-1
[137.367378] Dynamic subtest pipe-B-DP-1: SUCCESS (0.506s)
[137.372398] Starting dynamic subtest: pipe-C-DP-1
[137.875239] Dynamic subtest pipe-C-DP-1: SUCCESS (0.507s)
[137.882339] Starting dynamic subtest: pipe-D-DP-1
[138.388276] Dynamic subtest pipe-D-DP-1: SUCCESS (0.512s)
[138.389110] Subtest read-crc: SUCCESS (2.096s)
[138.533378] [119/165] (859s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[138.753956] Starting subtest: read-crc-frame-sequence
[138.755245] Starting dynamic subtest: pipe-A-DP-1
[139.337012] Dynamic subtest pipe-A-DP-1: SUCCESS (0.583s)
[139.341915] Starting dynamic subtest: pipe-B-DP-1
[139.829385] Dynamic subtest pipe-B-DP-1: SUCCESS (0.492s)
[139.835426] Starting dynamic subtest: pipe-C-DP-1
[140.339741] Dynamic subtest pipe-C-DP-1: SUCCESS (0.509s)
[140.344744] Starting dynamic subtest: pipe-D-DP-1
[140.850956] Dynamic subtest pipe-D-DP-1: SUCCESS (0.510s)
[140.851969] Subtest read-crc-frame-sequence: SUCCESS (2.099s)
[140.997169] [120/165] (856s left) kms_pm_backlight (basic-brightness)
[141.215666] Subtest basic-brightness: SKIP (0.000s)
[141.247427] [121/165] (856s left) kms_pm_rpm (basic-pci-d3-state)
[142.788222] Starting subtest: basic-pci-d3-state
[143.677208] Subtest basic-pci-d3-state: SUCCESS (0.889s)
[143.897210] [122/165] (853s left) kms_pm_rpm (basic-rte)
[143.931157] Starting subtest: basic-rte
[145.794997] Subtest basic-rte: SUCCESS (1.862s)
[146.448468] [123/165] (851s left) kms_psr (primary_page_flip)
[146.482982] Subtest primary_page_flip: SKIP (0.000s)
[146.503047] [124/165] (851s left) kms_psr (cursor_plane_move)
[146.530827] Subtest cursor_plane_move: SKIP (0.000s)
[146.553800] [125/165] (851s left) kms_psr (sprite_plane_onoff)
[146.587052] Subtest sprite_plane_onoff: SKIP (0.000s)
[146.602727] [126/165] (851s left) kms_psr (primary_mmap_gtt)
[146.630193] Subtest primary_mmap_gtt: SKIP (0.000s)
[146.653417] [127/165] (851s left) kms_setmode (basic-clone-single-crtc)
[146.685174] Starting subtest: basic-clone-single-crtc
[146.687730] Subtest basic-clone-single-crtc: SKIP (0.000s)
[146.751581] [128/165] (851s left) i915_pm_rps (basic-api)
[146.789481] Starting subtest: basic-api
[146.791218] Subtest basic-api: SKIP (0.000s)
[146.849373] [129/165] (850s left) prime_self_import (basic-llseek-bad)
[146.879456] Starting subtest: basic-llseek-bad
[146.881163] Subtest basic-llseek-bad: SUCCESS (0.001s)
[146.968346] [130/165] (850s left) prime_self_import (basic-llseek-size)
[147.000328] Starting subtest: basic-llseek-size
[147.002073] Subtest basic-llseek-size: SUCCESS (0.001s)
[147.066612] [131/165] (850s left) prime_self_import (basic-with_fd_dup)
[147.099814] Starting subtest: basic-with_fd_dup
[147.101666] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[147.168765] [132/165] (850s left) prime_self_import (basic-with_one_bo)
[147.194281] Starting subtest: basic-with_one_bo
[147.195694] Subtest basic-with_one_bo: SUCCESS (0.002s)
[147.252886] [133/165] (850s left) prime_self_import (basic-with_one_bo_two_files)
[147.277335] Starting subtest: basic-with_one_bo_two_files
[147.279191] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[147.351999] [134/165] (850s left) prime_self_import (basic-with_two_bos)
[147.380252] Starting subtest: basic-with_two_bos
[147.382322] Subtest basic-with_two_bos: SUCCESS (0.002s)
[147.451872] [135/165] (850s left) prime_vgem (basic-fence-flip)
[147.482797] Starting subtest: basic-fence-flip
[148.063330] Subtest basic-fence-flip: SUCCESS (0.580s)
[148.152947] [136/165] (849s left) prime_vgem (basic-fence-mmap)
[148.206893] Starting subtest: basic-fence-mmap
[148.225086] Subtest basic-fence-mmap: SUCCESS (0.018s)
[148.317561] [137/165] (849s left) prime_vgem (basic-fence-read)
[148.348999] Starting subtest: basic-fence-read
[148.352469] Subtest basic-fence-read: SKIP (0.003s)
[148.435071] [138/165] (849s left) prime_vgem (basic-gtt)
[148.492969] Starting subtest: basic-gtt
[148.500615] Subtest basic-gtt: SUCCESS (0.007s)
[148.584772] [139/165] (849s left) prime_vgem (basic-read)
[148.633347] Starting subtest: basic-read
[148.636418] Subtest basic-read: SKIP (0.003s)
[148.718357] [140/165] (849s left) prime_vgem (basic-write)
[148.776498] Starting subtest: basic-write
[148.780356] Subtest basic-write: SKIP (0.003s)
[148.868607] [141/165] (849s left) vgem_basic (setversion)
[148.914123] Starting subtest: setversion
[148.915809] Subtest setversion: SUCCESS (0.000s)
[148.967299] [142/165] (849s left) vgem_basic (create)
[148.997117] Starting subtest: create
[148.998114] Subtest create: SUCCESS (0.000s)
[149.054019] [143/165] (848s left) vgem_basic (debugfs)
[149.097446] Starting subtest: debugfs
[149.098302] Subtest debugfs: SUCCESS (0.000s)
[149.152389] [144/165] (848s left) vgem_basic (dmabuf-export)
[149.180249] Starting subtest: dmabuf-export
[149.181666] Subtest dmabuf-export: SUCCESS (0.002s)
[149.267669] [145/165] (848s left) vgem_basic (dmabuf-fence)
[149.314177] Starting subtest: dmabuf-fence
[149.315241] Subtest dmabuf-fence: SUCCESS (0.000s)
[149.368147] [146/165] (848s left) vgem_basic (dmabuf-fence-before)
[149.397148] Starting subtest: dmabuf-fence-before
[149.398250] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[149.446720] [147/165] (848s left) vgem_basic (dmabuf-mmap)
[149.481808] Starting subtest: dmabuf-mmap
[149.486237] Subtest dmabuf-mmap: SUCCESS (0.006s)
[149.531474] [148/165] (848s left) vgem_basic (mmap)
[149.564096] Starting subtest: mmap
[149.567565] Subtest mmap: SUCCESS (0.004s)
[149.616850] [149/165] (848s left) vgem_basic (second-client)
[149.664165] Starting subtest: second-client
[149.698942] Subtest second-client: SUCCESS (0.034s)
[149.753455] [150/165] (848s left) vgem_basic (sysfs)
[149.780609] Starting subtest: sysfs
[149.781337] Subtest sysfs: SUCCESS (0.000s)
[149.834391] [151/165] (848s left) core_hotunplug (unbind-rebind)
[149.880265] Starting subtest: unbind-rebind
[154.019026] Subtest unbind-rebind: SUCCESS (4.139s)
[154.033575] [152/165] (844s left) vgem_basic (unload)
[154.067590] Starting subtest: unload
[183.011660] Subtest unload: SUCCESS (28.909s)
[183.060406] [153/165] (815s left) i915_module_load (reload)
[183.092472] Starting subtest: reload
[185.946151] Subtest reload: SUCCESS (2.854s)
[185.955358] [154/165] (812s left) gem_lmem_swapping (basic)
[185.996764] Subtest basic: SKIP (0.000s)
[186.018436] [155/165] (812s left) gem_lmem_swapping (parallel-random-engines)
[186.049761] Subtest parallel-random-engines: SKIP (0.000s)
[186.069107] [156/165] (812s left) gem_lmem_swapping (random-engines)
[186.097223] Subtest random-engines: SKIP (0.000s)
[186.118422] [157/165] (812s left) gem_lmem_swapping (verify-random)
[186.146753] Subtest verify-random: SKIP (0.000s)
[186.168445] [158/165] (811s left) i915_pm_rpm (module-reload)
[187.828693] Starting subtest: module-reload
[195.711803] Subtest module-reload: SUCCESS (7.874s)
[195.722088] [159/165] (802s left) i915_selftest (live)
[195.760847] Starting subtest: live
[195.761716] Starting dynamic subtest: sanitycheck
[197.423290] Dynamic subtest sanitycheck: SUCCESS (1.653s)
[197.427037] Starting dynamic subtest: uncore
[199.103893] Dynamic subtest uncore: SUCCESS (1.679s)
[199.107536] Starting dynamic subtest: workarounds
[201.637034] Dynamic subtest workarounds: SUCCESS (2.532s)
[201.640421] Starting dynamic subtest: gt_engines
[203.810251] Dynamic subtest gt_engines: SUCCESS (2.173s)
[203.814871] Starting dynamic subtest: gt_timelines
[214.169486] Dynamic subtest gt_timelines: SUCCESS (10.357s)
[214.173010] Starting dynamic subtest: gt_contexts
[215.842670] Dynamic subtest gt_contexts: SUCCESS (1.672s)
[215.848094] Starting dynamic subtest: gt_lrc
[220.443291] Dynamic subtest gt_lrc: SUCCESS (4.599s)
[220.447043] Starting dynamic subtest: gt_mocs
[222.579884] Dynamic subtest gt_mocs: SUCCESS (2.136s)
[222.583213] Starting dynamic subtest: gt_pm
[225.133865] Dynamic subtest gt_pm: SUCCESS (2.553s)
[225.137374] Starting dynamic subtest: gt_heartbeat
[226.919325] Dynamic subtest gt_heartbeat: SUCCESS (1.785s)
[226.922919] Starting dynamic subtest: gt_tlb
[230.082521] Dynamic subtest gt_tlb: SUCCESS (3.162s)
[230.085949] Starting dynamic subtest: requests
[239.681409] Dynamic subtest requests: SUCCESS (9.597s)
[239.685415] Starting dynamic subtest: migrate
[244.526335] Dynamic subtest migrate: SUCCESS (4.844s)
[244.529817] Starting dynamic subtest: active
[246.186483] Dynamic subtest active: SUCCESS (1.659s)
[246.190188] Starting dynamic subtest: objects
[248.438677] Dynamic subtest objects: SUCCESS (2.251s)
[248.442418] Starting dynamic subtest: mman
[253.726788] Dynamic subtest mman: SUCCESS (5.287s)
[253.730712] Starting dynamic subtest: dmabuf
[255.454339] Dynamic subtest dmabuf: SUCCESS (1.726s)
[255.458878] Starting dynamic subtest: vma
[257.123462] Dynamic subtest vma: SUCCESS (1.668s)
[257.127694] Starting dynamic subtest: coherency
[261.028848] Dynamic subtest coherency: SUCCESS (3.904s)
[261.032720] Starting dynamic subtest: gtt
[270.053537] Dynamic subtest gtt: SUCCESS (9.024s)
[270.057085] Starting dynamic subtest: gem
[271.828477] Dynamic subtest gem: SUCCESS (1.774s)
[271.832217] Starting dynamic subtest: evict
[274.822685] Dynamic subtest evict: SUCCESS (2.993s)
[274.826377] Starting dynamic subtest: hugepages
[282.921122] Dynamic subtest hugepages: SUCCESS (8.098s)
[282.925645] Starting dynamic subtest: gem_contexts
[299.346496] Dynamic subtest gem_contexts: SUCCESS (16.431s)
[299.350982] Starting dynamic subtest: client
[301.062221] Dynamic subtest client: SUCCESS (1.707s)
[301.066186] Starting dynamic subtest: gem_migrate
[302.712410] Dynamic subtest gem_migrate: SUCCESS (1.649s)
[302.716405] Starting dynamic subtest: reset
[308.556238] Dynamic subtest reset: SUCCESS (5.843s)
[308.559948] Starting dynamic subtest: memory_region
[310.232692] Dynamic subtest memory_region: SUCCESS (1.675s)
[310.236397] Starting dynamic subtest: hangcheck
[328.923665] Dynamic subtest hangcheck: SUCCESS (18.690s)
[328.927607] Starting dynamic subtest: execlists
[330.578621] Dynamic subtest execlists: SUCCESS (1.654s)
[330.582689] Starting dynamic subtest: ring_submission
[332.241677] Dynamic subtest ring_submission: SUCCESS (1.662s)
[332.245676] Starting dynamic subtest: perf
[333.980870] Dynamic subtest perf: SUCCESS (1.738s)
[333.984872] Starting dynamic subtest: slpc
[342.121492] Dynamic subtest slpc: SUCCESS (8.140s)
[342.125575] Starting dynamic subtest: guc
[344.548711] Dynamic subtest guc: SUCCESS (2.426s)
[344.552641] Starting dynamic subtest: guc_multi_lrc
[346.208278] Dynamic subtest guc_multi_lrc: SUCCESS (1.659s)
[346.212141] Starting dynamic subtest: guc_hang
[348.491288] Dynamic subtest guc_hang: SUCCESS (2.282s)
[348.495195] Starting dynamic subtest: late_gt_pm
[350.188402] Dynamic subtest late_gt_pm: SUCCESS (1.696s)
[350.189375] Subtest live: SUCCESS (154.419s)
[350.203546] [160/165] (647s left) dmabuf (all-tests)
[350.240633] Starting subtest: all-tests
[350.242295] Starting dynamic subtest: sanitycheck
[350.311935] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[350.318041] Starting dynamic subtest: dma_fence
[350.486401] Dynamic subtest dma_fence: SUCCESS (0.173s)
[350.492434] Starting dynamic subtest: dma_fence_chain
[359.797085] Dynamic subtest dma_fence_chain: SUCCESS (9.309s)
[359.805492] Starting dynamic subtest: dma_fence_unwrap
[359.860175] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s)
[359.871406] Starting dynamic subtest: dma_resv
[359.932324] Dynamic subtest dma_resv: SUCCESS (0.070s)
[359.934336] Subtest all-tests: SUCCESS (9.692s)
[359.949668] [161/165] (638s left) i915_suspend (basic-s2idle-without-i915)
[359.982478] Starting subtest: basic-s2idle-without-i915
[380.326590] Subtest basic-s2idle-without-i915: SUCCESS (5.565s)
[380.489774] [162/165] (632s left) i915_suspend (basic-s3-without-i915)
[380.518335] Starting subtest: basic-s3-without-i915
[400.962063] Subtest basic-s3-without-i915: SUCCESS (4.454s)
[401.123265] [163/165] (627s left) gem_exec_suspend (basic-s0)
[401.162936] Starting subtest: basic-S0
[401.163919] Starting dynamic subtest: smem
[419.157349] Dynamic subtest smem: SUCCESS (2.477s)
[419.158517] Subtest basic-S0: SUCCESS (2.477s)
[419.292949] [164/165] (625s left) gem_exec_suspend (basic-s3)
[419.324432] Starting subtest: basic-S3
[419.325373] Starting dynamic subtest: smem
[437.118640] Dynamic subtest smem: SUCCESS (2.415s)
[437.119476] Subtest basic-S3: SUCCESS (2.416s)
[437.251970] [165/165] (622s left) kms_pipe_crc_basic (suspend-read-crc)
[437.464588] Starting subtest: suspend-read-crc
[437.465742] Starting dynamic subtest: pipe-A-DP-1
[455.291495] Dynamic subtest pipe-A-DP-1: SUCCESS (2.328s)
[455.296806] Starting dynamic subtest: pipe-B-DP-1
[473.225515] Dynamic subtest pipe-B-DP-1: SUCCESS (2.191s)
[473.233342] Starting dynamic subtest: pipe-C-DP-1
[491.228553] Dynamic subtest pipe-C-DP-1: SUCCESS (2.202s)
[491.233880] Starting dynamic subtest: pipe-D-DP-1
[509.235014] Dynamic subtest pipe-D-DP-1: SUCCESS (2.217s)
[509.235841] Subtest suspend-read-crc: SUCCESS (8.944s)
[509.338189] Closing watchdogs
Done.