[28.087413] Initializing watchdogs
[28.087463]   /dev/watchdog0
[28.092871] [001/165] (960s left) i915_module_load (load)
[28.133650] Starting subtest: load
[30.247997] Subtest load: SUCCESS (2.117s)
[30.262699] [002/165] (958s left) core_auth (basic-auth)
[30.313469] Starting subtest: basic-auth
[30.315490] Subtest basic-auth: SUCCESS (0.001s)
[30.365502] [003/165] (958s left) debugfs_test (read_all_entries)
[30.409459] Starting subtest: read_all_entries
[30.536518] Subtest read_all_entries: SUCCESS (0.123s)
[30.858989] [004/165] (957s left) debugfs_test (basic-hwmon)
[30.923419] Starting subtest: basic-hwmon
[30.927404] Subtest basic-hwmon: SKIP (0.000s)
[31.276487] [005/165] (957s left) fbdev (eof)
[31.331634] Starting subtest: eof
[31.333794] Subtest eof: SUCCESS (0.000s)
[31.394576] [006/165] (957s left) fbdev (info)
[31.443550] Starting subtest: info
[31.445613] Subtest info: SUCCESS (0.000s)
[31.504971] [007/165] (957s left) fbdev (nullptr)
[31.564948] Starting subtest: nullptr
[31.567447] Subtest nullptr: SUCCESS (0.000s)
[31.622440] [008/165] (957s left) fbdev (read)
[31.681563] Starting subtest: read
[33.368124] Subtest read: SUCCESS (1.686s)
[33.414968] [009/165] (955s left) fbdev (write)
[33.465476] Starting subtest: write
[34.601242] Subtest write: SUCCESS (1.135s)
[34.649512] [010/165] (954s left) gem_basic (bad-close)
[34.696234] Starting subtest: bad-close
[34.701773] Subtest bad-close: SUCCESS (0.000s)
[34.765472] [011/165] (954s left) gem_basic (create-close)
[34.830884] Starting subtest: create-close
[34.836235] Subtest create-close: SUCCESS (0.000s)
[34.927124] [012/165] (953s left) gem_basic (create-fd-close)
[34.982298] Starting subtest: create-fd-close
[34.986871] Subtest create-fd-close: SUCCESS (0.000s)
[35.070811] [013/165] (953s left) gem_busy (busy@all-engines)
[35.129508] Starting subtest: busy
[35.132081] Starting dynamic subtest: all-engines
[35.152523] Dynamic subtest all-engines: SUCCESS (0.023s)
[35.155127] Subtest busy: SUCCESS (0.023s)
[35.497699] [014/165] (953s left) gem_close_race (basic-process)
[35.568244] Starting subtest: basic-process
[35.603124] Subtest basic-process: SUCCESS (0.034s)
[35.786950] [015/165] (953s left) gem_close_race (basic-threads)
[35.850233] Starting subtest: basic-threads
[37.128183] Subtest basic-threads: SUCCESS (1.278s)
[37.315319] [016/165] (951s left) gem_ctx_create (basic)
[37.379300] Starting subtest: basic
[37.382180] Subtest basic: SUCCESS (0.000s)
[37.563697] [017/165] (951s left) gem_ctx_create (basic-files)
[37.615247] Starting subtest: basic-files
[39.625932] Subtest basic-files: SUCCESS (2.012s)
[39.816859] [018/165] (949s left) gem_ctx_exec (basic)
[39.873723] Starting subtest: basic
[39.876279] Subtest basic: SUCCESS (0.002s)
[39.999642] [019/165] (948s left) gem_exec_basic (basic)
[40.055678] Starting subtest: basic
[40.058206] Starting dynamic subtest: rcs0-smem
[40.060765] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[40.068935] Starting dynamic subtest: bcs0-smem
[40.071963] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[40.082654] Starting dynamic subtest: vcs0-smem
[40.085500] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[40.094491] Starting dynamic subtest: vcs1-smem
[40.097262] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[40.105463] Starting dynamic subtest: vecs0-smem
[40.108186] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[40.110968] Subtest basic: SUCCESS (0.002s)
[40.246740] [020/165] (948s left) gem_exec_create (basic)
[40.303829] Starting subtest: basic
[40.306589] Starting dynamic subtest: smem
[42.354573] Dynamic subtest smem: SUCCESS (2.051s)
[42.357788] Subtest basic: SUCCESS (2.051s)
[42.531181] [021/165] (946s left) gem_exec_fence (basic-busy)
[42.724784] Starting subtest: basic-busy
[42.728593] Starting dynamic subtest: rcs0
[42.776486] Dynamic subtest rcs0: SUCCESS (0.052s)
[42.793104] Starting dynamic subtest: bcs0
[42.804926] Dynamic subtest bcs0: SUCCESS (0.026s)
[42.820975] Starting dynamic subtest: vcs0
[42.831191] Dynamic subtest vcs0: SUCCESS (0.026s)
[42.845060] Starting dynamic subtest: vcs1
[42.854769] Dynamic subtest vcs1: SUCCESS (0.027s)
[42.868155] Starting dynamic subtest: vecs0
[42.879129] Dynamic subtest vecs0: SUCCESS (0.023s)
[42.882355] Subtest basic-busy: SUCCESS (0.154s)
[43.363628] [022/165] (945s left) gem_exec_fence (basic-wait)
[43.524664] Starting subtest: basic-wait
[43.528294] Starting dynamic subtest: rcs0
[43.580461] Dynamic subtest rcs0: SUCCESS (0.057s)
[43.596306] Starting dynamic subtest: bcs0
[43.608165] Dynamic subtest bcs0: SUCCESS (0.027s)
[43.619257] Starting dynamic subtest: vcs0
[43.629322] Dynamic subtest vcs0: SUCCESS (0.021s)
[43.642149] Starting dynamic subtest: vcs1
[43.653992] Dynamic subtest vcs1: SUCCESS (0.023s)
[43.672350] Starting dynamic subtest: vecs0
[43.679429] Dynamic subtest vecs0: SUCCESS (0.026s)
[43.682995] Subtest basic-wait: SUCCESS (0.154s)
[44.115587] [023/165] (944s left) gem_exec_fence (basic-await)
[44.292459] Starting subtest: basic-await
[44.296149] Starting dynamic subtest: rcs0
[44.367623] Dynamic subtest rcs0: SUCCESS (0.076s)
[44.377121] Starting dynamic subtest: bcs0
[44.443105] Dynamic subtest bcs0: SUCCESS (0.074s)
[44.450102] Starting dynamic subtest: vcs0
[44.514447] Dynamic subtest vcs0: SUCCESS (0.071s)
[44.527325] Starting dynamic subtest: vcs1
[44.592897] Dynamic subtest vcs1: SUCCESS (0.078s)
[44.606981] Starting dynamic subtest: vecs0
[44.672759] Dynamic subtest vecs0: SUCCESS (0.080s)
[44.676713] Subtest basic-await: SUCCESS (0.382s)
[45.115619] [024/165] (943s left) gem_exec_fence (nb-await)
[45.292256] Starting subtest: nb-await
[45.295471] Starting dynamic subtest: rcs0
[45.352824] Dynamic subtest rcs0: SUCCESS (0.061s)
[45.363916] Starting dynamic subtest: bcs0
[45.413846] Dynamic subtest bcs0: SUCCESS (0.061s)
[45.426808] Starting dynamic subtest: vcs0
[45.475394] Dynamic subtest vcs0: SUCCESS (0.061s)
[45.487437] Starting dynamic subtest: vcs1
[45.533283] Dynamic subtest vcs1: SUCCESS (0.058s)
[45.545384] Starting dynamic subtest: vecs0
[45.593754] Dynamic subtest vecs0: SUCCESS (0.061s)
[45.597360] Subtest nb-await: SUCCESS (0.302s)
[46.033324] [025/165] (943s left) gem_exec_gttfill (basic)
[46.091702] Starting subtest: basic
[48.419037] Subtest basic: SUCCESS (2.328s)
[48.584041] [026/165] (940s left) gem_exec_parallel (engines)
[48.691068] Starting subtest: engines
[48.693757] Starting dynamic subtest: basic
[50.301764] Dynamic subtest basic: SUCCESS (1.610s)
[50.308133] Starting dynamic subtest: contexts
[52.175283] Dynamic subtest contexts: SUCCESS (1.873s)
[52.181904] Starting dynamic subtest: fds
[54.276950] Dynamic subtest fds: SUCCESS (2.102s)
[54.284670] Starting dynamic subtest: userptr
[55.845862] Dynamic subtest userptr: SUCCESS (1.569s)
[55.849258] Subtest engines: SUCCESS (7.154s)
[56.053748] [027/165] (933s left) gem_exec_store (basic)
[56.123640] Starting subtest: basic
[56.185089] Subtest basic: SUCCESS (0.068s)
[56.366785] [028/165] (932s left) gem_flink_basic (bad-flink)
[56.423536] Starting subtest: bad-flink
[56.426370] Subtest bad-flink: SUCCESS (0.000s)
[56.500078] [029/165] (932s left) gem_flink_basic (bad-open)
[56.549400] Starting subtest: bad-open
[56.551639] Subtest bad-open: SUCCESS (0.000s)
[56.610301] [030/165] (932s left) gem_flink_basic (basic)
[56.664872] Starting subtest: basic
[56.667089] Subtest basic: SUCCESS (0.000s)
[56.741132] [031/165] (932s left) gem_flink_basic (double-flink)
[56.782213] Starting subtest: double-flink
[56.784809] Subtest double-flink: SUCCESS (0.000s)
[56.884770] [032/165] (932s left) gem_flink_basic (flink-lifetime)
[56.934766] Starting subtest: flink-lifetime
[56.936880] Subtest flink-lifetime: SUCCESS (0.001s)
[57.020184] [033/165] (932s left) gem_huc_copy (huc-copy)
[57.083778] Starting subtest: huc-copy
[57.086222] Subtest huc-copy: SUCCESS (0.002s)
[57.186679] [034/165] (932s left) gem_linear_blits (basic)
[57.299150] Starting subtest: basic
[57.304915] Subtest basic: SUCCESS (0.006s)
[57.424080] [035/165] (931s left) gem_mmap (basic)
[57.503057] Starting subtest: basic
[57.513190] Subtest basic: SUCCESS (0.000s)
[57.597652] [036/165] (931s left) gem_mmap_gtt (basic)
[57.649294] Starting subtest: basic
[57.651200] Subtest basic: SUCCESS (0.000s)
[57.694605] [037/165] (931s left) gem_render_linear_blits (basic)
[57.739470] Starting subtest: basic
[57.756396] Subtest basic: SUCCESS (0.018s)
[57.835124] [038/165] (931s left) gem_render_tiled_blits (basic)
[57.889823] Starting subtest: basic
[57.907304] Subtest basic: SUCCESS (0.020s)
[57.968271] [039/165] (931s left) gem_ringfill (basic-all)
[58.190166] Starting subtest: basic-all
[59.304694] Subtest basic-all: SUCCESS (1.114s)
[59.415255] [040/165] (930s left) gem_softpin (allocator-basic)
[59.466341] Starting subtest: allocator-basic
[59.519733] Subtest allocator-basic: SUCCESS (0.053s)
[59.634384] [041/165] (929s left) gem_softpin (allocator-basic-reserve)
[59.688288] Starting subtest: allocator-basic-reserve
[59.736822] Subtest allocator-basic-reserve: SUCCESS (0.051s)
[59.853170] [042/165] (929s left) gem_softpin (safe-alignment)
[59.908218] Starting subtest: safe-alignment
[59.915237] Subtest safe-alignment: SUCCESS (0.009s)
[60.020247] [043/165] (929s left) gem_sync (basic-all)
[60.101207] Starting subtest: basic-all
[62.318439] Subtest basic-all: SUCCESS (2.236s)
[62.499419] [044/165] (927s left) gem_sync (basic-each)
[62.567254] Starting subtest: basic-each
[64.616442] Subtest basic-each: SUCCESS (2.068s)
[64.807535] [045/165] (924s left) gem_tiled_blits (basic)
[64.921051] Starting subtest: basic
[64.931419] Subtest basic: SUCCESS (0.011s)
[65.049567] [046/165] (924s left) gem_tiled_fence_blits (basic)
[65.225275] Starting subtest: basic
[65.237659] Subtest basic: SUCCESS (0.013s)
[65.370377] [047/165] (924s left) gem_tiled_pread_basic
[65.550281] [048/165] (924s left) gem_wait (busy@all-engines)
[65.611825] Starting subtest: busy
[65.614378] Starting dynamic subtest: all-engines
[66.125128] Dynamic subtest all-engines: SUCCESS (0.513s)
[66.127922] Subtest busy: SUCCESS (0.513s)
[66.337455] [049/165] (923s left) gem_wait (wait@all-engines)
[66.406019] Starting subtest: wait
[66.408953] Starting dynamic subtest: all-engines
[67.452969] Dynamic subtest all-engines: SUCCESS (1.047s)
[67.456337] Subtest wait: SUCCESS (1.047s)
[67.670345] [050/165] (922s left) i915_getparams_basic (basic-eu-total)
[67.728717] Starting subtest: basic-eu-total
[67.734125] Subtest basic-eu-total: SUCCESS (0.000s)
[67.799395] [051/165] (921s left) i915_getparams_basic (basic-subslice-total)
[67.867131] Starting subtest: basic-subslice-total
[67.872896] Subtest basic-subslice-total: SUCCESS (0.000s)
[67.933726] [052/165] (921s left) i915_hangman (error-state-basic)
[68.001942] Starting subtest: error-state-basic
[68.100403] Subtest error-state-basic: SUCCESS (0.100s)
[68.184906] [053/165] (921s left) i915_pciid
[68.298625] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled)
[68.599130] Starting subtest: addfb25-4-tiled
[68.601183] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[68.681666] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[68.732490] Starting subtest: addfb25-bad-modifier
[68.734639] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[69.049129] [056/165] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[69.103512] Starting subtest: addfb25-framebuffer-vs-set-tiling
[69.105531] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[69.412238] [057/165] (920s left) kms_addfb_basic (addfb25-modifier-no-flag)
[69.451185] Starting subtest: addfb25-modifier-no-flag
[69.452986] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[69.747472] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[69.801485] Starting subtest: addfb25-x-tiled-legacy
[69.803413] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[70.247078] [059/165] (919s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[70.296508] Starting subtest: addfb25-x-tiled-mismatch-legacy
[70.298655] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[70.662034] [060/165] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[70.944382] Starting subtest: addfb25-yf-tiled-legacy
[70.946762] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[71.049617] [061/165] (918s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.322255] Starting subtest: addfb25-y-tiled-legacy
[71.324777] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[71.422920] [062/165] (918s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[71.686206] Starting subtest: addfb25-y-tiled-small-legacy
[71.688220] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[71.786423] [063/165] (918s left) kms_addfb_basic (bad-pitch-0)
[71.835933] Starting subtest: bad-pitch-0
[71.837658] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.129161] [064/165] (917s left) kms_addfb_basic (bad-pitch-1024)
[72.185322] Starting subtest: bad-pitch-1024
[72.187369] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.574728] [065/165] (917s left) kms_addfb_basic (bad-pitch-128)
[72.629842] Starting subtest: bad-pitch-128
[72.631872] Subtest bad-pitch-128: SUCCESS (0.000s)
[72.922443] [066/165] (917s left) kms_addfb_basic (bad-pitch-256)
[72.958533] Starting subtest: bad-pitch-256
[72.960368] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.263916] [067/165] (916s left) kms_addfb_basic (bad-pitch-32)
[73.313159] Starting subtest: bad-pitch-32
[73.315312] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.700069] [068/165] (916s left) kms_addfb_basic (bad-pitch-63)
[73.744075] Starting subtest: bad-pitch-63
[73.745642] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.049312] [069/165] (916s left) kms_addfb_basic (bad-pitch-65536)
[74.106070] Starting subtest: bad-pitch-65536
[74.108034] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.400333] [070/165] (915s left) kms_addfb_basic (bad-pitch-999)
[74.452038] Starting subtest: bad-pitch-999
[74.453993] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.746236] [071/165] (915s left) kms_addfb_basic (basic)
[74.800933] Starting subtest: basic
[74.802879] Subtest basic: SUCCESS (0.000s)
[75.122370] [072/165] (915s left) kms_addfb_basic (basic-x-tiled-legacy)
[75.176137] Starting subtest: basic-x-tiled-legacy
[75.178444] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.484092] [073/165] (914s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.540450] Starting subtest: basic-y-tiled-legacy
[75.542193] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.864347] [074/165] (914s left) kms_addfb_basic (bo-too-small)
[76.137928] Starting subtest: bo-too-small
[76.140379] Subtest bo-too-small: SUCCESS (0.000s)
[76.230947] [075/165] (914s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[76.497406] Starting subtest: bo-too-small-due-to-tiling
[76.499840] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[76.588523] [076/165] (913s left) kms_addfb_basic (clobberred-modifier)
[76.640959] Starting subtest: clobberred-modifier
[76.643105] Subtest clobberred-modifier: SUCCESS (0.000s)
[76.950189] [077/165] (913s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[77.009400] Starting subtest: framebuffer-vs-set-tiling
[77.011941] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.378869] [078/165] (913s left) kms_addfb_basic (invalid-get-prop)
[77.414936] Starting subtest: invalid-get-prop
[77.416891] Subtest invalid-get-prop: SUCCESS (0.000s)
[77.715836] [079/165] (912s left) kms_addfb_basic (invalid-get-prop-any)
[77.772090] Starting subtest: invalid-get-prop-any
[77.776779] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.080993] [080/165] (912s left) kms_addfb_basic (invalid-set-prop)
[78.127264] Starting subtest: invalid-set-prop
[78.129029] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.431572] [081/165] (912s left) kms_addfb_basic (invalid-set-prop-any)
[78.485658] Starting subtest: invalid-set-prop-any
[78.487702] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[78.830981] [082/165] (911s left) kms_addfb_basic (no-handle)
[78.888131] Starting subtest: no-handle
[78.890045] Subtest no-handle: SUCCESS (0.000s)
[79.196937] [083/165] (911s left) kms_addfb_basic (size-max)
[79.473341] Starting subtest: size-max
[79.475810] Subtest size-max: SUCCESS (0.000s)
[79.564870] [084/165] (911s left) kms_addfb_basic (small-bo)
[79.852080] Starting subtest: small-bo
[79.854460] Subtest small-bo: SUCCESS (0.000s)
[79.950121] [085/165] (910s left) kms_addfb_basic (tile-pitch-mismatch)
[80.004482] Starting subtest: tile-pitch-mismatch
[80.006119] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[80.332880] [086/165] (910s left) kms_addfb_basic (too-high)
[80.602448] Starting subtest: too-high
[80.605106] Subtest too-high: SUCCESS (0.001s)
[80.702882] [087/165] (909s left) kms_addfb_basic (too-wide)
[80.973356] Starting subtest: too-wide
[80.975971] Subtest too-wide: SUCCESS (0.000s)
[81.059189] [088/165] (909s left) kms_addfb_basic (unused-handle)
[81.110221] Starting subtest: unused-handle
[81.111867] Subtest unused-handle: SUCCESS (0.000s)
[81.409992] [089/165] (909s left) kms_addfb_basic (unused-modifier)
[81.452530] Starting subtest: unused-modifier
[81.454525] Subtest unused-modifier: SUCCESS (0.000s)
[81.749267] [090/165] (908s left) kms_addfb_basic (unused-offsets)
[81.794348] Starting subtest: unused-offsets
[81.796088] Subtest unused-offsets: SUCCESS (0.000s)
[82.115680] [091/165] (908s left) kms_addfb_basic (unused-pitches)
[82.157199] Starting subtest: unused-pitches
[82.159432] Subtest unused-pitches: SUCCESS (0.000s)
[82.467526] [092/165] (908s left) kms_busy (basic)
[82.751018] Starting subtest: basic
[82.753275] Starting dynamic subtest: flip
[83.336817] Dynamic subtest flip: SUCCESS (0.584s)
[83.342384] Starting dynamic subtest: modeset
[84.254522] Dynamic subtest modeset: SUCCESS (0.917s)
[84.256660] Subtest basic: SUCCESS (1.502s)
[84.472205] [093/165] (906s left) kms_prop_blob (basic)
[84.535668] Starting subtest: basic
[84.537314] Subtest basic: SUCCESS (0.000s)
[84.602438] [094/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[84.864354] Starting subtest: basic-busy-flip-before-cursor-atomic
[84.869127] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[84.930330] [095/165] (905s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[85.202309] Starting subtest: basic-busy-flip-before-cursor-legacy
[85.206288] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[85.268705] [096/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[85.534932] Starting subtest: basic-flip-after-cursor-atomic
[86.528215] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.990s)
[86.727055] [097/165] (904s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[87.004986] Starting subtest: basic-flip-after-cursor-legacy
[87.996617] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.989s)
[88.175935] [098/165] (902s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[88.450236] Starting subtest: basic-flip-after-cursor-varying-size
[89.444081] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.993s)
[89.633522] [099/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[89.892162] Starting subtest: basic-flip-before-cursor-atomic
[90.888746] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.994s)
[91.091673] [100/165] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[91.358143] Starting subtest: basic-flip-before-cursor-legacy
[92.357891] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.998s)
[92.554504] [101/165] (898s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[92.819399] Starting subtest: basic-flip-before-cursor-varying-size
[93.805825] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.987s)
[93.996496] [102/165] (897s left) kms_dsc (dsc-basic)
[94.280397] Subtest dsc-basic: SKIP (0.000s)
[94.304538] [103/165] (896s left) kms_flip (basic-flip-vs-dpms)
[94.583288] Starting subtest: basic-flip-vs-dpms
[94.586278] Starting dynamic subtest: A-DP2
[95.360043] Dynamic subtest A-DP2: SUCCESS (0.775s)
[95.366408] Starting dynamic subtest: B-DP2
[96.185057] Dynamic subtest B-DP2: SUCCESS (0.824s)
[96.191241] Starting dynamic subtest: C-DP2
[97.012070] Dynamic subtest C-DP2: SUCCESS (0.825s)
[97.018088] Starting dynamic subtest: D-DP2
[97.836634] Dynamic subtest D-DP2: SUCCESS (0.824s)
[97.838578] Subtest basic-flip-vs-dpms: SUCCESS (3.259s)
[98.052636] [104/165] (893s left) kms_flip (basic-flip-vs-modeset)
[98.323658] Starting subtest: basic-flip-vs-modeset
[98.328113] Starting dynamic subtest: A-DP2
[99.128361] Dynamic subtest A-DP2: SUCCESS (0.800s)
[99.134358] Starting dynamic subtest: B-DP2
[99.959496] Dynamic subtest B-DP2: SUCCESS (0.830s)
[99.966986] Starting dynamic subtest: C-DP2
[100.783577] Dynamic subtest C-DP2: SUCCESS (0.824s)
[100.792737] Starting dynamic subtest: D-DP2
[101.613196] Dynamic subtest D-DP2: SUCCESS (0.827s)
[101.615471] Subtest basic-flip-vs-modeset: SUCCESS (3.292s)
[101.812573] [105/165] (889s left) kms_flip (basic-flip-vs-wf_vblank)
[102.072616] Starting subtest: basic-flip-vs-wf_vblank
[102.077257] Starting dynamic subtest: A-DP2
[103.167193] Dynamic subtest A-DP2: SUCCESS (1.091s)
[103.179789] Starting dynamic subtest: B-DP2
[104.214799] Dynamic subtest B-DP2: SUCCESS (1.046s)
[104.230481] Starting dynamic subtest: C-DP2
[105.271049] Dynamic subtest C-DP2: SUCCESS (1.054s)
[105.286962] Starting dynamic subtest: D-DP2
[106.322513] Dynamic subtest D-DP2: SUCCESS (1.049s)
[106.332103] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.260s)
[106.570334] [106/165] (884s left) kms_flip (basic-plain-flip)
[106.881811] Starting subtest: basic-plain-flip
[106.884590] Starting dynamic subtest: A-DP2
[107.692680] Dynamic subtest A-DP2: SUCCESS (0.808s)
[107.708340] Starting dynamic subtest: B-DP2
[108.461492] Dynamic subtest B-DP2: SUCCESS (0.766s)
[108.476131] Starting dynamic subtest: C-DP2
[109.238307] Dynamic subtest C-DP2: SUCCESS (0.774s)
[109.245736] Starting dynamic subtest: D-DP2
[110.013569] Dynamic subtest D-DP2: SUCCESS (0.773s)
[110.023206] Subtest basic-plain-flip: SUCCESS (3.143s)
[110.271836] [107/165] (880s left) kms_force_connector_basic (force-connector-state)
[110.490561] Starting subtest: force-connector-state
[110.906670] Subtest force-connector-state: SUCCESS (0.418s)
[111.673692] [108/165] (879s left) kms_force_connector_basic (force-edid)
[111.898419] Starting subtest: force-edid
[111.915010] Subtest force-edid: SUCCESS (0.020s)
[112.572774] [109/165] (878s left) kms_force_connector_basic (force-load-detect)
[112.787624] Starting subtest: force-load-detect
[112.791520] Subtest force-load-detect: SKIP (0.000s)
[113.252687] [110/165] (877s left) kms_force_connector_basic (prune-stale-modes)
[113.465394] Starting subtest: prune-stale-modes
[113.481363] Subtest prune-stale-modes: SUCCESS (0.019s)
[114.096384] [111/165] (877s left) kms_frontbuffer_tracking (basic)
[114.400120] Starting subtest: basic
[117.861348] Subtest basic: SUCCESS (3.465s)
[117.990390] [112/165] (873s left) kms_hdmi_inject (inject-audio)
[118.112488] Starting subtest: inject-audio
[118.213758] Subtest inject-audio: SUCCESS (0.098s)
[118.608485] [113/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[118.907043] Starting subtest: compare-crc-sanitycheck-xr24
[118.909152] Starting dynamic subtest: pipe-A-DP-2
[119.348998] Dynamic subtest pipe-A-DP-2: SUCCESS (0.441s)
[119.356941] Starting dynamic subtest: pipe-B-DP-2
[119.784127] Dynamic subtest pipe-B-DP-2: SUCCESS (0.435s)
[119.791036] Starting dynamic subtest: pipe-C-DP-2
[120.202768] Dynamic subtest pipe-C-DP-2: SUCCESS (0.415s)
[120.209539] Starting dynamic subtest: pipe-D-DP-2
[120.621766] Dynamic subtest pipe-D-DP-2: SUCCESS (0.419s)
[120.623798] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.717s)
[120.819695] [114/165] (870s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[121.092557] Starting subtest: compare-crc-sanitycheck-nv12
[121.097839] Starting dynamic subtest: pipe-A-DP-2
[121.673666] Dynamic subtest pipe-A-DP-2: SUCCESS (0.575s)
[121.680946] Starting dynamic subtest: pipe-B-DP-2
[122.199538] Dynamic subtest pipe-B-DP-2: SUCCESS (0.526s)
[122.207879] Starting dynamic subtest: pipe-C-DP-2
[122.728213] Dynamic subtest pipe-C-DP-2: SUCCESS (0.528s)
[122.736317] Starting dynamic subtest: pipe-D-DP-2
[123.266518] Dynamic subtest pipe-D-DP-2: SUCCESS (0.533s)
[123.269295] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.172s)
[123.470350] [115/165] (867s left) kms_pipe_crc_basic (hang-read-crc)
[123.742230] Starting subtest: hang-read-crc
[123.744942] Starting dynamic subtest: pipe-A-DP-2
[125.001477] Dynamic subtest pipe-A-DP-2: SUCCESS (1.258s)
[125.009723] Starting dynamic subtest: pipe-B-DP-2
[126.191550] Dynamic subtest pipe-B-DP-2: SUCCESS (1.191s)
[126.198290] Starting dynamic subtest: pipe-C-DP-2
[127.383210] Dynamic subtest pipe-C-DP-2: SUCCESS (1.188s)
[127.391639] Starting dynamic subtest: pipe-D-DP-2
[128.545859] Dynamic subtest pipe-D-DP-2: SUCCESS (1.160s)
[128.548389] Subtest hang-read-crc: SUCCESS (4.805s)
[128.716429] [116/165] (862s left) kms_pipe_crc_basic (nonblocking-crc)
[128.998960] Starting subtest: nonblocking-crc
[129.002103] Starting dynamic subtest: pipe-A-DP-2
[129.629853] Dynamic subtest pipe-A-DP-2: SUCCESS (0.633s)
[129.636514] Starting dynamic subtest: pipe-B-DP-2
[130.245322] Dynamic subtest pipe-B-DP-2: SUCCESS (0.610s)
[130.252525] Starting dynamic subtest: pipe-C-DP-2
[130.860535] Dynamic subtest pipe-C-DP-2: SUCCESS (0.614s)
[130.868752] Starting dynamic subtest: pipe-D-DP-2
[131.474540] Dynamic subtest pipe-D-DP-2: SUCCESS (0.613s)
[131.477729] Subtest nonblocking-crc: SUCCESS (2.479s)
[131.646600] [117/165] (859s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[131.932056] Starting subtest: nonblocking-crc-frame-sequence
[131.934112] Starting dynamic subtest: pipe-A-DP-2
[132.576993] Dynamic subtest pipe-A-DP-2: SUCCESS (0.646s)
[132.583802] Starting dynamic subtest: pipe-B-DP-2
[133.207679] Dynamic subtest pipe-B-DP-2: SUCCESS (0.628s)
[133.220763] Starting dynamic subtest: pipe-C-DP-2
[133.829496] Dynamic subtest pipe-C-DP-2: SUCCESS (0.618s)
[133.838320] Starting dynamic subtest: pipe-D-DP-2
[134.445947] Dynamic subtest pipe-D-DP-2: SUCCESS (0.616s)
[134.449057] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.516s)
[134.614672] [118/165] (856s left) kms_pipe_crc_basic (read-crc)
[134.888946] Starting subtest: read-crc
[134.891223] Starting dynamic subtest: pipe-A-DP-2
[135.467726] Dynamic subtest pipe-A-DP-2: SUCCESS (0.578s)
[135.474603] Starting dynamic subtest: pipe-B-DP-2
[136.015333] Dynamic subtest pipe-B-DP-2: SUCCESS (0.544s)
[136.022723] Starting dynamic subtest: pipe-C-DP-2
[136.544116] Dynamic subtest pipe-C-DP-2: SUCCESS (0.530s)
[136.551802] Starting dynamic subtest: pipe-D-DP-2
[137.078183] Dynamic subtest pipe-D-DP-2: SUCCESS (0.531s)
[137.080758] Subtest read-crc: SUCCESS (2.192s)
[137.252669] [119/165] (854s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[137.524147] Starting subtest: read-crc-frame-sequence
[137.526875] Starting dynamic subtest: pipe-A-DP-2
[138.104260] Dynamic subtest pipe-A-DP-2: SUCCESS (0.579s)
[138.111408] Starting dynamic subtest: pipe-B-DP-2
[138.686187] Dynamic subtest pipe-B-DP-2: SUCCESS (0.579s)
[138.697988] Starting dynamic subtest: pipe-C-DP-2
[139.217542] Dynamic subtest pipe-C-DP-2: SUCCESS (0.530s)
[139.224330] Starting dynamic subtest: pipe-D-DP-2
[139.766505] Dynamic subtest pipe-D-DP-2: SUCCESS (0.547s)
[139.769034] Subtest read-crc-frame-sequence: SUCCESS (2.243s)
[139.937359] [120/165] (851s left) kms_pm_backlight (basic-brightness)
[140.210929] Subtest basic-brightness: SKIP (0.000s)
[140.229733] [121/165] (851s left) kms_pm_rpm (basic-pci-d3-state)
[142.077988] Starting subtest: basic-pci-d3-state
[142.503906] Subtest basic-pci-d3-state: SUCCESS (0.424s)
[142.751928] [122/165] (848s left) kms_pm_rpm (basic-rte)
[142.809921] Starting subtest: basic-rte
[145.077936] Subtest basic-rte: SUCCESS (2.267s)
[145.972952] [123/165] (845s left) kms_psr (psr-primary-page-flip)
[146.266992] Subtest psr-primary-page-flip: SKIP (0.000s)
[146.288955] [124/165] (845s left) kms_psr (psr-cursor-plane-move)
[146.572074] Subtest psr-cursor-plane-move: SKIP (0.000s)
[146.621048] [125/165] (844s left) kms_psr (psr-sprite-plane-onoff)
[146.901229] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[146.920152] [126/165] (844s left) kms_psr (psr-primary-mmap-gtt)
[147.254172] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[147.297898] [127/165] (844s left) kms_setmode (basic-clone-single-crtc)
[147.352670] Starting subtest: basic-clone-single-crtc
[147.358970] Subtest basic-clone-single-crtc: SKIP (0.000s)
[147.430846] [128/165] (844s left) i915_pm_rps (basic-api)
[147.480786] Starting subtest: basic-api
[147.482945] Subtest basic-api: SUCCESS (0.001s)
[147.564209] [129/165] (844s left) prime_self_import (basic-llseek-bad)
[147.621384] Starting subtest: basic-llseek-bad
[147.625184] Subtest basic-llseek-bad: SUCCESS (0.001s)
[147.711968] [130/165] (843s left) prime_self_import (basic-llseek-size)
[147.756919] Starting subtest: basic-llseek-size
[147.760761] Subtest basic-llseek-size: SUCCESS (0.002s)
[147.838642] [131/165] (843s left) prime_self_import (basic-with_fd_dup)
[147.870662] Starting subtest: basic-with_fd_dup
[147.874542] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[147.990881] [132/165] (843s left) prime_self_import (basic-with_one_bo)
[148.047281] Starting subtest: basic-with_one_bo
[148.051315] Subtest basic-with_one_bo: SUCCESS (0.002s)
[148.110603] [133/165] (843s left) prime_self_import (basic-with_one_bo_two_files)
[148.160952] Starting subtest: basic-with_one_bo_two_files
[148.164720] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[148.247818] [134/165] (843s left) prime_self_import (basic-with_two_bos)
[148.293929] Starting subtest: basic-with_two_bos
[148.298144] Subtest basic-with_two_bos: SUCCESS (0.002s)
[148.397685] [135/165] (843s left) prime_vgem (basic-fence-flip)
[148.469972] Starting subtest: basic-fence-flip
[149.162208] Subtest basic-fence-flip: SUCCESS (0.692s)
[149.265596] [136/165] (842s left) prime_vgem (basic-fence-mmap)
[149.335028] Starting subtest: basic-fence-mmap
[149.355089] Subtest basic-fence-mmap: SUCCESS (0.022s)
[149.464376] [137/165] (842s left) prime_vgem (basic-fence-read)
[149.517720] Starting subtest: basic-fence-read
[149.523852] Subtest basic-fence-read: SKIP (0.003s)
[149.630385] [138/165] (842s left) prime_vgem (basic-gtt)
[149.687545] Starting subtest: basic-gtt
[149.689779] Subtest basic-gtt: SUCCESS (0.008s)
[149.796063] [139/165] (842s left) prime_vgem (basic-read)
[149.873353] Starting subtest: basic-read
[149.882851] Subtest basic-read: SKIP (0.006s)
[149.981570] [140/165] (841s left) prime_vgem (basic-write)
[150.034321] Starting subtest: basic-write
[150.039521] Subtest basic-write: SKIP (0.004s)
[150.133943] [141/165] (841s left) vgem_basic (setversion)
[150.198365] Starting subtest: setversion
[150.203270] Subtest setversion: SUCCESS (0.000s)
[150.262301] [142/165] (841s left) vgem_basic (create)
[150.330447] Starting subtest: create
[150.332299] Subtest create: SUCCESS (0.000s)
[150.398098] [143/165] (841s left) vgem_basic (debugfs)
[150.464532] Starting subtest: debugfs
[150.466670] Subtest debugfs: SUCCESS (0.000s)
[150.527241] [144/165] (841s left) vgem_basic (dmabuf-export)
[150.581115] Starting subtest: dmabuf-export
[150.585780] Subtest dmabuf-export: SUCCESS (0.007s)
[150.677971] [145/165] (841s left) vgem_basic (dmabuf-fence)
[150.731738] Starting subtest: dmabuf-fence
[150.734159] Subtest dmabuf-fence: SUCCESS (0.000s)
[150.796072] [146/165] (841s left) vgem_basic (dmabuf-fence-before)
[150.864091] Starting subtest: dmabuf-fence-before
[150.866529] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[150.929729] [147/165] (841s left) vgem_basic (dmabuf-mmap)
[150.980950] Starting subtest: dmabuf-mmap
[150.985500] Subtest dmabuf-mmap: SUCCESS (0.007s)
[151.034147] [148/165] (841s left) vgem_basic (mmap)
[151.083441] Starting subtest: mmap
[151.088620] Subtest mmap: SUCCESS (0.009s)
[151.139822] [149/165] (841s left) vgem_basic (second-client)
[151.198033] Starting subtest: second-client
[151.231939] Subtest second-client: SUCCESS (0.033s)
[151.291613] [150/165] (840s left) vgem_basic (sysfs)
[151.348209] Starting subtest: sysfs
[151.350706] Subtest sysfs: SUCCESS (0.001s)
[151.407189] [151/165] (840s left) core_hotunplug (unbind-rebind)
[151.461569] Starting subtest: unbind-rebind
[155.626868] Subtest unbind-rebind: SUCCESS (4.164s)
[155.655272] [152/165] (836s left) vgem_basic (unload)
[155.693353] Starting subtest: unload
[184.648595] Subtest unload: SUCCESS (28.955s)
[184.763974] [153/165] (807s left) i915_module_load (reload)
[184.812057] Starting subtest: reload
[187.845077] Subtest reload: SUCCESS (3.035s)
[187.866364] [154/165] (804s left) gem_lmem_swapping (basic)
[187.921158] Subtest basic: SKIP (0.000s)
[187.952526] [155/165] (804s left) gem_lmem_swapping (parallel-random-engines)
[187.994672] Subtest parallel-random-engines: SKIP (0.000s)
[188.029832] [156/165] (804s left) gem_lmem_swapping (random-engines)
[188.100123] Subtest random-engines: SKIP (0.000s)
[188.132820] [157/165] (804s left) gem_lmem_swapping (verify-random)
[188.182087] Subtest verify-random: SKIP (0.000s)
[188.203279] [158/165] (804s left) i915_pm_rpm (module-reload)
[190.251917] Starting subtest: module-reload
[198.943659] Subtest module-reload: SUCCESS (8.695s)
[198.963918] [159/165] (793s left) i915_selftest (live)
[199.007287] Starting subtest: live
[199.010075] Starting dynamic subtest: sanitycheck
[200.684646] Dynamic subtest sanitycheck: SUCCESS (1.677s)
[200.690860] Starting dynamic subtest: uncore
[202.375721] Dynamic subtest uncore: SUCCESS (1.689s)
[202.386534] Starting dynamic subtest: workarounds
[204.322682] Dynamic subtest workarounds: SUCCESS (1.945s)
[204.332644] Starting dynamic subtest: gt_engines
[206.613685] Dynamic subtest gt_engines: SUCCESS (2.289s)
[206.622990] Starting dynamic subtest: gt_timelines
[214.682225] Dynamic subtest gt_timelines: SUCCESS (8.067s)
[214.692104] Starting dynamic subtest: gt_contexts
[216.504913] Dynamic subtest gt_contexts: SUCCESS (1.821s)
[216.513332] Starting dynamic subtest: gt_lrc
[221.098863] Dynamic subtest gt_lrc: SUCCESS (4.592s)
[221.110992] Starting dynamic subtest: gt_mocs
[222.935795] Dynamic subtest gt_mocs: SUCCESS (1.835s)
[222.945157] Starting dynamic subtest: gt_pm
[242.627071] Dynamic subtest gt_pm: SUCCESS (19.689s)
[242.637047] Starting dynamic subtest: gt_heartbeat
[244.447967] Dynamic subtest gt_heartbeat: SUCCESS (1.819s)
[244.458124] Starting dynamic subtest: gt_tlb
[247.696168] Dynamic subtest gt_tlb: SUCCESS (3.246s)
[247.705595] Starting dynamic subtest: requests
[256.750060] Dynamic subtest requests: SUCCESS (9.051s)
[256.759176] Starting dynamic subtest: migrate
[261.912579] Dynamic subtest migrate: SUCCESS (5.162s)
[261.923958] Starting dynamic subtest: active
[263.630704] Dynamic subtest active: SUCCESS (1.716s)
[263.641036] Starting dynamic subtest: objects
[265.776716] Dynamic subtest objects: SUCCESS (2.144s)
[265.783313] Starting dynamic subtest: mman
[271.108823] Dynamic subtest mman: SUCCESS (5.330s)
[271.114976] Starting dynamic subtest: dmabuf
[272.818120] Dynamic subtest dmabuf: SUCCESS (1.705s)
[272.828799] Starting dynamic subtest: vma
[274.546891] Dynamic subtest vma: SUCCESS (1.729s)
[274.555855] Starting dynamic subtest: coherency
[277.003362] Dynamic subtest coherency: SUCCESS (2.454s)
[277.014383] Starting dynamic subtest: gtt
[286.363881] Dynamic subtest gtt: SUCCESS (9.359s)
[286.369859] Starting dynamic subtest: gem
[288.145531] Dynamic subtest gem: SUCCESS (1.780s)
[288.154982] Starting dynamic subtest: evict
[290.554872] Dynamic subtest evict: SUCCESS (2.408s)
[290.564625] Starting dynamic subtest: hugepages
[298.754632] Dynamic subtest hugepages: SUCCESS (8.198s)
[298.766688] Starting dynamic subtest: gem_contexts
[313.654312] Dynamic subtest gem_contexts: SUCCESS (14.897s)
[313.662246] Starting dynamic subtest: client
[315.429971] Dynamic subtest client: SUCCESS (1.774s)
[315.436384] Starting dynamic subtest: gem_migrate
[317.136623] Dynamic subtest gem_migrate: SUCCESS (1.705s)
[317.145628] Starting dynamic subtest: reset
[321.378744] Dynamic subtest reset: SUCCESS (4.241s)
[321.384838] Starting dynamic subtest: memory_region
[323.072287] Dynamic subtest memory_region: SUCCESS (1.692s)
[323.082865] Starting dynamic subtest: hangcheck
[353.463583] Dynamic subtest hangcheck: SUCCESS (30.389s)
[353.475090] Starting dynamic subtest: execlists
[366.921657] Dynamic subtest execlists: SUCCESS (13.456s)
[366.932112] Starting dynamic subtest: ring_submission
[368.590801] Dynamic subtest ring_submission: SUCCESS (1.667s)
[368.602836] Starting dynamic subtest: perf
[370.357700] Dynamic subtest perf: SUCCESS (1.765s)
[370.364134] Starting dynamic subtest: slpc
[372.039615] Dynamic subtest slpc: SUCCESS (1.680s)
[372.049078] Starting dynamic subtest: guc
[373.728063] Dynamic subtest guc: SUCCESS (1.686s)
[373.738288] Starting dynamic subtest: guc_multi_lrc
[375.426497] Dynamic subtest guc_multi_lrc: SUCCESS (1.697s)
[375.437438] Starting dynamic subtest: guc_hang
[377.139717] Dynamic subtest guc_hang: SUCCESS (1.711s)
[377.150396] Starting dynamic subtest: late_gt_pm
[378.907957] Dynamic subtest late_gt_pm: SUCCESS (1.766s)
[378.911610] Subtest live: SUCCESS (179.901s)
[378.935857] [160/165] (613s left) dmabuf (all-tests)
[378.987482] Starting subtest: all-tests
[378.989646] Starting dynamic subtest: sanitycheck
[379.059531] Dynamic subtest sanitycheck: SUCCESS (0.073s)
[379.071567] Starting dynamic subtest: dma_fence
[379.234933] Dynamic subtest dma_fence: SUCCESS (0.174s)
[379.245298] Starting dynamic subtest: dma_fence_chain
[389.464659] Dynamic subtest dma_fence_chain: SUCCESS (10.227s)
[389.473418] Starting dynamic subtest: dma_fence_unwrap
[389.530235] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[389.545321] Starting dynamic subtest: dma_resv
[389.606159] Dynamic subtest dma_resv: SUCCESS (0.074s)
[389.609931] Subtest all-tests: SUCCESS (10.621s)
[389.636497] [161/165] (602s left) i915_suspend (basic-s2idle-without-i915)
[389.682690] Starting subtest: basic-s2idle-without-i915
[410.401446] Subtest basic-s2idle-without-i915: SUCCESS (7.447s)
[410.591426] [162/165] (595s left) i915_suspend (basic-s3-without-i915)
[410.629187] Starting subtest: basic-s3-without-i915
[432.882212] Subtest basic-s3-without-i915: SUCCESS (4.952s)
[433.068824] [163/165] (590s left) gem_exec_suspend (basic-s0)
[433.122965] Starting subtest: basic-S0
[433.125452] Starting dynamic subtest: smem
[451.085986] Dynamic subtest smem: SUCCESS (3.816s)
[451.089042] Subtest basic-S0: SUCCESS (3.816s)
[451.244044] [164/165] (586s left) gem_exec_suspend (basic-s3)
[451.292532] Starting subtest: basic-S3
[451.295187] Starting dynamic subtest: smem
[471.466929] Dynamic subtest smem: SUCCESS (3.357s)
[471.469444] Subtest basic-S3: SUCCESS (3.357s)
[471.630623] [165/165] (582s left) kms_pipe_crc_basic (suspend-read-crc)
[471.899148] Starting subtest: suspend-read-crc
[471.902083] Starting dynamic subtest: pipe-A-DP-2
[492.775207] Dynamic subtest pipe-A-DP-2: SUCCESS (3.560s)
[492.784882] Starting dynamic subtest: pipe-B-DP-2
[513.704833] Dynamic subtest pipe-B-DP-2: SUCCESS (3.457s)
[513.712464] Starting dynamic subtest: pipe-C-DP-2
[534.692473] Dynamic subtest pipe-C-DP-2: SUCCESS (3.453s)
[534.700406] Starting dynamic subtest: pipe-D-DP-2
[555.690167] Dynamic subtest pipe-D-DP-2: SUCCESS (3.451s)
[555.692765] Subtest suspend-read-crc: SUCCESS (13.928s)
[555.822043] Closing watchdogs
Done.