[37.066961] Initializing watchdogs
[37.067036]   /dev/watchdog0
[37.071264] [001/171] (960s left) i915_module_load (load)
[37.181013] Starting subtest: load
[38.216571] Subtest load: SUCCESS (1.035s)
[38.227554] [002/171] (959s left) core_auth (basic-auth)
[38.302970] Starting subtest: basic-auth
[38.304818] Subtest basic-auth: SUCCESS (0.002s)
[38.395789] [003/171] (959s left) debugfs_test (read_all_entries)
[38.485733] Starting subtest: read_all_entries
[38.833879] Subtest read_all_entries: SUCCESS (0.348s)
[38.949457] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.009691] Starting subtest: basic-hwmon
[39.013103] Subtest basic-hwmon: SUCCESS (0.003s)
[39.099769] [005/171] (958s left) fbdev (eof)
[39.166938] Starting subtest: eof
[39.167872] Subtest eof: SUCCESS (0.000s)
[39.217283] [006/171] (958s left) fbdev (info)
[39.272517] Starting subtest: info
[39.273584] Subtest info: SUCCESS (0.000s)
[39.333123] [007/171] (958s left) fbdev (nullptr)
[39.400112] Starting subtest: nullptr
[39.401216] Subtest nullptr: SUCCESS (0.000s)
[39.452300] [008/171] (958s left) fbdev (read)
[39.533432] Starting subtest: read
[50.107282] Subtest read: SUCCESS (10.539s)
[50.118320] [009/171] (947s left) fbdev (write)
[50.167507] Starting subtest: write
[55.464393] Subtest write: SUCCESS (5.297s)
[55.517240] [010/171] (942s left) gem_basic (bad-close)
[55.572844] Starting subtest: bad-close
[55.575172] Subtest bad-close: SUCCESS (0.000s)
[55.636458] [011/171] (942s left) gem_basic (create-close)
[55.692410] Starting subtest: create-close
[55.694035] Subtest create-close: SUCCESS (0.000s)
[55.779779] [012/171] (941s left) gem_basic (create-fd-close)
[55.837254] Starting subtest: create-fd-close
[55.839480] Subtest create-fd-close: SUCCESS (0.000s)
[55.945370] [013/171] (941s left) gem_busy (busy@all-engines)
[56.021132] Starting subtest: busy
[56.021960] Starting dynamic subtest: all-engines
[56.115870] Dynamic subtest all-engines: SUCCESS (0.095s)
[56.116662] Subtest busy: SUCCESS (0.095s)
[56.528839] [014/171] (941s left) gem_close_race (basic-process)
[56.640133] Starting subtest: basic-process
[56.688162] Subtest basic-process: SUCCESS (0.048s)
[56.867620] [015/171] (940s left) gem_close_race (basic-threads)
[56.950238] Starting subtest: basic-threads
[58.144192] Subtest basic-threads: SUCCESS (1.194s)
[58.376380] [016/171] (939s left) gem_ctx_create (basic)
[58.485541] Starting subtest: basic
[58.486382] Subtest basic: SUCCESS (0.000s)
[58.673360] [017/171] (939s left) gem_ctx_create (basic-files)
[58.746543] Starting subtest: basic-files
[60.756722] Subtest basic-files: SUCCESS (2.010s)
[61.386918] [018/171] (936s left) gem_ctx_exec (basic)
[61.445493] Starting subtest: basic
[61.448385] Subtest basic: SUCCESS (0.003s)
[61.566914] [019/171] (936s left) gem_exec_basic (basic)
[61.666407] Starting subtest: basic
[61.667232] Starting dynamic subtest: rcs0-smem
[61.668054] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[61.672913] Starting dynamic subtest: bcs0-smem
[61.673751] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[61.679169] Starting dynamic subtest: vcs0-smem
[61.680225] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[61.684866] Starting dynamic subtest: vcs1-smem
[61.685910] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[61.690168] Starting dynamic subtest: vecs0-smem
[61.691013] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[61.695308] Starting dynamic subtest: vecs1-smem
[61.696099] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[61.700792] Starting dynamic subtest: ccs0-smem
[61.701637] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[61.705952] Starting dynamic subtest: ccs1-smem
[61.706742] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[61.711063] Starting dynamic subtest: ccs2-smem
[61.711859] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[61.716574] Starting dynamic subtest: ccs3-smem
[61.717648] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[61.722154] Starting dynamic subtest: rcs0-lmem0
[61.723201] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[61.727696] Starting dynamic subtest: bcs0-lmem0
[61.728779] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[61.733252] Starting dynamic subtest: vcs0-lmem0
[61.734345] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[61.738959] Starting dynamic subtest: vcs1-lmem0
[61.740204] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[61.744798] Starting dynamic subtest: vecs0-lmem0
[61.745961] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[61.750675] Starting dynamic subtest: vecs1-lmem0
[61.751799] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[61.756058] Starting dynamic subtest: ccs0-lmem0
[61.756836] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[61.761517] Starting dynamic subtest: ccs1-lmem0
[61.762635] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[61.767233] Starting dynamic subtest: ccs2-lmem0
[61.768431] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[61.773115] Starting dynamic subtest: ccs3-lmem0
[61.774214] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[61.775395] Subtest basic: SUCCESS (0.011s)
[61.864356] [020/171] (936s left) gem_exec_create (basic)
[61.934854] Starting subtest: basic
[61.935616] Starting dynamic subtest: smem
[64.035027] Dynamic subtest smem: SUCCESS (2.100s)
[64.040166] Starting dynamic subtest: lmem0
[66.127598] Dynamic subtest lmem0: SUCCESS (2.092s)
[66.128449] Subtest basic: SUCCESS (4.193s)
[66.328151] [021/171] (931s left) gem_exec_fence (basic-busy)
[66.512489] Starting subtest: basic-busy
[66.513334] Starting dynamic subtest: rcs0
[66.615446] Dynamic subtest rcs0: SUCCESS (0.102s)
[66.622926] Starting dynamic subtest: bcs0
[66.665043] Dynamic subtest bcs0: SUCCESS (0.050s)
[66.674244] Starting dynamic subtest: vcs0
[66.724985] Dynamic subtest vcs0: SUCCESS (0.059s)
[66.742988] Starting dynamic subtest: vcs1
[66.783047] Dynamic subtest vcs1: SUCCESS (0.058s)
[66.801412] Starting dynamic subtest: vecs0
[66.841164] Dynamic subtest vecs0: SUCCESS (0.058s)
[66.860894] Starting dynamic subtest: vecs1
[66.904976] Dynamic subtest vecs1: SUCCESS (0.064s)
[66.924913] Starting dynamic subtest: ccs0
[66.958042] Dynamic subtest ccs0: SUCCESS (0.053s)
[66.977961] Starting dynamic subtest: ccs1
[67.017064] Dynamic subtest ccs1: SUCCESS (0.059s)
[67.037245] Starting dynamic subtest: ccs2
[67.070075] Dynamic subtest ccs2: SUCCESS (0.053s)
[67.090094] Starting dynamic subtest: ccs3
[67.128909] Dynamic subtest ccs3: SUCCESS (0.059s)
[67.130673] Subtest basic-busy: SUCCESS (0.616s)
[67.690502] [022/171] (930s left) gem_exec_fence (basic-wait)
[67.884750] Starting subtest: basic-wait
[67.886242] Starting dynamic subtest: rcs0
[67.990197] Dynamic subtest rcs0: SUCCESS (0.114s)
[67.998283] Starting dynamic subtest: bcs0
[68.037868] Dynamic subtest bcs0: SUCCESS (0.048s)
[68.047081] Starting dynamic subtest: vcs0
[68.089203] Dynamic subtest vcs0: SUCCESS (0.050s)
[68.109562] Starting dynamic subtest: vcs1
[68.142907] Dynamic subtest vcs1: SUCCESS (0.053s)
[68.163295] Starting dynamic subtest: vecs0
[68.196197] Dynamic subtest vecs0: SUCCESS (0.053s)
[68.204875] Starting dynamic subtest: vecs1
[68.253201] Dynamic subtest vecs1: SUCCESS (0.057s)
[68.267584] Starting dynamic subtest: ccs0
[68.304930] Dynamic subtest ccs0: SUCCESS (0.051s)
[68.313884] Starting dynamic subtest: ccs1
[68.357988] Dynamic subtest ccs1: SUCCESS (0.054s)
[68.365979] Starting dynamic subtest: ccs2
[68.416127] Dynamic subtest ccs2: SUCCESS (0.057s)
[68.425430] Starting dynamic subtest: ccs3
[68.464763] Dynamic subtest ccs3: SUCCESS (0.049s)
[68.465727] Subtest basic-wait: SUCCESS (0.589s)
[69.019853] [023/171] (928s left) gem_exec_fence (basic-await)
[69.236545] Starting subtest: basic-await
[69.237511] Starting dynamic subtest: rcs0
[69.338390] Dynamic subtest rcs0: SUCCESS (0.111s)
[69.343621] Starting dynamic subtest: bcs0
[69.432216] Dynamic subtest bcs0: SUCCESS (0.094s)
[69.437496] Starting dynamic subtest: vcs0
[69.522866] Dynamic subtest vcs0: SUCCESS (0.091s)
[69.528292] Starting dynamic subtest: vcs1
[69.614158] Dynamic subtest vcs1: SUCCESS (0.091s)
[69.619425] Starting dynamic subtest: vecs0
[69.705673] Dynamic subtest vecs0: SUCCESS (0.091s)
[69.711058] Starting dynamic subtest: vecs1
[69.796728] Dynamic subtest vecs1: SUCCESS (0.091s)
[69.801896] Starting dynamic subtest: ccs0
[69.888094] Dynamic subtest ccs0: SUCCESS (0.091s)
[69.893395] Starting dynamic subtest: ccs1
[69.981351] Dynamic subtest ccs1: SUCCESS (0.093s)
[69.986406] Starting dynamic subtest: ccs2
[70.070569] Dynamic subtest ccs2: SUCCESS (0.089s)
[70.076113] Starting dynamic subtest: ccs3
[70.163818] Dynamic subtest ccs3: SUCCESS (0.093s)
[70.164658] Subtest basic-await: SUCCESS (0.937s)
[70.755203] [024/171] (927s left) gem_exec_fence (nb-await)
[70.946705] Starting subtest: nb-await
[70.947815] Starting dynamic subtest: rcs0
[71.038774] Dynamic subtest rcs0: SUCCESS (0.101s)
[71.044323] Starting dynamic subtest: bcs0
[71.101749] Dynamic subtest bcs0: SUCCESS (0.063s)
[71.110528] Starting dynamic subtest: vcs0
[71.166980] Dynamic subtest vcs0: SUCCESS (0.065s)
[71.174584] Starting dynamic subtest: vcs1
[71.236217] Dynamic subtest vcs1: SUCCESS (0.068s)
[71.245166] Starting dynamic subtest: vecs0
[71.302432] Dynamic subtest vecs0: SUCCESS (0.067s)
[71.312590] Starting dynamic subtest: vecs1
[71.376388] Dynamic subtest vecs1: SUCCESS (0.073s)
[71.399599] Starting dynamic subtest: ccs0
[71.480063] Dynamic subtest ccs0: SUCCESS (0.103s)
[71.503246] Starting dynamic subtest: ccs1
[71.571865] Dynamic subtest ccs1: SUCCESS (0.092s)
[71.587594] Starting dynamic subtest: ccs2
[71.663696] Dynamic subtest ccs2: SUCCESS (0.083s)
[71.685851] Starting dynamic subtest: ccs3
[71.749094] Dynamic subtest ccs3: SUCCESS (0.094s)
[71.750562] Subtest nb-await: SUCCESS (0.811s)
[72.320627] [025/171] (925s left) gem_exec_gttfill (basic)
[72.393265] Starting subtest: basic
[77.427447] Subtest basic: SUCCESS (5.026s)
[77.703452] [026/171] (920s left) gem_exec_parallel (engines)
[77.810483] Starting subtest: engines
[77.811321] Starting dynamic subtest: basic
[79.654413] Dynamic subtest basic: SUCCESS (1.844s)
[79.661542] Starting dynamic subtest: contexts
[82.435447] Dynamic subtest contexts: SUCCESS (2.772s)
[82.440720] Starting dynamic subtest: fds
[85.941113] Dynamic subtest fds: SUCCESS (3.506s)
[85.946426] Starting dynamic subtest: userptr
[87.484517] Dynamic subtest userptr: SUCCESS (1.552s)
[87.485632] Subtest engines: SUCCESS (9.674s)
[87.719062] [027/171] (910s left) gem_exec_store (basic)
[87.835036] Starting subtest: basic
[87.971536] Subtest basic: SUCCESS (0.136s)
[88.202320] [028/171] (909s left) gem_flink_basic (bad-flink)
[88.283042] Starting subtest: bad-flink
[88.284209] Subtest bad-flink: SUCCESS (0.000s)
[88.341952] [029/171] (909s left) gem_flink_basic (bad-open)
[88.401425] Starting subtest: bad-open
[88.402297] Subtest bad-open: SUCCESS (0.000s)
[88.458643] [030/171] (909s left) gem_flink_basic (basic)
[88.519805] Starting subtest: basic
[88.520599] Subtest basic: SUCCESS (0.000s)
[88.590856] [031/171] (909s left) gem_flink_basic (double-flink)
[88.661353] Starting subtest: double-flink
[88.662146] Subtest double-flink: SUCCESS (0.000s)
[88.749582] [032/171] (909s left) gem_flink_basic (flink-lifetime)
[88.809596] Starting subtest: flink-lifetime
[88.811466] Subtest flink-lifetime: SUCCESS (0.001s)
[88.892717] [033/171] (909s left) gem_huc_copy (huc-copy)
[88.987942] Starting subtest: huc-copy
[88.993429] Subtest huc-copy: SUCCESS (0.005s)
[89.096457] [034/171] (908s left) gem_linear_blits (basic)
[89.230540] Starting subtest: basic
[89.249440] Subtest basic: SUCCESS (0.019s)
[89.383467] [035/171] (908s left) gem_mmap (basic)
[89.494877] Subtest basic: SKIP (0.000s)
[89.527167] [036/171] (908s left) gem_mmap_gtt (basic)
[89.585780] Subtest basic: SKIP (0.000s)
[89.610143] [037/171] (908s left) gem_render_linear_blits (basic)
[89.680096] Starting subtest: basic
[89.727119] Subtest basic: SUCCESS (0.053s)
[89.795280] [038/171] (908s left) gem_render_tiled_blits (basic)
[89.876686] Subtest basic: SKIP (0.000s)
[89.910866] [039/171] (908s left) gem_ringfill (basic-all)
[90.318486] Starting subtest: basic-all
[91.849573] Subtest basic-all: SUCCESS (1.524s)
[91.985346] [040/171] (906s left) gem_softpin (allocator-basic)
[92.090907] Starting subtest: allocator-basic
[92.252970] Subtest allocator-basic: SUCCESS (0.154s)
[92.389832] [041/171] (905s left) gem_softpin (allocator-basic-reserve)
[92.459595] Starting subtest: allocator-basic-reserve
[92.621564] Subtest allocator-basic-reserve: SUCCESS (0.153s)
[92.712901] [042/171] (905s left) gem_softpin (safe-alignment)
[92.780546] Starting subtest: safe-alignment
[92.829813] Subtest safe-alignment: SUCCESS (0.049s)
[92.945854] [043/171] (905s left) gem_sync (basic-all)
[93.013987] Starting subtest: basic-all
[96.688274] Subtest basic-all: SUCCESS (3.675s)
[96.857685] [044/171] (901s left) gem_sync (basic-each)
[96.924888] Starting subtest: basic-each
[99.708274] Subtest basic-each: SUCCESS (2.783s)
[99.885467] [045/171] (898s left) gem_tiled_blits (basic)
[99.948863] Subtest basic: SKIP (0.000s)
[99.978294] [046/171] (898s left) gem_tiled_fence_blits (basic)
[100.040824] Subtest basic: SKIP (0.000s)
[100.061659] [047/171] (898s left) gem_tiled_pread_basic
[100.144442] [048/171] (898s left) gem_wait (busy@all-engines)
[100.218995] Starting subtest: busy
[100.219872] Starting dynamic subtest: all-engines
[100.788398] Dynamic subtest all-engines: SUCCESS (0.569s)
[100.789238] Subtest busy: SUCCESS (0.569s)
[101.038624] [049/171] (897s left) gem_wait (wait@all-engines)
[101.114012] Starting subtest: wait
[101.114850] Starting dynamic subtest: all-engines
[102.197976] Dynamic subtest all-engines: SUCCESS (1.084s)
[102.198852] Subtest wait: SUCCESS (1.084s)
[102.450878] [050/171] (895s left) i915_getparams_basic (basic-eu-total)
[102.509057] Starting subtest: basic-eu-total
[102.511130] Subtest basic-eu-total: SUCCESS (0.000s)
[102.582970] [051/171] (895s left) i915_getparams_basic (basic-subslice-total)
[102.645016] Starting subtest: basic-subslice-total
[102.647224] Subtest basic-subslice-total: SUCCESS (0.000s)
[102.707226] [052/171] (895s left) i915_hangman (error-state-basic)
[102.779646] Starting subtest: error-state-basic
[102.961429] Subtest error-state-basic: SUCCESS (0.182s)
[103.027754] [053/171] (895s left) i915_pciid
[103.139454] [054/171] (895s left) kms_addfb_basic (addfb25-bad-modifier)
[103.197893] Starting subtest: addfb25-bad-modifier
[103.198838] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[103.306468] [055/171] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[103.366943] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[103.472325] [056/171] (894s left) kms_addfb_basic (addfb25-modifier-no-flag)
[103.534516] Starting subtest: addfb25-modifier-no-flag
[103.535411] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[103.639696] [057/171] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[103.702406] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[103.806719] [058/171] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[103.866432] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[103.972819] [059/171] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[104.068595] Starting subtest: addfb25-yf-tiled-legacy
[104.069414] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[104.157251] [060/171] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[104.253874] Starting subtest: addfb25-y-tiled-legacy
[104.254746] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[104.323148] [061/171] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[104.417752] Starting subtest: addfb25-y-tiled-small-legacy
[104.419340] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[104.489391] [062/171] (893s left) kms_addfb_basic (bad-pitch-0)
[104.551482] Starting subtest: bad-pitch-0
[104.552391] Subtest bad-pitch-0: SUCCESS (0.000s)
[104.656660] [063/171] (893s left) kms_addfb_basic (bad-pitch-1024)
[104.722821] Starting subtest: bad-pitch-1024
[104.723759] Subtest bad-pitch-1024: SUCCESS (0.000s)
[104.840212] [064/171] (893s left) kms_addfb_basic (bad-pitch-128)
[104.908222] Starting subtest: bad-pitch-128
[104.909043] Subtest bad-pitch-128: SUCCESS (0.000s)
[105.023979] [065/171] (893s left) kms_addfb_basic (bad-pitch-256)
[105.091852] Starting subtest: bad-pitch-256
[105.092645] Subtest bad-pitch-256: SUCCESS (0.000s)
[105.207918] [066/171] (893s left) kms_addfb_basic (bad-pitch-32)
[105.267879] Starting subtest: bad-pitch-32
[105.268741] Subtest bad-pitch-32: SUCCESS (0.000s)
[105.373207] [067/171] (893s left) kms_addfb_basic (bad-pitch-63)
[105.437530] Starting subtest: bad-pitch-63
[105.438431] Subtest bad-pitch-63: SUCCESS (0.000s)
[105.539438] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536)
[105.600657] Starting subtest: bad-pitch-65536
[105.601543] Subtest bad-pitch-65536: SUCCESS (0.000s)
[105.706506] [069/171] (892s left) kms_addfb_basic (bad-pitch-999)
[105.771246] Starting subtest: bad-pitch-999
[105.772058] Subtest bad-pitch-999: SUCCESS (0.000s)
[105.891739] [070/171] (892s left) kms_addfb_basic (basic)
[105.951579] Starting subtest: basic
[105.952458] Subtest basic: SUCCESS (0.000s)
[106.055846] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy)
[106.118042] Starting subtest: basic-x-tiled-legacy
[106.119629] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[106.222658] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy)
[106.285420] Starting subtest: basic-y-tiled-legacy
[106.287100] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[106.389725] [073/171] (892s left) kms_addfb_basic (bo-too-small)
[106.483904] Starting subtest: bo-too-small
[106.484801] Subtest bo-too-small: SUCCESS (0.000s)
[106.573873] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[106.671625] Starting subtest: bo-too-small-due-to-tiling
[106.673183] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[106.740194] [075/171] (891s left) kms_addfb_basic (clobberred-modifier)
[106.801608] Starting subtest: clobberred-modifier
[106.803385] Subtest clobberred-modifier: SKIP (0.000s)
[106.906307] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[106.971573] Starting subtest: framebuffer-vs-set-tiling
[106.973188] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[107.124329] [077/171] (891s left) kms_addfb_basic (invalid-get-prop)
[107.188778] Starting subtest: invalid-get-prop
[107.189646] Subtest invalid-get-prop: SUCCESS (0.000s)
[107.307695] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any)
[107.368025] Starting subtest: invalid-get-prop-any
[107.368820] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[107.473718] [079/171] (891s left) kms_addfb_basic (invalid-set-prop)
[107.533474] Starting subtest: invalid-set-prop
[107.534294] Subtest invalid-set-prop: SUCCESS (0.000s)
[107.640137] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any)
[107.708873] Starting subtest: invalid-set-prop-any
[107.709786] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[107.824367] [081/171] (890s left) kms_addfb_basic (no-handle)
[107.905881] Starting subtest: no-handle
[107.906854] Subtest no-handle: SUCCESS (0.000s)
[108.024065] [082/171] (890s left) kms_addfb_basic (size-max)
[108.136612] Starting subtest: size-max
[108.137412] Subtest size-max: SUCCESS (0.000s)
[108.206692] [083/171] (890s left) kms_addfb_basic (small-bo)
[108.300709] Starting subtest: small-bo
[108.301530] Subtest small-bo: SUCCESS (0.000s)
[108.372852] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch)
[108.431275] Starting subtest: tile-pitch-mismatch
[108.432860] Subtest tile-pitch-mismatch: SKIP (0.000s)
[108.540774] [085/171] (890s left) kms_addfb_basic (too-high)
[108.637778] Starting subtest: too-high
[108.638631] Subtest too-high: SUCCESS (0.000s)
[108.706305] [086/171] (890s left) kms_addfb_basic (too-wide)
[108.793654] Starting subtest: too-wide
[108.794548] Subtest too-wide: SUCCESS (0.000s)
[108.873675] [087/171] (889s left) kms_addfb_basic (unused-handle)
[108.935470] Starting subtest: unused-handle
[108.936295] Subtest unused-handle: SUCCESS (0.000s)
[109.040223] [088/171] (889s left) kms_addfb_basic (unused-modifier)
[109.104503] Starting subtest: unused-modifier
[109.105396] Subtest unused-modifier: SUCCESS (0.000s)
[109.207073] [089/171] (889s left) kms_addfb_basic (unused-offsets)
[109.271967] Starting subtest: unused-offsets
[109.272873] Subtest unused-offsets: SUCCESS (0.000s)
[109.373594] [090/171] (889s left) kms_addfb_basic (unused-pitches)
[109.434763] Starting subtest: unused-pitches
[109.435683] Subtest unused-pitches: SUCCESS (0.000s)
[109.559782] [091/171] (889s left) kms_busy (basic)
[109.675373] Starting subtest: basic
[109.676277] Starting dynamic subtest: flip
[110.348017] Dynamic subtest flip: SUCCESS (0.672s)
[110.354224] Starting dynamic subtest: modeset
[111.117907] Dynamic subtest modeset: SUCCESS (0.770s)
[111.118751] Subtest basic: SUCCESS (1.442s)
[111.276278] [092/171] (887s left) kms_chamelium_hpd (dp-hpd-fast)
[111.432528] Subtest dp-hpd-fast: SKIP (0.000s)
[111.519532] [093/171] (887s left) kms_chamelium_edid (dp-edid-read)
[111.684785] Subtest dp-edid-read: SKIP (0.000s)
[111.772548] [094/171] (887s left) kms_chamelium_frames (dp-crc-fast)
[111.937942] Subtest dp-crc-fast: SKIP (0.000s)
[112.025501] [095/171] (886s left) kms_chamelium_hpd (hdmi-hpd-fast)
[112.190196] Subtest hdmi-hpd-fast: SKIP (0.000s)
[112.277723] [096/171] (886s left) kms_chamelium_edid (hdmi-edid-read)
[112.442461] Subtest hdmi-edid-read: SKIP (0.000s)
[112.530024] [097/171] (886s left) kms_chamelium_frames (hdmi-crc-fast)
[112.694047] Subtest hdmi-crc-fast: SKIP (0.000s)
[112.781670] [098/171] (886s left) kms_chamelium_hpd (vga-hpd-fast)
[112.947921] Subtest vga-hpd-fast: SKIP (0.000s)
[113.036563] [099/171] (885s left) kms_chamelium_edid (vga-edid-read)
[113.201344] Subtest vga-edid-read: SKIP (0.000s)
[113.288956] [100/171] (885s left) kms_prop_blob (basic)
[113.348022] Starting subtest: basic
[113.348859] Subtest basic: SUCCESS (0.000s)
[113.413478] [101/171] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[113.500610] Starting subtest: basic-busy-flip-before-cursor-atomic
[113.502193] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[113.564396] [102/171] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[113.651891] Starting subtest: basic-busy-flip-before-cursor-legacy
[113.653679] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[113.713863] [103/171] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[113.801213] Starting subtest: basic-flip-after-cursor-atomic
[114.819344] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.018s)
[114.978491] [104/171] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[115.069617] Starting subtest: basic-flip-after-cursor-legacy
[116.111389] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.030s)
[116.259906] [105/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[116.346853] Starting subtest: basic-flip-after-cursor-varying-size
[117.382111] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.036s)
[117.545536] [106/171] (881s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[117.632238] Starting subtest: basic-flip-before-cursor-atomic
[118.649666] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.018s)
[118.825218] [107/171] (880s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[118.912748] Starting subtest: basic-flip-before-cursor-legacy
[119.945608] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.033s)
[120.107497] [108/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[120.195909] Starting subtest: basic-flip-before-cursor-varying-size
[121.228809] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.034s)
[121.389733] [109/171] (877s left) kms_flip (basic-flip-vs-dpms)
[121.463909] Starting subtest: basic-flip-vs-dpms
[121.467563] Starting dynamic subtest: A-DP3
[122.327710] Dynamic subtest A-DP3: SUCCESS (0.859s)
[122.333689] Starting dynamic subtest: B-DP3
[123.164807] Dynamic subtest B-DP3: SUCCESS (0.837s)
[123.171099] Starting dynamic subtest: C-DP3
[124.004471] Dynamic subtest C-DP3: SUCCESS (0.839s)
[124.010852] Starting dynamic subtest: D-DP3
[124.849096] Dynamic subtest D-DP3: SUCCESS (0.844s)
[124.849949] Subtest basic-flip-vs-dpms: SUCCESS (3.387s)
[125.016059] [110/171] (874s left) kms_flip (basic-flip-vs-modeset)
[125.092245] Starting subtest: basic-flip-vs-modeset
[125.095673] Starting dynamic subtest: A-DP3
[125.978760] Dynamic subtest A-DP3: SUCCESS (0.882s)
[125.984996] Starting dynamic subtest: B-DP3
[126.685852] Dynamic subtest B-DP3: SUCCESS (0.707s)
[126.691816] Starting dynamic subtest: C-DP3
[127.391523] Dynamic subtest C-DP3: SUCCESS (0.705s)
[127.397759] Starting dynamic subtest: D-DP3
[128.092836] Dynamic subtest D-DP3: SUCCESS (0.702s)
[128.094887] Subtest basic-flip-vs-modeset: SUCCESS (3.003s)
[128.252141] [111/171] (870s left) kms_flip (basic-flip-vs-wf_vblank)
[128.326811] Starting subtest: basic-flip-vs-wf_vblank
[128.330808] Starting dynamic subtest: A-DP3
[129.444161] Dynamic subtest A-DP3: SUCCESS (1.113s)
[129.450667] Starting dynamic subtest: B-DP3
[130.504688] Dynamic subtest B-DP3: SUCCESS (1.060s)
[130.511176] Starting dynamic subtest: C-DP3
[131.713271] Dynamic subtest C-DP3: SUCCESS (1.208s)
[131.719466] Starting dynamic subtest: D-DP3
[132.753507] Dynamic subtest D-DP3: SUCCESS (1.040s)
[132.755096] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.429s)
[132.976473] [112/171] (866s left) kms_flip (basic-plain-flip)
[133.054526] Starting subtest: basic-plain-flip
[133.059377] Starting dynamic subtest: A-DP3
[133.901420] Dynamic subtest A-DP3: SUCCESS (0.842s)
[133.908485] Starting dynamic subtest: B-DP3
[134.661196] Dynamic subtest B-DP3: SUCCESS (0.759s)
[134.667524] Starting dynamic subtest: C-DP3
[135.422836] Dynamic subtest C-DP3: SUCCESS (0.761s)
[135.429124] Starting dynamic subtest: D-DP3
[136.180191] Dynamic subtest D-DP3: SUCCESS (0.757s)
[136.181699] Subtest basic-plain-flip: SUCCESS (3.127s)
[136.385686] [113/171] (862s left) kms_force_connector_basic (force-connector-state)
[136.454181] Starting subtest: force-connector-state
[136.983728] Subtest force-connector-state: SUCCESS (0.530s)
[137.209688] [114/171] (861s left) kms_force_connector_basic (force-edid)
[137.277300] Starting subtest: force-edid
[137.291955] Subtest force-edid: SUCCESS (0.015s)
[137.426611] [115/171] (861s left) kms_force_connector_basic (force-load-detect)
[137.494163] Starting subtest: force-load-detect
[137.495762] Subtest force-load-detect: SKIP (0.000s)
[137.593914] [116/171] (861s left) kms_force_connector_basic (prune-stale-modes)
[137.662238] Starting subtest: prune-stale-modes
[137.671378] Subtest prune-stale-modes: SKIP (0.008s)
[137.792882] [117/171] (861s left) kms_frontbuffer_tracking (basic)
[137.904202] Starting subtest: basic
[141.625066] Subtest basic: SUCCESS (3.723s)
[141.738946] [118/171] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[141.827098] Starting subtest: compare-crc-sanitycheck-xr24
[141.827968] Starting dynamic subtest: pipe-A-DP-3
[142.364136] Dynamic subtest pipe-A-DP-3: SUCCESS (0.536s)
[142.371663] Starting dynamic subtest: pipe-B-DP-3
[142.856693] Dynamic subtest pipe-B-DP-3: SUCCESS (0.491s)
[142.862899] Starting dynamic subtest: pipe-C-DP-3
[143.411453] Dynamic subtest pipe-C-DP-3: SUCCESS (0.554s)
[143.419390] Starting dynamic subtest: pipe-D-DP-3
[144.026555] Dynamic subtest pipe-D-DP-3: SUCCESS (0.613s)
[144.027552] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.200s)
[144.180947] [119/171] (855s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[144.270198] Starting subtest: compare-crc-sanitycheck-nv12
[144.271136] Starting dynamic subtest: pipe-A-DP-3
[145.525903] Dynamic subtest pipe-A-DP-3: SUCCESS (1.248s)
[145.532159] Starting dynamic subtest: pipe-B-DP-3
[146.706997] Dynamic subtest pipe-B-DP-3: SUCCESS (1.187s)
[146.714484] Starting dynamic subtest: pipe-C-DP-3
[147.970958] Dynamic subtest pipe-C-DP-3: SUCCESS (1.263s)
[147.978602] Starting dynamic subtest: pipe-D-DP-3
[149.113570] Dynamic subtest pipe-D-DP-3: SUCCESS (1.141s)
[149.114479] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.844s)
[149.270238] [120/171] (849s left) kms_pipe_crc_basic (hang-read-crc)
[149.359209] Starting subtest: hang-read-crc
[149.360138] Starting dynamic subtest: pipe-A-DP-3
[150.774993] Dynamic subtest pipe-A-DP-3: SUCCESS (1.416s)
[150.782544] Starting dynamic subtest: pipe-B-DP-3
[152.170288] Dynamic subtest pipe-B-DP-3: SUCCESS (1.394s)
[152.179227] Starting dynamic subtest: pipe-C-DP-3
[153.712322] Dynamic subtest pipe-C-DP-3: SUCCESS (1.539s)
[153.718829] Starting dynamic subtest: pipe-D-DP-3
[155.380879] Dynamic subtest pipe-D-DP-3: SUCCESS (1.668s)
[155.381636] Subtest hang-read-crc: SUCCESS (6.023s)
[155.534292] [121/171] (843s left) kms_pipe_crc_basic (nonblocking-crc)
[155.625106] Starting subtest: nonblocking-crc
[155.625953] Starting dynamic subtest: pipe-A-DP-3
[156.305361] Dynamic subtest pipe-A-DP-3: SUCCESS (0.680s)
[156.311822] Starting dynamic subtest: pipe-B-DP-3
[156.965232] Dynamic subtest pipe-B-DP-3: SUCCESS (0.658s)
[156.971930] Starting dynamic subtest: pipe-C-DP-3
[157.673348] Dynamic subtest pipe-C-DP-3: SUCCESS (0.706s)
[157.679752] Starting dynamic subtest: pipe-D-DP-3
[158.455378] Dynamic subtest pipe-D-DP-3: SUCCESS (0.781s)
[158.456283] Subtest nonblocking-crc: SUCCESS (2.832s)
[158.608436] [122/171] (840s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[158.696127] Starting subtest: nonblocking-crc-frame-sequence
[158.696953] Starting dynamic subtest: pipe-A-DP-3
[159.362359] Dynamic subtest pipe-A-DP-3: SUCCESS (0.666s)
[159.368952] Starting dynamic subtest: pipe-B-DP-3
[160.041270] Dynamic subtest pipe-B-DP-3: SUCCESS (0.678s)
[160.048974] Starting dynamic subtest: pipe-C-DP-3
[160.748869] Dynamic subtest pipe-C-DP-3: SUCCESS (0.705s)
[160.755691] Starting dynamic subtest: pipe-D-DP-3
[161.534975] Dynamic subtest pipe-D-DP-3: SUCCESS (0.785s)
[161.535879] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.841s)
[161.681464] [123/171] (837s left) kms_pipe_crc_basic (read-crc)
[161.767569] Starting subtest: read-crc
[161.769611] Starting dynamic subtest: pipe-A-DP-3
[162.385348] Dynamic subtest pipe-A-DP-3: SUCCESS (0.616s)
[162.391693] Starting dynamic subtest: pipe-B-DP-3
[162.977095] Dynamic subtest pipe-B-DP-3: SUCCESS (0.590s)
[162.984416] Starting dynamic subtest: pipe-C-DP-3
[163.647401] Dynamic subtest pipe-C-DP-3: SUCCESS (0.669s)
[163.655179] Starting dynamic subtest: pipe-D-DP-3
[164.351360] Dynamic subtest pipe-D-DP-3: SUCCESS (0.702s)
[164.352256] Subtest read-crc: SUCCESS (2.584s)
[164.500090] [124/171] (834s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[164.587813] Starting subtest: read-crc-frame-sequence
[164.588706] Starting dynamic subtest: pipe-A-DP-3
[165.238208] Dynamic subtest pipe-A-DP-3: SUCCESS (0.649s)
[165.244895] Starting dynamic subtest: pipe-B-DP-3
[165.832485] Dynamic subtest pipe-B-DP-3: SUCCESS (0.593s)
[165.840225] Starting dynamic subtest: pipe-C-DP-3
[166.491421] Dynamic subtest pipe-C-DP-3: SUCCESS (0.657s)
[166.499066] Starting dynamic subtest: pipe-D-DP-3
[167.196333] Dynamic subtest pipe-D-DP-3: SUCCESS (0.702s)
[167.197168] Subtest read-crc-frame-sequence: SUCCESS (2.609s)
[167.340665] [125/171] (831s left) kms_psr (primary_page_flip)
[167.400174] Subtest primary_page_flip: SKIP (0.000s)
[167.429348] [126/171] (831s left) kms_psr (cursor_plane_move)
[167.489375] Subtest cursor_plane_move: SKIP (0.000s)
[167.513344] [127/171] (831s left) kms_psr (sprite_plane_onoff)
[167.574015] Subtest sprite_plane_onoff: SKIP (0.000s)
[167.596522] [128/171] (831s left) kms_psr (primary_mmap_gtt)
[167.657978] Subtest primary_mmap_gtt: SKIP (0.000s)
[167.679328] [129/171] (831s left) kms_setmode (basic-clone-single-crtc)
[167.739598] Starting subtest: basic-clone-single-crtc
[167.742584] Subtest basic-clone-single-crtc: SKIP (0.000s)
[167.809953] [130/171] (831s left) i915_pm_backlight (basic-brightness)
[167.915880] Subtest basic-brightness: SKIP (0.000s)
[167.946821] [131/171] (831s left) i915_pm_rpm (basic-pci-d3-state)
[169.519443] Starting subtest: basic-pci-d3-state
[170.159235] Subtest basic-pci-d3-state: SUCCESS (0.640s)
[170.314788] [132/171] (829s left) i915_pm_rpm (basic-rte)
[170.376302] Starting subtest: basic-rte
[173.435207] Subtest basic-rte: SUCCESS (3.059s)
[174.404181] [133/171] (824s left) i915_pm_rps (basic-api)
[174.469310] Starting subtest: basic-api
[174.471095] Subtest basic-api: SKIP (0.000s)
[174.544953] [134/171] (824s left) prime_self_import (basic-llseek-bad)
[174.611118] Starting subtest: basic-llseek-bad
[174.622599] Subtest basic-llseek-bad: SUCCESS (0.011s)
[174.711166] [135/171] (824s left) prime_self_import (basic-llseek-size)
[174.762174] Starting subtest: basic-llseek-size
[174.773983] Subtest basic-llseek-size: SUCCESS (0.011s)
[174.878149] [136/171] (824s left) prime_self_import (basic-with_fd_dup)
[174.934861] Starting subtest: basic-with_fd_dup
[174.946206] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[175.056107] [137/171] (824s left) prime_self_import (basic-with_one_bo)
[175.135421] Starting subtest: basic-with_one_bo
[175.147171] Subtest basic-with_one_bo: SUCCESS (0.012s)
[175.192598] [138/171] (824s left) prime_self_import (basic-with_one_bo_two_files)
[175.240155] Starting subtest: basic-with_one_bo_two_files
[175.252258] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[175.355566] [139/171] (824s left) prime_self_import (basic-with_two_bos)
[175.403445] Starting subtest: basic-with_two_bos
[175.416201] Subtest basic-with_two_bos: SUCCESS (0.012s)
[175.517355] [140/171] (824s left) prime_vgem (basic-fence-flip)
[175.600337] Starting subtest: basic-fence-flip
[175.660503] Subtest basic-fence-flip: SKIP (0.059s)
[175.760081] [141/171] (823s left) prime_vgem (basic-fence-mmap)
[175.849218] Starting subtest: basic-fence-mmap
[175.850833] Subtest basic-fence-mmap: SKIP (0.000s)
[175.967777] [142/171] (823s left) prime_vgem (basic-fence-read)
[176.033576] Starting subtest: basic-fence-read
[176.038058] Subtest basic-fence-read: SKIP (0.004s)
[176.135964] [143/171] (823s left) prime_vgem (basic-gtt)
[176.233474] Starting subtest: basic-gtt
[176.235464] Subtest basic-gtt: SKIP (0.000s)
[176.328381] [144/171] (823s left) prime_vgem (basic-read)
[176.431063] Starting subtest: basic-read
[176.436265] Subtest basic-read: SKIP (0.004s)
[176.554577] [145/171] (823s left) prime_vgem (basic-write)
[176.633560] Starting subtest: basic-write
[176.639066] Subtest basic-write: SKIP (0.004s)
[176.731406] [146/171] (822s left) vgem_basic (setversion)
[176.818634] Starting subtest: setversion
[176.821229] Subtest setversion: SUCCESS (0.000s)
[176.871018] [147/171] (822s left) vgem_basic (create)
[176.935065] Starting subtest: create
[176.936370] Subtest create: SUCCESS (0.000s)
[176.988498] [148/171] (822s left) vgem_basic (debugfs)
[177.051933] Starting subtest: debugfs
[177.052763] Subtest debugfs: SUCCESS (0.000s)
[177.107592] [149/171] (822s left) vgem_basic (dmabuf-export)
[177.168537] Starting subtest: dmabuf-export
[177.189930] Subtest dmabuf-export: SUCCESS (0.022s)
[177.296856] [150/171] (822s left) vgem_basic (dmabuf-fence)
[177.385054] Starting subtest: dmabuf-fence
[177.385877] Subtest dmabuf-fence: SUCCESS (0.000s)
[177.439520] [151/171] (822s left) vgem_basic (dmabuf-fence-before)
[177.501761] Starting subtest: dmabuf-fence-before
[177.502560] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[177.556091] [152/171] (822s left) vgem_basic (dmabuf-mmap)
[177.618603] Starting subtest: dmabuf-mmap
[177.626863] Subtest dmabuf-mmap: SUCCESS (0.009s)
[177.672640] [153/171] (822s left) vgem_basic (mmap)
[177.735258] Starting subtest: mmap
[177.740207] Subtest mmap: SUCCESS (0.006s)
[177.787907] [154/171] (822s left) vgem_basic (second-client)
[177.852146] Starting subtest: second-client
[177.901505] Subtest second-client: SUCCESS (0.050s)
[177.992573] [155/171] (821s left) vgem_basic (sysfs)
[178.051900] Starting subtest: sysfs
[178.052733] Subtest sysfs: SUCCESS (0.000s)
[178.106879] [156/171] (821s left) core_hotunplug (unbind-rebind)
[178.201447] Starting subtest: unbind-rebind
[180.293238] Subtest unbind-rebind: SUCCESS (2.092s)
[180.308242] [157/171] (819s left) vgem_basic (unload)
[180.359815] Starting subtest: unload
[209.343063] Subtest unload: SUCCESS (28.948s)
[209.400943] [158/171] (790s left) i915_module_load (reload)
[209.456293] Starting subtest: reload
[212.295265] Subtest reload: SUCCESS (2.837s)
[212.305589] [159/171] (787s left) gem_lmem_swapping (basic)
[215.253281] Starting subtest: basic
[215.254007] Starting dynamic subtest: lmem0
[232.552031] Dynamic subtest lmem0: SUCCESS (17.267s)
[232.552915] Subtest basic: SUCCESS (17.267s)
[234.151616] [160/171] (765s left) gem_lmem_swapping (parallel-random-engines)
[234.804486] Starting subtest: parallel-random-engines
[234.805257] Starting dynamic subtest: lmem0
[235.618671] Dynamic subtest lmem0: SUCCESS (0.814s)
[235.619484] Subtest parallel-random-engines: SUCCESS (0.814s)
[236.899140] [161/171] (763s left) gem_lmem_swapping (random-engines)
[237.518151] Starting subtest: random-engines
[237.518936] Starting dynamic subtest: lmem0
[238.249259] Dynamic subtest lmem0: SUCCESS (0.722s)
[238.250112] Subtest random-engines: SUCCESS (0.723s)
[239.616404] [162/171] (760s left) gem_lmem_swapping (verify-random)
[240.228491] Starting subtest: verify-random
[240.229512] Starting dynamic subtest: lmem0
[247.489143] Dynamic subtest lmem0: SUCCESS (7.260s)
[247.489969] Subtest verify-random: SUCCESS (7.261s)
[248.875595] [163/171] (751s left) i915_pm_rpm (module-reload)
[251.784487] Starting subtest: module-reload
[264.549137] Subtest module-reload: SUCCESS (12.756s)
[264.588301] [164/171] (735s left) i915_selftest (live)
[264.655504] Starting subtest: live
[264.656449] Starting dynamic subtest: sanitycheck
[266.026355] Dynamic subtest sanitycheck: SUCCESS (1.362s)
[266.031715] Starting dynamic subtest: uncore
[267.405323] Dynamic subtest uncore: SUCCESS (1.378s)
[267.411546] Starting dynamic subtest: workarounds
[271.608617] Dynamic subtest workarounds: SUCCESS (4.203s)
[271.614580] Starting dynamic subtest: gt_engines
[274.057333] Dynamic subtest gt_engines: SUCCESS (2.448s)
[274.063191] Starting dynamic subtest: gt_timelines
[301.543522] Dynamic subtest gt_timelines: SUCCESS (27.485s)
[301.549878] Starting dynamic subtest: gt_contexts
[302.962429] Dynamic subtest gt_contexts: SUCCESS (1.420s)
[302.968316] Starting dynamic subtest: gt_lrc
[310.820166] Dynamic subtest gt_lrc: SUCCESS (7.857s)
[310.826016] Starting dynamic subtest: gt_mocs
[314.501392] Dynamic subtest gt_mocs: SUCCESS (3.681s)
[314.506526] Starting dynamic subtest: gt_pm
[316.820424] Dynamic subtest gt_pm: SUCCESS (2.319s)
[316.825557] Starting dynamic subtest: gt_heartbeat
[318.397379] Dynamic subtest gt_heartbeat: SUCCESS (1.576s)
[318.403200] Starting dynamic subtest: gt_tlb
[330.383341] Dynamic subtest gt_tlb: SUCCESS (11.985s)
[330.388789] Starting dynamic subtest: requests
[347.909566] Dynamic subtest requests: SUCCESS (17.526s)
[347.916203] Starting dynamic subtest: migrate
[352.401227] Dynamic subtest migrate: SUCCESS (4.491s)
[352.406049] Starting dynamic subtest: active
[353.797175] Dynamic subtest active: SUCCESS (1.395s)
[353.802603] Starting dynamic subtest: objects
[356.034402] Dynamic subtest objects: SUCCESS (2.237s)
[356.040253] Starting dynamic subtest: mman
[364.519743] Dynamic subtest mman: SUCCESS (8.483s)
[364.524758] Starting dynamic subtest: dmabuf
[365.917980] Dynamic subtest dmabuf: SUCCESS (1.400s)
[365.923018] Starting dynamic subtest: vma
[367.281944] Dynamic subtest vma: SUCCESS (1.364s)
[367.286977] Starting dynamic subtest: coherency
[370.178846] Dynamic subtest coherency: SUCCESS (2.897s)
[370.183787] Starting dynamic subtest: gtt
[378.893256] Dynamic subtest gtt: SUCCESS (8.714s)
[378.898508] Starting dynamic subtest: gem
[380.277298] Dynamic subtest gem: SUCCESS (1.384s)
[380.282914] Starting dynamic subtest: evict
[383.766340] Dynamic subtest evict: SUCCESS (3.489s)
[383.771769] Starting dynamic subtest: hugepages
[400.298299] Dynamic subtest hugepages: SUCCESS (16.531s)
[400.303272] Starting dynamic subtest: gem_contexts
[439.965197] Dynamic subtest gem_contexts: SUCCESS (39.641s)
[439.970273] Starting dynamic subtest: client
[441.333312] Dynamic subtest client: SUCCESS (1.393s)
[441.338922] Starting dynamic subtest: gem_migrate
[446.176321] Dynamic subtest gem_migrate: SUCCESS (4.843s)
[446.182303] Starting dynamic subtest: reset
[447.662138] Dynamic subtest reset: SUCCESS (1.485s)
[447.667140] Starting dynamic subtest: memory_region
[450.555234] Dynamic subtest memory_region: SUCCESS (2.893s)
[450.561277] Starting dynamic subtest: hangcheck
[498.502428] Dynamic subtest hangcheck: SUCCESS (47.947s)
[498.508847] Starting dynamic subtest: execlists
[499.878331] Dynamic subtest execlists: SUCCESS (1.376s)
[499.884257] Starting dynamic subtest: ring_submission
[501.237449] Dynamic subtest ring_submission: SUCCESS (1.359s)
[501.243942] Starting dynamic subtest: perf
[502.695162] Dynamic subtest perf: SUCCESS (1.457s)
[502.701069] Starting dynamic subtest: slpc
[511.867205] Dynamic subtest slpc: SUCCESS (9.172s)
[511.872773] Starting dynamic subtest: guc
[514.620174] Dynamic subtest guc: SUCCESS (2.752s)
[514.626530] Starting dynamic subtest: guc_multi_lrc
[516.034496] Dynamic subtest guc_multi_lrc: SUCCESS (1.414s)
[516.042849] Starting dynamic subtest: guc_hang
[518.185156] Dynamic subtest guc_hang: SUCCESS (2.150s)
[518.190802] Starting dynamic subtest: late_gt_pm
[519.611313] Dynamic subtest late_gt_pm: SUCCESS (1.426s)
[519.612168] Subtest live: SUCCESS (254.947s)
[520.038704] [165/171] (480s left) dmabuf (all-tests)
[520.102409] Starting subtest: all-tests
[520.103787] Starting dynamic subtest: sanitycheck
[520.179213] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[520.188016] Starting dynamic subtest: dma_fence
[520.359710] Dynamic subtest dma_fence: SUCCESS (0.180s)
[520.371172] Starting dynamic subtest: dma_fence_chain
[531.047510] Dynamic subtest dma_fence_chain: SUCCESS (10.687s)
[531.055306] Starting dynamic subtest: dma_fence_unwrap
[531.112304] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[531.119735] Starting dynamic subtest: dma_resv
[531.185298] Dynamic subtest dma_resv: SUCCESS (0.072s)
[531.187097] Subtest all-tests: SUCCESS (11.082s)
[531.224548] [166/171] (468s left) i915_suspend (basic-s2idle-without-i915)
[531.286549] Starting subtest: basic-s2idle-without-i915
[551.557039] Subtest basic-s2idle-without-i915: SUCCESS (4.599s)
[551.693121] [167/171] (464s left) i915_suspend (basic-s3-without-i915)
[551.745475] Starting subtest: basic-s3-without-i915
[573.196423] Subtest basic-s3-without-i915: SUCCESS (5.525s)
[573.331483] [168/171] (458s left) gem_exec_suspend (basic-s0)
[573.405758] Starting subtest: basic-S0
[573.406647] Starting dynamic subtest: smem
[593.194328] Dynamic subtest smem: SUCCESS (4.566s)
[593.209944] Starting dynamic subtest: lmem0
[612.209808] Dynamic subtest lmem0: SUCCESS (4.435s)
[612.210922] Subtest basic-S0: SUCCESS (9.002s)
[612.416696] [169/171] (449s left) gem_exec_suspend (basic-s3)
[612.483884] Starting subtest: basic-S3
[612.484781] Starting dynamic subtest: smem
[632.553674] Dynamic subtest smem: SUCCESS (5.037s)
[632.573293] Starting dynamic subtest: lmem0
[653.542099] Dynamic subtest lmem0: SUCCESS (4.796s)
[653.543260] Subtest basic-S3: SUCCESS (9.835s)
[653.734857] [170/171] (439s left) kms_chamelium_hpd (common-hpd-after-suspend)
[653.910887] Subtest common-hpd-after-suspend: SKIP (0.000s)
[653.994566] [171/171] (438s left) kms_pipe_crc_basic (suspend-read-crc)
[654.081777] Starting subtest: suspend-read-crc
[654.083919] Starting dynamic subtest: pipe-A-DP-3
[673.154742] Dynamic subtest pipe-A-DP-3: SUCCESS (3.143s)
[673.163023] Starting dynamic subtest: pipe-B-DP-3
[692.150473] Dynamic subtest pipe-B-DP-3: SUCCESS (2.944s)
[692.158757] Starting dynamic subtest: pipe-C-DP-3
[711.209471] Dynamic subtest pipe-C-DP-3: SUCCESS (3.094s)
[711.218511] Starting dynamic subtest: pipe-D-DP-3
[730.307879] Dynamic subtest pipe-D-DP-3: SUCCESS (3.221s)
[730.308815] Subtest suspend-read-crc: SUCCESS (12.408s)
[730.421626] Closing watchdogs
Done.