[29.986871] Initializing watchdogs
[29.986919]   /dev/watchdog0
[29.990933] [001/165] (960s left) i915_module_load (load)
[30.020177] Starting subtest: load
[31.980335] Subtest load: SUCCESS (1.959s)
[31.991014] [002/165] (958s left) core_auth (basic-auth)
[32.058886] Starting subtest: basic-auth
[32.060869] Subtest basic-auth: SUCCESS (0.002s)
[32.115441] [003/165] (958s left) debugfs_test (read_all_entries)
[32.148336] Starting subtest: read_all_entries
[32.281097] Subtest read_all_entries: SUCCESS (0.136s)
[32.531073] [004/165] (957s left) debugfs_test (basic-hwmon)
[32.557733] Starting subtest: basic-hwmon
[32.558965] Subtest basic-hwmon: SKIP (0.000s)
[32.797019] [005/165] (957s left) fbdev (eof)
[32.829831] Starting subtest: eof
[32.830560] Subtest eof: SUCCESS (0.000s)
[32.877088] [006/165] (957s left) fbdev (info)
[32.900640] Starting subtest: info
[32.901548] Subtest info: SUCCESS (0.000s)
[32.962019] [007/165] (957s left) fbdev (nullptr)
[32.996488] Starting subtest: nullptr
[32.997455] Subtest nullptr: SUCCESS (0.000s)
[33.044557] [008/165] (957s left) fbdev (read)
[33.079879] Starting subtest: read
[35.610260] Subtest read: SUCCESS (2.521s)
[35.645928] [009/165] (954s left) fbdev (write)
[35.679958] Starting subtest: write
[37.533100] Subtest write: SUCCESS (1.844s)
[37.579189] [010/165] (952s left) gem_basic (bad-close)
[37.605904] Starting subtest: bad-close
[37.607134] Subtest bad-close: SUCCESS (0.000s)
[37.665194] [011/165] (952s left) gem_basic (create-close)
[37.690825] Starting subtest: create-close
[37.692223] Subtest create-close: SUCCESS (0.000s)
[37.784657] [012/165] (952s left) gem_basic (create-fd-close)
[37.818923] Starting subtest: create-fd-close
[37.820582] Subtest create-fd-close: SUCCESS (0.000s)
[37.898471] [013/165] (952s left) gem_busy (busy@all-engines)
[37.934100] Starting subtest: busy
[37.934921] Starting dynamic subtest: all-engines
[37.955072] Dynamic subtest all-engines: SUCCESS (0.021s)
[37.956031] Subtest busy: SUCCESS (0.021s)
[38.303669] [014/165] (952s left) gem_close_race (basic-process)
[38.336171] Starting subtest: basic-process
[38.384233] Subtest basic-process: SUCCESS (0.047s)
[38.553431] [015/165] (952s left) gem_close_race (basic-threads)
[38.584295] Starting subtest: basic-threads
[39.812825] Subtest basic-threads: SUCCESS (1.228s)
[39.986191] [016/165] (950s left) gem_ctx_create (basic)
[40.019428] Starting subtest: basic
[40.020078] Subtest basic: SUCCESS (0.000s)
[40.186217] [017/165] (950s left) gem_ctx_create (basic-files)
[40.216421] Starting subtest: basic-files
[42.224972] Subtest basic-files: SUCCESS (2.008s)
[42.654232] [018/165] (947s left) gem_ctx_exec (basic)
[42.685929] Starting subtest: basic
[42.686757] Subtest basic: SUCCESS (0.002s)
[42.802835] [019/165] (947s left) gem_exec_basic (basic)
[42.836776] Starting subtest: basic
[42.837499] Starting dynamic subtest: rcs0-smem
[42.838285] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[42.842227] Starting dynamic subtest: bcs0-smem
[42.842857] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[42.845946] Starting dynamic subtest: vcs0-smem
[42.846587] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[42.849420] Starting dynamic subtest: vcs1-smem
[42.850042] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[42.852818] Starting dynamic subtest: vecs0-smem
[42.853430] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[42.854045] Subtest basic: SUCCESS (0.002s)
[43.022634] [020/165] (947s left) gem_exec_create (basic)
[43.052625] Starting subtest: basic
[43.059115] Starting dynamic subtest: smem
[45.136991] Dynamic subtest smem: SUCCESS (2.084s)
[45.138804] Subtest basic: SUCCESS (2.084s)
[45.295086] [021/165] (945s left) gem_exec_fence (basic-busy)
[45.461768] Starting subtest: basic-busy
[45.462632] Starting dynamic subtest: rcs0
[45.506309] Dynamic subtest rcs0: SUCCESS (0.052s)
[45.518018] Starting dynamic subtest: bcs0
[45.554141] Dynamic subtest bcs0: SUCCESS (0.047s)
[45.562874] Starting dynamic subtest: vcs0
[45.600922] Dynamic subtest vcs0: SUCCESS (0.047s)
[45.609925] Starting dynamic subtest: vcs1
[45.648056] Dynamic subtest vcs1: SUCCESS (0.047s)
[45.659036] Starting dynamic subtest: vecs0
[45.695063] Dynamic subtest vecs0: SUCCESS (0.047s)
[45.696875] Subtest basic-busy: SUCCESS (0.242s)
[46.186377] [022/165] (944s left) gem_exec_fence (basic-wait)
[46.344646] Starting subtest: basic-wait
[46.345692] Starting dynamic subtest: rcs0
[46.403076] Dynamic subtest rcs0: SUCCESS (0.067s)
[46.410888] Starting dynamic subtest: bcs0
[46.454406] Dynamic subtest bcs0: SUCCESS (0.051s)
[46.461205] Starting dynamic subtest: vcs0
[46.503643] Dynamic subtest vcs0: SUCCESS (0.048s)
[46.511386] Starting dynamic subtest: vcs1
[46.554456] Dynamic subtest vcs1: SUCCESS (0.050s)
[46.565749] Starting dynamic subtest: vecs0
[46.600896] Dynamic subtest vecs0: SUCCESS (0.047s)
[46.602339] Subtest basic-wait: SUCCESS (0.265s)
[47.069180] [023/165] (943s left) gem_exec_fence (basic-await)
[47.228136] Starting subtest: basic-await
[47.238600] Starting dynamic subtest: rcs0
[47.286796] Dynamic subtest rcs0: SUCCESS (0.070s)
[47.292711] Starting dynamic subtest: bcs0
[47.356952] Dynamic subtest bcs0: SUCCESS (0.070s)
[47.364971] Starting dynamic subtest: vcs0
[47.431865] Dynamic subtest vcs0: SUCCESS (0.074s)
[47.438980] Starting dynamic subtest: vcs1
[47.502768] Dynamic subtest vcs1: SUCCESS (0.071s)
[47.511024] Starting dynamic subtest: vecs0
[47.575295] Dynamic subtest vecs0: SUCCESS (0.072s)
[47.577188] Subtest basic-await: SUCCESS (0.359s)
[48.037591] [024/165] (942s left) gem_exec_fence (nb-await)
[48.197015] Starting subtest: nb-await
[48.198160] Starting dynamic subtest: rcs0
[48.245085] Dynamic subtest rcs0: SUCCESS (0.057s)
[48.252860] Starting dynamic subtest: bcs0
[48.304637] Dynamic subtest bcs0: SUCCESS (0.059s)
[48.311233] Starting dynamic subtest: vcs0
[48.362364] Dynamic subtest vcs0: SUCCESS (0.058s)
[48.373827] Starting dynamic subtest: vcs1
[48.423104] Dynamic subtest vcs1: SUCCESS (0.061s)
[48.431654] Starting dynamic subtest: vecs0
[48.479348] Dynamic subtest vecs0: SUCCESS (0.056s)
[48.481330] Subtest nb-await: SUCCESS (0.291s)
[48.949515] [025/165] (941s left) gem_exec_gttfill (basic)
[48.982059] Starting subtest: basic
[51.102611] Subtest basic: SUCCESS (2.120s)
[51.265574] [026/165] (939s left) gem_exec_parallel (engines)
[51.329399] Starting subtest: engines
[51.330246] Starting dynamic subtest: basic
[52.624267] Dynamic subtest basic: SUCCESS (1.294s)
[52.629494] Starting dynamic subtest: contexts
[54.277588] Dynamic subtest contexts: SUCCESS (1.644s)
[54.281749] Starting dynamic subtest: fds
[56.187501] Dynamic subtest fds: SUCCESS (1.918s)
[56.192232] Starting dynamic subtest: userptr
[57.469521] Dynamic subtest userptr: SUCCESS (1.283s)
[57.471055] Subtest engines: SUCCESS (6.140s)
[57.638373] [027/165] (933s left) gem_exec_store (basic)
[57.678606] Starting subtest: basic
[57.757844] Subtest basic: SUCCESS (0.078s)
[57.937064] [028/165] (932s left) gem_flink_basic (bad-flink)
[57.968531] Starting subtest: bad-flink
[57.969177] Subtest bad-flink: SUCCESS (0.000s)
[58.032083] [029/165] (932s left) gem_flink_basic (bad-open)
[58.059856] Starting subtest: bad-open
[58.060688] Subtest bad-open: SUCCESS (0.000s)
[58.116021] [030/165] (932s left) gem_flink_basic (basic)
[58.142812] Starting subtest: basic
[58.143723] Subtest basic: SUCCESS (0.000s)
[58.238268] [031/165] (932s left) gem_flink_basic (double-flink)
[58.263855] Starting subtest: double-flink
[58.264528] Subtest double-flink: SUCCESS (0.000s)
[58.352796] [032/165] (932s left) gem_flink_basic (flink-lifetime)
[58.379306] Starting subtest: flink-lifetime
[58.380037] Subtest flink-lifetime: SUCCESS (0.001s)
[58.467296] [033/165] (932s left) gem_huc_copy (huc-copy)
[58.498881] Starting subtest: huc-copy
[58.500382] Subtest huc-copy: SUCCESS (0.001s)
[58.606768] [034/165] (932s left) gem_linear_blits (basic)
[58.690891] Starting subtest: basic
[58.694316] Subtest basic: SUCCESS (0.004s)
[58.815116] [035/165] (932s left) gem_mmap (basic)
[58.881732] Starting subtest: basic
[58.885109] Subtest basic: SUCCESS (0.000s)
[58.977975] [036/165] (931s left) gem_mmap_gtt (basic)
[59.012838] Starting subtest: basic
[59.014082] Subtest basic: SUCCESS (0.000s)
[59.056249] [037/165] (931s left) gem_render_linear_blits (basic)
[59.083545] Starting subtest: basic
[59.096961] Subtest basic: SUCCESS (0.014s)
[59.153983] [038/165] (931s left) gem_render_tiled_blits (basic)
[59.193055] Starting subtest: basic
[59.211373] Subtest basic: SUCCESS (0.018s)
[59.270283] [039/165] (931s left) gem_ringfill (basic-all)
[59.580879] Starting subtest: basic-all
[60.718182] Subtest basic-all: SUCCESS (1.129s)
[60.806589] [040/165] (930s left) gem_softpin (allocator-basic)
[60.836214] Starting subtest: allocator-basic
[60.880178] Subtest allocator-basic: SUCCESS (0.044s)
[60.986328] [041/165] (929s left) gem_softpin (allocator-basic-reserve)
[61.016122] Starting subtest: allocator-basic-reserve
[61.061578] Subtest allocator-basic-reserve: SUCCESS (0.045s)
[61.151758] [042/165] (929s left) gem_softpin (safe-alignment)
[61.181378] Starting subtest: safe-alignment
[61.187856] Subtest safe-alignment: SUCCESS (0.007s)
[61.285704] [043/165] (929s left) gem_sync (basic-all)
[61.320772] Starting subtest: basic-all
[63.799202] Subtest basic-all: SUCCESS (2.479s)
[63.968206] [044/165] (926s left) gem_sync (basic-each)
[63.999619] Starting subtest: basic-each
[66.262635] Subtest basic-each: SUCCESS (2.262s)
[66.438285] [045/165] (924s left) gem_tiled_blits (basic)
[66.510018] Starting subtest: basic
[66.518741] Subtest basic: SUCCESS (0.009s)
[66.632421] [046/165] (924s left) gem_tiled_fence_blits (basic)
[66.759098] Starting subtest: basic
[66.778923] Subtest basic: SUCCESS (0.020s)
[66.893354] [047/165] (924s left) gem_tiled_pread_basic
[66.987206] [048/165] (923s left) gem_wait (busy@all-engines)
[67.025695] Starting subtest: busy
[67.026674] Starting dynamic subtest: all-engines
[67.574807] Dynamic subtest all-engines: SUCCESS (0.548s)
[67.576253] Subtest busy: SUCCESS (0.549s)
[67.786753] [049/165] (923s left) gem_wait (wait@all-engines)
[67.821186] Starting subtest: wait
[67.821967] Starting dynamic subtest: all-engines
[68.877258] Dynamic subtest all-engines: SUCCESS (1.055s)
[68.879063] Subtest wait: SUCCESS (1.055s)
[69.071804] [050/165] (921s left) i915_getparams_basic (basic-eu-total)
[69.098417] Starting subtest: basic-eu-total
[69.099832] Subtest basic-eu-total: SUCCESS (0.000s)
[69.170688] [051/165] (921s left) i915_getparams_basic (basic-subslice-total)
[69.195032] Starting subtest: basic-subslice-total
[69.196627] Subtest basic-subslice-total: SUCCESS (0.000s)
[69.248103] [052/165] (921s left) i915_hangman (error-state-basic)
[69.288083] Starting subtest: error-state-basic
[69.378218] Subtest error-state-basic: SUCCESS (0.088s)
[69.434260] [053/165] (921s left) i915_pciid
[69.514344] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled)
[69.730657] Starting subtest: addfb25-4-tiled
[69.731446] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[69.802722] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[69.837077] Starting subtest: addfb25-bad-modifier
[69.837836] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[70.103098] [056/165] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[70.130021] Starting subtest: addfb25-framebuffer-vs-set-tiling
[70.130823] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.403885] [057/165] (920s left) kms_addfb_basic (addfb25-modifier-no-flag)
[70.431344] Starting subtest: addfb25-modifier-no-flag
[70.432347] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[70.708479] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[70.734887] Starting subtest: addfb25-x-tiled-legacy
[70.735719] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.004847] [059/165] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.035191] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.035960] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[71.321280] [060/165] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[71.534199] Starting subtest: addfb25-yf-tiled-legacy
[71.534954] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[71.623510] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.838054] Starting subtest: addfb25-y-tiled-legacy
[71.838857] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[71.918059] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.132087] Starting subtest: addfb25-y-tiled-small-legacy
[72.133116] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[72.222454] [063/165] (918s left) kms_addfb_basic (bad-pitch-0)
[72.251146] Starting subtest: bad-pitch-0
[72.251818] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.522028] [064/165] (918s left) kms_addfb_basic (bad-pitch-1024)
[72.550572] Starting subtest: bad-pitch-1024
[72.551604] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.822078] [065/165] (918s left) kms_addfb_basic (bad-pitch-128)
[72.855310] Starting subtest: bad-pitch-128
[72.856125] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.122260] [066/165] (918s left) kms_addfb_basic (bad-pitch-256)
[73.152028] Starting subtest: bad-pitch-256
[73.152766] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.421275] [067/165] (917s left) kms_addfb_basic (bad-pitch-32)
[73.450188] Starting subtest: bad-pitch-32
[73.450911] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.703941] [068/165] (917s left) kms_addfb_basic (bad-pitch-63)
[73.731839] Starting subtest: bad-pitch-63
[73.732500] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.004935] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[74.033957] Starting subtest: bad-pitch-65536
[74.034844] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.293279] [070/165] (916s left) kms_addfb_basic (bad-pitch-999)
[74.322795] Starting subtest: bad-pitch-999
[74.323531] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.589340] [071/165] (916s left) kms_addfb_basic (basic)
[74.616599] Starting subtest: basic
[74.617330] Subtest basic: SUCCESS (0.000s)
[74.870617] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.901093] Starting subtest: basic-x-tiled-legacy
[74.901807] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.158304] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.187825] Starting subtest: basic-y-tiled-legacy
[75.188674] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.471132] [074/165] (915s left) kms_addfb_basic (bo-too-small)
[75.687781] Starting subtest: bo-too-small
[75.688577] Subtest bo-too-small: SUCCESS (0.000s)
[75.772182] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.989305] Starting subtest: bo-too-small-due-to-tiling
[75.990211] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[76.071848] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[76.104949] Starting subtest: clobberred-modifier
[76.105636] Subtest clobberred-modifier: SUCCESS (0.000s)
[76.371890] [077/165] (914s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[76.402992] Starting subtest: framebuffer-vs-set-tiling
[76.404017] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.671541] [078/165] (914s left) kms_addfb_basic (invalid-get-prop)
[76.699970] Starting subtest: invalid-get-prop
[76.700780] Subtest invalid-get-prop: SUCCESS (0.000s)
[76.988445] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any)
[77.016844] Starting subtest: invalid-get-prop-any
[77.017532] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[77.305948] [080/165] (914s left) kms_addfb_basic (invalid-set-prop)
[77.333429] Starting subtest: invalid-set-prop
[77.334133] Subtest invalid-set-prop: SUCCESS (0.000s)
[77.587312] [081/165] (913s left) kms_addfb_basic (invalid-set-prop-any)
[77.613984] Starting subtest: invalid-set-prop-any
[77.614763] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[77.888999] [082/165] (913s left) kms_addfb_basic (no-handle)
[77.927589] Starting subtest: no-handle
[77.928291] Subtest no-handle: SUCCESS (0.000s)
[78.205229] [083/165] (913s left) kms_addfb_basic (size-max)
[78.422249] Starting subtest: size-max
[78.423042] Subtest size-max: SUCCESS (0.000s)
[78.504239] [084/165] (912s left) kms_addfb_basic (small-bo)
[78.721763] Starting subtest: small-bo
[78.722640] Subtest small-bo: SUCCESS (0.000s)
[78.804209] [085/165] (912s left) kms_addfb_basic (tile-pitch-mismatch)
[78.833361] Starting subtest: tile-pitch-mismatch
[78.834648] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[79.105265] [086/165] (912s left) kms_addfb_basic (too-high)
[79.321382] Starting subtest: too-high
[79.322595] Subtest too-high: SUCCESS (0.000s)
[79.405067] [087/165] (911s left) kms_addfb_basic (too-wide)
[79.618164] Starting subtest: too-wide
[79.619054] Subtest too-wide: SUCCESS (0.000s)
[79.705606] [088/165] (911s left) kms_addfb_basic (unused-handle)
[79.734848] Starting subtest: unused-handle
[79.735577] Subtest unused-handle: SUCCESS (0.000s)
[80.006199] [089/165] (911s left) kms_addfb_basic (unused-modifier)
[80.033669] Starting subtest: unused-modifier
[80.034515] Subtest unused-modifier: SUCCESS (0.000s)
[80.303765] [090/165] (911s left) kms_addfb_basic (unused-offsets)
[80.330776] Starting subtest: unused-offsets
[80.331637] Subtest unused-offsets: SUCCESS (0.000s)
[80.605632] [091/165] (910s left) kms_addfb_basic (unused-pitches)
[80.633840] Starting subtest: unused-pitches
[80.634534] Subtest unused-pitches: SUCCESS (0.000s)
[80.887090] [092/165] (910s left) kms_busy (basic)
[81.107093] Starting subtest: basic
[81.107947] Starting dynamic subtest: flip
[81.699051] Dynamic subtest flip: SUCCESS (0.591s)
[81.703657] Starting dynamic subtest: modeset
[82.470867] Dynamic subtest modeset: SUCCESS (0.772s)
[82.471619] Subtest basic: SUCCESS (1.364s)
[82.635343] [093/165] (908s left) kms_prop_blob (basic)
[82.664704] Starting subtest: basic
[82.665513] Subtest basic: SUCCESS (0.000s)
[82.732759] [094/165] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[82.944099] Starting subtest: basic-busy-flip-before-cursor-atomic
[82.946615] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[83.014552] [095/165] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[83.232666] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.235179] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[83.301096] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.514129] Starting subtest: basic-flip-after-cursor-atomic
[84.505322] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.991s)
[84.666604] [097/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[84.880151] Starting subtest: basic-flip-after-cursor-legacy
[85.856217] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.976s)
[86.032435] [098/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[86.244460] Starting subtest: basic-flip-after-cursor-varying-size
[87.204067] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.960s)
[87.369950] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[87.582238] Starting subtest: basic-flip-before-cursor-atomic
[88.554837] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.973s)
[88.721160] [100/165] (902s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[88.934952] Starting subtest: basic-flip-before-cursor-legacy
[89.925656] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.990s)
[90.104843] [101/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[90.325229] Starting subtest: basic-flip-before-cursor-varying-size
[91.307961] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.983s)
[91.482977] [102/165] (900s left) kms_dsc (dsc-basic)
[91.699967] Starting subtest: dsc-basic
[91.702303] Subtest dsc-basic: SKIP (0.000s)
[91.765505] [103/165] (899s left) kms_flip (basic-flip-vs-dpms)
[91.909865] Starting subtest: basic-flip-vs-dpms
[91.912016] Starting dynamic subtest: A-DP1
[92.819147] Dynamic subtest A-DP1: SUCCESS (0.904s)
[92.824036] Starting dynamic subtest: B-DP1
[93.576311] Dynamic subtest B-DP1: SUCCESS (0.760s)
[93.581846] Starting dynamic subtest: C-DP1
[94.343855] Dynamic subtest C-DP1: SUCCESS (0.767s)
[94.348315] Starting dynamic subtest: D-DP1
[95.103131] Dynamic subtest D-DP1: SUCCESS (0.759s)
[95.105284] Subtest basic-flip-vs-dpms: SUCCESS (3.196s)
[95.270173] [104/165] (896s left) kms_flip (basic-flip-vs-modeset)
[95.408026] Starting subtest: basic-flip-vs-modeset
[95.410043] Starting dynamic subtest: A-DP1
[96.309816] Dynamic subtest A-DP1: SUCCESS (0.899s)
[96.314542] Starting dynamic subtest: B-DP1
[97.061813] Dynamic subtest B-DP1: SUCCESS (0.752s)
[97.066272] Starting dynamic subtest: C-DP1
[97.806573] Dynamic subtest C-DP1: SUCCESS (0.744s)
[97.811566] Starting dynamic subtest: D-DP1
[98.552336] Dynamic subtest D-DP1: SUCCESS (0.746s)
[98.554173] Subtest basic-flip-vs-modeset: SUCCESS (3.147s)
[98.722472] [105/165] (892s left) kms_flip (basic-flip-vs-wf_vblank)
[98.869783] Starting subtest: basic-flip-vs-wf_vblank
[98.871511] Starting dynamic subtest: A-DP1
[99.932350] Dynamic subtest A-DP1: SUCCESS (1.059s)
[99.939056] Starting dynamic subtest: B-DP1
[100.942764] Dynamic subtest B-DP1: SUCCESS (1.009s)
[100.949820] Starting dynamic subtest: C-DP1
[101.957307] Dynamic subtest C-DP1: SUCCESS (1.012s)
[101.967493] Starting dynamic subtest: D-DP1
[102.991602] Dynamic subtest D-DP1: SUCCESS (1.031s)
[102.995195] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.126s)
[103.212393] [106/165] (888s left) kms_flip (basic-plain-flip)
[103.349899] Starting subtest: basic-plain-flip
[103.351582] Starting dynamic subtest: A-DP1
[104.139717] Dynamic subtest A-DP1: SUCCESS (0.787s)
[104.151860] Starting dynamic subtest: B-DP1
[104.888454] Dynamic subtest B-DP1: SUCCESS (0.745s)
[104.898648] Starting dynamic subtest: C-DP1
[105.636176] Dynamic subtest C-DP1: SUCCESS (0.746s)
[105.647160] Starting dynamic subtest: D-DP1
[106.386819] Dynamic subtest D-DP1: SUCCESS (0.749s)
[106.391232] Subtest basic-plain-flip: SUCCESS (3.043s)
[106.611651] [107/165] (884s left) kms_force_connector_basic (force-connector-state)
[106.847724] Starting subtest: force-connector-state
[107.555962] Subtest force-connector-state: SUCCESS (0.708s)
[108.228420] [108/165] (883s left) kms_force_connector_basic (force-edid)
[108.461068] Starting subtest: force-edid
[108.869065] Subtest force-edid: SUCCESS (0.409s)
[109.360348] [109/165] (882s left) kms_force_connector_basic (force-load-detect)
[109.593646] Starting subtest: force-load-detect
[109.595488] Subtest force-load-detect: SKIP (0.000s)
[109.976863] [110/165] (881s left) kms_force_connector_basic (prune-stale-modes)
[110.211910] Starting subtest: prune-stale-modes
[110.678040] Subtest prune-stale-modes: SUCCESS (0.466s)
[111.180499] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[111.398371] Starting subtest: basic
[114.842158] Subtest basic: SUCCESS (3.445s)
[114.947413] [112/165] (876s left) kms_hdmi_inject (inject-audio)
[115.067304] Starting subtest: inject-audio
[115.601665] Subtest inject-audio: SUCCESS (0.535s)
[116.003147] [113/165] (875s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[116.224563] Starting subtest: compare-crc-sanitycheck-xr24
[116.225540] Starting dynamic subtest: pipe-A-DP-1
[116.660820] Dynamic subtest pipe-A-DP-1: SUCCESS (0.436s)
[116.670110] Starting dynamic subtest: pipe-B-DP-1
[117.055781] Dynamic subtest pipe-B-DP-1: SUCCESS (0.392s)
[117.060736] Starting dynamic subtest: pipe-C-DP-1
[117.461155] Dynamic subtest pipe-C-DP-1: SUCCESS (0.403s)
[117.467527] Starting dynamic subtest: pipe-D-DP-1
[117.866305] Dynamic subtest pipe-D-DP-1: SUCCESS (0.405s)
[117.867052] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.642s)
[118.037947] [114/165] (873s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[118.252521] Starting subtest: compare-crc-sanitycheck-nv12
[118.253532] Starting dynamic subtest: pipe-A-DP-1
[118.839272] Dynamic subtest pipe-A-DP-1: SUCCESS (0.586s)
[118.846081] Starting dynamic subtest: pipe-B-DP-1
[119.390694] Dynamic subtest pipe-B-DP-1: SUCCESS (0.542s)
[119.395458] Starting dynamic subtest: pipe-C-DP-1
[119.930660] Dynamic subtest pipe-C-DP-1: SUCCESS (0.546s)
[119.935327] Starting dynamic subtest: pipe-D-DP-1
[120.484600] Dynamic subtest pipe-D-DP-1: SUCCESS (0.554s)
[120.485317] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.233s)
[120.639079] [115/165] (871s left) kms_pipe_crc_basic (hang-read-crc)
[120.854589] Starting subtest: hang-read-crc
[120.855597] Starting dynamic subtest: pipe-A-DP-1
[122.026970] Dynamic subtest pipe-A-DP-1: SUCCESS (1.167s)
[122.032582] Starting dynamic subtest: pipe-B-DP-1
[123.125618] Dynamic subtest pipe-B-DP-1: SUCCESS (1.103s)
[123.134424] Starting dynamic subtest: pipe-C-DP-1
[124.250974] Dynamic subtest pipe-C-DP-1: SUCCESS (1.124s)
[124.256961] Starting dynamic subtest: pipe-D-DP-1
[125.379860] Dynamic subtest pipe-D-DP-1: SUCCESS (1.127s)
[125.380526] Subtest hang-read-crc: SUCCESS (4.526s)
[125.526263] [116/165] (866s left) kms_pipe_crc_basic (nonblocking-crc)
[125.740558] Starting subtest: nonblocking-crc
[125.741546] Starting dynamic subtest: pipe-A-DP-1
[126.346202] Dynamic subtest pipe-A-DP-1: SUCCESS (0.605s)
[126.352297] Starting dynamic subtest: pipe-B-DP-1
[126.924099] Dynamic subtest pipe-B-DP-1: SUCCESS (0.576s)
[126.928942] Starting dynamic subtest: pipe-C-DP-1
[127.502090] Dynamic subtest pipe-C-DP-1: SUCCESS (0.578s)
[127.509701] Starting dynamic subtest: pipe-D-DP-1
[128.084335] Dynamic subtest pipe-D-DP-1: SUCCESS (0.581s)
[128.085117] Subtest nonblocking-crc: SUCCESS (2.344s)
[128.228488] [117/165] (863s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[128.452237] Starting subtest: nonblocking-crc-frame-sequence
[128.452998] Starting dynamic subtest: pipe-A-DP-1
[129.068825] Dynamic subtest pipe-A-DP-1: SUCCESS (0.616s)
[129.074789] Starting dynamic subtest: pipe-B-DP-1
[129.631728] Dynamic subtest pipe-B-DP-1: SUCCESS (0.561s)
[129.636470] Starting dynamic subtest: pipe-C-DP-1
[130.195984] Dynamic subtest pipe-C-DP-1: SUCCESS (0.564s)
[130.201916] Starting dynamic subtest: pipe-D-DP-1
[130.776050] Dynamic subtest pipe-D-DP-1: SUCCESS (0.579s)
[130.776689] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.324s)
[130.922361] [118/165] (860s left) kms_pipe_crc_basic (read-crc)
[131.138226] Starting subtest: read-crc
[131.139067] Starting dynamic subtest: pipe-A-DP-1
[131.694619] Dynamic subtest pipe-A-DP-1: SUCCESS (0.554s)
[131.699999] Starting dynamic subtest: pipe-B-DP-1
[132.188247] Dynamic subtest pipe-B-DP-1: SUCCESS (0.493s)
[132.197140] Starting dynamic subtest: pipe-C-DP-1
[132.684634] Dynamic subtest pipe-C-DP-1: SUCCESS (0.494s)
[132.689651] Starting dynamic subtest: pipe-D-DP-1
[133.199061] Dynamic subtest pipe-D-DP-1: SUCCESS (0.513s)
[133.199936] Subtest read-crc: SUCCESS (2.060s)
[133.344366] [119/165] (858s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[133.566380] Starting subtest: read-crc-frame-sequence
[133.567226] Starting dynamic subtest: pipe-A-DP-1
[134.115096] Dynamic subtest pipe-A-DP-1: SUCCESS (0.547s)
[134.119945] Starting dynamic subtest: pipe-B-DP-1
[134.608323] Dynamic subtest pipe-B-DP-1: SUCCESS (0.492s)
[134.613279] Starting dynamic subtest: pipe-C-DP-1
[135.121054] Dynamic subtest pipe-C-DP-1: SUCCESS (0.512s)
[135.126979] Starting dynamic subtest: pipe-D-DP-1
[135.635797] Dynamic subtest pipe-D-DP-1: SUCCESS (0.513s)
[135.636617] Subtest read-crc-frame-sequence: SUCCESS (2.070s)
[135.780698] [120/165] (855s left) kms_pm_backlight (basic-brightness)
[135.991666] Subtest basic-brightness: SKIP (0.000s)
[136.015535] [121/165] (855s left) kms_psr (primary_page_flip)
[136.047872] Subtest primary_page_flip: SKIP (0.000s)
[136.064408] [122/165] (855s left) kms_psr (cursor_plane_move)
[136.090677] Subtest cursor_plane_move: SKIP (0.000s)
[136.116390] [123/165] (855s left) kms_psr (sprite_plane_onoff)
[136.147432] Subtest sprite_plane_onoff: SKIP (0.000s)
[136.164423] [124/165] (855s left) kms_psr (primary_mmap_gtt)
[136.190958] Subtest primary_mmap_gtt: SKIP (0.000s)
[136.214385] [125/165] (855s left) kms_setmode (basic-clone-single-crtc)
[136.240010] Starting subtest: basic-clone-single-crtc
[136.242204] Subtest basic-clone-single-crtc: SKIP (0.000s)
[136.313309] [126/165] (855s left) i915_pm_rpm (basic-pci-d3-state)
[137.858822] Starting subtest: basic-pci-d3-state
[139.366298] Subtest basic-pci-d3-state: SUCCESS (1.508s)
[139.584457] [127/165] (852s left) i915_pm_rpm (basic-rte)
[139.614611] Starting subtest: basic-rte
[144.352237] Subtest basic-rte: SUCCESS (4.738s)
[144.912870] [128/165] (846s left) i915_pm_rps (basic-api)
[144.948303] Starting subtest: basic-api
[144.949752] Subtest basic-api: SKIP (0.000s)
[145.016869] [129/165] (846s left) prime_self_import (basic-llseek-bad)
[145.049411] Starting subtest: basic-llseek-bad
[145.050855] Subtest basic-llseek-bad: SUCCESS (0.001s)
[145.132555] [130/165] (846s left) prime_self_import (basic-llseek-size)
[145.159691] Starting subtest: basic-llseek-size
[145.161334] Subtest basic-llseek-size: SUCCESS (0.001s)
[145.248936] [131/165] (846s left) prime_self_import (basic-with_fd_dup)
[145.273540] Starting subtest: basic-with_fd_dup
[145.274982] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[145.347020] [132/165] (846s left) prime_self_import (basic-with_one_bo)
[145.372508] Starting subtest: basic-with_one_bo
[145.373981] Subtest basic-with_one_bo: SUCCESS (0.002s)
[145.416430] [133/165] (846s left) prime_self_import (basic-with_one_bo_two_files)
[145.441935] Starting subtest: basic-with_one_bo_two_files
[145.443349] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[145.517512] [134/165] (846s left) prime_self_import (basic-with_two_bos)
[145.544070] Starting subtest: basic-with_two_bos
[145.545746] Subtest basic-with_two_bos: SUCCESS (0.002s)
[145.612322] [135/165] (846s left) prime_vgem (basic-fence-flip)
[145.646331] Starting subtest: basic-fence-flip
[146.233633] Subtest basic-fence-flip: SUCCESS (0.581s)
[146.318658] [136/165] (845s left) prime_vgem (basic-fence-mmap)
[146.363511] Starting subtest: basic-fence-mmap
[146.379089] Subtest basic-fence-mmap: SUCCESS (0.016s)
[146.465452] [137/165] (845s left) prime_vgem (basic-fence-read)
[146.497060] Starting subtest: basic-fence-read
[146.500780] Subtest basic-fence-read: SKIP (0.003s)
[146.583213] [138/165] (845s left) prime_vgem (basic-gtt)
[146.622010] Starting subtest: basic-gtt
[146.622643] Subtest basic-gtt: SUCCESS (0.008s)
[146.716410] [139/165] (845s left) prime_vgem (basic-read)
[146.746559] Starting subtest: basic-read
[146.750271] Subtest basic-read: SKIP (0.003s)
[146.848739] [140/165] (845s left) prime_vgem (basic-write)
[146.879805] Starting subtest: basic-write
[146.883710] Subtest basic-write: SKIP (0.003s)
[146.966528] [141/165] (845s left) vgem_basic (setversion)
[147.011242] Starting subtest: setversion
[147.012635] Subtest setversion: SUCCESS (0.000s)
[147.066970] [142/165] (844s left) vgem_basic (create)
[147.111888] Starting subtest: create
[147.112742] Subtest create: SUCCESS (0.000s)
[147.176611] [143/165] (844s left) vgem_basic (debugfs)
[147.211610] Starting subtest: debugfs
[147.212372] Subtest debugfs: SUCCESS (0.000s)
[147.262133] [144/165] (844s left) vgem_basic (dmabuf-export)
[147.294905] Starting subtest: dmabuf-export
[147.296467] Subtest dmabuf-export: SUCCESS (0.001s)
[147.383515] [145/165] (844s left) vgem_basic (dmabuf-fence)
[147.428528] Starting subtest: dmabuf-fence
[147.429567] Subtest dmabuf-fence: SUCCESS (0.001s)
[147.480802] [146/165] (844s left) vgem_basic (dmabuf-fence-before)
[147.519306] Starting subtest: dmabuf-fence-before
[147.521812] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[147.562312] [147/165] (844s left) vgem_basic (dmabuf-mmap)
[147.612131] Starting subtest: dmabuf-mmap
[147.620401] Subtest dmabuf-mmap: SUCCESS (0.009s)
[147.662298] [148/165] (844s left) vgem_basic (mmap)
[147.700707] Starting subtest: mmap
[147.701647] Subtest mmap: SUCCESS (0.004s)
[147.746602] [149/165] (844s left) vgem_basic (second-client)
[147.778123] Starting subtest: second-client
[147.812975] Subtest second-client: SUCCESS (0.033s)
[147.867483] [150/165] (844s left) vgem_basic (sysfs)
[147.912364] Starting subtest: sysfs
[147.913415] Subtest sysfs: SUCCESS (0.000s)
[147.966392] [151/165] (844s left) core_hotunplug (unbind-rebind)
[148.028164] Starting subtest: unbind-rebind
[152.210254] Subtest unbind-rebind: SUCCESS (4.183s)
[152.229022] [152/165] (839s left) vgem_basic (unload)
[152.256426] Starting subtest: unload
[181.196640] Subtest unload: SUCCESS (28.905s)
[181.250717] [153/165] (810s left) i915_module_load (reload)
[181.284128] Starting subtest: reload
[184.249796] Subtest reload: SUCCESS (2.969s)
[184.261810] [154/165] (807s left) gem_lmem_swapping (basic)
[184.296182] Subtest basic: SKIP (0.000s)
[184.322532] [155/165] (807s left) gem_lmem_swapping (parallel-random-engines)
[184.351022] Subtest parallel-random-engines: SKIP (0.000s)
[184.371580] [156/165] (807s left) gem_lmem_swapping (random-engines)
[184.407967] Subtest random-engines: SKIP (0.000s)
[184.442199] [157/165] (807s left) gem_lmem_swapping (verify-random)
[184.473987] Subtest verify-random: SKIP (0.000s)
[184.488418] [158/165] (807s left) i915_pm_rpm (module-reload)
[186.361454] Starting subtest: module-reload
[201.864878] Subtest module-reload: SUCCESS (15.497s)
[201.874515] [159/165] (790s left) i915_selftest (live)
[201.909683] Starting subtest: live
[201.910582] Starting dynamic subtest: sanitycheck
[203.586462] Dynamic subtest sanitycheck: SUCCESS (1.668s)
[203.597694] Starting dynamic subtest: uncore
[205.274023] Dynamic subtest uncore: SUCCESS (1.690s)
[205.277590] Starting dynamic subtest: workarounds
[207.885498] Dynamic subtest workarounds: SUCCESS (2.607s)
[207.889212] Starting dynamic subtest: gt_engines
[210.127729] Dynamic subtest gt_engines: SUCCESS (2.240s)
[210.131264] Starting dynamic subtest: gt_timelines
[220.687706] Dynamic subtest gt_timelines: SUCCESS (10.559s)
[220.693193] Starting dynamic subtest: gt_contexts
[222.391835] Dynamic subtest gt_contexts: SUCCESS (1.703s)
[222.396957] Starting dynamic subtest: gt_lrc
[227.004250] Dynamic subtest gt_lrc: SUCCESS (4.611s)
[227.008878] Starting dynamic subtest: gt_mocs
[229.199335] Dynamic subtest gt_mocs: SUCCESS (2.194s)
[229.202767] Starting dynamic subtest: gt_pm
[231.774529] Dynamic subtest gt_pm: SUCCESS (2.574s)
[231.778267] Starting dynamic subtest: gt_heartbeat
[233.618110] Dynamic subtest gt_heartbeat: SUCCESS (1.843s)
[233.621741] Starting dynamic subtest: gt_tlb
[236.804420] Dynamic subtest gt_tlb: SUCCESS (3.191s)
[236.809742] Starting dynamic subtest: requests
[246.430650] Dynamic subtest requests: SUCCESS (9.619s)
[246.436140] Starting dynamic subtest: migrate
[250.835501] Dynamic subtest migrate: SUCCESS (4.403s)
[250.839844] Starting dynamic subtest: active
[252.486483] Dynamic subtest active: SUCCESS (1.649s)
[252.490033] Starting dynamic subtest: objects
[254.636804] Dynamic subtest objects: SUCCESS (2.149s)
[254.643280] Starting dynamic subtest: mman
[259.940448] Dynamic subtest mman: SUCCESS (5.302s)
[259.944082] Starting dynamic subtest: dmabuf
[261.728102] Dynamic subtest dmabuf: SUCCESS (1.787s)
[261.731940] Starting dynamic subtest: vma
[263.454963] Dynamic subtest vma: SUCCESS (1.725s)
[263.460599] Starting dynamic subtest: coherency
[267.010198] Dynamic subtest coherency: SUCCESS (3.554s)
[267.013784] Starting dynamic subtest: gtt
[275.702141] Dynamic subtest gtt: SUCCESS (8.690s)
[275.705888] Starting dynamic subtest: gem
[277.484332] Dynamic subtest gem: SUCCESS (1.781s)
[277.488017] Starting dynamic subtest: evict
[280.618416] Dynamic subtest evict: SUCCESS (3.133s)
[280.621863] Starting dynamic subtest: hugepages
[288.765344] Dynamic subtest hugepages: SUCCESS (8.146s)
[288.770691] Starting dynamic subtest: gem_contexts
[305.204433] Dynamic subtest gem_contexts: SUCCESS (16.437s)
[305.208168] Starting dynamic subtest: client
[306.927397] Dynamic subtest client: SUCCESS (1.722s)
[306.931129] Starting dynamic subtest: gem_migrate
[308.613705] Dynamic subtest gem_migrate: SUCCESS (1.685s)
[308.617647] Starting dynamic subtest: reset
[314.025262] Dynamic subtest reset: SUCCESS (5.410s)
[314.028801] Starting dynamic subtest: memory_region
[315.691624] Dynamic subtest memory_region: SUCCESS (1.665s)
[315.695270] Starting dynamic subtest: hangcheck
[334.746181] Dynamic subtest hangcheck: SUCCESS (19.053s)
[334.750745] Starting dynamic subtest: execlists
[336.407635] Dynamic subtest execlists: SUCCESS (1.660s)
[336.413062] Starting dynamic subtest: ring_submission
[338.079674] Dynamic subtest ring_submission: SUCCESS (1.671s)
[338.083446] Starting dynamic subtest: perf
[339.809449] Dynamic subtest perf: SUCCESS (1.729s)
[339.827153] Starting dynamic subtest: slpc
[348.099828] Dynamic subtest slpc: SUCCESS (8.289s)
[348.105477] Starting dynamic subtest: guc
[350.566690] Dynamic subtest guc: SUCCESS (2.474s)
[350.576507] Starting dynamic subtest: guc_multi_lrc
[352.287568] Dynamic subtest guc_multi_lrc: SUCCESS (1.712s)
[352.291054] Starting dynamic subtest: guc_hang
[354.613161] Dynamic subtest guc_hang: SUCCESS (2.324s)
[354.617536] Starting dynamic subtest: late_gt_pm
[356.330031] Dynamic subtest late_gt_pm: SUCCESS (1.715s)
[356.331243] Subtest live: SUCCESS (154.412s)
[356.344061] [160/165] (635s left) dmabuf (all-tests)
[356.376677] Starting subtest: all-tests
[356.377722] Starting dynamic subtest: sanitycheck
[356.439629] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[356.449728] Starting dynamic subtest: dma_fence
[356.612409] Dynamic subtest dma_fence: SUCCESS (0.171s)
[356.619748] Starting dynamic subtest: dma_fence_chain
[365.988533] Dynamic subtest dma_fence_chain: SUCCESS (9.375s)
[365.999758] Starting dynamic subtest: dma_fence_unwrap
[366.059472] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[366.071128] Starting dynamic subtest: dma_resv
[366.132464] Dynamic subtest dma_resv: SUCCESS (0.071s)
[366.134376] Subtest all-tests: SUCCESS (9.757s)
[366.157173] [161/165] (626s left) i915_suspend (basic-s2idle-without-i915)
[366.191136] Starting subtest: basic-s2idle-without-i915
[386.149814] Subtest basic-s2idle-without-i915: SUCCESS (5.428s)
[386.411750] [162/165] (620s left) i915_suspend (basic-s3-without-i915)
[386.444856] Starting subtest: basic-s3-without-i915
[406.771975] Subtest basic-s3-without-i915: SUCCESS (4.285s)
[407.057677] [163/165] (615s left) gem_exec_suspend (basic-s0)
[407.097703] Starting subtest: basic-S0
[407.098525] Starting dynamic subtest: smem
[425.129771] Dynamic subtest smem: SUCCESS (2.593s)
[425.131344] Subtest basic-S0: SUCCESS (2.594s)
[425.262696] [164/165] (613s left) gem_exec_suspend (basic-s3)
[425.299950] Starting subtest: basic-S3
[425.300951] Starting dynamic subtest: smem
[443.105133] Dynamic subtest smem: SUCCESS (2.545s)
[443.106883] Subtest basic-S3: SUCCESS (2.546s)
[443.240030] [165/165] (610s left) kms_pipe_crc_basic (suspend-read-crc)
[443.462911] Starting subtest: suspend-read-crc
[443.463897] Starting dynamic subtest: pipe-A-DP-1
[461.248632] Dynamic subtest pipe-A-DP-1: SUCCESS (2.375s)
[461.253859] Starting dynamic subtest: pipe-B-DP-1
[479.190731] Dynamic subtest pipe-B-DP-1: SUCCESS (2.245s)
[479.195979] Starting dynamic subtest: pipe-C-DP-1
[496.188605] Dynamic subtest pipe-C-DP-1: SUCCESS (2.243s)
[496.193632] Starting dynamic subtest: pipe-D-DP-1
[513.193376] Dynamic subtest pipe-D-DP-1: SUCCESS (2.255s)
[513.194372] Subtest suspend-read-crc: SUCCESS (9.123s)
[513.297691] Closing watchdogs
Done.