[37.112378] Initializing watchdogs
[37.112446]   /dev/watchdog0
[37.116837] [001/171] (960s left) i915_module_load (load)
[37.223300] Starting subtest: load
[38.261740] Subtest load: SUCCESS (1.038s)
[38.296712] [002/171] (959s left) core_auth (basic-auth)
[38.430070] Starting subtest: basic-auth
[38.431136] Subtest basic-auth: SUCCESS (0.001s)
[38.524919] [003/171] (959s left) debugfs_test (read_all_entries)
[38.621018] Starting subtest: read_all_entries
[38.994792] Subtest read_all_entries: SUCCESS (0.373s)
[39.108709] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.167909] Starting subtest: basic-hwmon
[39.170846] Subtest basic-hwmon: SUCCESS (0.003s)
[39.260536] [005/171] (958s left) fbdev (eof)
[39.327817] Starting subtest: eof
[39.328773] Subtest eof: SUCCESS (0.000s)
[39.380676] [006/171] (958s left) fbdev (info)
[39.446048] Starting subtest: info
[39.446840] Subtest info: SUCCESS (0.000s)
[39.515770] [007/171] (958s left) fbdev (nullptr)
[39.594220] Starting subtest: nullptr
[39.595324] Subtest nullptr: SUCCESS (0.000s)
[39.644214] [008/171] (958s left) fbdev (read)
[39.694151] Starting subtest: read
[51.993248] Subtest read: SUCCESS (12.265s)
[52.011629] [009/171] (945s left) fbdev (write)
[52.061613] Starting subtest: write
[58.175246] Subtest write: SUCCESS (6.105s)
[58.211892] [010/171] (939s left) gem_basic (bad-close)
[58.266789] Starting subtest: bad-close
[58.269150] Subtest bad-close: SUCCESS (0.000s)
[58.329504] [011/171] (939s left) gem_basic (create-close)
[58.394667] Starting subtest: create-close
[58.396317] Subtest create-close: SUCCESS (0.000s)
[58.508212] [012/171] (939s left) gem_basic (create-fd-close)
[58.606835] Starting subtest: create-fd-close
[58.608720] Subtest create-fd-close: SUCCESS (0.000s)
[58.705962] [013/171] (939s left) gem_busy (busy@all-engines)
[58.806782] Starting subtest: busy
[58.807793] Starting dynamic subtest: all-engines
[58.898425] Dynamic subtest all-engines: SUCCESS (0.092s)
[58.899237] Subtest busy: SUCCESS (0.092s)
[59.306624] [014/171] (938s left) gem_close_race (basic-process)
[59.397685] Starting subtest: basic-process
[59.447305] Subtest basic-process: SUCCESS (0.050s)
[59.673533] [015/171] (938s left) gem_close_race (basic-threads)
[59.753902] Starting subtest: basic-threads
[60.937463] Subtest basic-threads: SUCCESS (1.183s)
[61.188230] [016/171] (936s left) gem_ctx_create (basic)
[61.296496] Starting subtest: basic
[61.297290] Subtest basic: SUCCESS (0.000s)
[61.481088] [017/171] (936s left) gem_ctx_create (basic-files)
[61.552868] Starting subtest: basic-files
[63.562652] Subtest basic-files: SUCCESS (2.010s)
[64.416874] [018/171] (933s left) gem_ctx_exec (basic)
[64.506415] Starting subtest: basic
[64.508746] Subtest basic: SUCCESS (0.003s)
[64.589788] [019/171] (933s left) gem_exec_basic (basic)
[64.653899] Starting subtest: basic
[64.654848] Starting dynamic subtest: rcs0-smem
[64.655837] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[64.660844] Starting dynamic subtest: bcs0-smem
[64.661605] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[64.666529] Starting dynamic subtest: vcs0-smem
[64.667328] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[64.671793] Starting dynamic subtest: vcs1-smem
[64.672603] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[64.677407] Starting dynamic subtest: vecs0-smem
[64.678652] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[64.683158] Starting dynamic subtest: vecs1-smem
[64.684348] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[64.689016] Starting dynamic subtest: ccs0-smem
[64.690240] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[64.694852] Starting dynamic subtest: ccs1-smem
[64.696142] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[64.700911] Starting dynamic subtest: ccs2-smem
[64.701955] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[64.706586] Starting dynamic subtest: ccs3-smem
[64.707591] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[64.711942] Starting dynamic subtest: rcs0-lmem0
[64.712772] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[64.717423] Starting dynamic subtest: bcs0-lmem0
[64.718503] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[64.722847] Starting dynamic subtest: vcs0-lmem0
[64.723631] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[64.727974] Starting dynamic subtest: vcs1-lmem0
[64.728785] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[64.733058] Starting dynamic subtest: vecs0-lmem0
[64.733842] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[64.738547] Starting dynamic subtest: vecs1-lmem0
[64.739631] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[64.744195] Starting dynamic subtest: ccs0-lmem0
[64.745351] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[64.750048] Starting dynamic subtest: ccs1-lmem0
[64.751219] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[64.755924] Starting dynamic subtest: ccs2-lmem0
[64.757127] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[64.761812] Starting dynamic subtest: ccs3-lmem0
[64.763020] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[64.764205] Subtest basic: SUCCESS (0.011s)
[64.838193] [020/171] (933s left) gem_exec_create (basic)
[64.924136] Starting subtest: basic
[64.925122] Starting dynamic subtest: smem
[67.016306] Dynamic subtest smem: SUCCESS (2.092s)
[67.022512] Starting dynamic subtest: lmem0
[69.110933] Dynamic subtest lmem0: SUCCESS (2.094s)
[69.111786] Subtest basic: SUCCESS (4.187s)
[69.313613] [021/171] (928s left) gem_exec_fence (basic-busy)
[69.559745] Starting subtest: basic-busy
[69.560708] Starting dynamic subtest: rcs0
[69.646167] Dynamic subtest rcs0: SUCCESS (0.095s)
[69.653126] Starting dynamic subtest: bcs0
[69.697922] Dynamic subtest bcs0: SUCCESS (0.051s)
[69.706943] Starting dynamic subtest: vcs0
[69.754649] Dynamic subtest vcs0: SUCCESS (0.055s)
[69.774496] Starting dynamic subtest: vcs1
[69.812992] Dynamic subtest vcs1: SUCCESS (0.058s)
[69.832803] Starting dynamic subtest: vecs0
[69.871195] Dynamic subtest vecs0: SUCCESS (0.058s)
[69.879950] Starting dynamic subtest: vecs1
[69.917909] Dynamic subtest vecs1: SUCCESS (0.047s)
[69.926070] Starting dynamic subtest: ccs0
[69.975224] Dynamic subtest ccs0: SUCCESS (0.056s)
[69.995201] Starting dynamic subtest: ccs1
[70.034231] Dynamic subtest ccs1: SUCCESS (0.059s)
[70.054630] Starting dynamic subtest: ccs2
[70.088947] Dynamic subtest ccs2: SUCCESS (0.053s)
[70.108822] Starting dynamic subtest: ccs3
[70.140729] Dynamic subtest ccs3: SUCCESS (0.053s)
[70.142658] Subtest basic-busy: SUCCESS (0.589s)
[70.702808] [022/171] (927s left) gem_exec_fence (basic-wait)
[70.906078] Starting subtest: basic-wait
[70.908051] Starting dynamic subtest: rcs0
[70.997819] Dynamic subtest rcs0: SUCCESS (0.099s)
[71.004127] Starting dynamic subtest: bcs0
[71.053244] Dynamic subtest bcs0: SUCCESS (0.054s)
[71.073805] Starting dynamic subtest: vcs0
[71.112291] Dynamic subtest vcs0: SUCCESS (0.059s)
[71.132765] Starting dynamic subtest: vcs1
[71.169198] Dynamic subtest vcs1: SUCCESS (0.057s)
[71.177935] Starting dynamic subtest: vecs0
[71.215964] Dynamic subtest vecs0: SUCCESS (0.047s)
[71.224066] Starting dynamic subtest: vecs1
[71.273190] Dynamic subtest vecs1: SUCCESS (0.056s)
[71.293915] Starting dynamic subtest: ccs0
[71.331794] Dynamic subtest ccs0: SUCCESS (0.058s)
[71.352408] Starting dynamic subtest: ccs1
[71.388200] Dynamic subtest ccs1: SUCCESS (0.056s)
[71.408811] Starting dynamic subtest: ccs2
[71.441996] Dynamic subtest ccs2: SUCCESS (0.053s)
[71.462753] Starting dynamic subtest: ccs3
[71.495214] Dynamic subtest ccs3: SUCCESS (0.053s)
[71.497165] Subtest basic-wait: SUCCESS (0.596s)
[72.067274] [023/171] (925s left) gem_exec_fence (basic-await)
[72.281285] Starting subtest: basic-await
[72.284051] Starting dynamic subtest: rcs0
[72.399729] Dynamic subtest rcs0: SUCCESS (0.133s)
[72.404376] Starting dynamic subtest: bcs0
[72.488362] Dynamic subtest bcs0: SUCCESS (0.089s)
[72.493305] Starting dynamic subtest: vcs0
[72.577859] Dynamic subtest vcs0: SUCCESS (0.089s)
[72.582829] Starting dynamic subtest: vcs1
[72.667815] Dynamic subtest vcs1: SUCCESS (0.090s)
[72.673543] Starting dynamic subtest: vecs0
[72.762558] Dynamic subtest vecs0: SUCCESS (0.095s)
[72.767921] Starting dynamic subtest: vecs1
[72.853843] Dynamic subtest vecs1: SUCCESS (0.091s)
[72.859455] Starting dynamic subtest: ccs0
[72.948119] Dynamic subtest ccs0: SUCCESS (0.094s)
[72.953301] Starting dynamic subtest: ccs1
[73.039617] Dynamic subtest ccs1: SUCCESS (0.092s)
[73.044926] Starting dynamic subtest: ccs2
[73.131081] Dynamic subtest ccs2: SUCCESS (0.091s)
[73.136351] Starting dynamic subtest: ccs3
[73.222459] Dynamic subtest ccs3: SUCCESS (0.091s)
[73.223556] Subtest basic-await: SUCCESS (0.956s)
[73.831299] [024/171] (924s left) gem_exec_fence (nb-await)
[74.025938] Starting subtest: nb-await
[74.027827] Starting dynamic subtest: rcs0
[74.129186] Dynamic subtest rcs0: SUCCESS (0.108s)
[74.134747] Starting dynamic subtest: bcs0
[74.191663] Dynamic subtest bcs0: SUCCESS (0.062s)
[74.205931] Starting dynamic subtest: vcs0
[74.274825] Dynamic subtest vcs0: SUCCESS (0.082s)
[74.282511] Starting dynamic subtest: vcs1
[74.338962] Dynamic subtest vcs1: SUCCESS (0.065s)
[74.346124] Starting dynamic subtest: vecs0
[74.405922] Dynamic subtest vecs0: SUCCESS (0.066s)
[74.423255] Starting dynamic subtest: vecs1
[74.492457] Dynamic subtest vecs1: SUCCESS (0.086s)
[74.500398] Starting dynamic subtest: ccs0
[74.557497] Dynamic subtest ccs0: SUCCESS (0.066s)
[74.564377] Starting dynamic subtest: ccs1
[74.624824] Dynamic subtest ccs1: SUCCESS (0.066s)
[74.647960] Starting dynamic subtest: ccs2
[74.716465] Dynamic subtest ccs2: SUCCESS (0.091s)
[74.732372] Starting dynamic subtest: ccs3
[74.799043] Dynamic subtest ccs3: SUCCESS (0.082s)
[74.800604] Subtest nb-await: SUCCESS (0.777s)
[75.380653] [025/171] (922s left) gem_exec_gttfill (basic)
[75.487072] Starting subtest: basic
[80.491586] Subtest basic: SUCCESS (4.996s)
[80.748249] [026/171] (917s left) gem_exec_parallel (engines)
[80.854456] Starting subtest: engines
[80.855382] Starting dynamic subtest: basic
[83.401171] Dynamic subtest basic: SUCCESS (2.547s)
[83.408979] Starting dynamic subtest: contexts
[86.230526] Dynamic subtest contexts: SUCCESS (2.821s)
[86.235906] Starting dynamic subtest: fds
[89.632545] Dynamic subtest fds: SUCCESS (3.410s)
[89.637772] Starting dynamic subtest: userptr
[91.284406] Dynamic subtest userptr: SUCCESS (1.652s)
[91.285473] Subtest engines: SUCCESS (10.430s)
[91.529351] [027/171] (906s left) gem_exec_store (basic)
[91.644728] Starting subtest: basic
[91.788272] Subtest basic: SUCCESS (0.143s)
[92.007260] [028/171] (906s left) gem_flink_basic (bad-flink)
[92.065917] Starting subtest: bad-flink
[92.066827] Subtest bad-flink: SUCCESS (0.000s)
[92.135271] [029/171] (906s left) gem_flink_basic (bad-open)
[92.208732] Starting subtest: bad-open
[92.209522] Subtest bad-open: SUCCESS (0.000s)
[92.266131] [030/171] (905s left) gem_flink_basic (basic)
[92.329925] Starting subtest: basic
[92.330761] Subtest basic: SUCCESS (0.000s)
[92.445230] [031/171] (905s left) gem_flink_basic (double-flink)
[92.511618] Starting subtest: double-flink
[92.512437] Subtest double-flink: SUCCESS (0.000s)
[92.586132] [032/171] (905s left) gem_flink_basic (flink-lifetime)
[92.646466] Starting subtest: flink-lifetime
[92.647453] Subtest flink-lifetime: SUCCESS (0.002s)
[92.749930] [033/171] (905s left) gem_huc_copy (huc-copy)
[92.834619] Starting subtest: huc-copy
[92.839220] Subtest huc-copy: SUCCESS (0.005s)
[92.964915] [034/171] (905s left) gem_linear_blits (basic)
[93.100753] Starting subtest: basic
[93.123976] Subtest basic: SUCCESS (0.023s)
[93.262755] [035/171] (905s left) gem_mmap (basic)
[93.363691] Subtest basic: SKIP (0.000s)
[93.388515] [036/171] (904s left) gem_mmap_gtt (basic)
[93.447720] Subtest basic: SKIP (0.000s)
[93.471686] [037/171] (904s left) gem_render_linear_blits (basic)
[93.533015] Starting subtest: basic
[93.583800] Subtest basic: SUCCESS (0.051s)
[93.656095] [038/171] (904s left) gem_render_tiled_blits (basic)
[93.729321] Subtest basic: SKIP (0.000s)
[93.754873] [039/171] (904s left) gem_ringfill (basic-all)
[94.149057] Starting subtest: basic-all
[95.557847] Subtest basic-all: SUCCESS (1.403s)
[95.659267] [040/171] (902s left) gem_softpin (allocator-basic)
[95.754513] Starting subtest: allocator-basic
[95.915451] Subtest allocator-basic: SUCCESS (0.152s)
[96.044890] [041/171] (902s left) gem_softpin (allocator-basic-reserve)
[96.107137] Starting subtest: allocator-basic-reserve
[96.274528] Subtest allocator-basic-reserve: SUCCESS (0.159s)
[96.414219] [042/171] (901s left) gem_softpin (safe-alignment)
[96.502383] Starting subtest: safe-alignment
[96.551146] Subtest safe-alignment: SUCCESS (0.049s)
[96.682199] [043/171] (901s left) gem_sync (basic-all)
[96.796279] Starting subtest: basic-all
[100.607844] Subtest basic-all: SUCCESS (3.812s)
[100.786273] [044/171] (897s left) gem_sync (basic-each)
[100.853176] Starting subtest: basic-each
[103.761444] Subtest basic-each: SUCCESS (2.909s)
[103.949738] [045/171] (894s left) gem_tiled_blits (basic)
[104.018857] Subtest basic: SKIP (0.000s)
[104.039440] [046/171] (894s left) gem_tiled_fence_blits (basic)
[104.101657] Subtest basic: SKIP (0.000s)
[104.122208] [047/171] (894s left) gem_tiled_pread_basic
[104.206099] [048/171] (894s left) gem_wait (busy@all-engines)
[104.276326] Starting subtest: busy
[104.277257] Starting dynamic subtest: all-engines
[104.839621] Dynamic subtest all-engines: SUCCESS (0.563s)
[104.840495] Subtest busy: SUCCESS (0.563s)
[105.053596] [049/171] (893s left) gem_wait (wait@all-engines)
[105.122905] Starting subtest: wait
[105.123765] Starting dynamic subtest: all-engines
[106.203970] Dynamic subtest all-engines: SUCCESS (1.081s)
[106.204922] Subtest wait: SUCCESS (1.081s)
[106.443633] [050/171] (892s left) i915_getparams_basic (basic-eu-total)
[106.505916] Starting subtest: basic-eu-total
[106.507621] Subtest basic-eu-total: SUCCESS (0.000s)
[106.580121] [051/171] (891s left) i915_getparams_basic (basic-subslice-total)
[106.666266] Starting subtest: basic-subslice-total
[106.668156] Subtest basic-subslice-total: SUCCESS (0.000s)
[106.735897] [052/171] (891s left) i915_hangman (error-state-basic)
[106.818777] Starting subtest: error-state-basic
[106.991380] Subtest error-state-basic: SUCCESS (0.173s)
[107.055789] [053/171] (891s left) i915_pciid
[107.172381] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier)
[107.238380] Starting subtest: addfb25-bad-modifier
[107.239211] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[107.350544] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[107.418256] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[107.517614] [056/171] (891s left) kms_addfb_basic (addfb25-modifier-no-flag)
[107.575640] Starting subtest: addfb25-modifier-no-flag
[107.576452] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[107.684159] [057/171] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[107.753517] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[107.850259] [058/171] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[107.912332] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[108.001092] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[108.088838] Starting subtest: addfb25-yf-tiled-legacy
[108.089802] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[108.167505] [060/171] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[108.261598] Starting subtest: addfb25-y-tiled-legacy
[108.262470] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[108.333940] [061/171] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[108.431386] Starting subtest: addfb25-y-tiled-small-legacy
[108.432994] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[108.500313] [062/171] (890s left) kms_addfb_basic (bad-pitch-0)
[108.556896] Starting subtest: bad-pitch-0
[108.557815] Subtest bad-pitch-0: SUCCESS (0.000s)
[108.687921] [063/171] (889s left) kms_addfb_basic (bad-pitch-1024)
[108.762557] Starting subtest: bad-pitch-1024
[108.763410] Subtest bad-pitch-1024: SUCCESS (0.000s)
[108.867660] [064/171] (889s left) kms_addfb_basic (bad-pitch-128)
[108.925761] Starting subtest: bad-pitch-128
[108.926670] Subtest bad-pitch-128: SUCCESS (0.000s)
[109.034247] [065/171] (889s left) kms_addfb_basic (bad-pitch-256)
[109.099378] Starting subtest: bad-pitch-256
[109.100260] Subtest bad-pitch-256: SUCCESS (0.000s)
[109.200531] [066/171] (889s left) kms_addfb_basic (bad-pitch-32)
[109.262040] Starting subtest: bad-pitch-32
[109.262840] Subtest bad-pitch-32: SUCCESS (0.000s)
[109.367649] [067/171] (889s left) kms_addfb_basic (bad-pitch-63)
[109.425843] Starting subtest: bad-pitch-63
[109.426828] Subtest bad-pitch-63: SUCCESS (0.000s)
[109.533998] [068/171] (889s left) kms_addfb_basic (bad-pitch-65536)
[109.592259] Starting subtest: bad-pitch-65536
[109.593147] Subtest bad-pitch-65536: SUCCESS (0.000s)
[109.700650] [069/171] (889s left) kms_addfb_basic (bad-pitch-999)
[109.761839] Starting subtest: bad-pitch-999
[109.762819] Subtest bad-pitch-999: SUCCESS (0.000s)
[109.867521] [070/171] (888s left) kms_addfb_basic (basic)
[109.928965] Starting subtest: basic
[109.929915] Subtest basic: SUCCESS (0.000s)
[110.034103] [071/171] (888s left) kms_addfb_basic (basic-x-tiled-legacy)
[110.098913] Starting subtest: basic-x-tiled-legacy
[110.100482] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[110.200529] [072/171] (888s left) kms_addfb_basic (basic-y-tiled-legacy)
[110.262456] Starting subtest: basic-y-tiled-legacy
[110.264045] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[110.367308] [073/171] (888s left) kms_addfb_basic (bo-too-small)
[110.459593] Starting subtest: bo-too-small
[110.460529] Subtest bo-too-small: SUCCESS (0.000s)
[110.534280] [074/171] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[110.626686] Starting subtest: bo-too-small-due-to-tiling
[110.628286] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[110.718545] [075/171] (888s left) kms_addfb_basic (clobberred-modifier)
[110.792534] Starting subtest: clobberred-modifier
[110.794261] Subtest clobberred-modifier: SKIP (0.000s)
[110.900418] [076/171] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.965774] Starting subtest: framebuffer-vs-set-tiling
[110.967533] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[111.067256] [077/171] (887s left) kms_addfb_basic (invalid-get-prop)
[111.131163] Starting subtest: invalid-get-prop
[111.131959] Subtest invalid-get-prop: SUCCESS (0.000s)
[111.252504] [078/171] (887s left) kms_addfb_basic (invalid-get-prop-any)
[111.319814] Starting subtest: invalid-get-prop-any
[111.320627] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[111.417593] [079/171] (887s left) kms_addfb_basic (invalid-set-prop)
[111.477042] Starting subtest: invalid-set-prop
[111.477840] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.584647] [080/171] (887s left) kms_addfb_basic (invalid-set-prop-any)
[111.653437] Starting subtest: invalid-set-prop-any
[111.654359] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[111.767633] [081/171] (887s left) kms_addfb_basic (no-handle)
[111.833511] Starting subtest: no-handle
[111.834319] Subtest no-handle: SUCCESS (0.000s)
[111.934426] [082/171] (886s left) kms_addfb_basic (size-max)
[112.033900] Starting subtest: size-max
[112.034809] Subtest size-max: SUCCESS (0.000s)
[112.117929] [083/171] (886s left) kms_addfb_basic (small-bo)
[112.207700] Starting subtest: small-bo
[112.208588] Subtest small-bo: SUCCESS (0.000s)
[112.284418] [084/171] (886s left) kms_addfb_basic (tile-pitch-mismatch)
[112.351565] Starting subtest: tile-pitch-mismatch
[112.353319] Subtest tile-pitch-mismatch: SKIP (0.000s)
[112.450832] [085/171] (886s left) kms_addfb_basic (too-high)
[112.541661] Starting subtest: too-high
[112.542481] Subtest too-high: SUCCESS (0.000s)
[112.617175] [086/171] (886s left) kms_addfb_basic (too-wide)
[112.710486] Starting subtest: too-wide
[112.711302] Subtest too-wide: SUCCESS (0.000s)
[112.801490] [087/171] (886s left) kms_addfb_basic (unused-handle)
[112.868981] Starting subtest: unused-handle
[112.869948] Subtest unused-handle: SUCCESS (0.000s)
[112.967229] [088/171] (885s left) kms_addfb_basic (unused-modifier)
[113.028252] Starting subtest: unused-modifier
[113.029172] Subtest unused-modifier: SUCCESS (0.000s)
[113.153212] [089/171] (885s left) kms_addfb_basic (unused-offsets)
[113.224516] Starting subtest: unused-offsets
[113.225448] Subtest unused-offsets: SUCCESS (0.000s)
[113.333869] [090/171] (885s left) kms_addfb_basic (unused-pitches)
[113.399657] Starting subtest: unused-pitches
[113.400585] Subtest unused-pitches: SUCCESS (0.000s)
[113.519731] [091/171] (885s left) kms_busy (basic)
[113.627835] Starting subtest: basic
[113.628745] Starting dynamic subtest: flip
[114.306772] Dynamic subtest flip: SUCCESS (0.679s)
[114.312826] Starting dynamic subtest: modeset
[115.052525] Dynamic subtest modeset: SUCCESS (0.746s)
[115.053370] Subtest basic: SUCCESS (1.426s)
[115.210228] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast)
[115.382116] Subtest dp-hpd-fast: SKIP (0.000s)
[115.466094] [093/171] (883s left) kms_chamelium_edid (dp-edid-read)
[115.631471] Subtest dp-edid-read: SKIP (0.000s)
[115.715729] [094/171] (883s left) kms_chamelium_frames (dp-crc-fast)
[115.881696] Subtest dp-crc-fast: SKIP (0.000s)
[115.966727] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast)
[116.132426] Subtest hdmi-hpd-fast: SKIP (0.000s)
[116.216763] [096/171] (882s left) kms_chamelium_edid (hdmi-edid-read)
[116.382532] Subtest hdmi-edid-read: SKIP (0.000s)
[116.465638] [097/171] (882s left) kms_chamelium_frames (hdmi-crc-fast)
[116.631455] Subtest hdmi-crc-fast: SKIP (0.000s)
[116.716481] [098/171] (882s left) kms_chamelium_hpd (vga-hpd-fast)
[116.883254] Subtest vga-hpd-fast: SKIP (0.000s)
[116.968240] [099/171] (882s left) kms_chamelium_edid (vga-edid-read)
[117.132605] Subtest vga-edid-read: SKIP (0.000s)
[117.218059] [100/171] (881s left) kms_prop_blob (basic)
[117.276397] Starting subtest: basic
[117.277296] Subtest basic: SUCCESS (0.000s)
[117.343326] [101/171] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[117.428956] Starting subtest: basic-busy-flip-before-cursor-atomic
[117.430503] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[117.493318] [102/171] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[117.579941] Starting subtest: basic-busy-flip-before-cursor-legacy
[117.581586] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[117.643416] [103/171] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[117.729822] Starting subtest: basic-flip-after-cursor-atomic
[118.748212] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.019s)
[118.906220] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[119.031454] Starting subtest: basic-flip-after-cursor-legacy
[120.059435] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.028s)
[120.228485] [105/171] (878s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[120.314247] Starting subtest: basic-flip-after-cursor-varying-size
[121.349946] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[121.505395] [106/171] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[121.590986] Starting subtest: basic-flip-before-cursor-atomic
[122.608523] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.018s)
[122.762534] [107/171] (876s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[122.851050] Starting subtest: basic-flip-before-cursor-legacy
[123.882280] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.033s)
[124.039059] [108/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[124.127056] Starting subtest: basic-flip-before-cursor-varying-size
[125.159226] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.033s)
[125.331904] [109/171] (873s left) kms_flip (basic-flip-vs-dpms)
[125.406701] Starting subtest: basic-flip-vs-dpms
[125.411046] Starting dynamic subtest: A-DP3
[126.263806] Dynamic subtest A-DP3: SUCCESS (0.852s)
[126.270237] Starting dynamic subtest: B-DP3
[127.085881] Dynamic subtest B-DP3: SUCCESS (0.821s)
[127.092126] Starting dynamic subtest: C-DP3
[127.907833] Dynamic subtest C-DP3: SUCCESS (0.822s)
[127.914272] Starting dynamic subtest: D-DP3
[128.733717] Dynamic subtest D-DP3: SUCCESS (0.826s)
[128.735493] Subtest basic-flip-vs-dpms: SUCCESS (3.329s)
[128.893496] [110/171] (870s left) kms_flip (basic-flip-vs-modeset)
[128.968311] Starting subtest: basic-flip-vs-modeset
[128.972701] Starting dynamic subtest: A-DP3
[129.828776] Dynamic subtest A-DP3: SUCCESS (0.856s)
[129.835201] Starting dynamic subtest: B-DP3
[130.520350] Dynamic subtest B-DP3: SUCCESS (0.691s)
[130.526533] Starting dynamic subtest: C-DP3
[131.213553] Dynamic subtest C-DP3: SUCCESS (0.693s)
[131.219646] Starting dynamic subtest: D-DP3
[132.040985] Dynamic subtest D-DP3: SUCCESS (0.826s)
[132.041887] Subtest basic-flip-vs-modeset: SUCCESS (3.074s)
[132.193590] [111/171] (867s left) kms_flip (basic-flip-vs-wf_vblank)
[132.268466] Starting subtest: basic-flip-vs-wf_vblank
[132.272952] Starting dynamic subtest: A-DP3
[133.381133] Dynamic subtest A-DP3: SUCCESS (1.108s)
[133.387555] Starting dynamic subtest: B-DP3
[134.421384] Dynamic subtest B-DP3: SUCCESS (1.040s)
[134.427806] Starting dynamic subtest: C-DP3
[135.462192] Dynamic subtest C-DP3: SUCCESS (1.040s)
[135.468488] Starting dynamic subtest: D-DP3
[136.502431] Dynamic subtest D-DP3: SUCCESS (1.039s)
[136.504529] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.236s)
[136.708096] [112/171] (862s left) kms_flip (basic-plain-flip)
[136.780627] Starting subtest: basic-plain-flip
[136.785127] Starting dynamic subtest: A-DP3
[137.614212] Dynamic subtest A-DP3: SUCCESS (0.829s)
[137.621768] Starting dynamic subtest: B-DP3
[138.372688] Dynamic subtest B-DP3: SUCCESS (0.758s)
[138.379188] Starting dynamic subtest: C-DP3
[139.128071] Dynamic subtest C-DP3: SUCCESS (0.755s)
[139.134339] Starting dynamic subtest: D-DP3
[139.882173] Dynamic subtest D-DP3: SUCCESS (0.753s)
[139.884107] Subtest basic-plain-flip: SUCCESS (3.104s)
[140.104120] [113/171] (859s left) kms_force_connector_basic (force-connector-state)
[140.170945] Starting subtest: force-connector-state
[140.659828] Subtest force-connector-state: SUCCESS (0.489s)
[140.882847] [114/171] (858s left) kms_force_connector_basic (force-edid)
[140.951160] Starting subtest: force-edid
[140.965357] Subtest force-edid: SUCCESS (0.014s)
[141.099282] [115/171] (858s left) kms_force_connector_basic (force-load-detect)
[141.171105] Starting subtest: force-load-detect
[141.172670] Subtest force-load-detect: SKIP (0.000s)
[141.266317] [116/171] (858s left) kms_force_connector_basic (prune-stale-modes)
[141.332257] Starting subtest: prune-stale-modes
[141.341213] Subtest prune-stale-modes: SKIP (0.008s)
[141.466263] [117/171] (857s left) kms_frontbuffer_tracking (basic)
[141.574439] Starting subtest: basic
[145.297346] Subtest basic: SUCCESS (3.725s)
[145.385595] [118/171] (853s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[145.474230] Starting subtest: compare-crc-sanitycheck-xr24
[145.475108] Starting dynamic subtest: pipe-A-DP-3
[146.020546] Dynamic subtest pipe-A-DP-3: SUCCESS (0.546s)
[146.028100] Starting dynamic subtest: pipe-B-DP-3
[146.504791] Dynamic subtest pipe-B-DP-3: SUCCESS (0.482s)
[146.511578] Starting dynamic subtest: pipe-C-DP-3
[147.046478] Dynamic subtest pipe-C-DP-3: SUCCESS (0.540s)
[147.052677] Starting dynamic subtest: pipe-D-DP-3
[147.649807] Dynamic subtest pipe-D-DP-3: SUCCESS (0.602s)
[147.650724] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.176s)
[147.799743] [119/171] (851s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[147.886133] Starting subtest: compare-crc-sanitycheck-nv12
[147.887028] Starting dynamic subtest: pipe-A-DP-3
[149.187360] Dynamic subtest pipe-A-DP-3: SUCCESS (1.300s)
[149.193653] Starting dynamic subtest: pipe-B-DP-3
[150.382109] Dynamic subtest pipe-B-DP-3: SUCCESS (1.193s)
[150.389713] Starting dynamic subtest: pipe-C-DP-3
[151.656177] Dynamic subtest pipe-C-DP-3: SUCCESS (1.272s)
[151.663487] Starting dynamic subtest: pipe-D-DP-3
[152.916502] Dynamic subtest pipe-D-DP-3: SUCCESS (1.259s)
[152.917482] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.032s)
[153.062752] [120/171] (846s left) kms_pipe_crc_basic (hang-read-crc)
[153.147747] Starting subtest: hang-read-crc
[153.148622] Starting dynamic subtest: pipe-A-DP-3
[154.617125] Dynamic subtest pipe-A-DP-3: SUCCESS (1.468s)
[154.624491] Starting dynamic subtest: pipe-B-DP-3
[155.999470] Dynamic subtest pipe-B-DP-3: SUCCESS (1.380s)
[156.007153] Starting dynamic subtest: pipe-C-DP-3
[157.509100] Dynamic subtest pipe-C-DP-3: SUCCESS (1.508s)
[157.516910] Starting dynamic subtest: pipe-D-DP-3
[159.131051] Dynamic subtest pipe-D-DP-3: SUCCESS (1.620s)
[159.131961] Subtest hang-read-crc: SUCCESS (5.983s)
[159.273886] [121/171] (840s left) kms_pipe_crc_basic (nonblocking-crc)
[159.362646] Starting subtest: nonblocking-crc
[159.363485] Starting dynamic subtest: pipe-A-DP-3
[160.062100] Dynamic subtest pipe-A-DP-3: SUCCESS (0.698s)
[160.069533] Starting dynamic subtest: pipe-B-DP-3
[160.698255] Dynamic subtest pipe-B-DP-3: SUCCESS (0.634s)
[160.706096] Starting dynamic subtest: pipe-C-DP-3
[161.412096] Dynamic subtest pipe-C-DP-3: SUCCESS (0.712s)
[161.419590] Starting dynamic subtest: pipe-D-DP-3
[162.180234] Dynamic subtest pipe-D-DP-3: SUCCESS (0.766s)
[162.181131] Subtest nonblocking-crc: SUCCESS (2.817s)
[162.324551] [122/171] (837s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[162.411398] Starting subtest: nonblocking-crc-frame-sequence
[162.412277] Starting dynamic subtest: pipe-A-DP-3
[163.095089] Dynamic subtest pipe-A-DP-3: SUCCESS (0.683s)
[163.103105] Starting dynamic subtest: pipe-B-DP-3
[163.748272] Dynamic subtest pipe-B-DP-3: SUCCESS (0.651s)
[163.754430] Starting dynamic subtest: pipe-C-DP-3
[164.448144] Dynamic subtest pipe-C-DP-3: SUCCESS (0.698s)
[164.455531] Starting dynamic subtest: pipe-D-DP-3
[165.202346] Dynamic subtest pipe-D-DP-3: SUCCESS (0.752s)
[165.203427] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.792s)
[165.354027] [123/171] (834s left) kms_pipe_crc_basic (read-crc)
[165.439802] Starting subtest: read-crc
[165.440731] Starting dynamic subtest: pipe-A-DP-3
[166.074217] Dynamic subtest pipe-A-DP-3: SUCCESS (0.632s)
[166.080458] Starting dynamic subtest: pipe-B-DP-3
[166.646272] Dynamic subtest pipe-B-DP-3: SUCCESS (0.570s)
[166.653615] Starting dynamic subtest: pipe-C-DP-3
[167.273501] Dynamic subtest pipe-C-DP-3: SUCCESS (0.625s)
[167.281557] Starting dynamic subtest: pipe-D-DP-3
[167.980305] Dynamic subtest pipe-D-DP-3: SUCCESS (0.705s)
[167.981256] Subtest read-crc: SUCCESS (2.540s)
[168.123868] [124/171] (831s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[168.210262] Starting subtest: read-crc-frame-sequence
[168.211096] Starting dynamic subtest: pipe-A-DP-3
[168.877287] Dynamic subtest pipe-A-DP-3: SUCCESS (0.666s)
[168.883616] Starting dynamic subtest: pipe-B-DP-3
[169.446409] Dynamic subtest pipe-B-DP-3: SUCCESS (0.567s)
[169.452673] Starting dynamic subtest: pipe-C-DP-3
[170.095469] Dynamic subtest pipe-C-DP-3: SUCCESS (0.647s)
[170.103048] Starting dynamic subtest: pipe-D-DP-3
[170.783682] Dynamic subtest pipe-D-DP-3: SUCCESS (0.686s)
[170.784550] Subtest read-crc-frame-sequence: SUCCESS (2.574s)
[170.934444] [125/171] (828s left) kms_psr (primary_page_flip)
[170.995166] Subtest primary_page_flip: SKIP (0.000s)
[171.024851] [126/171] (828s left) kms_psr (cursor_plane_move)
[171.090186] Subtest cursor_plane_move: SKIP (0.000s)
[171.122843] [127/171] (828s left) kms_psr (sprite_plane_onoff)
[171.187160] Subtest sprite_plane_onoff: SKIP (0.000s)
[171.206621] [128/171] (828s left) kms_psr (primary_mmap_gtt)
[171.267450] Subtest primary_mmap_gtt: SKIP (0.000s)
[171.289814] [129/171] (828s left) kms_setmode (basic-clone-single-crtc)
[171.348976] Starting subtest: basic-clone-single-crtc
[171.352406] Subtest basic-clone-single-crtc: SKIP (0.000s)
[171.432837] [130/171] (828s left) i915_pm_backlight (basic-brightness)
[171.549351] Subtest basic-brightness: SKIP (0.000s)
[171.573646] [131/171] (827s left) i915_pm_rpm (basic-pci-d3-state)
[173.530504] Starting subtest: basic-pci-d3-state
[174.264728] Subtest basic-pci-d3-state: SUCCESS (0.725s)
[174.407757] [132/171] (825s left) i915_pm_rpm (basic-rte)
[174.479432] Starting subtest: basic-rte
[177.526133] Subtest basic-rte: SUCCESS (3.055s)
[178.302300] [133/171] (821s left) i915_pm_rps (basic-api)
[178.364845] Starting subtest: basic-api
[178.366492] Subtest basic-api: SKIP (0.000s)
[178.443668] [134/171] (821s left) prime_self_import (basic-llseek-bad)
[178.503994] Starting subtest: basic-llseek-bad
[178.515590] Subtest basic-llseek-bad: SUCCESS (0.011s)
[178.586650] [135/171] (820s left) prime_self_import (basic-llseek-size)
[178.634471] Starting subtest: basic-llseek-size
[178.646160] Subtest basic-llseek-size: SUCCESS (0.011s)
[178.744083] [136/171] (820s left) prime_self_import (basic-with_fd_dup)
[178.802533] Starting subtest: basic-with_fd_dup
[178.815495] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[178.921875] [137/171] (820s left) prime_self_import (basic-with_one_bo)
[178.976494] Starting subtest: basic-with_one_bo
[178.989275] Subtest basic-with_one_bo: SUCCESS (0.012s)
[179.042046] [138/171] (820s left) prime_self_import (basic-with_one_bo_two_files)
[179.098018] Starting subtest: basic-with_one_bo_two_files
[179.108991] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[179.236717] [139/171] (820s left) prime_self_import (basic-with_two_bos)
[179.312112] Starting subtest: basic-with_two_bos
[179.324103] Subtest basic-with_two_bos: SUCCESS (0.012s)
[179.405566] [140/171] (820s left) prime_vgem (basic-fence-flip)
[179.481946] Starting subtest: basic-fence-flip
[179.541520] Subtest basic-fence-flip: SKIP (0.059s)
[179.641377] [141/171] (820s left) prime_vgem (basic-fence-mmap)
[179.728122] Starting subtest: basic-fence-mmap
[179.729792] Subtest basic-fence-mmap: SKIP (0.000s)
[179.854560] [142/171] (819s left) prime_vgem (basic-fence-read)
[179.964816] Starting subtest: basic-fence-read
[179.969753] Subtest basic-fence-read: SKIP (0.004s)
[180.096997] [143/171] (819s left) prime_vgem (basic-gtt)
[180.171118] Starting subtest: basic-gtt
[180.173395] Subtest basic-gtt: SKIP (0.000s)
[180.304140] [144/171] (819s left) prime_vgem (basic-read)
[180.395236] Starting subtest: basic-read
[180.401318] Subtest basic-read: SKIP (0.005s)
[180.519481] [145/171] (819s left) prime_vgem (basic-write)
[180.614798] Starting subtest: basic-write
[180.619259] Subtest basic-write: SKIP (0.004s)
[180.743790] [146/171] (819s left) vgem_basic (setversion)
[180.816524] Starting subtest: setversion
[180.818200] Subtest setversion: SUCCESS (0.000s)
[180.878331] [147/171] (818s left) vgem_basic (create)
[180.966484] Starting subtest: create
[180.967321] Subtest create: SUCCESS (0.000s)
[181.018641] [148/171] (818s left) vgem_basic (debugfs)
[181.082989] Starting subtest: debugfs
[181.083854] Subtest debugfs: SUCCESS (0.000s)
[181.137559] [149/171] (818s left) vgem_basic (dmabuf-export)
[181.199864] Starting subtest: dmabuf-export
[181.223126] Subtest dmabuf-export: SUCCESS (0.023s)
[181.316705] [150/171] (818s left) vgem_basic (dmabuf-fence)
[181.383378] Starting subtest: dmabuf-fence
[181.384658] Subtest dmabuf-fence: SUCCESS (0.000s)
[181.436621] [151/171] (818s left) vgem_basic (dmabuf-fence-before)
[181.499991] Starting subtest: dmabuf-fence-before
[181.500901] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[181.554337] [152/171] (818s left) vgem_basic (dmabuf-mmap)
[181.616480] Starting subtest: dmabuf-mmap
[181.624639] Subtest dmabuf-mmap: SUCCESS (0.009s)
[181.668247] [153/171] (818s left) vgem_basic (mmap)
[181.733294] Starting subtest: mmap
[181.738196] Subtest mmap: SUCCESS (0.005s)
[181.788419] [154/171] (818s left) vgem_basic (second-client)
[181.850011] Starting subtest: second-client
[181.883237] Subtest second-client: SUCCESS (0.033s)
[181.964767] [155/171] (818s left) vgem_basic (sysfs)
[182.066628] Starting subtest: sysfs
[182.067912] Subtest sysfs: SUCCESS (0.000s)
[182.119678] [156/171] (817s left) core_hotunplug (unbind-rebind)
[182.216270] Starting subtest: unbind-rebind
[184.282979] Subtest unbind-rebind: SUCCESS (2.067s)
[184.298474] [157/171] (815s left) vgem_basic (unload)
[184.348586] Starting subtest: unload
[213.326212] Subtest unload: SUCCESS (28.943s)
[213.377760] [158/171] (786s left) i915_module_load (reload)
[213.425476] Starting subtest: reload
[216.269846] Subtest reload: SUCCESS (2.845s)
[216.287373] [159/171] (783s left) gem_lmem_swapping (basic)
[219.336919] Starting subtest: basic
[219.338131] Starting dynamic subtest: lmem0
[236.764315] Dynamic subtest lmem0: SUCCESS (17.392s)
[236.765336] Subtest basic: SUCCESS (17.394s)
[238.438437] [160/171] (761s left) gem_lmem_swapping (parallel-random-engines)
[239.077139] Starting subtest: parallel-random-engines
[239.077996] Starting dynamic subtest: lmem0
[239.900621] Dynamic subtest lmem0: SUCCESS (0.823s)
[239.901417] Subtest parallel-random-engines: SUCCESS (0.824s)
[241.238573] [161/171] (758s left) gem_lmem_swapping (random-engines)
[241.932400] Starting subtest: random-engines
[241.933296] Starting dynamic subtest: lmem0
[242.652451] Dynamic subtest lmem0: SUCCESS (0.712s)
[242.653378] Subtest random-engines: SUCCESS (0.713s)
[243.929400] [162/171] (756s left) gem_lmem_swapping (verify-random)
[244.604355] Starting subtest: verify-random
[244.605200] Starting dynamic subtest: lmem0
[252.337952] Dynamic subtest lmem0: SUCCESS (7.699s)
[252.338834] Subtest verify-random: SUCCESS (7.700s)
[253.647331] [163/171] (746s left) i915_pm_rpm (module-reload)
[256.759662] Starting subtest: module-reload
[269.035599] Subtest module-reload: SUCCESS (12.266s)
[269.073565] [164/171] (731s left) i915_selftest (live)
[269.157461] Starting subtest: live
[269.158383] Starting dynamic subtest: sanitycheck
[270.499210] Dynamic subtest sanitycheck: SUCCESS (1.333s)
[270.505035] Starting dynamic subtest: uncore
[271.849261] Dynamic subtest uncore: SUCCESS (1.349s)
[271.855315] Starting dynamic subtest: workarounds
[276.094213] Dynamic subtest workarounds: SUCCESS (4.244s)
[276.099228] Starting dynamic subtest: gt_engines
[278.498901] Dynamic subtest gt_engines: SUCCESS (2.404s)
[278.503951] Starting dynamic subtest: gt_timelines
[306.075168] Dynamic subtest gt_timelines: SUCCESS (27.575s)
[306.080463] Starting dynamic subtest: gt_contexts
[307.477583] Dynamic subtest gt_contexts: SUCCESS (1.401s)
[307.483375] Starting dynamic subtest: gt_lrc
[315.398384] Dynamic subtest gt_lrc: SUCCESS (7.920s)
[315.404202] Starting dynamic subtest: gt_mocs
[319.112610] Dynamic subtest gt_mocs: SUCCESS (3.713s)
[319.118820] Starting dynamic subtest: gt_pm
[321.405131] Dynamic subtest gt_pm: SUCCESS (2.292s)
[321.410595] Starting dynamic subtest: gt_heartbeat
[322.989305] Dynamic subtest gt_heartbeat: SUCCESS (1.583s)
[322.995438] Starting dynamic subtest: gt_tlb
[334.941435] Dynamic subtest gt_tlb: SUCCESS (11.951s)
[334.947310] Starting dynamic subtest: requests
[351.910280] Dynamic subtest requests: SUCCESS (16.968s)
[351.915859] Starting dynamic subtest: migrate
[356.324229] Dynamic subtest migrate: SUCCESS (4.413s)
[356.330151] Starting dynamic subtest: active
[357.676352] Dynamic subtest active: SUCCESS (1.351s)
[357.682658] Starting dynamic subtest: objects
[359.916228] Dynamic subtest objects: SUCCESS (2.239s)
[359.921389] Starting dynamic subtest: mman
[368.375997] Dynamic subtest mman: SUCCESS (8.459s)
[368.380952] Starting dynamic subtest: dmabuf
[369.741940] Dynamic subtest dmabuf: SUCCESS (1.365s)
[369.746987] Starting dynamic subtest: vma
[371.127957] Dynamic subtest vma: SUCCESS (1.385s)
[371.132972] Starting dynamic subtest: coherency
[374.070943] Dynamic subtest coherency: SUCCESS (2.942s)
[374.075923] Starting dynamic subtest: gtt
[382.715375] Dynamic subtest gtt: SUCCESS (8.644s)
[382.722452] Starting dynamic subtest: gem
[384.115306] Dynamic subtest gem: SUCCESS (1.399s)
[384.120176] Starting dynamic subtest: evict
[387.600341] Dynamic subtest evict: SUCCESS (3.484s)
[387.605943] Starting dynamic subtest: hugepages
[404.574247] Dynamic subtest hugepages: SUCCESS (16.973s)
[404.580158] Starting dynamic subtest: gem_contexts
[443.671536] Dynamic subtest gem_contexts: SUCCESS (39.096s)
[443.678478] Starting dynamic subtest: client
[445.073589] Dynamic subtest client: SUCCESS (1.401s)
[445.082193] Starting dynamic subtest: gem_migrate
[449.668258] Dynamic subtest gem_migrate: SUCCESS (4.594s)
[449.673937] Starting dynamic subtest: reset
[451.140434] Dynamic subtest reset: SUCCESS (1.471s)
[451.146389] Starting dynamic subtest: memory_region
[454.044245] Dynamic subtest memory_region: SUCCESS (2.903s)
[454.050234] Starting dynamic subtest: hangcheck
[500.659362] Dynamic subtest hangcheck: SUCCESS (46.614s)
[500.665685] Starting dynamic subtest: execlists
[502.037214] Dynamic subtest execlists: SUCCESS (1.377s)
[502.043490] Starting dynamic subtest: ring_submission
[503.411158] Dynamic subtest ring_submission: SUCCESS (1.373s)
[503.416377] Starting dynamic subtest: perf
[504.886251] Dynamic subtest perf: SUCCESS (1.474s)
[504.892364] Starting dynamic subtest: slpc
[514.030275] Dynamic subtest slpc: SUCCESS (9.143s)
[514.036501] Starting dynamic subtest: guc
[516.797587] Dynamic subtest guc: SUCCESS (2.766s)
[516.804893] Starting dynamic subtest: guc_multi_lrc
[518.195052] Dynamic subtest guc_multi_lrc: SUCCESS (1.397s)
[518.200956] Starting dynamic subtest: guc_hang
[520.289308] Dynamic subtest guc_hang: SUCCESS (2.093s)
[520.296425] Starting dynamic subtest: late_gt_pm
[521.717063] Dynamic subtest late_gt_pm: SUCCESS (1.427s)
[521.718118] Subtest live: SUCCESS (252.551s)
[522.159842] [165/171] (478s left) dmabuf (all-tests)
[522.223153] Starting subtest: all-tests
[522.224047] Starting dynamic subtest: sanitycheck
[522.291867] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[522.310130] Starting dynamic subtest: dma_fence
[522.468477] Dynamic subtest dma_fence: SUCCESS (0.175s)
[522.474566] Starting dynamic subtest: dma_fence_chain
[533.077714] Dynamic subtest dma_fence_chain: SUCCESS (10.608s)
[533.085082] Starting dynamic subtest: dma_fence_unwrap
[533.159296] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[533.174492] Starting dynamic subtest: dma_resv
[533.236587] Dynamic subtest dma_resv: SUCCESS (0.075s)
[533.237831] Subtest all-tests: SUCCESS (11.014s)
[533.268869] [166/171] (466s left) i915_suspend (basic-s2idle-without-i915)
[533.329367] Starting subtest: basic-s2idle-without-i915
[552.251826] Subtest basic-s2idle-without-i915: SUCCESS (4.522s)
[552.390166] [167/171] (462s left) i915_suspend (basic-s3-without-i915)
[552.440313] Starting subtest: basic-s3-without-i915
[573.932865] Subtest basic-s3-without-i915: SUCCESS (5.607s)
[574.064728] [168/171] (456s left) gem_exec_suspend (basic-s0)
[574.138691] Starting subtest: basic-S0
[574.139535] Starting dynamic subtest: smem
[593.902268] Dynamic subtest smem: SUCCESS (4.608s)
[593.914805] Starting dynamic subtest: lmem0
[612.907834] Dynamic subtest lmem0: SUCCESS (4.439s)
[612.909032] Subtest basic-S0: SUCCESS (9.050s)
[613.081956] [169/171] (447s left) gem_exec_suspend (basic-s3)
[613.186524] Starting subtest: basic-S3
[613.187542] Starting dynamic subtest: smem
[633.252104] Dynamic subtest smem: SUCCESS (5.310s)
[633.264350] Starting dynamic subtest: lmem0
[654.269229] Dynamic subtest lmem0: SUCCESS (4.908s)
[654.270554] Subtest basic-S3: SUCCESS (10.221s)
[654.451908] [170/171] (436s left) kms_chamelium_hpd (common-hpd-after-suspend)
[654.660089] Subtest common-hpd-after-suspend: SKIP (0.000s)
[654.741885] [171/171] (436s left) kms_pipe_crc_basic (suspend-read-crc)
[654.827894] Starting subtest: suspend-read-crc
[654.830117] Starting dynamic subtest: pipe-A-DP-3
[673.860348] Dynamic subtest pipe-A-DP-3: SUCCESS (3.092s)
[673.868047] Starting dynamic subtest: pipe-B-DP-3
[692.882657] Dynamic subtest pipe-B-DP-3: SUCCESS (3.023s)
[692.892014] Starting dynamic subtest: pipe-C-DP-3
[711.955893] Dynamic subtest pipe-C-DP-3: SUCCESS (3.122s)
[711.963410] Starting dynamic subtest: pipe-D-DP-3
[731.011855] Dynamic subtest pipe-D-DP-3: SUCCESS (3.224s)
[731.012672] Subtest suspend-read-crc: SUCCESS (12.471s)
[731.120106] Closing watchdogs
Done.