[37.610863] Initializing watchdogs
[37.610927]   /dev/watchdog0
[37.615657] [001/171] (960s left) i915_module_load (load)
[37.667357] Starting subtest: load
[38.693675] Subtest load: SUCCESS (1.026s)
[38.703746] [002/171] (959s left) core_auth (basic-auth)
[38.783925] Starting subtest: basic-auth
[38.784888] Subtest basic-auth: SUCCESS (0.001s)
[38.908049] [003/171] (959s left) debugfs_test (read_all_entries)
[38.998823] Starting subtest: read_all_entries
[39.394803] Subtest read_all_entries: SUCCESS (0.395s)
[39.509306] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.569518] Starting subtest: basic-hwmon
[39.573033] Subtest basic-hwmon: SUCCESS (0.003s)
[39.660158] [005/171] (958s left) fbdev (eof)
[39.727882] Starting subtest: eof
[39.728807] Subtest eof: SUCCESS (0.000s)
[39.777330] [006/171] (958s left) fbdev (info)
[39.829425] Starting subtest: info
[39.830641] Subtest info: SUCCESS (0.000s)
[39.893923] [007/171] (958s left) fbdev (nullptr)
[39.960842] Starting subtest: nullptr
[39.961842] Subtest nullptr: SUCCESS (0.000s)
[40.012111] [008/171] (958s left) fbdev (read)
[40.077506] Starting subtest: read
[52.420053] Subtest read: SUCCESS (12.308s)
[52.428853] [009/171] (945s left) fbdev (write)
[52.478237] Starting subtest: write
[58.600488] Subtest write: SUCCESS (6.114s)
[58.645528] [010/171] (939s left) gem_basic (bad-close)
[58.700655] Starting subtest: bad-close
[58.702208] Subtest bad-close: SUCCESS (0.000s)
[58.770042] [011/171] (939s left) gem_basic (create-close)
[58.850958] Starting subtest: create-close
[58.852499] Subtest create-close: SUCCESS (0.000s)
[58.945712] [012/171] (939s left) gem_basic (create-fd-close)
[59.035540] Starting subtest: create-fd-close
[59.037127] Subtest create-fd-close: SUCCESS (0.000s)
[59.134283] [013/171] (939s left) gem_busy (busy@all-engines)
[59.211432] Starting subtest: busy
[59.212267] Starting dynamic subtest: all-engines
[59.306812] Dynamic subtest all-engines: SUCCESS (0.095s)
[59.307740] Subtest busy: SUCCESS (0.095s)
[59.691568] [014/171] (938s left) gem_close_race (basic-process)
[59.809249] Starting subtest: basic-process
[59.850380] Subtest basic-process: SUCCESS (0.041s)
[60.073536] [015/171] (938s left) gem_close_race (basic-threads)
[60.155593] Starting subtest: basic-threads
[61.344351] Subtest basic-threads: SUCCESS (1.189s)
[61.612330] [016/171] (936s left) gem_ctx_create (basic)
[61.715891] Starting subtest: basic
[61.716673] Subtest basic: SUCCESS (0.000s)
[61.909857] [017/171] (936s left) gem_ctx_create (basic-files)
[62.006182] Starting subtest: basic-files
[64.040728] Subtest basic-files: SUCCESS (2.035s)
[64.463215] [018/171] (933s left) gem_ctx_exec (basic)
[64.527468] Starting subtest: basic
[64.531401] Subtest basic: SUCCESS (0.004s)
[64.638448] [019/171] (933s left) gem_exec_basic (basic)
[64.708615] Starting subtest: basic
[64.709560] Starting dynamic subtest: rcs0-smem
[64.710433] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[64.715222] Starting dynamic subtest: bcs0-smem
[64.716044] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[64.720872] Starting dynamic subtest: vcs0-smem
[64.721645] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[64.726164] Starting dynamic subtest: vcs1-smem
[64.726960] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[64.731369] Starting dynamic subtest: vecs0-smem
[64.732162] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[64.736500] Starting dynamic subtest: vecs1-smem
[64.737293] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[64.741550] Starting dynamic subtest: ccs0-smem
[64.742337] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[64.746574] Starting dynamic subtest: ccs1-smem
[64.747367] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[64.751635] Starting dynamic subtest: ccs2-smem
[64.752429] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[64.756838] Starting dynamic subtest: ccs3-smem
[64.757583] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[64.761911] Starting dynamic subtest: rcs0-lmem0
[64.762705] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[64.767032] Starting dynamic subtest: bcs0-lmem0
[64.767826] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[64.772156] Starting dynamic subtest: vcs0-lmem0
[64.772955] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[64.777265] Starting dynamic subtest: vcs1-lmem0
[64.778095] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[64.782404] Starting dynamic subtest: vecs0-lmem0
[64.783191] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[64.787800] Starting dynamic subtest: vecs1-lmem0
[64.789021] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[64.793589] Starting dynamic subtest: ccs0-lmem0
[64.794757] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[64.799470] Starting dynamic subtest: ccs1-lmem0
[64.800637] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[64.805347] Starting dynamic subtest: ccs2-lmem0
[64.806554] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[64.811201] Starting dynamic subtest: ccs3-lmem0
[64.812359] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[64.813562] Subtest basic: SUCCESS (0.009s)
[64.885777] [020/171] (933s left) gem_exec_create (basic)
[64.974600] Starting subtest: basic
[64.975546] Starting dynamic subtest: smem
[67.070834] Dynamic subtest smem: SUCCESS (2.096s)
[67.078904] Starting dynamic subtest: lmem0
[69.179101] Dynamic subtest lmem0: SUCCESS (2.108s)
[69.180058] Subtest basic: SUCCESS (4.204s)
[69.390785] [021/171] (929s left) gem_exec_fence (basic-busy)
[69.615509] Starting subtest: basic-busy
[69.616399] Starting dynamic subtest: rcs0
[69.715193] Dynamic subtest rcs0: SUCCESS (0.100s)
[69.723549] Starting dynamic subtest: bcs0
[69.770024] Dynamic subtest bcs0: SUCCESS (0.055s)
[69.778946] Starting dynamic subtest: vcs0
[69.819935] Dynamic subtest vcs0: SUCCESS (0.049s)
[69.838173] Starting dynamic subtest: vcs1
[69.874962] Dynamic subtest vcs1: SUCCESS (0.055s)
[69.894844] Starting dynamic subtest: vecs0
[69.928077] Dynamic subtest vecs0: SUCCESS (0.053s)
[69.948052] Starting dynamic subtest: vecs1
[69.980125] Dynamic subtest vecs1: SUCCESS (0.052s)
[70.000058] Starting dynamic subtest: ccs0
[70.037977] Dynamic subtest ccs0: SUCCESS (0.057s)
[70.057962] Starting dynamic subtest: ccs1
[70.094382] Dynamic subtest ccs1: SUCCESS (0.056s)
[70.114247] Starting dynamic subtest: ccs2
[70.149196] Dynamic subtest ccs2: SUCCESS (0.054s)
[70.168979] Starting dynamic subtest: ccs3
[70.203992] Dynamic subtest ccs3: SUCCESS (0.054s)
[70.205936] Subtest basic-busy: SUCCESS (0.589s)
[70.808290] [022/171] (927s left) gem_exec_fence (basic-wait)
[71.019824] Starting subtest: basic-wait
[71.021700] Starting dynamic subtest: rcs0
[71.124969] Dynamic subtest rcs0: SUCCESS (0.114s)
[71.134447] Starting dynamic subtest: bcs0
[71.178943] Dynamic subtest bcs0: SUCCESS (0.053s)
[71.199347] Starting dynamic subtest: vcs0
[71.236040] Dynamic subtest vcs0: SUCCESS (0.057s)
[71.256162] Starting dynamic subtest: vcs1
[71.295946] Dynamic subtest vcs1: SUCCESS (0.059s)
[71.304845] Starting dynamic subtest: vecs0
[71.342885] Dynamic subtest vecs0: SUCCESS (0.048s)
[71.350664] Starting dynamic subtest: vecs1
[71.396910] Dynamic subtest vecs1: SUCCESS (0.053s)
[71.405872] Starting dynamic subtest: ccs0
[71.447802] Dynamic subtest ccs0: SUCCESS (0.051s)
[71.459027] Starting dynamic subtest: ccs1
[71.508203] Dynamic subtest ccs1: SUCCESS (0.059s)
[71.529125] Starting dynamic subtest: ccs2
[71.564962] Dynamic subtest ccs2: SUCCESS (0.056s)
[71.584942] Starting dynamic subtest: ccs3
[71.626918] Dynamic subtest ccs3: SUCCESS (0.062s)
[71.628772] Subtest basic-wait: SUCCESS (0.616s)
[72.200775] [023/171] (926s left) gem_exec_fence (basic-await)
[72.397352] Starting subtest: basic-await
[72.398255] Starting dynamic subtest: rcs0
[72.497424] Dynamic subtest rcs0: SUCCESS (0.109s)
[72.502383] Starting dynamic subtest: bcs0
[72.588483] Dynamic subtest bcs0: SUCCESS (0.091s)
[72.593546] Starting dynamic subtest: vcs0
[72.678214] Dynamic subtest vcs0: SUCCESS (0.089s)
[72.683171] Starting dynamic subtest: vcs1
[72.767500] Dynamic subtest vcs1: SUCCESS (0.089s)
[72.773015] Starting dynamic subtest: vecs0
[72.858885] Dynamic subtest vecs0: SUCCESS (0.091s)
[72.863694] Starting dynamic subtest: vecs1
[72.948317] Dynamic subtest vecs1: SUCCESS (0.089s)
[72.953237] Starting dynamic subtest: ccs0
[73.037581] Dynamic subtest ccs0: SUCCESS (0.089s)
[73.043250] Starting dynamic subtest: ccs1
[73.130642] Dynamic subtest ccs1: SUCCESS (0.093s)
[73.135645] Starting dynamic subtest: ccs2
[73.219627] Dynamic subtest ccs2: SUCCESS (0.089s)
[73.225115] Starting dynamic subtest: ccs3
[73.310632] Dynamic subtest ccs3: SUCCESS (0.091s)
[73.311648] Subtest basic-await: SUCCESS (0.922s)
[73.952353] [024/171] (924s left) gem_exec_fence (nb-await)
[74.172114] Starting subtest: nb-await
[74.173085] Starting dynamic subtest: rcs0
[74.259564] Dynamic subtest rcs0: SUCCESS (0.088s)
[74.266102] Starting dynamic subtest: bcs0
[74.322831] Dynamic subtest bcs0: SUCCESS (0.063s)
[74.332737] Starting dynamic subtest: vcs0
[74.394977] Dynamic subtest vcs0: SUCCESS (0.072s)
[74.401246] Starting dynamic subtest: vcs1
[74.461589] Dynamic subtest vcs1: SUCCESS (0.066s)
[74.478199] Starting dynamic subtest: vecs0
[74.547292] Dynamic subtest vecs0: SUCCESS (0.085s)
[74.555415] Starting dynamic subtest: vecs1
[74.613134] Dynamic subtest vecs1: SUCCESS (0.066s)
[74.619780] Starting dynamic subtest: ccs0
[74.679361] Dynamic subtest ccs0: SUCCESS (0.066s)
[74.700593] Starting dynamic subtest: ccs1
[74.772279] Dynamic subtest ccs1: SUCCESS (0.092s)
[74.795116] Starting dynamic subtest: ccs2
[74.874444] Dynamic subtest ccs2: SUCCESS (0.102s)
[74.883205] Starting dynamic subtest: ccs3
[74.939892] Dynamic subtest ccs3: SUCCESS (0.066s)
[74.940992] Subtest nb-await: SUCCESS (0.768s)
[75.531119] [025/171] (922s left) gem_exec_gttfill (basic)
[75.598055] Starting subtest: basic
[80.487849] Subtest basic: SUCCESS (4.881s)
[80.748659] [026/171] (917s left) gem_exec_parallel (engines)
[80.857389] Starting subtest: engines
[80.858266] Starting dynamic subtest: basic
[83.333223] Dynamic subtest basic: SUCCESS (2.475s)
[83.352499] Starting dynamic subtest: contexts
[86.265486] Dynamic subtest contexts: SUCCESS (2.923s)
[86.270713] Starting dynamic subtest: fds
[89.594928] Dynamic subtest fds: SUCCESS (3.338s)
[89.600289] Starting dynamic subtest: userptr
[91.084170] Dynamic subtest userptr: SUCCESS (1.489s)
[91.085748] Subtest engines: SUCCESS (10.226s)
[91.348684] [027/171] (907s left) gem_exec_store (basic)
[91.454176] Starting subtest: basic
[91.590701] Subtest basic: SUCCESS (0.136s)
[91.808724] [028/171] (906s left) gem_flink_basic (bad-flink)
[91.866500] Starting subtest: bad-flink
[91.867317] Subtest bad-flink: SUCCESS (0.000s)
[91.940451] [029/171] (906s left) gem_flink_basic (bad-open)
[92.024185] Starting subtest: bad-open
[92.024987] Subtest bad-open: SUCCESS (0.000s)
[92.084183] [030/171] (906s left) gem_flink_basic (basic)
[92.154834] Starting subtest: basic
[92.155764] Subtest basic: SUCCESS (0.000s)
[92.239282] [031/171] (906s left) gem_flink_basic (double-flink)
[92.300754] Starting subtest: double-flink
[92.301769] Subtest double-flink: SUCCESS (0.000s)
[92.370444] [032/171] (906s left) gem_flink_basic (flink-lifetime)
[92.433377] Starting subtest: flink-lifetime
[92.434341] Subtest flink-lifetime: SUCCESS (0.001s)
[92.525244] [033/171] (906s left) gem_huc_copy (huc-copy)
[92.612824] Starting subtest: huc-copy
[92.617690] Subtest huc-copy: SUCCESS (0.005s)
[92.746187] [034/171] (905s left) gem_linear_blits (basic)
[92.889128] Starting subtest: basic
[92.915770] Subtest basic: SUCCESS (0.027s)
[93.069379] [035/171] (905s left) gem_mmap (basic)
[93.178974] Subtest basic: SKIP (0.000s)
[93.204675] [036/171] (905s left) gem_mmap_gtt (basic)
[93.264788] Subtest basic: SKIP (0.000s)
[93.288110] [037/171] (905s left) gem_render_linear_blits (basic)
[93.352986] Starting subtest: basic
[93.404433] Subtest basic: SUCCESS (0.052s)
[93.472098] [038/171] (905s left) gem_render_tiled_blits (basic)
[93.549679] Subtest basic: SKIP (0.000s)
[93.572111] [039/171] (905s left) gem_ringfill (basic-all)
[93.953747] Starting subtest: basic-all
[95.427821] Subtest basic-all: SUCCESS (1.476s)
[95.597999] [040/171] (903s left) gem_softpin (allocator-basic)
[95.692853] Starting subtest: allocator-basic
[95.856537] Subtest allocator-basic: SUCCESS (0.155s)
[95.980869] [041/171] (902s left) gem_softpin (allocator-basic-reserve)
[96.046280] Starting subtest: allocator-basic-reserve
[96.210757] Subtest allocator-basic-reserve: SUCCESS (0.156s)
[96.311820] [042/171] (902s left) gem_softpin (safe-alignment)
[96.375481] Starting subtest: safe-alignment
[96.423849] Subtest safe-alignment: SUCCESS (0.048s)
[96.533786] [043/171] (902s left) gem_sync (basic-all)
[96.636516] Starting subtest: basic-all
[100.085374] Subtest basic-all: SUCCESS (3.449s)
[100.250207] [044/171] (898s left) gem_sync (basic-each)
[100.318750] Starting subtest: basic-each
[103.136421] Subtest basic-each: SUCCESS (2.818s)
[103.301338] [045/171] (895s left) gem_tiled_blits (basic)
[103.366501] Subtest basic: SKIP (0.000s)
[103.389311] [046/171] (895s left) gem_tiled_fence_blits (basic)
[103.452321] Subtest basic: SKIP (0.000s)
[103.472246] [047/171] (895s left) gem_tiled_pread_basic
[103.555412] [048/171] (895s left) gem_wait (busy@all-engines)
[103.625113] Starting subtest: busy
[103.626057] Starting dynamic subtest: all-engines
[104.193528] Dynamic subtest all-engines: SUCCESS (0.568s)
[104.194454] Subtest busy: SUCCESS (0.569s)
[104.407671] [049/171] (894s left) gem_wait (wait@all-engines)
[104.476247] Starting subtest: wait
[104.477197] Starting dynamic subtest: all-engines
[105.559222] Dynamic subtest all-engines: SUCCESS (1.083s)
[105.560157] Subtest wait: SUCCESS (1.083s)
[105.814568] [050/171] (893s left) i915_getparams_basic (basic-eu-total)
[105.878876] Starting subtest: basic-eu-total
[105.880584] Subtest basic-eu-total: SUCCESS (0.000s)
[105.933990] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[105.992503] Starting subtest: basic-subslice-total
[105.994149] Subtest basic-subslice-total: SUCCESS (0.000s)
[106.051569] [052/171] (892s left) i915_hangman (error-state-basic)
[106.122450] Starting subtest: error-state-basic
[106.305184] Subtest error-state-basic: SUCCESS (0.181s)
[106.414466] [053/171] (892s left) i915_pciid
[106.569911] [054/171] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[106.632051] Starting subtest: addfb25-bad-modifier
[106.632961] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[106.734219] [055/171] (892s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[106.797502] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[106.901184] [056/171] (892s left) kms_addfb_basic (addfb25-modifier-no-flag)
[106.959656] Starting subtest: addfb25-modifier-no-flag
[106.960425] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[107.067397] [057/171] (891s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[107.133788] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[107.234280] [058/171] (891s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[107.299804] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[107.400877] [059/171] (891s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[107.493626] Starting subtest: addfb25-yf-tiled-legacy
[107.494421] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[107.584884] [060/171] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[107.672365] Starting subtest: addfb25-y-tiled-legacy
[107.673289] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[107.751436] [061/171] (891s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[107.838624] Starting subtest: addfb25-y-tiled-small-legacy
[107.840175] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[107.916826] [062/171] (891s left) kms_addfb_basic (bad-pitch-0)
[107.981834] Starting subtest: bad-pitch-0
[107.982755] Subtest bad-pitch-0: SUCCESS (0.000s)
[108.135263] [063/171] (890s left) kms_addfb_basic (bad-pitch-1024)
[108.221857] Starting subtest: bad-pitch-1024
[108.222676] Subtest bad-pitch-1024: SUCCESS (0.000s)
[108.318088] [064/171] (890s left) kms_addfb_basic (bad-pitch-128)
[108.376552] Starting subtest: bad-pitch-128
[108.377416] Subtest bad-pitch-128: SUCCESS (0.000s)
[108.484340] [065/171] (890s left) kms_addfb_basic (bad-pitch-256)
[108.553755] Starting subtest: bad-pitch-256
[108.554654] Subtest bad-pitch-256: SUCCESS (0.000s)
[108.667832] [066/171] (890s left) kms_addfb_basic (bad-pitch-32)
[108.731849] Starting subtest: bad-pitch-32
[108.732766] Subtest bad-pitch-32: SUCCESS (0.000s)
[108.852545] [067/171] (890s left) kms_addfb_basic (bad-pitch-63)
[108.923987] Starting subtest: bad-pitch-63
[108.924893] Subtest bad-pitch-63: SUCCESS (0.000s)
[109.034635] [068/171] (890s left) kms_addfb_basic (bad-pitch-65536)
[109.099465] Starting subtest: bad-pitch-65536
[109.100332] Subtest bad-pitch-65536: SUCCESS (0.000s)
[109.201259] [069/171] (889s left) kms_addfb_basic (bad-pitch-999)
[109.262686] Starting subtest: bad-pitch-999
[109.263634] Subtest bad-pitch-999: SUCCESS (0.000s)
[109.384731] [070/171] (889s left) kms_addfb_basic (basic)
[109.451914] Starting subtest: basic
[109.452825] Subtest basic: SUCCESS (0.000s)
[109.568689] [071/171] (889s left) kms_addfb_basic (basic-x-tiled-legacy)
[109.641778] Starting subtest: basic-x-tiled-legacy
[109.643580] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[109.734643] [072/171] (889s left) kms_addfb_basic (basic-y-tiled-legacy)
[109.797199] Starting subtest: basic-y-tiled-legacy
[109.798969] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[109.901135] [073/171] (889s left) kms_addfb_basic (bo-too-small)
[109.994673] Starting subtest: bo-too-small
[109.995607] Subtest bo-too-small: SUCCESS (0.000s)
[110.084922] [074/171] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[110.172876] Starting subtest: bo-too-small-due-to-tiling
[110.174661] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[110.251162] [075/171] (888s left) kms_addfb_basic (clobberred-modifier)
[110.315862] Starting subtest: clobberred-modifier
[110.317387] Subtest clobberred-modifier: SKIP (0.000s)
[110.418139] [076/171] (888s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.482479] Starting subtest: framebuffer-vs-set-tiling
[110.484115] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[110.584351] [077/171] (888s left) kms_addfb_basic (invalid-get-prop)
[110.646361] Starting subtest: invalid-get-prop
[110.647268] Subtest invalid-get-prop: SUCCESS (0.000s)
[110.770409] [078/171] (888s left) kms_addfb_basic (invalid-get-prop-any)
[110.846975] Starting subtest: invalid-get-prop-any
[110.847847] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[110.951303] [079/171] (888s left) kms_addfb_basic (invalid-set-prop)
[111.013866] Starting subtest: invalid-set-prop
[111.014819] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.137395] [080/171] (888s left) kms_addfb_basic (invalid-set-prop-any)
[111.213596] Starting subtest: invalid-set-prop-any
[111.214473] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[111.336898] [081/171] (887s left) kms_addfb_basic (no-handle)
[111.408800] Starting subtest: no-handle
[111.409655] Subtest no-handle: SUCCESS (0.000s)
[111.537277] [082/171] (887s left) kms_addfb_basic (size-max)
[111.625606] Starting subtest: size-max
[111.626496] Subtest size-max: SUCCESS (0.000s)
[111.701268] [083/171] (887s left) kms_addfb_basic (small-bo)
[111.794591] Starting subtest: small-bo
[111.795442] Subtest small-bo: SUCCESS (0.000s)
[111.884589] [084/171] (887s left) kms_addfb_basic (tile-pitch-mismatch)
[111.943277] Starting subtest: tile-pitch-mismatch
[111.944876] Subtest tile-pitch-mismatch: SKIP (0.000s)
[112.051520] [085/171] (887s left) kms_addfb_basic (too-high)
[112.143886] Starting subtest: too-high
[112.144737] Subtest too-high: SUCCESS (0.000s)
[112.218276] [086/171] (887s left) kms_addfb_basic (too-wide)
[112.317407] Starting subtest: too-wide
[112.318363] Subtest too-wide: SUCCESS (0.000s)
[112.401984] [087/171] (886s left) kms_addfb_basic (unused-handle)
[112.473364] Starting subtest: unused-handle
[112.474272] Subtest unused-handle: SUCCESS (0.000s)
[112.585277] [088/171] (886s left) kms_addfb_basic (unused-modifier)
[112.653268] Starting subtest: unused-modifier
[112.654176] Subtest unused-modifier: SUCCESS (0.000s)
[112.769089] [089/171] (886s left) kms_addfb_basic (unused-offsets)
[112.833620] Starting subtest: unused-offsets
[112.834433] Subtest unused-offsets: SUCCESS (0.000s)
[112.934584] [090/171] (886s left) kms_addfb_basic (unused-pitches)
[112.998720] Starting subtest: unused-pitches
[112.999660] Subtest unused-pitches: SUCCESS (0.000s)
[113.101508] [091/171] (886s left) kms_busy (basic)
[113.200930] Starting subtest: basic
[113.201799] Starting dynamic subtest: flip
[113.889930] Dynamic subtest flip: SUCCESS (0.689s)
[113.896097] Starting dynamic subtest: modeset
[114.619936] Dynamic subtest modeset: SUCCESS (0.729s)
[114.620782] Subtest basic: SUCCESS (1.420s)
[114.781641] [092/171] (884s left) kms_chamelium_hpd (dp-hpd-fast)
[114.938317] Subtest dp-hpd-fast: SKIP (0.000s)
[115.022982] [093/171] (884s left) kms_chamelium_edid (dp-edid-read)
[115.188074] Subtest dp-edid-read: SKIP (0.000s)
[115.272574] [094/171] (884s left) kms_chamelium_frames (dp-crc-fast)
[115.438931] Subtest dp-crc-fast: SKIP (0.000s)
[115.522613] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast)
[115.687650] Subtest hdmi-hpd-fast: SKIP (0.000s)
[115.771613] [096/171] (883s left) kms_chamelium_edid (hdmi-edid-read)
[115.935957] Subtest hdmi-edid-read: SKIP (0.000s)
[116.020689] [097/171] (883s left) kms_chamelium_frames (hdmi-crc-fast)
[116.187351] Subtest hdmi-crc-fast: SKIP (0.000s)
[116.270642] [098/171] (883s left) kms_chamelium_hpd (vga-hpd-fast)
[116.435587] Subtest vga-hpd-fast: SKIP (0.000s)
[116.520042] [099/171] (883s left) kms_chamelium_edid (vga-edid-read)
[116.684531] Subtest vga-edid-read: SKIP (0.000s)
[116.768608] [100/171] (882s left) kms_prop_blob (basic)
[116.827518] Starting subtest: basic
[116.828367] Subtest basic: SUCCESS (0.000s)
[116.894097] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[116.980845] Starting subtest: basic-busy-flip-before-cursor-atomic
[116.982336] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[117.044190] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[117.131823] Starting subtest: basic-busy-flip-before-cursor-legacy
[117.133385] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[117.194318] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[117.281241] Starting subtest: basic-flip-after-cursor-atomic
[118.300754] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.020s)
[118.462071] [104/171] (881s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[118.550561] Starting subtest: basic-flip-after-cursor-legacy
[119.581236] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.032s)
[119.738093] [105/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[119.824961] Starting subtest: basic-flip-after-cursor-varying-size
[120.859299] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s)
[121.021490] [106/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[121.109221] Starting subtest: basic-flip-before-cursor-atomic
[122.126099] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.016s)
[122.283329] [107/171] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[122.369840] Starting subtest: basic-flip-before-cursor-legacy
[123.403425] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.034s)
[123.559133] [108/171] (876s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[123.650018] Starting subtest: basic-flip-before-cursor-varying-size
[124.695434] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.046s)
[124.853064] [109/171] (874s left) kms_flip (basic-flip-vs-dpms)
[124.927536] Starting subtest: basic-flip-vs-dpms
[124.930765] Starting dynamic subtest: A-DP3
[125.777756] Dynamic subtest A-DP3: SUCCESS (0.846s)
[125.784122] Starting dynamic subtest: B-DP3
[126.601706] Dynamic subtest B-DP3: SUCCESS (0.823s)
[126.608226] Starting dynamic subtest: C-DP3
[127.422799] Dynamic subtest C-DP3: SUCCESS (0.821s)
[127.429268] Starting dynamic subtest: D-DP3
[128.251685] Dynamic subtest D-DP3: SUCCESS (0.828s)
[128.253970] Subtest basic-flip-vs-dpms: SUCCESS (3.327s)
[128.416117] [110/171] (871s left) kms_flip (basic-flip-vs-modeset)
[128.491133] Starting subtest: basic-flip-vs-modeset
[128.495290] Starting dynamic subtest: A-DP3
[129.351971] Dynamic subtest A-DP3: SUCCESS (0.856s)
[129.358414] Starting dynamic subtest: B-DP3
[130.050631] Dynamic subtest B-DP3: SUCCESS (0.698s)
[130.056709] Starting dynamic subtest: C-DP3
[130.883239] Dynamic subtest C-DP3: SUCCESS (0.831s)
[130.889672] Starting dynamic subtest: D-DP3
[131.713971] Dynamic subtest D-DP3: SUCCESS (0.830s)
[131.714864] Subtest basic-flip-vs-modeset: SUCCESS (3.224s)
[131.875223] [111/171] (867s left) kms_flip (basic-flip-vs-wf_vblank)
[131.949749] Starting subtest: basic-flip-vs-wf_vblank
[131.954438] Starting dynamic subtest: A-DP3
[133.063111] Dynamic subtest A-DP3: SUCCESS (1.109s)
[133.069670] Starting dynamic subtest: B-DP3
[134.103174] Dynamic subtest B-DP3: SUCCESS (1.039s)
[134.109514] Starting dynamic subtest: C-DP3
[135.141395] Dynamic subtest C-DP3: SUCCESS (1.037s)
[135.147973] Starting dynamic subtest: D-DP3
[136.179481] Dynamic subtest D-DP3: SUCCESS (1.037s)
[136.181579] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.232s)
[136.384676] [112/171] (863s left) kms_flip (basic-plain-flip)
[136.458763] Starting subtest: basic-plain-flip
[136.463452] Starting dynamic subtest: A-DP3
[137.288498] Dynamic subtest A-DP3: SUCCESS (0.825s)
[137.296886] Starting dynamic subtest: B-DP3
[138.062282] Dynamic subtest B-DP3: SUCCESS (0.773s)
[138.068760] Starting dynamic subtest: C-DP3
[138.817192] Dynamic subtest C-DP3: SUCCESS (0.754s)
[138.823521] Starting dynamic subtest: D-DP3
[139.571048] Dynamic subtest D-DP3: SUCCESS (0.753s)
[139.573192] Subtest basic-plain-flip: SUCCESS (3.115s)
[139.775861] [113/171] (859s left) kms_force_connector_basic (force-connector-state)
[139.844134] Starting subtest: force-connector-state
[140.325542] Subtest force-connector-state: SUCCESS (0.482s)
[140.545919] [114/171] (859s left) kms_force_connector_basic (force-edid)
[140.611266] Starting subtest: force-edid
[140.625212] Subtest force-edid: SUCCESS (0.014s)
[140.762435] [115/171] (858s left) kms_force_connector_basic (force-load-detect)
[140.827940] Starting subtest: force-load-detect
[140.829478] Subtest force-load-detect: SKIP (0.000s)
[140.928806] [116/171] (858s left) kms_force_connector_basic (prune-stale-modes)
[140.995406] Starting subtest: prune-stale-modes
[141.003232] Subtest prune-stale-modes: SKIP (0.008s)
[141.129163] [117/171] (858s left) kms_frontbuffer_tracking (basic)
[141.238269] Starting subtest: basic
[144.628132] Subtest basic: SUCCESS (3.391s)
[144.738352] [118/171] (855s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[144.826793] Starting subtest: compare-crc-sanitycheck-xr24
[144.827580] Starting dynamic subtest: pipe-A-DP-3
[145.351511] Dynamic subtest pipe-A-DP-3: SUCCESS (0.523s)
[145.357922] Starting dynamic subtest: pipe-B-DP-3
[145.831798] Dynamic subtest pipe-B-DP-3: SUCCESS (0.479s)
[145.839368] Starting dynamic subtest: pipe-C-DP-3
[146.378293] Dynamic subtest pipe-C-DP-3: SUCCESS (0.544s)
[146.384526] Starting dynamic subtest: pipe-D-DP-3
[146.973909] Dynamic subtest pipe-D-DP-3: SUCCESS (0.593s)
[146.974769] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.147s)
[147.123162] [119/171] (852s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[147.210853] Starting subtest: compare-crc-sanitycheck-nv12
[147.211661] Starting dynamic subtest: pipe-A-DP-3
[148.458912] Dynamic subtest pipe-A-DP-3: SUCCESS (1.247s)
[148.466315] Starting dynamic subtest: pipe-B-DP-3
[149.618300] Dynamic subtest pipe-B-DP-3: SUCCESS (1.157s)
[149.624924] Starting dynamic subtest: pipe-C-DP-3
[150.811312] Dynamic subtest pipe-C-DP-3: SUCCESS (1.191s)
[150.819303] Starting dynamic subtest: pipe-D-DP-3
[152.064144] Dynamic subtest pipe-D-DP-3: SUCCESS (1.250s)
[152.064971] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.854s)
[152.225793] [120/171] (847s left) kms_pipe_crc_basic (hang-read-crc)
[152.313942] Starting subtest: hang-read-crc
[152.314808] Starting dynamic subtest: pipe-A-DP-3
[153.731226] Dynamic subtest pipe-A-DP-3: SUCCESS (1.417s)
[153.738890] Starting dynamic subtest: pipe-B-DP-3
[155.137540] Dynamic subtest pipe-B-DP-3: SUCCESS (1.403s)
[155.144245] Starting dynamic subtest: pipe-C-DP-3
[156.627896] Dynamic subtest pipe-C-DP-3: SUCCESS (1.489s)
[156.634569] Starting dynamic subtest: pipe-D-DP-3
[158.277785] Dynamic subtest pipe-D-DP-3: SUCCESS (1.648s)
[158.278794] Subtest hang-read-crc: SUCCESS (5.964s)
[158.427525] [121/171] (841s left) kms_pipe_crc_basic (nonblocking-crc)
[158.517180] Starting subtest: nonblocking-crc
[158.518068] Starting dynamic subtest: pipe-A-DP-3
[159.197989] Dynamic subtest pipe-A-DP-3: SUCCESS (0.680s)
[159.205366] Starting dynamic subtest: pipe-B-DP-3
[159.849412] Dynamic subtest pipe-B-DP-3: SUCCESS (0.649s)
[159.856785] Starting dynamic subtest: pipe-C-DP-3
[160.546410] Dynamic subtest pipe-C-DP-3: SUCCESS (0.695s)
[160.554119] Starting dynamic subtest: pipe-D-DP-3
[161.315946] Dynamic subtest pipe-D-DP-3: SUCCESS (0.767s)
[161.316927] Subtest nonblocking-crc: SUCCESS (2.799s)
[161.470270] [122/171] (838s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[161.556787] Starting subtest: nonblocking-crc-frame-sequence
[161.558983] Starting dynamic subtest: pipe-A-DP-3
[162.241430] Dynamic subtest pipe-A-DP-3: SUCCESS (0.683s)
[162.249182] Starting dynamic subtest: pipe-B-DP-3
[162.896182] Dynamic subtest pipe-B-DP-3: SUCCESS (0.654s)
[162.903732] Starting dynamic subtest: pipe-C-DP-3
[163.606169] Dynamic subtest pipe-C-DP-3: SUCCESS (0.707s)
[163.612566] Starting dynamic subtest: pipe-D-DP-3
[164.371269] Dynamic subtest pipe-D-DP-3: SUCCESS (0.763s)
[164.372211] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.814s)
[164.512613] [123/171] (835s left) kms_pipe_crc_basic (read-crc)
[164.602674] Starting subtest: read-crc
[164.604821] Starting dynamic subtest: pipe-A-DP-3
[165.249383] Dynamic subtest pipe-A-DP-3: SUCCESS (0.645s)
[165.256675] Starting dynamic subtest: pipe-B-DP-3
[165.817209] Dynamic subtest pipe-B-DP-3: SUCCESS (0.566s)
[165.824896] Starting dynamic subtest: pipe-C-DP-3
[166.476996] Dynamic subtest pipe-C-DP-3: SUCCESS (0.658s)
[166.484303] Starting dynamic subtest: pipe-D-DP-3
[167.161079] Dynamic subtest pipe-D-DP-3: SUCCESS (0.683s)
[167.161981] Subtest read-crc: SUCCESS (2.559s)
[167.305215] [124/171] (832s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[167.401767] Starting subtest: read-crc-frame-sequence
[167.411472] Starting dynamic subtest: pipe-A-DP-3
[168.063794] Dynamic subtest pipe-A-DP-3: SUCCESS (0.656s)
[168.070267] Starting dynamic subtest: pipe-B-DP-3
[168.658156] Dynamic subtest pipe-B-DP-3: SUCCESS (0.598s)
[168.665761] Starting dynamic subtest: pipe-C-DP-3
[169.304068] Dynamic subtest pipe-C-DP-3: SUCCESS (0.644s)
[169.311869] Starting dynamic subtest: pipe-D-DP-3
[169.998868] Dynamic subtest pipe-D-DP-3: SUCCESS (0.691s)
[169.999749] Subtest read-crc-frame-sequence: SUCCESS (2.597s)
[170.150719] [125/171] (829s left) kms_psr (primary_page_flip)
[170.225593] Subtest primary_page_flip: SKIP (0.000s)
[170.256391] [126/171] (829s left) kms_psr (cursor_plane_move)
[170.325183] Subtest cursor_plane_move: SKIP (0.000s)
[170.391362] [127/171] (829s left) kms_psr (sprite_plane_onoff)
[170.482195] Subtest sprite_plane_onoff: SKIP (0.000s)
[170.506161] [128/171] (829s left) kms_psr (primary_mmap_gtt)
[170.570275] Subtest primary_mmap_gtt: SKIP (0.000s)
[170.589614] [129/171] (829s left) kms_setmode (basic-clone-single-crtc)
[170.661213] Starting subtest: basic-clone-single-crtc
[170.663550] Subtest basic-clone-single-crtc: SKIP (0.000s)
[170.723649] [130/171] (829s left) i915_pm_backlight (basic-brightness)
[170.837058] Subtest basic-brightness: SKIP (0.000s)
[170.856902] [131/171] (829s left) i915_pm_rpm (basic-pci-d3-state)
[172.528902] Starting subtest: basic-pci-d3-state
[173.386226] Subtest basic-pci-d3-state: SUCCESS (0.857s)
[173.538838] [132/171] (826s left) i915_pm_rpm (basic-rte)
[173.589979] Starting subtest: basic-rte
[176.536484] Subtest basic-rte: SUCCESS (2.946s)
[177.694946] [133/171] (822s left) i915_pm_rps (basic-api)
[177.758403] Starting subtest: basic-api
[177.760187] Subtest basic-api: SKIP (0.000s)
[177.836317] [134/171] (822s left) prime_self_import (basic-llseek-bad)
[177.889056] Starting subtest: basic-llseek-bad
[177.899541] Subtest basic-llseek-bad: SUCCESS (0.010s)
[177.984058] [135/171] (822s left) prime_self_import (basic-llseek-size)
[178.033200] Starting subtest: basic-llseek-size
[178.044910] Subtest basic-llseek-size: SUCCESS (0.011s)
[178.136540] [136/171] (821s left) prime_self_import (basic-with_fd_dup)
[178.203446] Starting subtest: basic-with_fd_dup
[178.216791] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[178.302044] [137/171] (821s left) prime_self_import (basic-with_one_bo)
[178.352823] Starting subtest: basic-with_one_bo
[178.364733] Subtest basic-with_one_bo: SUCCESS (0.012s)
[178.418291] [138/171] (821s left) prime_self_import (basic-with_one_bo_two_files)
[178.467030] Starting subtest: basic-with_one_bo_two_files
[178.478269] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[178.595145] [139/171] (821s left) prime_self_import (basic-with_two_bos)
[178.681712] Starting subtest: basic-with_two_bos
[178.694047] Subtest basic-with_two_bos: SUCCESS (0.012s)
[178.787066] [140/171] (821s left) prime_vgem (basic-fence-flip)
[178.858068] Starting subtest: basic-fence-flip
[178.918229] Subtest basic-fence-flip: SKIP (0.059s)
[178.998955] [141/171] (821s left) prime_vgem (basic-fence-mmap)
[179.090867] Starting subtest: basic-fence-mmap
[179.092934] Subtest basic-fence-mmap: SKIP (0.000s)
[179.191163] [142/171] (821s left) prime_vgem (basic-fence-read)
[179.274253] Starting subtest: basic-fence-read
[179.279440] Subtest basic-fence-read: SKIP (0.004s)
[179.405408] [143/171] (820s left) prime_vgem (basic-gtt)
[179.508541] Starting subtest: basic-gtt
[179.510148] Subtest basic-gtt: SKIP (0.000s)
[179.628958] [144/171] (820s left) prime_vgem (basic-read)
[179.741185] Starting subtest: basic-read
[179.746445] Subtest basic-read: SKIP (0.004s)
[179.876644] [145/171] (820s left) prime_vgem (basic-write)
[179.958245] Starting subtest: basic-write
[179.963590] Subtest basic-write: SKIP (0.004s)
[180.055277] [146/171] (820s left) vgem_basic (setversion)
[180.110386] Starting subtest: setversion
[180.112624] Subtest setversion: SUCCESS (0.000s)
[180.167856] [147/171] (820s left) vgem_basic (create)
[180.242870] Starting subtest: create
[180.244148] Subtest create: SUCCESS (0.000s)
[180.300856] [148/171] (820s left) vgem_basic (debugfs)
[180.359392] Starting subtest: debugfs
[180.360220] Subtest debugfs: SUCCESS (0.000s)
[180.415988] [149/171] (819s left) vgem_basic (dmabuf-export)
[180.476036] Starting subtest: dmabuf-export
[180.499333] Subtest dmabuf-export: SUCCESS (0.022s)
[180.595900] [150/171] (819s left) vgem_basic (dmabuf-fence)
[180.659581] Starting subtest: dmabuf-fence
[180.660647] Subtest dmabuf-fence: SUCCESS (0.000s)
[180.713839] [151/171] (819s left) vgem_basic (dmabuf-fence-before)
[180.776141] Starting subtest: dmabuf-fence-before
[180.777208] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[180.831266] [152/171] (819s left) vgem_basic (dmabuf-mmap)
[180.892828] Starting subtest: dmabuf-mmap
[180.901125] Subtest dmabuf-mmap: SUCCESS (0.009s)
[180.944839] [153/171] (819s left) vgem_basic (mmap)
[181.009721] Starting subtest: mmap
[181.014782] Subtest mmap: SUCCESS (0.006s)
[181.062468] [154/171] (819s left) vgem_basic (second-client)
[181.126055] Starting subtest: second-client
[181.160056] Subtest second-client: SUCCESS (0.033s)
[181.228754] [155/171] (819s left) vgem_basic (sysfs)
[181.293083] Starting subtest: sysfs
[181.293956] Subtest sysfs: SUCCESS (0.000s)
[181.347283] [156/171] (819s left) core_hotunplug (unbind-rebind)
[181.442539] Starting subtest: unbind-rebind
[183.499770] Subtest unbind-rebind: SUCCESS (2.057s)
[183.515434] [157/171] (816s left) vgem_basic (unload)
[183.566516] Starting subtest: unload
[212.542321] Subtest unload: SUCCESS (28.941s)
[212.593259] [158/171] (787s left) i915_module_load (reload)
[212.642420] Starting subtest: reload
[215.347131] Subtest reload: SUCCESS (2.705s)
[215.360784] [159/171] (785s left) gem_lmem_swapping (basic)
[218.364871] Starting subtest: basic
[218.365771] Starting dynamic subtest: lmem0
[235.564985] Dynamic subtest lmem0: SUCCESS (17.165s)
[235.566047] Subtest basic: SUCCESS (17.166s)
[237.140784] [160/171] (763s left) gem_lmem_swapping (parallel-random-engines)
[237.752533] Starting subtest: parallel-random-engines
[237.753400] Starting dynamic subtest: lmem0
[238.560504] Dynamic subtest lmem0: SUCCESS (0.809s)
[238.561361] Subtest parallel-random-engines: SUCCESS (0.810s)
[239.825519] [161/171] (760s left) gem_lmem_swapping (random-engines)
[240.450513] Starting subtest: random-engines
[240.451413] Starting dynamic subtest: lmem0
[241.180124] Dynamic subtest lmem0: SUCCESS (0.721s)
[241.181056] Subtest random-engines: SUCCESS (0.722s)
[242.472521] [162/171] (758s left) gem_lmem_swapping (verify-random)
[243.111575] Starting subtest: verify-random
[243.112396] Starting dynamic subtest: lmem0
[250.557777] Dynamic subtest lmem0: SUCCESS (7.411s)
[250.558653] Subtest verify-random: SUCCESS (7.412s)
[251.916564] [163/171] (748s left) i915_pm_rpm (module-reload)
[254.744392] Starting subtest: module-reload
[266.765725] Subtest module-reload: SUCCESS (12.012s)
[266.813354] [164/171] (733s left) i915_selftest (live)
[266.880847] Starting subtest: live
[266.881890] Starting dynamic subtest: sanitycheck
[268.238320] Dynamic subtest sanitycheck: SUCCESS (1.348s)
[268.244423] Starting dynamic subtest: uncore
[269.573192] Dynamic subtest uncore: SUCCESS (1.334s)
[269.578526] Starting dynamic subtest: workarounds
[273.924413] Dynamic subtest workarounds: SUCCESS (4.350s)
[273.930215] Starting dynamic subtest: gt_engines
[276.340360] Dynamic subtest gt_engines: SUCCESS (2.415s)
[276.346804] Starting dynamic subtest: gt_timelines
[303.751306] Dynamic subtest gt_timelines: SUCCESS (27.410s)
[303.756820] Starting dynamic subtest: gt_contexts
[305.131542] Dynamic subtest gt_contexts: SUCCESS (1.379s)
[305.137491] Starting dynamic subtest: gt_lrc
[312.925563] Dynamic subtest gt_lrc: SUCCESS (7.801s)
[312.931628] Starting dynamic subtest: gt_mocs
[316.695267] Dynamic subtest gt_mocs: SUCCESS (3.761s)
[316.700983] Starting dynamic subtest: gt_pm
[318.949074] Dynamic subtest gt_pm: SUCCESS (2.253s)
[318.954614] Starting dynamic subtest: gt_heartbeat
[320.522332] Dynamic subtest gt_heartbeat: SUCCESS (1.572s)
[320.528168] Starting dynamic subtest: gt_tlb
[332.497317] Dynamic subtest gt_tlb: SUCCESS (11.974s)
[332.503077] Starting dynamic subtest: requests
[350.145310] Dynamic subtest requests: SUCCESS (17.647s)
[350.151161] Starting dynamic subtest: migrate
[354.550270] Dynamic subtest migrate: SUCCESS (4.404s)
[354.555662] Starting dynamic subtest: active
[355.903323] Dynamic subtest active: SUCCESS (1.352s)
[355.909931] Starting dynamic subtest: objects
[358.082246] Dynamic subtest objects: SUCCESS (2.178s)
[358.088115] Starting dynamic subtest: mman
[366.426866] Dynamic subtest mman: SUCCESS (8.344s)
[366.431681] Starting dynamic subtest: dmabuf
[367.787956] Dynamic subtest dmabuf: SUCCESS (1.360s)
[367.792910] Starting dynamic subtest: vma
[369.139986] Dynamic subtest vma: SUCCESS (1.351s)
[369.145029] Starting dynamic subtest: coherency
[372.372972] Dynamic subtest coherency: SUCCESS (3.232s)
[372.377905] Starting dynamic subtest: gtt
[381.021351] Dynamic subtest gtt: SUCCESS (8.648s)
[381.027214] Starting dynamic subtest: gem
[382.414288] Dynamic subtest gem: SUCCESS (1.392s)
[382.419489] Starting dynamic subtest: evict
[385.904368] Dynamic subtest evict: SUCCESS (3.489s)
[385.909407] Starting dynamic subtest: hugepages
[402.552222] Dynamic subtest hugepages: SUCCESS (16.647s)
[402.558058] Starting dynamic subtest: gem_contexts
[442.394472] Dynamic subtest gem_contexts: SUCCESS (39.815s)
[442.399261] Starting dynamic subtest: client
[443.762363] Dynamic subtest client: SUCCESS (1.393s)
[443.768276] Starting dynamic subtest: gem_migrate
[448.596349] Dynamic subtest gem_migrate: SUCCESS (4.833s)
[448.602172] Starting dynamic subtest: reset
[450.008306] Dynamic subtest reset: SUCCESS (1.411s)
[450.014241] Starting dynamic subtest: memory_region
[452.867152] Dynamic subtest memory_region: SUCCESS (2.858s)
[452.873155] Starting dynamic subtest: hangcheck
[499.673199] Dynamic subtest hangcheck: SUCCESS (46.805s)
[499.678376] Starting dynamic subtest: execlists
[501.004290] Dynamic subtest execlists: SUCCESS (1.330s)
[501.010523] Starting dynamic subtest: ring_submission
[502.349279] Dynamic subtest ring_submission: SUCCESS (1.344s)
[502.355676] Starting dynamic subtest: perf
[503.810332] Dynamic subtest perf: SUCCESS (1.460s)
[503.816505] Starting dynamic subtest: slpc
[512.991305] Dynamic subtest slpc: SUCCESS (9.180s)
[512.997237] Starting dynamic subtest: guc
[515.748354] Dynamic subtest guc: SUCCESS (2.756s)
[515.754374] Starting dynamic subtest: guc_multi_lrc
[517.105275] Dynamic subtest guc_multi_lrc: SUCCESS (1.356s)
[517.111182] Starting dynamic subtest: guc_hang
[519.178215] Dynamic subtest guc_hang: SUCCESS (2.072s)
[519.183852] Starting dynamic subtest: late_gt_pm
[520.585487] Dynamic subtest late_gt_pm: SUCCESS (1.406s)
[520.586630] Subtest live: SUCCESS (253.696s)
[520.985160] [165/171] (479s left) dmabuf (all-tests)
[521.072327] Starting subtest: all-tests
[521.073755] Starting dynamic subtest: sanitycheck
[521.135726] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[521.141677] Starting dynamic subtest: dma_fence
[521.319909] Dynamic subtest dma_fence: SUCCESS (0.183s)
[521.330753] Starting dynamic subtest: dma_fence_chain
[531.574711] Dynamic subtest dma_fence_chain: SUCCESS (10.253s)
[531.582231] Starting dynamic subtest: dma_fence_unwrap
[531.653187] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s)
[531.662226] Starting dynamic subtest: dma_resv
[531.731253] Dynamic subtest dma_resv: SUCCESS (0.075s)
[531.732874] Subtest all-tests: SUCCESS (10.660s)
[531.779108] [166/171] (468s left) i915_suspend (basic-s2idle-without-i915)
[531.852309] Starting subtest: basic-s2idle-without-i915
[551.433924] Subtest basic-s2idle-without-i915: SUCCESS (4.573s)
[551.569279] [167/171] (464s left) i915_suspend (basic-s3-without-i915)
[551.620672] Starting subtest: basic-s3-without-i915
[573.124488] Subtest basic-s3-without-i915: SUCCESS (5.570s)
[573.256214] [168/171] (458s left) gem_exec_suspend (basic-s0)
[573.332237] Starting subtest: basic-S0
[573.333027] Starting dynamic subtest: smem
[593.119542] Dynamic subtest smem: SUCCESS (4.547s)
[593.134991] Starting dynamic subtest: lmem0
[612.073886] Dynamic subtest lmem0: SUCCESS (4.545s)
[612.075206] Subtest basic-S0: SUCCESS (9.097s)
[612.270154] [169/171] (449s left) gem_exec_suspend (basic-s3)
[612.337744] Starting subtest: basic-S3
[612.338709] Starting dynamic subtest: smem
[632.433668] Dynamic subtest smem: SUCCESS (5.319s)
[632.446126] Starting dynamic subtest: lmem0
[653.446234] Dynamic subtest lmem0: SUCCESS (4.910s)
[653.447432] Subtest basic-S3: SUCCESS (10.231s)
[653.583872] [170/171] (438s left) kms_chamelium_hpd (common-hpd-after-suspend)
[653.793220] Subtest common-hpd-after-suspend: SKIP (0.000s)
[653.876768] [171/171] (438s left) kms_pipe_crc_basic (suspend-read-crc)
[653.965068] Starting subtest: suspend-read-crc
[653.967122] Starting dynamic subtest: pipe-A-DP-3
[673.056683] Dynamic subtest pipe-A-DP-3: SUCCESS (3.070s)
[673.065528] Starting dynamic subtest: pipe-B-DP-3
[692.050543] Dynamic subtest pipe-B-DP-3: SUCCESS (3.034s)
[692.060003] Starting dynamic subtest: pipe-C-DP-3
[711.122971] Dynamic subtest pipe-C-DP-3: SUCCESS (3.040s)
[711.130919] Starting dynamic subtest: pipe-D-DP-3
[730.201643] Dynamic subtest pipe-D-DP-3: SUCCESS (3.244s)
[730.202640] Subtest suspend-read-crc: SUCCESS (12.397s)
[730.314489] Closing watchdogs
Done.