[39.193123] Initializing watchdogs
[39.193213]   /dev/watchdog0
[39.203915] [001/171] (960s left) i915_module_load (load)
[39.298410] Starting subtest: load
[40.696890] Subtest load: SUCCESS (1.398s)
[40.717511] [002/171] (959s left) core_auth (basic-auth)
[40.883148] Starting subtest: basic-auth
[40.884210] Subtest basic-auth: SUCCESS (0.001s)
[40.953817] [003/171] (958s left) debugfs_test (read_all_entries)
[41.063803] Starting subtest: read_all_entries
[41.581055] Subtest read_all_entries: SUCCESS (0.517s)
[41.701152] [004/171] (958s left) debugfs_test (basic-hwmon)
[41.799271] Starting subtest: basic-hwmon
[41.803342] Subtest basic-hwmon: SUCCESS (0.004s)
[41.936548] [005/171] (957s left) fbdev (eof)
[42.031511] Starting subtest: eof
[42.032674] Subtest eof: SUCCESS (0.000s)
[42.100979] [006/171] (957s left) fbdev (info)
[42.188492] Starting subtest: info
[42.189499] Subtest info: SUCCESS (0.000s)
[42.267293] [007/171] (957s left) fbdev (nullptr)
[42.363569] Starting subtest: nullptr
[42.364539] Subtest nullptr: SUCCESS (0.000s)
[42.433845] [008/171] (957s left) fbdev (read)
[42.530505] Starting subtest: read
[54.928021] Subtest read: SUCCESS (12.363s)
[54.952327] [009/171] (944s left) fbdev (write)
[55.047500] Starting subtest: write
[61.196761] Subtest write: SUCCESS (6.141s)
[61.252249] [010/171] (938s left) gem_basic (bad-close)
[61.339336] Starting subtest: bad-close
[61.341243] Subtest bad-close: SUCCESS (0.000s)
[61.402424] [011/171] (938s left) gem_basic (create-close)
[61.491950] Starting subtest: create-close
[61.494072] Subtest create-close: SUCCESS (0.000s)
[61.573691] [012/171] (938s left) gem_basic (create-fd-close)
[61.676158] Starting subtest: create-fd-close
[61.677976] Subtest create-fd-close: SUCCESS (0.000s)
[61.754721] [013/171] (938s left) gem_busy (busy@all-engines)
[61.863575] Starting subtest: busy
[61.864576] Starting dynamic subtest: all-engines
[62.003610] Dynamic subtest all-engines: SUCCESS (0.140s)
[62.004485] Subtest busy: SUCCESS (0.140s)
[62.480773] [014/171] (937s left) gem_close_race (basic-process)
[62.618763] Starting subtest: basic-process
[62.672538] Subtest basic-process: SUCCESS (0.054s)
[62.913393] [015/171] (937s left) gem_close_race (basic-threads)
[63.040171] Starting subtest: basic-threads
[64.259434] Subtest basic-threads: SUCCESS (1.219s)
[64.530581] [016/171] (935s left) gem_ctx_create (basic)
[64.646714] Starting subtest: basic
[64.647829] Subtest basic: SUCCESS (0.000s)
[64.864082] [017/171] (935s left) gem_ctx_create (basic-files)
[64.981525] Starting subtest: basic-files
[66.996236] Subtest basic-files: SUCCESS (2.015s)
[67.451565] [018/171] (932s left) gem_ctx_exec (basic)
[67.543381] Starting subtest: basic
[67.548389] Subtest basic: SUCCESS (0.005s)
[67.682044] [019/171] (932s left) gem_exec_basic (basic)
[67.790702] Starting subtest: basic
[67.791764] Starting dynamic subtest: rcs0-smem
[67.793985] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[67.800127] Starting dynamic subtest: bcs0-smem
[67.801189] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[67.807465] Starting dynamic subtest: vcs0-smem
[67.808466] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[67.814186] Starting dynamic subtest: vcs1-smem
[67.815200] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[67.820956] Starting dynamic subtest: vecs0-smem
[67.822017] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[67.827816] Starting dynamic subtest: vecs1-smem
[67.828989] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[67.834825] Starting dynamic subtest: ccs0-smem
[67.835966] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[67.841944] Starting dynamic subtest: ccs1-smem
[67.843080] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[67.848914] Starting dynamic subtest: ccs2-smem
[67.850062] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[67.855648] Starting dynamic subtest: ccs3-smem
[67.856549] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[67.862376] Starting dynamic subtest: rcs0-lmem0
[67.863537] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[67.869411] Starting dynamic subtest: bcs0-lmem0
[67.870522] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[67.876385] Starting dynamic subtest: vcs0-lmem0
[67.877523] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[67.883365] Starting dynamic subtest: vcs1-lmem0
[67.884521] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[67.890360] Starting dynamic subtest: vecs0-lmem0
[67.891506] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[67.897367] Starting dynamic subtest: vecs1-lmem0
[67.898526] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[67.904362] Starting dynamic subtest: ccs0-lmem0
[67.905378] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[67.911188] Starting dynamic subtest: ccs1-lmem0
[67.912191] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[67.918134] Starting dynamic subtest: ccs2-lmem0
[67.919012] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[67.924772] Starting dynamic subtest: ccs3-lmem0
[67.925698] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[67.926640] Subtest basic: SUCCESS (0.014s)
[67.990475] [020/171] (932s left) gem_exec_create (basic)
[68.099077] Starting subtest: basic
[68.100044] Starting dynamic subtest: smem
[70.217245] Dynamic subtest smem: SUCCESS (2.118s)
[70.223716] Starting dynamic subtest: lmem0
[72.340985] Dynamic subtest lmem0: SUCCESS (2.123s)
[72.342173] Subtest basic: SUCCESS (4.242s)
[72.550084] [021/171] (927s left) gem_exec_fence (basic-busy)
[72.839574] Starting subtest: basic-busy
[72.840996] Starting dynamic subtest: rcs0
[72.928583] Dynamic subtest rcs0: SUCCESS (0.098s)
[72.936506] Starting dynamic subtest: bcs0
[72.984618] Dynamic subtest bcs0: SUCCESS (0.054s)
[73.010718] Starting dynamic subtest: vcs0
[73.042623] Dynamic subtest vcs0: SUCCESS (0.057s)
[73.069230] Starting dynamic subtest: vcs1
[73.104568] Dynamic subtest vcs1: SUCCESS (0.061s)
[73.130581] Starting dynamic subtest: vecs0
[73.167778] Dynamic subtest vecs0: SUCCESS (0.063s)
[73.189246] Starting dynamic subtest: vecs1
[73.227578] Dynamic subtest vecs1: SUCCESS (0.059s)
[73.253161] Starting dynamic subtest: ccs0
[73.287810] Dynamic subtest ccs0: SUCCESS (0.060s)
[73.303628] Starting dynamic subtest: ccs1
[73.341041] Dynamic subtest ccs1: SUCCESS (0.053s)
[73.355348] Starting dynamic subtest: ccs2
[73.396630] Dynamic subtest ccs2: SUCCESS (0.054s)
[73.422691] Starting dynamic subtest: ccs3
[73.460388] Dynamic subtest ccs3: SUCCESS (0.063s)
[73.462825] Subtest basic-busy: SUCCESS (0.629s)
[74.738548] [022/171] (925s left) gem_exec_fence (basic-wait)
[74.973132] Starting subtest: basic-wait
[74.974257] Starting dynamic subtest: rcs0
[75.045486] Dynamic subtest rcs0: SUCCESS (0.081s)
[75.054067] Starting dynamic subtest: bcs0
[75.101596] Dynamic subtest bcs0: SUCCESS (0.054s)
[75.128273] Starting dynamic subtest: vcs0
[75.168299] Dynamic subtest vcs0: SUCCESS (0.066s)
[75.196165] Starting dynamic subtest: vcs1
[75.224933] Dynamic subtest vcs1: SUCCESS (0.055s)
[75.243945] Starting dynamic subtest: vecs0
[75.279545] Dynamic subtest vecs0: SUCCESS (0.055s)
[75.305363] Starting dynamic subtest: vecs1
[75.339839] Dynamic subtest vecs1: SUCCESS (0.060s)
[75.356710] Starting dynamic subtest: ccs0
[75.400459] Dynamic subtest ccs0: SUCCESS (0.060s)
[75.426082] Starting dynamic subtest: ccs1
[75.461573] Dynamic subtest ccs1: SUCCESS (0.061s)
[75.483670] Starting dynamic subtest: ccs2
[75.518399] Dynamic subtest ccs2: SUCCESS (0.056s)
[75.545487] Starting dynamic subtest: ccs3
[75.578587] Dynamic subtest ccs3: SUCCESS (0.059s)
[75.581076] Subtest basic-wait: SUCCESS (0.613s)
[76.874440] [023/171] (923s left) gem_exec_fence (basic-await)
[77.151314] Starting subtest: basic-await
[77.152587] Starting dynamic subtest: rcs0
[77.291801] Dynamic subtest rcs0: SUCCESS (0.149s)
[77.299261] Starting dynamic subtest: bcs0
[77.409220] Dynamic subtest bcs0: SUCCESS (0.117s)
[77.415706] Starting dynamic subtest: vcs0
[77.524683] Dynamic subtest vcs0: SUCCESS (0.115s)
[77.530618] Starting dynamic subtest: vcs1
[77.639428] Dynamic subtest vcs1: SUCCESS (0.115s)
[77.645387] Starting dynamic subtest: vecs0
[77.754042] Dynamic subtest vecs0: SUCCESS (0.114s)
[77.760210] Starting dynamic subtest: vecs1
[77.866592] Dynamic subtest vecs1: SUCCESS (0.112s)
[77.872814] Starting dynamic subtest: ccs0
[77.980704] Dynamic subtest ccs0: SUCCESS (0.114s)
[77.986805] Starting dynamic subtest: ccs1
[78.094631] Dynamic subtest ccs1: SUCCESS (0.114s)
[78.101684] Starting dynamic subtest: ccs2
[78.212616] Dynamic subtest ccs2: SUCCESS (0.118s)
[78.219146] Starting dynamic subtest: ccs3
[78.327147] Dynamic subtest ccs3: SUCCESS (0.114s)
[78.328112] Subtest basic-await: SUCCESS (1.185s)
[79.653189] [024/171] (920s left) gem_exec_fence (nb-await)
[79.929275] Starting subtest: nb-await
[79.930366] Starting dynamic subtest: rcs0
[80.025191] Dynamic subtest rcs0: SUCCESS (0.104s)
[80.033984] Starting dynamic subtest: bcs0
[80.105592] Dynamic subtest bcs0: SUCCESS (0.079s)
[80.111934] Starting dynamic subtest: vcs0
[80.173032] Dynamic subtest vcs0: SUCCESS (0.068s)
[80.187086] Starting dynamic subtest: vcs1
[80.267530] Dynamic subtest vcs1: SUCCESS (0.093s)
[80.274343] Starting dynamic subtest: vecs0
[80.335652] Dynamic subtest vecs0: SUCCESS (0.068s)
[80.350945] Starting dynamic subtest: vecs1
[80.425484] Dynamic subtest vecs1: SUCCESS (0.088s)
[80.452715] Starting dynamic subtest: ccs0
[80.525443] Dynamic subtest ccs0: SUCCESS (0.100s)
[80.541118] Starting dynamic subtest: ccs1
[80.615326] Dynamic subtest ccs1: SUCCESS (0.089s)
[80.641577] Starting dynamic subtest: ccs2
[80.717750] Dynamic subtest ccs2: SUCCESS (0.103s)
[80.729408] Starting dynamic subtest: ccs3
[80.802300] Dynamic subtest ccs3: SUCCESS (0.083s)
[80.803521] Subtest nb-await: SUCCESS (0.881s)
[82.141625] [025/171] (917s left) gem_exec_gttfill (basic)
[82.252168] Starting subtest: basic
[89.500184] Subtest basic: SUCCESS (7.240s)
[89.719185] [026/171] (910s left) gem_exec_parallel (engines)
[89.879054] Starting subtest: engines
[89.880052] Starting dynamic subtest: basic
[91.855559] Dynamic subtest basic: SUCCESS (1.975s)
[91.880261] Starting dynamic subtest: contexts
[95.053175] Dynamic subtest contexts: SUCCESS (3.189s)
[95.060015] Starting dynamic subtest: fds
[98.653062] Dynamic subtest fds: SUCCESS (3.600s)
[98.659875] Starting dynamic subtest: userptr
[100.352433] Dynamic subtest userptr: SUCCESS (1.708s)
[100.353540] Subtest engines: SUCCESS (10.474s)
[100.638677] [027/171] (899s left) gem_exec_store (basic)
[100.746540] Starting subtest: basic
[100.881639] Subtest basic: SUCCESS (0.135s)
[101.150895] [028/171] (899s left) gem_flink_basic (bad-flink)
[101.243500] Starting subtest: bad-flink
[101.244543] Subtest bad-flink: SUCCESS (0.000s)
[101.308350] [029/171] (898s left) gem_flink_basic (bad-open)
[101.406145] Starting subtest: bad-open
[101.407167] Subtest bad-open: SUCCESS (0.000s)
[101.471665] [030/171] (898s left) gem_flink_basic (basic)
[101.566548] Starting subtest: basic
[101.567595] Subtest basic: SUCCESS (0.000s)
[101.667185] [031/171] (898s left) gem_flink_basic (double-flink)
[101.781442] Starting subtest: double-flink
[101.782465] Subtest double-flink: SUCCESS (0.000s)
[101.893441] [032/171] (898s left) gem_flink_basic (flink-lifetime)
[101.984111] Starting subtest: flink-lifetime
[101.985203] Subtest flink-lifetime: SUCCESS (0.002s)
[102.081344] [033/171] (898s left) gem_huc_copy (huc-copy)
[102.210270] Starting subtest: huc-copy
[102.217430] Subtest huc-copy: SUCCESS (0.007s)
[102.356626] [034/171] (897s left) gem_linear_blits (basic)
[102.585825] Starting subtest: basic
[102.624351] Subtest basic: SUCCESS (0.039s)
[102.746320] [035/171] (897s left) gem_mmap (basic)
[102.890204] Subtest basic: SKIP (0.000s)
[102.924143] [036/171] (897s left) gem_mmap_gtt (basic)
[103.019472] Subtest basic: SKIP (0.000s)
[103.056769] [037/171] (897s left) gem_render_linear_blits (basic)
[103.156880] Starting subtest: basic
[103.240545] Subtest basic: SUCCESS (0.084s)
[103.307169] [038/171] (897s left) gem_render_tiled_blits (basic)
[103.406199] Subtest basic: SKIP (0.000s)
[103.440494] [039/171] (896s left) gem_ringfill (basic-all)
[103.906489] Starting subtest: basic-all
[107.937633] Subtest basic-all: SUCCESS (3.996s)
[108.048974] [040/171] (892s left) gem_softpin (allocator-basic)
[108.154271] Starting subtest: allocator-basic
[108.423201] Subtest allocator-basic: SUCCESS (0.260s)
[108.549072] [041/171] (891s left) gem_softpin (allocator-basic-reserve)
[108.676108] Starting subtest: allocator-basic-reserve
[108.949677] Subtest allocator-basic-reserve: SUCCESS (0.265s)
[109.073219] [042/171] (891s left) gem_softpin (safe-alignment)
[109.174226] Starting subtest: safe-alignment
[109.249535] Subtest safe-alignment: SUCCESS (0.075s)
[109.384502] [043/171] (891s left) gem_sync (basic-all)
[109.509353] Starting subtest: basic-all
[113.112398] Subtest basic-all: SUCCESS (3.603s)
[113.306661] [044/171] (887s left) gem_sync (basic-each)
[113.420977] Starting subtest: basic-each
[115.952440] Subtest basic-each: SUCCESS (2.531s)
[116.172397] [045/171] (884s left) gem_tiled_blits (basic)
[116.274351] Subtest basic: SKIP (0.000s)
[116.307842] [046/171] (884s left) gem_tiled_fence_blits (basic)
[116.410367] Subtest basic: SKIP (0.000s)
[116.441186] [047/171] (884s left) gem_tiled_pread_basic
[116.557691] [048/171] (884s left) gem_wait (busy@all-engines)
[116.667379] Starting subtest: busy
[116.668474] Starting dynamic subtest: all-engines
[117.244612] Dynamic subtest all-engines: SUCCESS (0.577s)
[117.245724] Subtest busy: SUCCESS (0.577s)
[117.486404] [049/171] (883s left) gem_wait (wait@all-engines)
[117.597080] Starting subtest: wait
[117.598203] Starting dynamic subtest: all-engines
[118.708667] Dynamic subtest all-engines: SUCCESS (1.111s)
[118.710144] Subtest wait: SUCCESS (1.112s)
[118.985976] [050/171] (881s left) i915_getparams_basic (basic-eu-total)
[119.078015] Starting subtest: basic-eu-total
[119.079786] Subtest basic-eu-total: SUCCESS (0.000s)
[119.140989] [051/171] (881s left) i915_getparams_basic (basic-subslice-total)
[119.234947] Starting subtest: basic-subslice-total
[119.236890] Subtest basic-subslice-total: SUCCESS (0.000s)
[119.305986] [052/171] (881s left) i915_hangman (error-state-basic)
[119.425580] Starting subtest: error-state-basic
[119.640118] Subtest error-state-basic: SUCCESS (0.214s)
[119.712715] [053/171] (880s left) i915_pciid
[119.887327] [054/171] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[120.003854] Starting subtest: addfb25-bad-modifier
[120.004889] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[120.155710] [055/171] (880s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[120.251407] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[120.405573] [056/171] (880s left) kms_addfb_basic (addfb25-modifier-no-flag)
[120.499745] Starting subtest: addfb25-modifier-no-flag
[120.500798] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[120.639042] [057/171] (880s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[120.732679] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[120.872119] [058/171] (879s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[120.965440] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[121.108628] [059/171] (879s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[121.264515] Starting subtest: addfb25-yf-tiled-legacy
[121.265490] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[121.355563] [060/171] (879s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[121.510552] Starting subtest: addfb25-y-tiled-legacy
[121.511526] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[121.588978] [061/171] (879s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[121.745540] Starting subtest: addfb25-y-tiled-small-legacy
[121.747532] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[121.839404] [062/171] (878s left) kms_addfb_basic (bad-pitch-0)
[121.935014] Starting subtest: bad-pitch-0
[121.936075] Subtest bad-pitch-0: SUCCESS (0.000s)
[122.089237] [063/171] (878s left) kms_addfb_basic (bad-pitch-1024)
[122.181951] Starting subtest: bad-pitch-1024
[122.183017] Subtest bad-pitch-1024: SUCCESS (0.000s)
[122.339595] [064/171] (878s left) kms_addfb_basic (bad-pitch-128)
[122.433793] Starting subtest: bad-pitch-128
[122.434776] Subtest bad-pitch-128: SUCCESS (0.000s)
[122.589059] [065/171] (878s left) kms_addfb_basic (bad-pitch-256)
[122.683457] Starting subtest: bad-pitch-256
[122.684504] Subtest bad-pitch-256: SUCCESS (0.000s)
[122.822452] [066/171] (878s left) kms_addfb_basic (bad-pitch-32)
[122.916178] Starting subtest: bad-pitch-32
[122.917225] Subtest bad-pitch-32: SUCCESS (0.000s)
[123.055744] [067/171] (877s left) kms_addfb_basic (bad-pitch-63)
[123.148452] Starting subtest: bad-pitch-63
[123.149505] Subtest bad-pitch-63: SUCCESS (0.000s)
[123.305619] [068/171] (877s left) kms_addfb_basic (bad-pitch-65536)
[123.398191] Starting subtest: bad-pitch-65536
[123.399252] Subtest bad-pitch-65536: SUCCESS (0.000s)
[123.539307] [069/171] (877s left) kms_addfb_basic (bad-pitch-999)
[123.632557] Starting subtest: bad-pitch-999
[123.633617] Subtest bad-pitch-999: SUCCESS (0.000s)
[123.772452] [070/171] (877s left) kms_addfb_basic (basic)
[123.865470] Starting subtest: basic
[123.866519] Subtest basic: SUCCESS (0.000s)
[124.022529] [071/171] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[124.117845] Starting subtest: basic-x-tiled-legacy
[124.119666] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[124.272503] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[124.365566] Starting subtest: basic-y-tiled-legacy
[124.367505] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[124.522820] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[124.678022] Starting subtest: bo-too-small
[124.678931] Subtest bo-too-small: SUCCESS (0.000s)
[124.755632] [074/171] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[124.910813] Starting subtest: bo-too-small-due-to-tiling
[124.912730] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[125.005800] [075/171] (876s left) kms_addfb_basic (clobberred-modifier)
[125.098921] Starting subtest: clobberred-modifier
[125.100706] Subtest clobberred-modifier: SKIP (0.000s)
[125.255861] [076/171] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[125.354140] Starting subtest: framebuffer-vs-set-tiling
[125.356036] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[125.489506] [077/171] (875s left) kms_addfb_basic (invalid-get-prop)
[125.582729] Starting subtest: invalid-get-prop
[125.583777] Subtest invalid-get-prop: SUCCESS (0.000s)
[125.722577] [078/171] (875s left) kms_addfb_basic (invalid-get-prop-any)
[125.818405] Starting subtest: invalid-get-prop-any
[125.819439] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[125.972535] [079/171] (875s left) kms_addfb_basic (invalid-set-prop)
[126.065372] Starting subtest: invalid-set-prop
[126.066419] Subtest invalid-set-prop: SUCCESS (0.000s)
[126.224964] [080/171] (874s left) kms_addfb_basic (invalid-set-prop-any)
[126.320557] Starting subtest: invalid-set-prop-any
[126.321492] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[126.472505] [081/171] (874s left) kms_addfb_basic (no-handle)
[126.564110] Starting subtest: no-handle
[126.565052] Subtest no-handle: SUCCESS (0.000s)
[126.722700] [082/171] (874s left) kms_addfb_basic (size-max)
[126.880634] Starting subtest: size-max
[126.881580] Subtest size-max: SUCCESS (0.000s)
[126.972294] [083/171] (874s left) kms_addfb_basic (small-bo)
[127.128080] Starting subtest: small-bo
[127.129136] Subtest small-bo: SUCCESS (0.000s)
[127.205809] [084/171] (873s left) kms_addfb_basic (tile-pitch-mismatch)
[127.300171] Starting subtest: tile-pitch-mismatch
[127.301967] Subtest tile-pitch-mismatch: SKIP (0.000s)
[127.455796] [085/171] (873s left) kms_addfb_basic (too-high)
[127.614776] Starting subtest: too-high
[127.615819] Subtest too-high: SUCCESS (0.001s)
[127.689490] [086/171] (873s left) kms_addfb_basic (too-wide)
[127.845875] Starting subtest: too-wide
[127.846880] Subtest too-wide: SUCCESS (0.000s)
[127.939169] [087/171] (873s left) kms_addfb_basic (unused-handle)
[128.031861] Starting subtest: unused-handle
[128.032784] Subtest unused-handle: SUCCESS (0.000s)
[128.172680] [088/171] (873s left) kms_addfb_basic (unused-modifier)
[128.266070] Starting subtest: unused-modifier
[128.266996] Subtest unused-modifier: SUCCESS (0.000s)
[128.422627] [089/171] (872s left) kms_addfb_basic (unused-offsets)
[128.515312] Starting subtest: unused-offsets
[128.516222] Subtest unused-offsets: SUCCESS (0.000s)
[128.655562] [090/171] (872s left) kms_addfb_basic (unused-pitches)
[128.748319] Starting subtest: unused-pitches
[128.749379] Subtest unused-pitches: SUCCESS (0.000s)
[128.905866] [091/171] (872s left) kms_busy (basic)
[129.069175] Starting subtest: basic
[129.070380] Starting dynamic subtest: flip
[129.875046] Dynamic subtest flip: SUCCESS (0.805s)
[129.882737] Starting dynamic subtest: modeset
[130.850168] Dynamic subtest modeset: SUCCESS (0.976s)
[130.851200] Subtest basic: SUCCESS (1.782s)
[131.084370] [092/171] (870s left) kms_chamelium_hpd (dp-hpd-fast)
[131.318473] Subtest dp-hpd-fast: SKIP (0.000s)
[131.454643] [093/171] (869s left) kms_chamelium_edid (dp-edid-read)
[131.684513] Subtest dp-edid-read: SKIP (0.000s)
[131.820604] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast)
[132.051325] Subtest dp-crc-fast: SKIP (0.000s)
[132.187545] [095/171] (869s left) kms_chamelium_hpd (hdmi-hpd-fast)
[132.418299] Subtest hdmi-hpd-fast: SKIP (0.000s)
[132.553886] [096/171] (868s left) kms_chamelium_edid (hdmi-edid-read)
[132.784082] Subtest hdmi-edid-read: SKIP (0.000s)
[132.920630] [097/171] (868s left) kms_chamelium_frames (hdmi-crc-fast)
[133.150634] Subtest hdmi-crc-fast: SKIP (0.000s)
[133.288780] [098/171] (868s left) kms_chamelium_hpd (vga-hpd-fast)
[133.519602] Subtest vga-hpd-fast: SKIP (0.000s)
[133.655533] [099/171] (867s left) kms_chamelium_edid (vga-edid-read)
[133.886585] Subtest vga-edid-read: SKIP (0.000s)
[134.022509] [100/171] (867s left) kms_prop_blob (basic)
[134.116067] Starting subtest: basic
[134.117154] Subtest basic: SUCCESS (0.000s)
[134.183559] [101/171] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[134.340101] Starting subtest: basic-busy-flip-before-cursor-atomic
[134.342138] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[134.400620] [102/171] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[134.555073] Starting subtest: basic-busy-flip-before-cursor-legacy
[134.557073] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[134.616982] [103/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[134.774224] Starting subtest: basic-flip-after-cursor-atomic
[135.838439] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.061s)
[136.041342] [104/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[136.196881] Starting subtest: basic-flip-after-cursor-legacy
[137.259960] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.062s)
[137.462293] [105/171] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[137.617155] Starting subtest: basic-flip-after-cursor-varying-size
[138.695825] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.080s)
[138.916554] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[139.076136] Starting subtest: basic-flip-before-cursor-atomic
[140.149917] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.074s)
[140.366757] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[140.523511] Starting subtest: basic-flip-before-cursor-legacy
[141.599639] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.075s)
[141.817569] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[141.973814] Starting subtest: basic-flip-before-cursor-varying-size
[143.051646] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.078s)
[143.273288] [109/171] (858s left) kms_flip (basic-flip-vs-dpms)
[143.414739] Starting subtest: basic-flip-vs-dpms
[143.419862] Starting dynamic subtest: A-DP1
[144.502096] Dynamic subtest A-DP1: SUCCESS (1.081s)
[144.509795] Starting dynamic subtest: B-DP1
[145.402880] Dynamic subtest B-DP1: SUCCESS (0.899s)
[145.410901] Starting dynamic subtest: C-DP1
[146.305468] Dynamic subtest C-DP1: SUCCESS (0.903s)
[146.314726] Starting dynamic subtest: D-DP1
[147.220605] Dynamic subtest D-DP1: SUCCESS (0.914s)
[147.225736] Subtest basic-flip-vs-dpms: SUCCESS (3.812s)
[147.454577] [110/171] (854s left) kms_flip (basic-flip-vs-modeset)
[147.596135] Starting subtest: basic-flip-vs-modeset
[147.600666] Starting dynamic subtest: A-DP1
[148.493133] Dynamic subtest A-DP1: SUCCESS (0.892s)
[148.501051] Starting dynamic subtest: B-DP1
[149.407278] Dynamic subtest B-DP1: SUCCESS (0.913s)
[149.415446] Starting dynamic subtest: C-DP1
[150.323481] Dynamic subtest C-DP1: SUCCESS (0.915s)
[150.331399] Starting dynamic subtest: D-DP1
[151.231144] Dynamic subtest D-DP1: SUCCESS (0.907s)
[151.236133] Subtest basic-flip-vs-modeset: SUCCESS (3.642s)
[151.446718] [111/171] (850s left) kms_flip (basic-flip-vs-wf_vblank)
[151.588886] Starting subtest: basic-flip-vs-wf_vblank
[151.593802] Starting dynamic subtest: A-DP1
[152.810795] Dynamic subtest A-DP1: SUCCESS (1.217s)
[152.822864] Starting dynamic subtest: B-DP1
[153.932063] Dynamic subtest B-DP1: SUCCESS (1.120s)
[153.941690] Starting dynamic subtest: C-DP1
[155.054064] Dynamic subtest C-DP1: SUCCESS (1.121s)
[155.063728] Starting dynamic subtest: D-DP1
[156.174216] Dynamic subtest D-DP1: SUCCESS (1.119s)
[156.179694] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.593s)
[156.478578] [112/171] (845s left) kms_flip (basic-plain-flip)
[156.616555] Starting subtest: basic-plain-flip
[156.622889] Starting dynamic subtest: A-DP1
[157.560497] Dynamic subtest A-DP1: SUCCESS (0.938s)
[157.570523] Starting dynamic subtest: B-DP1
[158.399855] Dynamic subtest B-DP1: SUCCESS (0.838s)
[158.409725] Starting dynamic subtest: C-DP1
[159.236184] Dynamic subtest C-DP1: SUCCESS (0.835s)
[159.245816] Starting dynamic subtest: D-DP1
[160.073754] Dynamic subtest D-DP1: SUCCESS (0.836s)
[160.079289] Subtest basic-plain-flip: SUCCESS (3.463s)
[160.344874] [113/171] (841s left) kms_force_connector_basic (force-connector-state)
[160.443688] Starting subtest: force-connector-state
[161.013355] Subtest force-connector-state: SUCCESS (0.570s)
[161.281164] [114/171] (840s left) kms_force_connector_basic (force-edid)
[161.380523] Starting subtest: force-edid
[161.394500] Subtest force-edid: SUCCESS (0.014s)
[161.564249] [115/171] (840s left) kms_force_connector_basic (force-load-detect)
[161.662491] Starting subtest: force-load-detect
[161.664317] Subtest force-load-detect: SKIP (0.000s)
[161.780953] [116/171] (839s left) kms_force_connector_basic (prune-stale-modes)
[161.879054] Starting subtest: prune-stale-modes
[161.888362] Subtest prune-stale-modes: SKIP (0.009s)
[162.064178] [117/171] (839s left) kms_frontbuffer_tracking (basic)
[162.228166] Starting subtest: basic
[166.191170] Subtest basic: SUCCESS (3.965s)
[166.334815] [118/171] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[166.496011] Starting subtest: compare-crc-sanitycheck-xr24
[166.497041] Starting dynamic subtest: pipe-A-DP-1
[167.081315] Dynamic subtest pipe-A-DP-1: SUCCESS (0.584s)
[167.090879] Starting dynamic subtest: pipe-B-DP-1
[167.650993] Dynamic subtest pipe-B-DP-1: SUCCESS (0.566s)
[167.661102] Starting dynamic subtest: pipe-C-DP-1
[168.282902] Dynamic subtest pipe-C-DP-1: SUCCESS (0.629s)
[168.292820] Starting dynamic subtest: pipe-D-DP-1
[168.985427] Dynamic subtest pipe-D-DP-1: SUCCESS (0.700s)
[168.986358] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.491s)
[169.182356] [119/171] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[169.338557] Starting subtest: compare-crc-sanitycheck-nv12
[169.341351] Starting dynamic subtest: pipe-A-DP-1
[170.609441] Dynamic subtest pipe-A-DP-1: SUCCESS (1.259s)
[170.617921] Starting dynamic subtest: pipe-B-DP-1
[171.750768] Dynamic subtest pipe-B-DP-1: SUCCESS (1.148s)
[171.760539] Starting dynamic subtest: pipe-C-DP-1
[173.068611] Dynamic subtest pipe-C-DP-1: SUCCESS (1.315s)
[173.078545] Starting dynamic subtest: pipe-D-DP-1
[174.363242] Dynamic subtest pipe-D-DP-1: SUCCESS (1.292s)
[174.364265] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.025s)
[174.565356] [120/171] (827s left) kms_pipe_crc_basic (hang-read-crc)
[174.721626] Starting subtest: hang-read-crc
[174.724446] Starting dynamic subtest: pipe-A-DP-1
[176.227186] Dynamic subtest pipe-A-DP-1: SUCCESS (1.503s)
[176.236592] Starting dynamic subtest: pipe-B-DP-1
[177.790423] Dynamic subtest pipe-B-DP-1: SUCCESS (1.561s)
[177.800180] Starting dynamic subtest: pipe-C-DP-1
[179.484900] Dynamic subtest pipe-C-DP-1: SUCCESS (1.691s)
[179.494523] Starting dynamic subtest: pipe-D-DP-1
[181.304144] Dynamic subtest pipe-D-DP-1: SUCCESS (1.817s)
[181.305206] Subtest hang-read-crc: SUCCESS (6.583s)
[181.502905] [121/171] (820s left) kms_pipe_crc_basic (nonblocking-crc)
[181.663793] Starting subtest: nonblocking-crc
[181.666530] Starting dynamic subtest: pipe-A-DP-1
[182.352455] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s)
[182.362244] Starting dynamic subtest: pipe-B-DP-1
[183.116785] Dynamic subtest pipe-B-DP-1: SUCCESS (0.761s)
[183.126869] Starting dynamic subtest: pipe-C-DP-1
[183.945835] Dynamic subtest pipe-C-DP-1: FAIL (0.760s)
[183.953827] Starting dynamic subtest: pipe-D-DP-1
[184.739986] Dynamic subtest pipe-D-DP-1: SUCCESS (0.858s)
[184.740989] Subtest nonblocking-crc: FAIL (3.077s)
[184.949399] [122/171] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[185.105046] Starting subtest: nonblocking-crc-frame-sequence
[185.107609] Starting dynamic subtest: pipe-A-DP-1
[185.815657] Dynamic subtest pipe-A-DP-1: SUCCESS (0.708s)
[185.825403] Starting dynamic subtest: pipe-B-DP-1
[186.540390] Dynamic subtest pipe-B-DP-1: SUCCESS (0.720s)
[186.552130] Starting dynamic subtest: pipe-C-DP-1
[187.451552] Dynamic subtest pipe-C-DP-1: FAIL (0.819s)
[187.459513] Starting dynamic subtest: pipe-D-DP-1
[188.209282] Dynamic subtest pipe-D-DP-1: SUCCESS (0.847s)
[188.210357] Subtest nonblocking-crc-frame-sequence: FAIL (3.105s)
[188.415098] [123/171] (813s left) kms_pipe_crc_basic (read-crc)
[188.580560] Starting subtest: read-crc
[188.581545] Starting dynamic subtest: pipe-A-DP-1
[189.247175] Dynamic subtest pipe-A-DP-1: SUCCESS (0.665s)
[189.256793] Starting dynamic subtest: pipe-B-DP-1
[189.903604] Dynamic subtest pipe-B-DP-1: SUCCESS (0.654s)
[189.913312] Starting dynamic subtest: pipe-C-DP-1
[190.625575] Dynamic subtest pipe-C-DP-1: SUCCESS (0.719s)
[190.635516] Starting dynamic subtest: pipe-D-DP-1
[191.407731] Dynamic subtest pipe-D-DP-1: SUCCESS (0.780s)
[191.408894] Subtest read-crc: SUCCESS (2.829s)
[191.606021] [124/171] (810s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[191.762115] Starting subtest: read-crc-frame-sequence
[191.765018] Starting dynamic subtest: pipe-A-DP-1
[192.406516] Dynamic subtest pipe-A-DP-1: SUCCESS (0.642s)
[192.416501] Starting dynamic subtest: pipe-B-DP-1
[193.060717] Dynamic subtest pipe-B-DP-1: SUCCESS (0.651s)
[193.071056] Starting dynamic subtest: pipe-C-DP-1
[193.778633] Dynamic subtest pipe-C-DP-1: SUCCESS (0.715s)
[193.788394] Starting dynamic subtest: pipe-D-DP-1
[194.579615] Dynamic subtest pipe-D-DP-1: SUCCESS (0.798s)
[194.580703] Subtest read-crc-frame-sequence: SUCCESS (2.817s)
[194.787328] [125/171] (807s left) kms_psr (primary_page_flip)
[194.883666] Subtest primary_page_flip: SKIP (0.000s)
[194.924027] [126/171] (807s left) kms_psr (cursor_plane_move)
[195.019348] Subtest cursor_plane_move: SKIP (0.000s)
[195.057226] [127/171] (806s left) kms_psr (sprite_plane_onoff)
[195.151843] Subtest sprite_plane_onoff: SKIP (0.000s)
[195.190653] [128/171] (806s left) kms_psr (primary_mmap_gtt)
[195.285415] Subtest primary_mmap_gtt: SKIP (0.000s)
[195.323747] [129/171] (806s left) kms_setmode (basic-clone-single-crtc)
[195.418354] Starting subtest: basic-clone-single-crtc
[195.421443] Subtest basic-clone-single-crtc: SKIP (0.001s)
[195.487841] [130/171] (806s left) i915_pm_backlight (basic-brightness)
[195.643748] Subtest basic-brightness: SKIP (0.000s)
[195.673890] [131/171] (806s left) i915_pm_rpm (basic-pci-d3-state)
[197.564123] Starting subtest: basic-pci-d3-state
[198.562515] Subtest basic-pci-d3-state: SUCCESS (0.999s)
[198.719468] [132/171] (803s left) i915_pm_rpm (basic-rte)
[198.810750] Starting subtest: basic-rte
[201.174169] Subtest basic-rte: SUCCESS (2.362s)
[202.508211] [133/171] (799s left) i915_pm_rps (basic-api)
[202.611162] Starting subtest: basic-api
[202.613195] Subtest basic-api: SKIP (0.000s)
[202.690220] [134/171] (799s left) prime_self_import (basic-llseek-bad)
[202.782100] Starting subtest: basic-llseek-bad
[202.786179] Subtest basic-llseek-bad: SUCCESS (0.003s)
[202.888454] [135/171] (799s left) prime_self_import (basic-llseek-size)
[202.985083] Starting subtest: basic-llseek-size
[202.988631] Subtest basic-llseek-size: SUCCESS (0.003s)
[203.090880] [136/171] (799s left) prime_self_import (basic-with_fd_dup)
[203.180161] Starting subtest: basic-with_fd_dup
[203.184117] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[203.288181] [137/171] (798s left) prime_self_import (basic-with_one_bo)
[203.384893] Starting subtest: basic-with_one_bo
[203.389398] Subtest basic-with_one_bo: SUCCESS (0.004s)
[203.443260] [138/171] (798s left) prime_self_import (basic-with_one_bo_two_files)
[203.535152] Starting subtest: basic-with_one_bo_two_files
[203.538530] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[203.652093] [139/171] (798s left) prime_self_import (basic-with_two_bos)
[203.751183] Starting subtest: basic-with_two_bos
[203.756167] Subtest basic-with_two_bos: SUCCESS (0.005s)
[203.848580] [140/171] (798s left) prime_vgem (basic-fence-flip)
[203.975989] Starting subtest: basic-fence-flip
[204.088666] Subtest basic-fence-flip: SKIP (0.112s)
[204.193792] [141/171] (798s left) prime_vgem (basic-fence-mmap)
[204.309418] Starting subtest: basic-fence-mmap
[204.311539] Subtest basic-fence-mmap: SKIP (0.000s)
[204.439700] [142/171] (797s left) prime_vgem (basic-fence-read)
[204.575960] Starting subtest: basic-fence-read
[204.582510] Subtest basic-fence-read: SKIP (0.006s)
[204.688888] [143/171] (797s left) prime_vgem (basic-gtt)
[204.823814] Starting subtest: basic-gtt
[204.826098] Subtest basic-gtt: SKIP (0.000s)
[204.937498] [144/171] (797s left) prime_vgem (basic-read)
[205.076053] Starting subtest: basic-read
[205.083197] Subtest basic-read: SKIP (0.006s)
[205.220474] [145/171] (797s left) prime_vgem (basic-write)
[205.325984] Starting subtest: basic-write
[205.332576] Subtest basic-write: SKIP (0.006s)
[205.467597] [146/171] (796s left) vgem_basic (setversion)
[205.600296] Starting subtest: setversion
[205.602519] Subtest setversion: SUCCESS (0.000s)
[205.661727] [147/171] (796s left) vgem_basic (create)
[205.766718] Starting subtest: create
[205.767738] Subtest create: SUCCESS (0.000s)
[205.826255] [148/171] (796s left) vgem_basic (debugfs)
[205.933437] Starting subtest: debugfs
[205.934475] Subtest debugfs: SUCCESS (0.000s)
[205.995762] [149/171] (796s left) vgem_basic (dmabuf-export)
[206.116714] Starting subtest: dmabuf-export
[206.131052] Subtest dmabuf-export: SUCCESS (0.013s)
[206.235241] [150/171] (796s left) vgem_basic (dmabuf-fence)
[206.366863] Starting subtest: dmabuf-fence
[206.368049] Subtest dmabuf-fence: SUCCESS (0.000s)
[206.424562] [151/171] (796s left) vgem_basic (dmabuf-fence-before)
[206.533441] Starting subtest: dmabuf-fence-before
[206.534494] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[206.597284] [152/171] (795s left) vgem_basic (dmabuf-mmap)
[206.700142] Starting subtest: dmabuf-mmap
[206.712704] Subtest dmabuf-mmap: SUCCESS (0.013s)
[206.776273] [153/171] (795s left) vgem_basic (mmap)
[206.883533] Starting subtest: mmap
[206.891853] Subtest mmap: SUCCESS (0.009s)
[206.939853] [154/171] (795s left) vgem_basic (second-client)
[207.050142] Starting subtest: second-client
[207.083483] Subtest second-client: SUCCESS (0.033s)
[207.164779] [155/171] (795s left) vgem_basic (sysfs)
[207.300236] Starting subtest: sysfs
[207.301314] Subtest sysfs: SUCCESS (0.000s)
[207.363393] [156/171] (795s left) core_hotunplug (unbind-rebind)
[207.499678] Starting subtest: unbind-rebind
[210.313307] Subtest unbind-rebind: SUCCESS (2.814s)
[210.335540] [157/171] (792s left) vgem_basic (unload)
[210.432507] Starting subtest: unload
[239.435548] Subtest unload: SUCCESS (28.968s)
[239.505609] [158/171] (763s left) i915_module_load (reload)
[239.598062] Starting subtest: reload
[243.440171] Subtest reload: SUCCESS (3.842s)
[243.461314] [159/171] (759s left) gem_lmem_swapping (basic)
[247.402443] Starting subtest: basic
[247.403348] Starting dynamic subtest: lmem0
[275.627252] Dynamic subtest lmem0: SUCCESS (28.215s)
[275.628218] Subtest basic: SUCCESS (28.217s)
[278.818563] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines)
[279.799552] Starting subtest: parallel-random-engines
[279.800562] Starting dynamic subtest: lmem0
[281.270080] Dynamic subtest lmem0: SUCCESS (1.461s)
[281.271036] Subtest parallel-random-engines: SUCCESS (1.463s)
[282.878359] [161/171] (719s left) gem_lmem_swapping (random-engines)
[283.908647] Starting subtest: random-engines
[283.909634] Starting dynamic subtest: lmem0
[285.188189] Dynamic subtest lmem0: SUCCESS (1.270s)
[285.189151] Subtest random-engines: SUCCESS (1.272s)
[286.846108] [162/171] (715s left) gem_lmem_swapping (verify-random)
[287.885228] Starting subtest: verify-random
[287.886269] Starting dynamic subtest: lmem0
[298.878203] Dynamic subtest lmem0: SUCCESS (10.984s)
[298.879307] Subtest verify-random: SUCCESS (10.985s)
[300.567146] [163/171] (702s left) i915_pm_rpm (module-reload)
[303.875041] Starting subtest: module-reload
[318.959247] Subtest module-reload: SUCCESS (15.075s)
[318.979966] [164/171] (683s left) i915_selftest (live)
[319.109368] Starting subtest: live
[319.110438] Starting dynamic subtest: sanitycheck
[321.227538] Dynamic subtest sanitycheck: SUCCESS (2.109s)
[321.234998] Starting dynamic subtest: uncore
[323.354304] Dynamic subtest uncore: SUCCESS (2.125s)
[323.360910] Starting dynamic subtest: workarounds
[328.055776] Dynamic subtest workarounds: SUCCESS (4.700s)
[328.063616] Starting dynamic subtest: gt_engines
[331.295575] Dynamic subtest gt_engines: SUCCESS (3.238s)
[331.302201] Starting dynamic subtest: gt_timelines
[368.084401] Dynamic subtest gt_timelines: SUCCESS (36.787s)
[368.091110] Starting dynamic subtest: gt_contexts
[370.222550] Dynamic subtest gt_contexts: SUCCESS (2.137s)
[370.230822] Starting dynamic subtest: gt_lrc
[379.158471] Dynamic subtest gt_lrc: SUCCESS (8.934s)
[379.165080] Starting dynamic subtest: gt_mocs
[383.208401] Dynamic subtest gt_mocs: SUCCESS (4.049s)
[383.214233] Starting dynamic subtest: gt_pm
[386.273318] Dynamic subtest gt_pm: SUCCESS (3.061s)
[386.279586] Starting dynamic subtest: gt_heartbeat
[388.607394] Dynamic subtest gt_heartbeat: SUCCESS (2.335s)
[388.613219] Starting dynamic subtest: gt_tlb
[405.581368] Dynamic subtest gt_tlb: SUCCESS (16.973s)
[405.587234] Starting dynamic subtest: requests
[424.241374] Dynamic subtest requests: SUCCESS (18.659s)
[424.247614] Starting dynamic subtest: migrate
[429.976387] Dynamic subtest migrate: SUCCESS (5.734s)
[429.983048] Starting dynamic subtest: active
[432.129639] Dynamic subtest active: SUCCESS (2.151s)
[432.137067] Starting dynamic subtest: objects
[435.504360] Dynamic subtest objects: SUCCESS (3.374s)
[435.511061] Starting dynamic subtest: mman
[446.226269] Dynamic subtest mman: SUCCESS (10.721s)
[446.232345] Starting dynamic subtest: dmabuf
[448.295254] Dynamic subtest dmabuf: SUCCESS (2.068s)
[448.301272] Starting dynamic subtest: vma
[450.397263] Dynamic subtest vma: SUCCESS (2.101s)
[450.403362] Starting dynamic subtest: coherency
[454.953185] Dynamic subtest coherency: SUCCESS (4.555s)
[454.959176] Starting dynamic subtest: gtt
[465.607368] Dynamic subtest gtt: SUCCESS (10.653s)
[465.613275] Starting dynamic subtest: gem
[467.752534] Dynamic subtest gem: SUCCESS (2.143s)
[467.759578] Starting dynamic subtest: evict
[472.333523] Dynamic subtest evict: SUCCESS (4.580s)
[472.340630] Starting dynamic subtest: hugepages
[491.743413] Dynamic subtest hugepages: SUCCESS (19.409s)
[491.749407] Starting dynamic subtest: gem_contexts
[540.177242] Dynamic subtest gem_contexts: SUCCESS (48.431s)
[540.183988] Starting dynamic subtest: client
[542.339542] Dynamic subtest client: SUCCESS (2.162s)
[542.346606] Starting dynamic subtest: gem_migrate
[547.638453] Dynamic subtest gem_migrate: SUCCESS (5.297s)
[547.645552] Starting dynamic subtest: reset
[549.865633] Dynamic subtest reset: SUCCESS (2.224s)
[549.871541] Starting dynamic subtest: memory_region
[553.519371] Dynamic subtest memory_region: SUCCESS (3.653s)
[553.526148] Starting dynamic subtest: hangcheck
[601.153584] Dynamic subtest hangcheck: SUCCESS (47.633s)
[601.159559] Starting dynamic subtest: execlists
[603.280777] Dynamic subtest execlists: SUCCESS (2.126s)
[603.288046] Starting dynamic subtest: ring_submission
[605.434500] Dynamic subtest ring_submission: SUCCESS (2.152s)
[605.440895] Starting dynamic subtest: perf
[607.698366] Dynamic subtest perf: SUCCESS (2.263s)
[607.705460] Starting dynamic subtest: slpc
[617.617368] Dynamic subtest slpc: SUCCESS (9.918s)
[617.624214] Starting dynamic subtest: guc
[621.156948] Dynamic subtest guc: SUCCESS (3.546s)
[621.164294] Starting dynamic subtest: guc_multi_lrc
[623.331300] Dynamic subtest guc_multi_lrc: SUCCESS (2.165s)
[623.337518] Starting dynamic subtest: guc_hang
[626.229422] Dynamic subtest guc_hang: SUCCESS (2.895s)
[626.235462] Starting dynamic subtest: late_gt_pm
[628.414434] Dynamic subtest late_gt_pm: SUCCESS (2.186s)
[628.415538] Subtest live: SUCCESS (309.297s)
[628.863805] [165/171] (374s left) dmabuf (all-tests)
[628.952197] Starting subtest: all-tests
[628.953327] Starting dynamic subtest: sanitycheck
[629.020641] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[629.040353] Starting dynamic subtest: dma_fence
[629.207999] Dynamic subtest dma_fence: SUCCESS (0.185s)
[629.217987] Starting dynamic subtest: dma_fence_chain
[643.224677] Dynamic subtest dma_fence_chain: SUCCESS (14.005s)
[643.234994] Starting dynamic subtest: dma_fence_unwrap
[643.302862] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[643.324811] Starting dynamic subtest: dma_resv
[643.398727] Dynamic subtest dma_resv: SUCCESS (0.093s)
[643.400208] Subtest all-tests: SUCCESS (14.448s)
[643.442049] [166/171] (359s left) i915_suspend (basic-s2idle-without-i915)
[643.532341] Starting subtest: basic-s2idle-without-i915
[663.934300] Subtest basic-s2idle-without-i915: SUCCESS (5.772s)
[664.181350] [167/171] (353s left) i915_suspend (basic-s3-without-i915)
[664.276621] Starting subtest: basic-s3-without-i915
[667.044181] Subtest basic-s3-without-i915: SKIP (2.753s)
[667.963885] [168/171] (349s left) gem_exec_suspend (basic-s0)
[668.083241] Starting subtest: basic-S0
[668.084259] Starting dynamic subtest: smem
[688.660559] Dynamic subtest smem: SUCCESS (5.885s)
[688.675041] Starting dynamic subtest: lmem0
[708.646453] Dynamic subtest lmem0: SUCCESS (5.828s)
[708.647632] Subtest basic-S0: SUCCESS (11.720s)
[708.841725] [169/171] (337s left) gem_exec_suspend (basic-s3)
[708.951407] Starting subtest: basic-S3
[708.952522] Starting dynamic subtest: smem
[729.636092] Dynamic subtest smem: SUCCESS (5.800s)
[729.654700] Starting dynamic subtest: lmem0
[749.652942] Dynamic subtest lmem0: SUCCESS (5.929s)
[749.654386] Subtest basic-S3: SUCCESS (11.734s)
[749.883147] [170/171] (325s left) kms_chamelium_hpd (common-hpd-after-suspend)
[750.116943] Subtest common-hpd-after-suspend: SKIP (0.000s)
[750.254674] [171/171] (325s left) kms_pipe_crc_basic (suspend-read-crc)
[750.412345] Starting subtest: suspend-read-crc
[750.413500] Starting dynamic subtest: pipe-A-DP-1
[767.950992] Dynamic subtest pipe-A-DP-1: SUCCESS (2.913s)
[767.961057] Starting dynamic subtest: pipe-B-DP-1
[770.602047] Dynamic subtest pipe-B-DP-1: SUCCESS (2.649s)
[770.612360] Starting dynamic subtest: pipe-C-DP-1
[788.096817] Dynamic subtest pipe-C-DP-1: SUCCESS (3.037s)
[788.107395] Starting dynamic subtest: pipe-D-DP-1
[806.142733] Dynamic subtest pipe-D-DP-1: SUCCESS (3.132s)
[806.143812] Subtest suspend-read-crc: SUCCESS (11.743s)
[806.337055] Closing watchdogs
Done.