[41.943351] Initializing watchdogs
[41.943443]   /dev/watchdog0
[41.950086] [001/171] (960s left) i915_module_load (load)
[42.031061] Starting subtest: load
[43.469661] Subtest load: SUCCESS (1.439s)
[43.488496] [002/171] (958s left) core_auth (basic-auth)
[43.634969] Starting subtest: basic-auth
[43.635932] Subtest basic-auth: SUCCESS (0.001s)
[43.708062] [003/171] (958s left) debugfs_test (read_all_entries)
[43.808078] Starting subtest: read_all_entries
[44.304443] Subtest read_all_entries: SUCCESS (0.496s)
[44.424456] [004/171] (958s left) debugfs_test (basic-hwmon)
[44.523047] Starting subtest: basic-hwmon
[44.527344] Subtest basic-hwmon: SUCCESS (0.004s)
[44.656997] [005/171] (957s left) fbdev (eof)
[44.736845] Starting subtest: eof
[44.737944] Subtest eof: SUCCESS (0.000s)
[44.806594] [006/171] (957s left) fbdev (info)
[44.882016] Starting subtest: info
[44.883166] Subtest info: SUCCESS (0.000s)
[44.956300] [007/171] (957s left) fbdev (nullptr)
[45.053253] Starting subtest: nullptr
[45.054396] Subtest nullptr: SUCCESS (0.000s)
[45.123348] [008/171] (957s left) fbdev (read)
[45.203365] Starting subtest: read
[57.539280] Subtest read: SUCCESS (12.328s)
[57.591599] [009/171] (944s left) fbdev (write)
[57.670031] Starting subtest: write
[63.817831] Subtest write: SUCCESS (6.139s)
[63.874775] [010/171] (938s left) gem_basic (bad-close)
[63.963378] Starting subtest: bad-close
[63.965503] Subtest bad-close: SUCCESS (0.000s)
[64.024804] [011/171] (938s left) gem_basic (create-close)
[64.112286] Starting subtest: create-close
[64.114280] Subtest create-close: SUCCESS (0.000s)
[64.199622] [012/171] (938s left) gem_basic (create-fd-close)
[64.305081] Starting subtest: create-fd-close
[64.306909] Subtest create-fd-close: SUCCESS (0.000s)
[64.403640] [013/171] (938s left) gem_busy (busy@all-engines)
[64.529116] Starting subtest: busy
[64.530174] Starting dynamic subtest: all-engines
[64.652606] Dynamic subtest all-engines: SUCCESS (0.123s)
[64.653667] Subtest busy: SUCCESS (0.124s)
[65.111334] [014/171] (937s left) gem_close_race (basic-process)
[65.264053] Starting subtest: basic-process
[65.321315] Subtest basic-process: SUCCESS (0.057s)
[65.558786] [015/171] (937s left) gem_close_race (basic-threads)
[65.695047] Starting subtest: basic-threads
[66.922468] Subtest basic-threads: SUCCESS (1.227s)
[67.179159] [016/171] (935s left) gem_ctx_create (basic)
[67.312762] Starting subtest: basic
[67.313653] Subtest basic: SUCCESS (0.000s)
[67.497300] [017/171] (935s left) gem_ctx_create (basic-files)
[67.610506] Starting subtest: basic-files
[69.626206] Subtest basic-files: SUCCESS (2.016s)
[70.158127] [018/171] (932s left) gem_ctx_exec (basic)
[70.251209] Starting subtest: basic
[70.256168] Subtest basic: SUCCESS (0.005s)
[70.405742] [019/171] (932s left) gem_exec_basic (basic)
[70.513823] Starting subtest: basic
[70.514964] Starting dynamic subtest: rcs0-smem
[70.517206] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[70.524877] Starting dynamic subtest: bcs0-smem
[70.525985] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[70.533596] Starting dynamic subtest: vcs0-smem
[70.534624] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[70.541577] Starting dynamic subtest: vcs1-smem
[70.542549] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[70.549510] Starting dynamic subtest: vecs0-smem
[70.550553] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[70.557917] Starting dynamic subtest: vecs1-smem
[70.558810] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[70.564492] Starting dynamic subtest: ccs0-smem
[70.565626] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[70.571339] Starting dynamic subtest: ccs1-smem
[70.572470] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[70.578021] Starting dynamic subtest: ccs2-smem
[70.578902] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[70.584350] Starting dynamic subtest: ccs3-smem
[70.585231] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[70.590959] Starting dynamic subtest: rcs0-lmem0
[70.592099] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[70.597813] Starting dynamic subtest: bcs0-lmem0
[70.598957] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[70.604718] Starting dynamic subtest: vcs0-lmem0
[70.605837] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[70.611516] Starting dynamic subtest: vcs1-lmem0
[70.612630] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[70.618344] Starting dynamic subtest: vecs0-lmem0
[70.619480] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[70.625141] Starting dynamic subtest: vecs1-lmem0
[70.626204] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[70.631787] Starting dynamic subtest: ccs0-lmem0
[70.632762] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[70.639116] Starting dynamic subtest: ccs1-lmem0
[70.640141] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[70.645889] Starting dynamic subtest: ccs2-lmem0
[70.647065] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[70.652546] Starting dynamic subtest: ccs3-lmem0
[70.653419] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[70.654317] Subtest basic: SUCCESS (0.014s)
[70.710648] [020/171] (932s left) gem_exec_create (basic)
[70.822152] Starting subtest: basic
[70.823093] Starting dynamic subtest: smem
[72.940275] Dynamic subtest smem: SUCCESS (2.118s)
[72.947161] Starting dynamic subtest: lmem0
[75.053914] Dynamic subtest lmem0: SUCCESS (2.113s)
[75.055066] Subtest basic: SUCCESS (4.232s)
[75.274820] [021/171] (927s left) gem_exec_fence (basic-busy)
[75.551810] Starting subtest: basic-busy
[75.552734] Starting dynamic subtest: rcs0
[75.646741] Dynamic subtest rcs0: SUCCESS (0.103s)
[75.658296] Starting dynamic subtest: bcs0
[75.706650] Dynamic subtest bcs0: SUCCESS (0.058s)
[75.732598] Starting dynamic subtest: vcs0
[75.767674] Dynamic subtest vcs0: SUCCESS (0.060s)
[75.794445] Starting dynamic subtest: vcs1
[75.834620] Dynamic subtest vcs1: SUCCESS (0.066s)
[75.860118] Starting dynamic subtest: vecs0
[75.895589] Dynamic subtest vecs0: SUCCESS (0.060s)
[75.920796] Starting dynamic subtest: vecs1
[75.965713] Dynamic subtest vecs1: SUCCESS (0.069s)
[75.991498] Starting dynamic subtest: ccs0
[76.035650] Dynamic subtest ccs0: SUCCESS (0.069s)
[76.061515] Starting dynamic subtest: ccs1
[76.097662] Dynamic subtest ccs1: SUCCESS (0.061s)
[76.123608] Starting dynamic subtest: ccs2
[76.167614] Dynamic subtest ccs2: SUCCESS (0.069s)
[76.193258] Starting dynamic subtest: ccs3
[76.243619] Dynamic subtest ccs3: SUCCESS (0.075s)
[76.246233] Subtest basic-busy: SUCCESS (0.699s)
[77.493643] [022/171] (925s left) gem_exec_fence (basic-wait)
[77.714578] Starting subtest: basic-wait
[77.715666] Starting dynamic subtest: rcs0
[77.795350] Dynamic subtest rcs0: SUCCESS (0.081s)
[77.803350] Starting dynamic subtest: bcs0
[77.846352] Dynamic subtest bcs0: SUCCESS (0.051s)
[77.854278] Starting dynamic subtest: vcs0
[77.898591] Dynamic subtest vcs0: SUCCESS (0.052s)
[77.904819] Starting dynamic subtest: vcs1
[77.948418] Dynamic subtest vcs1: SUCCESS (0.050s)
[77.956217] Starting dynamic subtest: vecs0
[77.998433] Dynamic subtest vecs0: SUCCESS (0.050s)
[78.005976] Starting dynamic subtest: vecs1
[78.046372] Dynamic subtest vecs1: SUCCESS (0.048s)
[78.054095] Starting dynamic subtest: ccs0
[78.096391] Dynamic subtest ccs0: SUCCESS (0.050s)
[78.102441] Starting dynamic subtest: ccs1
[78.140409] Dynamic subtest ccs1: SUCCESS (0.044s)
[78.147583] Starting dynamic subtest: ccs2
[78.184631] Dynamic subtest ccs2: SUCCESS (0.044s)
[78.190718] Starting dynamic subtest: ccs3
[78.236825] Dynamic subtest ccs3: SUCCESS (0.052s)
[78.238154] Subtest basic-wait: SUCCESS (0.522s)
[79.557079] [023/171] (923s left) gem_exec_fence (basic-await)
[79.792149] Starting subtest: basic-await
[79.793191] Starting dynamic subtest: rcs0
[79.932284] Dynamic subtest rcs0: SUCCESS (0.149s)
[79.938560] Starting dynamic subtest: bcs0
[80.047386] Dynamic subtest bcs0: SUCCESS (0.115s)
[80.056874] Starting dynamic subtest: vcs0
[80.168138] Dynamic subtest vcs0: SUCCESS (0.121s)
[80.174496] Starting dynamic subtest: vcs1
[80.284368] Dynamic subtest vcs1: SUCCESS (0.116s)
[80.290455] Starting dynamic subtest: vecs0
[80.396854] Dynamic subtest vecs0: SUCCESS (0.112s)
[80.404062] Starting dynamic subtest: vecs1
[80.512372] Dynamic subtest vecs1: SUCCESS (0.115s)
[80.518398] Starting dynamic subtest: ccs0
[80.627064] Dynamic subtest ccs0: SUCCESS (0.115s)
[80.633057] Starting dynamic subtest: ccs1
[80.739433] Dynamic subtest ccs1: SUCCESS (0.112s)
[80.745511] Starting dynamic subtest: ccs2
[80.853544] Dynamic subtest ccs2: SUCCESS (0.114s)
[80.860712] Starting dynamic subtest: ccs3
[80.969314] Dynamic subtest ccs3: SUCCESS (0.115s)
[80.970325] Subtest basic-await: SUCCESS (1.186s)
[82.231271] [024/171] (920s left) gem_exec_fence (nb-await)
[82.468225] Starting subtest: nb-await
[82.469336] Starting dynamic subtest: rcs0
[82.569456] Dynamic subtest rcs0: SUCCESS (0.107s)
[82.582494] Starting dynamic subtest: bcs0
[82.651240] Dynamic subtest bcs0: SUCCESS (0.080s)
[82.657608] Starting dynamic subtest: vcs0
[82.718847] Dynamic subtest vcs0: SUCCESS (0.068s)
[82.734090] Starting dynamic subtest: vcs1
[82.811774] Dynamic subtest vcs1: SUCCESS (0.092s)
[82.838270] Starting dynamic subtest: vecs0
[82.914353] Dynamic subtest vecs0: SUCCESS (0.103s)
[82.927149] Starting dynamic subtest: vecs1
[82.998479] Dynamic subtest vecs1: SUCCESS (0.084s)
[83.018173] Starting dynamic subtest: ccs0
[83.092504] Dynamic subtest ccs0: SUCCESS (0.094s)
[83.108742] Starting dynamic subtest: ccs1
[83.183948] Dynamic subtest ccs1: SUCCESS (0.091s)
[83.203755] Starting dynamic subtest: ccs2
[83.277096] Dynamic subtest ccs2: SUCCESS (0.093s)
[83.299861] Starting dynamic subtest: ccs3
[83.378564] Dynamic subtest ccs3: SUCCESS (0.101s)
[83.381126] Subtest nb-await: SUCCESS (0.915s)
[84.596397] [025/171] (918s left) gem_exec_gttfill (basic)
[84.703117] Starting subtest: basic
[91.871076] Subtest basic: SUCCESS (7.160s)
[92.109666] [026/171] (910s left) gem_exec_parallel (engines)
[92.267559] Starting subtest: engines
[92.268514] Starting dynamic subtest: basic
[94.212841] Dynamic subtest basic: SUCCESS (1.945s)
[94.220350] Starting dynamic subtest: contexts
[97.384118] Dynamic subtest contexts: SUCCESS (3.171s)
[97.390777] Starting dynamic subtest: fds
[100.664790] Dynamic subtest fds: SUCCESS (3.281s)
[100.672767] Starting dynamic subtest: userptr
[102.697581] Dynamic subtest userptr: SUCCESS (2.033s)
[102.698831] Subtest engines: SUCCESS (10.430s)
[102.990356] [027/171] (899s left) gem_exec_store (basic)
[103.110633] Starting subtest: basic
[103.272595] Subtest basic: SUCCESS (0.161s)
[103.512059] [028/171] (899s left) gem_flink_basic (bad-flink)
[103.607149] Starting subtest: bad-flink
[103.608126] Subtest bad-flink: SUCCESS (0.000s)
[103.679873] [029/171] (899s left) gem_flink_basic (bad-open)
[103.779244] Starting subtest: bad-open
[103.780296] Subtest bad-open: SUCCESS (0.000s)
[103.843940] [030/171] (899s left) gem_flink_basic (basic)
[103.938306] Starting subtest: basic
[103.939370] Subtest basic: SUCCESS (0.000s)
[104.039981] [031/171] (898s left) gem_flink_basic (double-flink)
[104.136225] Starting subtest: double-flink
[104.137264] Subtest double-flink: SUCCESS (0.000s)
[104.227889] [032/171] (898s left) gem_flink_basic (flink-lifetime)
[104.326274] Starting subtest: flink-lifetime
[104.329565] Subtest flink-lifetime: SUCCESS (0.003s)
[104.419556] [033/171] (898s left) gem_huc_copy (huc-copy)
[104.573502] Starting subtest: huc-copy
[104.579531] Subtest huc-copy: SUCCESS (0.006s)
[104.712313] [034/171] (898s left) gem_linear_blits (basic)
[104.926426] Starting subtest: basic
[104.969265] Subtest basic: SUCCESS (0.043s)
[105.118892] [035/171] (898s left) gem_mmap (basic)
[105.260640] Subtest basic: SKIP (0.000s)
[105.297654] [036/171] (897s left) gem_mmap_gtt (basic)
[105.390857] Subtest basic: SKIP (0.000s)
[105.413182] [037/171] (897s left) gem_render_linear_blits (basic)
[105.511531] Starting subtest: basic
[105.594209] Subtest basic: SUCCESS (0.083s)
[105.663799] [038/171] (897s left) gem_render_tiled_blits (basic)
[105.764994] Subtest basic: SKIP (0.000s)
[105.796277] [039/171] (897s left) gem_ringfill (basic-all)
[106.260560] Starting subtest: basic-all
[110.628156] Subtest basic-all: SUCCESS (4.335s)
[110.704802] [040/171] (892s left) gem_softpin (allocator-basic)
[110.823407] Starting subtest: allocator-basic
[111.095449] Subtest allocator-basic: SUCCESS (0.263s)
[111.227063] [041/171] (892s left) gem_softpin (allocator-basic-reserve)
[111.331558] Starting subtest: allocator-basic-reserve
[111.604150] Subtest allocator-basic-reserve: SUCCESS (0.264s)
[111.739615] [042/171] (891s left) gem_softpin (safe-alignment)
[111.835766] Starting subtest: safe-alignment
[111.904728] Subtest safe-alignment: SUCCESS (0.069s)
[112.043082] [043/171] (891s left) gem_sync (basic-all)
[112.153153] Starting subtest: basic-all
[116.126356] Subtest basic-all: SUCCESS (3.973s)
[116.310482] [044/171] (886s left) gem_sync (basic-each)
[116.419669] Starting subtest: basic-each
[119.107453] Subtest basic-each: SUCCESS (2.688s)
[119.329187] [045/171] (883s left) gem_tiled_blits (basic)
[119.455288] Subtest basic: SKIP (0.000s)
[119.480341] [046/171] (883s left) gem_tiled_fence_blits (basic)
[119.580723] Subtest basic: SKIP (0.000s)
[119.613620] [047/171] (883s left) gem_tiled_pread_basic
[119.746527] [048/171] (883s left) gem_wait (busy@all-engines)
[119.859257] Starting subtest: busy
[119.860254] Starting dynamic subtest: all-engines
[120.439544] Dynamic subtest all-engines: SUCCESS (0.580s)
[120.440549] Subtest busy: SUCCESS (0.580s)
[120.743313] [049/171] (882s left) gem_wait (wait@all-engines)
[120.876481] Starting subtest: wait
[120.877509] Starting dynamic subtest: all-engines
[121.967622] Dynamic subtest all-engines: SUCCESS (1.091s)
[121.968919] Subtest wait: SUCCESS (1.091s)
[122.242289] [050/171] (881s left) i915_getparams_basic (basic-eu-total)
[122.333105] Starting subtest: basic-eu-total
[122.334748] Subtest basic-eu-total: SUCCESS (0.000s)
[122.403213] [051/171] (881s left) i915_getparams_basic (basic-subslice-total)
[122.511554] Starting subtest: basic-subslice-total
[122.513403] Subtest basic-subslice-total: SUCCESS (0.000s)
[122.577616] [052/171] (880s left) i915_hangman (error-state-basic)
[122.693423] Starting subtest: error-state-basic
[122.897417] Subtest error-state-basic: SUCCESS (0.204s)
[122.962270] [053/171] (880s left) i915_pciid
[123.110476] [054/171] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[123.204736] Starting subtest: addfb25-bad-modifier
[123.205789] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[123.344894] [055/171] (880s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[123.439711] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[123.578046] [056/171] (879s left) kms_addfb_basic (addfb25-modifier-no-flag)
[123.672499] Starting subtest: addfb25-modifier-no-flag
[123.673506] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[123.811820] [057/171] (879s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[123.904792] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[124.044569] [058/171] (879s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[124.138841] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[124.278061] [059/171] (879s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[124.432970] Starting subtest: addfb25-yf-tiled-legacy
[124.434062] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[124.528294] [060/171] (879s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[124.681806] Starting subtest: addfb25-y-tiled-legacy
[124.682850] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[124.761512] [061/171] (878s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[124.919139] Starting subtest: addfb25-y-tiled-small-legacy
[124.921113] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[125.018449] [062/171] (878s left) kms_addfb_basic (bad-pitch-0)
[125.110444] Starting subtest: bad-pitch-0
[125.111388] Subtest bad-pitch-0: SUCCESS (0.000s)
[125.261367] [063/171] (878s left) kms_addfb_basic (bad-pitch-1024)
[125.354116] Starting subtest: bad-pitch-1024
[125.355119] Subtest bad-pitch-1024: SUCCESS (0.000s)
[125.495596] [064/171] (878s left) kms_addfb_basic (bad-pitch-128)
[125.587275] Starting subtest: bad-pitch-128
[125.588287] Subtest bad-pitch-128: SUCCESS (0.000s)
[125.728591] [065/171] (877s left) kms_addfb_basic (bad-pitch-256)
[125.820946] Starting subtest: bad-pitch-256
[125.821919] Subtest bad-pitch-256: SUCCESS (0.000s)
[125.961254] [066/171] (877s left) kms_addfb_basic (bad-pitch-32)
[126.054276] Starting subtest: bad-pitch-32
[126.055196] Subtest bad-pitch-32: SUCCESS (0.000s)
[126.195176] [067/171] (877s left) kms_addfb_basic (bad-pitch-63)
[126.287148] Starting subtest: bad-pitch-63
[126.288149] Subtest bad-pitch-63: SUCCESS (0.000s)
[126.444892] [068/171] (877s left) kms_addfb_basic (bad-pitch-65536)
[126.537164] Starting subtest: bad-pitch-65536
[126.538162] Subtest bad-pitch-65536: SUCCESS (0.000s)
[126.695273] [069/171] (877s left) kms_addfb_basic (bad-pitch-999)
[126.786389] Starting subtest: bad-pitch-999
[126.787369] Subtest bad-pitch-999: SUCCESS (0.000s)
[126.927335] [070/171] (876s left) kms_addfb_basic (basic)
[127.017897] Starting subtest: basic
[127.018917] Subtest basic: SUCCESS (0.000s)
[127.162163] [071/171] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[127.255970] Starting subtest: basic-x-tiled-legacy
[127.257882] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[127.395594] [072/171] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[127.488716] Starting subtest: basic-y-tiled-legacy
[127.490501] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[127.644488] [073/171] (876s left) kms_addfb_basic (bo-too-small)
[127.798738] Starting subtest: bo-too-small
[127.799713] Subtest bo-too-small: SUCCESS (0.000s)
[127.878217] [074/171] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[128.034389] Starting subtest: bo-too-small-due-to-tiling
[128.036385] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[128.114137] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[128.209849] Starting subtest: clobberred-modifier
[128.211665] Subtest clobberred-modifier: SKIP (0.000s)
[128.385531] [076/171] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[128.479425] Starting subtest: framebuffer-vs-set-tiling
[128.481435] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[128.628458] [077/171] (875s left) kms_addfb_basic (invalid-get-prop)
[128.720263] Starting subtest: invalid-get-prop
[128.721280] Subtest invalid-get-prop: SUCCESS (0.000s)
[128.864152] [078/171] (875s left) kms_addfb_basic (invalid-get-prop-any)
[128.960170] Starting subtest: invalid-get-prop-any
[128.961130] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[129.114152] [079/171] (874s left) kms_addfb_basic (invalid-set-prop)
[129.207354] Starting subtest: invalid-set-prop
[129.208418] Subtest invalid-set-prop: SUCCESS (0.000s)
[129.348095] [080/171] (874s left) kms_addfb_basic (invalid-set-prop-any)
[129.444457] Starting subtest: invalid-set-prop-any
[129.445467] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[129.597333] [081/171] (874s left) kms_addfb_basic (no-handle)
[129.692421] Starting subtest: no-handle
[129.693472] Subtest no-handle: SUCCESS (0.000s)
[129.830973] [082/171] (874s left) kms_addfb_basic (size-max)
[129.987104] Starting subtest: size-max
[129.988146] Subtest size-max: SUCCESS (0.000s)
[130.082263] [083/171] (873s left) kms_addfb_basic (small-bo)
[130.241601] Starting subtest: small-bo
[130.242645] Subtest small-bo: SUCCESS (0.000s)
[130.330663] [084/171] (873s left) kms_addfb_basic (tile-pitch-mismatch)
[130.425663] Starting subtest: tile-pitch-mismatch
[130.427589] Subtest tile-pitch-mismatch: SKIP (0.000s)
[130.581067] [085/171] (873s left) kms_addfb_basic (too-high)
[130.740115] Starting subtest: too-high
[130.741153] Subtest too-high: SUCCESS (0.001s)
[130.828666] [086/171] (873s left) kms_addfb_basic (too-wide)
[130.982137] Starting subtest: too-wide
[130.983160] Subtest too-wide: SUCCESS (0.000s)
[131.078642] [087/171] (872s left) kms_addfb_basic (unused-handle)
[131.170356] Starting subtest: unused-handle
[131.171410] Subtest unused-handle: SUCCESS (0.000s)
[131.311752] [088/171] (872s left) kms_addfb_basic (unused-modifier)
[131.404011] Starting subtest: unused-modifier
[131.405071] Subtest unused-modifier: SUCCESS (0.000s)
[131.561994] [089/171] (872s left) kms_addfb_basic (unused-offsets)
[131.654039] Starting subtest: unused-offsets
[131.654992] Subtest unused-offsets: SUCCESS (0.000s)
[131.812078] [090/171] (872s left) kms_addfb_basic (unused-pitches)
[131.905228] Starting subtest: unused-pitches
[131.906259] Subtest unused-pitches: SUCCESS (0.000s)
[132.045399] [091/171] (872s left) kms_busy (basic)
[132.207190] Starting subtest: basic
[132.208174] Starting dynamic subtest: flip
[132.997216] Dynamic subtest flip: SUCCESS (0.789s)
[133.005097] Starting dynamic subtest: modeset
[133.964173] Dynamic subtest modeset: SUCCESS (0.968s)
[133.965211] Subtest basic: SUCCESS (1.759s)
[134.198884] [092/171] (869s left) kms_chamelium_hpd (dp-hpd-fast)
[134.434126] Subtest dp-hpd-fast: SKIP (0.000s)
[134.573663] [093/171] (869s left) kms_chamelium_edid (dp-edid-read)
[134.799535] Subtest dp-edid-read: SKIP (0.000s)
[134.935467] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast)
[135.166079] Subtest dp-crc-fast: SKIP (0.000s)
[135.303832] [095/171] (868s left) kms_chamelium_hpd (hdmi-hpd-fast)
[135.533589] Subtest hdmi-hpd-fast: SKIP (0.000s)
[135.670432] [096/171] (868s left) kms_chamelium_edid (hdmi-edid-read)
[135.901308] Subtest hdmi-edid-read: SKIP (0.000s)
[136.037734] [097/171] (868s left) kms_chamelium_frames (hdmi-crc-fast)
[136.268300] Subtest hdmi-crc-fast: SKIP (0.000s)
[136.405600] [098/171] (867s left) kms_chamelium_hpd (vga-hpd-fast)
[136.636338] Subtest vga-hpd-fast: SKIP (0.000s)
[136.774209] [099/171] (867s left) kms_chamelium_edid (vga-edid-read)
[137.004309] Subtest vga-edid-read: SKIP (0.000s)
[137.175656] [100/171] (867s left) kms_prop_blob (basic)
[137.268142] Starting subtest: basic
[137.269073] Subtest basic: SUCCESS (0.000s)
[137.336469] [101/171] (866s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[137.507999] Starting subtest: basic-busy-flip-before-cursor-atomic
[137.510047] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[137.570207] [102/171] (866s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[137.724984] Starting subtest: basic-busy-flip-before-cursor-legacy
[137.727165] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[137.787925] [103/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[137.941162] Starting subtest: basic-flip-after-cursor-atomic
[138.988642] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.049s)
[139.209287] [104/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[139.363059] Starting subtest: basic-flip-after-cursor-legacy
[140.433995] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.071s)
[140.643899] [105/171] (863s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[140.798201] Starting subtest: basic-flip-after-cursor-varying-size
[141.876980] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.078s)
[142.098499] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[142.252393] Starting subtest: basic-flip-before-cursor-atomic
[143.315168] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.062s)
[143.502979] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[143.657058] Starting subtest: basic-flip-before-cursor-legacy
[144.720691] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.063s)
[144.933675] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[145.088055] Starting subtest: basic-flip-before-cursor-varying-size
[146.166925] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.079s)
[146.386824] [109/171] (858s left) kms_flip (basic-flip-vs-dpms)
[146.525523] Starting subtest: basic-flip-vs-dpms
[146.530428] Starting dynamic subtest: A-DP1
[147.614513] Dynamic subtest A-DP1: SUCCESS (1.084s)
[147.622625] Starting dynamic subtest: B-DP1
[148.527949] Dynamic subtest B-DP1: SUCCESS (0.912s)
[148.535621] Starting dynamic subtest: C-DP1
[149.441525] Dynamic subtest C-DP1: SUCCESS (0.913s)
[149.449603] Starting dynamic subtest: D-DP1
[150.350234] Dynamic subtest D-DP1: SUCCESS (0.909s)
[150.355597] Subtest basic-flip-vs-dpms: SUCCESS (3.832s)
[150.579300] [110/171] (853s left) kms_flip (basic-flip-vs-modeset)
[150.720768] Starting subtest: basic-flip-vs-modeset
[150.725197] Starting dynamic subtest: A-DP1
[151.615278] Dynamic subtest A-DP1: SUCCESS (0.890s)
[151.623295] Starting dynamic subtest: B-DP1
[152.519123] Dynamic subtest B-DP1: SUCCESS (0.903s)
[152.526955] Starting dynamic subtest: C-DP1
[153.425213] Dynamic subtest C-DP1: SUCCESS (0.905s)
[153.433375] Starting dynamic subtest: D-DP1
[154.338280] Dynamic subtest D-DP1: SUCCESS (0.912s)
[154.343115] Subtest basic-flip-vs-modeset: SUCCESS (3.625s)
[154.539473] [111/171] (849s left) kms_flip (basic-flip-vs-wf_vblank)
[154.680531] Starting subtest: basic-flip-vs-wf_vblank
[154.685150] Starting dynamic subtest: A-DP1
[155.889226] Dynamic subtest A-DP1: SUCCESS (1.201s)
[155.897578] Starting dynamic subtest: B-DP1
[157.009706] Dynamic subtest B-DP1: SUCCESS (1.123s)
[157.019667] Starting dynamic subtest: C-DP1
[158.130470] Dynamic subtest C-DP1: SUCCESS (1.119s)
[158.140155] Starting dynamic subtest: D-DP1
[159.250860] Dynamic subtest D-DP1: SUCCESS (1.119s)
[159.256427] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.578s)
[159.522193] [112/171] (844s left) kms_flip (basic-plain-flip)
[159.662493] Starting subtest: basic-plain-flip
[159.667542] Starting dynamic subtest: A-DP1
[160.586507] Dynamic subtest A-DP1: SUCCESS (0.919s)
[160.596192] Starting dynamic subtest: B-DP1
[161.424725] Dynamic subtest B-DP1: SUCCESS (0.837s)
[161.434784] Starting dynamic subtest: C-DP1
[162.264810] Dynamic subtest C-DP1: SUCCESS (0.839s)
[162.274802] Starting dynamic subtest: D-DP1
[163.098798] Dynamic subtest D-DP1: SUCCESS (0.832s)
[163.104468] Subtest basic-plain-flip: SUCCESS (3.443s)
[163.371215] [113/171] (841s left) kms_force_connector_basic (force-connector-state)
[163.468678] Starting subtest: force-connector-state
[164.038743] Subtest force-connector-state: SUCCESS (0.569s)
[164.331432] [114/171] (840s left) kms_force_connector_basic (force-edid)
[164.429538] Starting subtest: force-edid
[164.448358] Subtest force-edid: SUCCESS (0.018s)
[164.614478] [115/171] (839s left) kms_force_connector_basic (force-load-detect)
[164.709592] Starting subtest: force-load-detect
[164.711528] Subtest force-load-detect: SKIP (0.000s)
[164.831360] [116/171] (839s left) kms_force_connector_basic (prune-stale-modes)
[164.927410] Starting subtest: prune-stale-modes
[164.936776] Subtest prune-stale-modes: SKIP (0.010s)
[165.098114] [117/171] (839s left) kms_frontbuffer_tracking (basic)
[165.262593] Starting subtest: basic
[169.308212] Subtest basic: SUCCESS (4.047s)
[169.450702] [118/171] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[169.610372] Starting subtest: compare-crc-sanitycheck-xr24
[169.613240] Starting dynamic subtest: pipe-A-DP-1
[170.198370] Dynamic subtest pipe-A-DP-1: SUCCESS (0.586s)
[170.207953] Starting dynamic subtest: pipe-B-DP-1
[170.768831] Dynamic subtest pipe-B-DP-1: SUCCESS (0.567s)
[170.778464] Starting dynamic subtest: pipe-C-DP-1
[171.434240] Dynamic subtest pipe-C-DP-1: SUCCESS (0.663s)
[171.444205] Starting dynamic subtest: pipe-D-DP-1
[172.132161] Dynamic subtest pipe-D-DP-1: SUCCESS (0.695s)
[172.133048] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.522s)
[172.330821] [119/171] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[172.487847] Starting subtest: compare-crc-sanitycheck-nv12
[172.490566] Starting dynamic subtest: pipe-A-DP-1
[173.730380] Dynamic subtest pipe-A-DP-1: SUCCESS (1.240s)
[173.739893] Starting dynamic subtest: pipe-B-DP-1
[174.868141] Dynamic subtest pipe-B-DP-1: SUCCESS (1.135s)
[174.878154] Starting dynamic subtest: pipe-C-DP-1
[176.042123] Dynamic subtest pipe-C-DP-1: SUCCESS (1.171s)
[176.051732] Starting dynamic subtest: pipe-D-DP-1
[177.320235] Dynamic subtest pipe-D-DP-1: SUCCESS (1.274s)
[177.321279] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.831s)
[177.520488] [120/171] (827s left) kms_pipe_crc_basic (hang-read-crc)
[177.675647] Starting subtest: hang-read-crc
[177.678362] Starting dynamic subtest: pipe-A-DP-1
[179.166618] Dynamic subtest pipe-A-DP-1: SUCCESS (1.488s)
[179.178222] Starting dynamic subtest: pipe-B-DP-1
[180.721486] Dynamic subtest pipe-B-DP-1: SUCCESS (1.552s)
[180.736972] Starting dynamic subtest: pipe-C-DP-1
[182.419779] Dynamic subtest pipe-C-DP-1: SUCCESS (1.685s)
[182.430455] Starting dynamic subtest: pipe-D-DP-1
[184.206523] Dynamic subtest pipe-D-DP-1: SUCCESS (1.795s)
[184.207527] Subtest hang-read-crc: SUCCESS (6.532s)
[184.414054] [121/171] (820s left) kms_pipe_crc_basic (nonblocking-crc)
[184.573126] Starting subtest: nonblocking-crc
[184.575889] Starting dynamic subtest: pipe-A-DP-1
[185.263306] Dynamic subtest pipe-A-DP-1: SUCCESS (0.688s)
[185.272881] Starting dynamic subtest: pipe-B-DP-1
[186.016912] Dynamic subtest pipe-B-DP-1: SUCCESS (0.751s)
[186.026911] Starting dynamic subtest: pipe-C-DP-1
[186.842478] Dynamic subtest pipe-C-DP-1: FAIL (0.757s)
[186.850151] Starting dynamic subtest: pipe-D-DP-1
[187.667159] Dynamic subtest pipe-D-DP-1: SUCCESS (0.888s)
[187.668155] Subtest nonblocking-crc: FAIL (3.095s)
[187.866743] [122/171] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[188.022252] Starting subtest: nonblocking-crc-frame-sequence
[188.023289] Starting dynamic subtest: pipe-A-DP-1
[188.734886] Dynamic subtest pipe-A-DP-1: SUCCESS (0.711s)
[188.744534] Starting dynamic subtest: pipe-B-DP-1
[189.463251] Dynamic subtest pipe-B-DP-1: SUCCESS (0.727s)
[189.473295] Starting dynamic subtest: pipe-C-DP-1
[190.276249] Dynamic subtest pipe-C-DP-1: FAIL (0.745s)
[190.284064] Starting dynamic subtest: pipe-D-DP-1
[191.136577] Dynamic subtest pipe-D-DP-1: SUCCESS (0.922s)
[191.137554] Subtest nonblocking-crc-frame-sequence: FAIL (3.116s)
[191.339240] [123/171] (813s left) kms_pipe_crc_basic (read-crc)
[191.495795] Starting subtest: read-crc
[191.496716] Starting dynamic subtest: pipe-A-DP-1
[192.138414] Dynamic subtest pipe-A-DP-1: SUCCESS (0.641s)
[192.148175] Starting dynamic subtest: pipe-B-DP-1
[192.793180] Dynamic subtest pipe-B-DP-1: SUCCESS (0.653s)
[192.803186] Starting dynamic subtest: pipe-C-DP-1
[193.514285] Dynamic subtest pipe-C-DP-1: SUCCESS (0.718s)
[193.523942] Starting dynamic subtest: pipe-D-DP-1
[194.297166] Dynamic subtest pipe-D-DP-1: SUCCESS (0.780s)
[194.298194] Subtest read-crc: SUCCESS (2.803s)
[194.491910] [124/171] (810s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[194.648280] Starting subtest: read-crc-frame-sequence
[194.651054] Starting dynamic subtest: pipe-A-DP-1
[195.275565] Dynamic subtest pipe-A-DP-1: SUCCESS (0.625s)
[195.285462] Starting dynamic subtest: pipe-B-DP-1
[195.934558] Dynamic subtest pipe-B-DP-1: SUCCESS (0.656s)
[195.944546] Starting dynamic subtest: pipe-C-DP-1
[196.657574] Dynamic subtest pipe-C-DP-1: SUCCESS (0.721s)
[196.667862] Starting dynamic subtest: pipe-D-DP-1
[197.442304] Dynamic subtest pipe-D-DP-1: SUCCESS (0.782s)
[197.443425] Subtest read-crc-frame-sequence: SUCCESS (2.795s)
[197.641791] [125/171] (807s left) kms_psr (primary_page_flip)
[197.740045] Subtest primary_page_flip: SKIP (0.000s)
[197.778214] [126/171] (807s left) kms_psr (cursor_plane_move)
[197.871867] Subtest cursor_plane_move: SKIP (0.000s)
[197.914695] [127/171] (806s left) kms_psr (sprite_plane_onoff)
[198.008896] Subtest sprite_plane_onoff: SKIP (0.000s)
[198.044845] [128/171] (806s left) kms_psr (primary_mmap_gtt)
[198.137350] Subtest primary_mmap_gtt: SKIP (0.000s)
[198.178073] [129/171] (806s left) kms_setmode (basic-clone-single-crtc)
[198.273258] Starting subtest: basic-clone-single-crtc
[198.276213] Subtest basic-clone-single-crtc: SKIP (0.001s)
[198.342192] [130/171] (806s left) i915_pm_backlight (basic-brightness)
[198.497620] Subtest basic-brightness: SKIP (0.000s)
[198.528363] [131/171] (806s left) i915_pm_rpm (basic-pci-d3-state)
[200.433489] Starting subtest: basic-pci-d3-state
[201.372131] Subtest basic-pci-d3-state: SUCCESS (0.937s)
[201.525582] [132/171] (803s left) i915_pm_rpm (basic-rte)
[201.601066] Starting subtest: basic-rte
[204.426428] Subtest basic-rte: SUCCESS (2.825s)
[205.546198] [133/171] (799s left) i915_pm_rps (basic-api)
[205.649093] Starting subtest: basic-api
[205.651190] Subtest basic-api: SKIP (0.000s)
[205.727985] [134/171] (799s left) prime_self_import (basic-llseek-bad)
[205.807572] Starting subtest: basic-llseek-bad
[205.823544] Subtest basic-llseek-bad: SUCCESS (0.017s)
[205.926656] [135/171] (799s left) prime_self_import (basic-llseek-size)
[206.007470] Starting subtest: basic-llseek-size
[206.024894] Subtest basic-llseek-size: SUCCESS (0.018s)
[206.121170] [136/171] (798s left) prime_self_import (basic-with_fd_dup)
[206.195960] Starting subtest: basic-with_fd_dup
[206.214890] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[206.334587] [137/171] (798s left) prime_self_import (basic-with_one_bo)
[206.417781] Starting subtest: basic-with_one_bo
[206.436272] Subtest basic-with_one_bo: SUCCESS (0.019s)
[206.498370] [138/171] (798s left) prime_self_import (basic-with_one_bo_two_files)
[206.575947] Starting subtest: basic-with_one_bo_two_files
[206.595357] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[206.688847] [139/171] (798s left) prime_self_import (basic-with_two_bos)
[206.781102] Starting subtest: basic-with_two_bos
[206.798975] Subtest basic-with_two_bos: SUCCESS (0.019s)
[206.926584] [140/171] (798s left) prime_vgem (basic-fence-flip)
[207.061864] Starting subtest: basic-fence-flip
[207.174040] Subtest basic-fence-flip: SKIP (0.111s)
[207.278400] [141/171] (797s left) prime_vgem (basic-fence-mmap)
[207.395555] Starting subtest: basic-fence-mmap
[207.397341] Subtest basic-fence-mmap: SKIP (0.000s)
[207.526998] [142/171] (797s left) prime_vgem (basic-fence-read)
[207.673069] Starting subtest: basic-fence-read
[207.680084] Subtest basic-fence-read: SKIP (0.006s)
[207.805107] [143/171] (797s left) prime_vgem (basic-gtt)
[207.928712] Starting subtest: basic-gtt
[207.931061] Subtest basic-gtt: SKIP (0.000s)
[208.035430] [144/171] (797s left) prime_vgem (basic-read)
[208.145081] Starting subtest: basic-read
[208.152511] Subtest basic-read: SKIP (0.007s)
[208.291143] [145/171] (796s left) prime_vgem (basic-write)
[208.431924] Starting subtest: basic-write
[208.438466] Subtest basic-write: SKIP (0.006s)
[208.553848] [146/171] (796s left) vgem_basic (setversion)
[208.654659] Starting subtest: setversion
[208.656782] Subtest setversion: SUCCESS (0.000s)
[208.715584] [147/171] (796s left) vgem_basic (create)
[208.804843] Starting subtest: create
[208.805832] Subtest create: SUCCESS (0.000s)
[208.862256] [148/171] (796s left) vgem_basic (debugfs)
[208.954644] Starting subtest: debugfs
[208.955641] Subtest debugfs: SUCCESS (0.000s)
[209.012021] [149/171] (796s left) vgem_basic (dmabuf-export)
[209.104831] Starting subtest: dmabuf-export
[209.121843] Subtest dmabuf-export: SUCCESS (0.017s)
[209.234887] [150/171] (796s left) vgem_basic (dmabuf-fence)
[209.354885] Starting subtest: dmabuf-fence
[209.355958] Subtest dmabuf-fence: SUCCESS (0.000s)
[209.414350] [151/171] (795s left) vgem_basic (dmabuf-fence-before)
[209.504835] Starting subtest: dmabuf-fence-before
[209.505863] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[209.562270] [152/171] (795s left) vgem_basic (dmabuf-mmap)
[209.654771] Starting subtest: dmabuf-mmap
[209.667985] Subtest dmabuf-mmap: SUCCESS (0.013s)
[209.743518] [153/171] (795s left) vgem_basic (mmap)
[209.838189] Starting subtest: mmap
[209.846693] Subtest mmap: SUCCESS (0.009s)
[209.894609] [154/171] (795s left) vgem_basic (second-client)
[209.988037] Starting subtest: second-client
[210.022220] Subtest second-client: SUCCESS (0.033s)
[210.109991] [155/171] (795s left) vgem_basic (sysfs)
[210.204693] Starting subtest: sysfs
[210.205638] Subtest sysfs: SUCCESS (0.000s)
[210.261156] [156/171] (795s left) core_hotunplug (unbind-rebind)
[210.388750] Starting subtest: unbind-rebind
[213.189715] Subtest unbind-rebind: SUCCESS (2.801s)
[213.211658] [157/171] (792s left) vgem_basic (unload)
[213.293521] Starting subtest: unload
[242.264836] Subtest unload: SUCCESS (28.936s)
[242.337831] [158/171] (763s left) i915_module_load (reload)
[242.413789] Starting subtest: reload
[246.242088] Subtest reload: SUCCESS (3.828s)
[246.261780] [159/171] (759s left) gem_lmem_swapping (basic)
[250.126087] Starting subtest: basic
[250.127023] Starting dynamic subtest: lmem0
[277.710095] Dynamic subtest lmem0: SUCCESS (27.576s)
[277.711107] Subtest basic: SUCCESS (27.578s)
[280.566324] [160/171] (724s left) gem_lmem_swapping (parallel-random-engines)
[281.588100] Starting subtest: parallel-random-engines
[281.589185] Starting dynamic subtest: lmem0
[283.081981] Dynamic subtest lmem0: SUCCESS (1.485s)
[283.082999] Subtest parallel-random-engines: SUCCESS (1.487s)
[284.623796] [161/171] (720s left) gem_lmem_swapping (random-engines)
[285.623359] Starting subtest: random-engines
[285.624392] Starting dynamic subtest: lmem0
[286.856553] Dynamic subtest lmem0: SUCCESS (1.224s)
[286.857505] Subtest random-engines: SUCCESS (1.225s)
[288.421452] [162/171] (717s left) gem_lmem_swapping (verify-random)
[289.398179] Starting subtest: verify-random
[289.399228] Starting dynamic subtest: lmem0
[300.069208] Dynamic subtest lmem0: SUCCESS (10.662s)
[300.070276] Subtest verify-random: SUCCESS (10.663s)
[301.719152] [163/171] (703s left) i915_pm_rpm (module-reload)
[304.950080] Starting subtest: module-reload
[319.944413] Subtest module-reload: SUCCESS (14.985s)
[319.991926] [164/171] (685s left) i915_selftest (live)
[320.107372] Starting subtest: live
[320.108388] Starting dynamic subtest: sanitycheck
[322.216138] Dynamic subtest sanitycheck: SUCCESS (2.108s)
[322.225533] Starting dynamic subtest: uncore
[324.299521] Dynamic subtest uncore: SUCCESS (2.073s)
[324.306167] Starting dynamic subtest: workarounds
[328.957201] Dynamic subtest workarounds: SUCCESS (4.656s)
[328.963462] Starting dynamic subtest: gt_engines
[332.132306] Dynamic subtest gt_engines: SUCCESS (3.174s)
[332.139041] Starting dynamic subtest: gt_timelines
[367.827465] Dynamic subtest gt_timelines: SUCCESS (35.694s)
[367.834255] Starting dynamic subtest: gt_contexts
[369.955496] Dynamic subtest gt_contexts: SUCCESS (2.127s)
[369.962890] Starting dynamic subtest: gt_lrc
[379.107388] Dynamic subtest gt_lrc: SUCCESS (9.150s)
[379.114438] Starting dynamic subtest: gt_mocs
[383.110542] Dynamic subtest gt_mocs: SUCCESS (4.002s)
[383.116772] Starting dynamic subtest: gt_pm
[386.112458] Dynamic subtest gt_pm: SUCCESS (3.000s)
[386.119536] Starting dynamic subtest: gt_heartbeat
[388.445269] Dynamic subtest gt_heartbeat: SUCCESS (2.331s)
[388.451084] Starting dynamic subtest: gt_tlb
[405.363433] Dynamic subtest gt_tlb: SUCCESS (16.917s)
[405.369293] Starting dynamic subtest: requests
[424.327680] Dynamic subtest requests: SUCCESS (18.963s)
[424.335126] Starting dynamic subtest: migrate
[429.981509] Dynamic subtest migrate: SUCCESS (5.652s)
[429.987300] Starting dynamic subtest: active
[432.085705] Dynamic subtest active: SUCCESS (2.102s)
[432.093065] Starting dynamic subtest: objects
[435.478508] Dynamic subtest objects: SUCCESS (3.391s)
[435.485910] Starting dynamic subtest: mman
[446.114239] Dynamic subtest mman: SUCCESS (10.634s)
[446.120185] Starting dynamic subtest: dmabuf
[448.208228] Dynamic subtest dmabuf: SUCCESS (2.093s)
[448.214282] Starting dynamic subtest: vma
[450.295224] Dynamic subtest vma: SUCCESS (2.086s)
[450.301247] Starting dynamic subtest: coherency
[454.291347] Dynamic subtest coherency: SUCCESS (3.995s)
[454.297512] Starting dynamic subtest: gtt
[465.058469] Dynamic subtest gtt: SUCCESS (10.766s)
[465.065222] Starting dynamic subtest: gem
[467.223359] Dynamic subtest gem: SUCCESS (2.164s)
[467.229955] Starting dynamic subtest: evict
[471.796269] Dynamic subtest evict: SUCCESS (4.571s)
[471.802853] Starting dynamic subtest: hugepages
[491.191550] Dynamic subtest hugepages: SUCCESS (19.394s)
[491.199059] Starting dynamic subtest: gem_contexts
[538.104413] Dynamic subtest gem_contexts: SUCCESS (46.885s)
[538.110756] Starting dynamic subtest: client
[540.223538] Dynamic subtest client: SUCCESS (2.151s)
[540.231050] Starting dynamic subtest: gem_migrate
[545.245288] Dynamic subtest gem_migrate: SUCCESS (5.012s)
[545.251200] Starting dynamic subtest: reset
[547.439425] Dynamic subtest reset: SUCCESS (2.192s)
[547.446535] Starting dynamic subtest: memory_region
[551.069401] Dynamic subtest memory_region: SUCCESS (3.628s)
[551.077583] Starting dynamic subtest: hangcheck
[599.263339] Dynamic subtest hangcheck: SUCCESS (48.194s)
[599.269283] Starting dynamic subtest: execlists
[601.348857] Dynamic subtest execlists: SUCCESS (2.084s)
[601.356245] Starting dynamic subtest: ring_submission
[603.423369] Dynamic subtest ring_submission: SUCCESS (2.073s)
[603.429712] Starting dynamic subtest: perf
[605.658519] Dynamic subtest perf: SUCCESS (2.234s)
[605.664453] Starting dynamic subtest: slpc
[615.567362] Dynamic subtest slpc: SUCCESS (9.908s)
[615.575556] Starting dynamic subtest: guc
[619.228503] Dynamic subtest guc: SUCCESS (3.659s)
[619.235871] Starting dynamic subtest: guc_multi_lrc
[621.359260] Dynamic subtest guc_multi_lrc: SUCCESS (2.130s)
[621.366133] Starting dynamic subtest: guc_hang
[624.198583] Dynamic subtest guc_hang: SUCCESS (2.838s)
[624.204822] Starting dynamic subtest: late_gt_pm
[626.367394] Dynamic subtest late_gt_pm: SUCCESS (2.167s)
[626.368570] Subtest live: SUCCESS (306.252s)
[626.818340] [165/171] (378s left) dmabuf (all-tests)
[626.904205] Starting subtest: all-tests
[626.905284] Starting dynamic subtest: sanitycheck
[626.982981] Dynamic subtest sanitycheck: SUCCESS (0.077s)
[627.013118] Starting dynamic subtest: dma_fence
[627.180742] Dynamic subtest dma_fence: SUCCESS (0.193s)
[627.202330] Starting dynamic subtest: dma_fence_chain
[640.891017] Dynamic subtest dma_fence_chain: SUCCESS (13.699s)
[640.897219] Starting dynamic subtest: dma_fence_unwrap
[640.951671] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s)
[640.964045] Starting dynamic subtest: dma_resv
[641.027239] Dynamic subtest dma_resv: SUCCESS (0.070s)
[641.029850] Subtest all-tests: SUCCESS (14.125s)
[641.075642] [166/171] (364s left) i915_suspend (basic-s2idle-without-i915)
[641.150592] Starting subtest: basic-s2idle-without-i915
[661.801154] Subtest basic-s2idle-without-i915: SUCCESS (5.725s)
[662.004223] [167/171] (358s left) i915_suspend (basic-s3-without-i915)
[662.086676] Starting subtest: basic-s3-without-i915
[664.863007] Subtest basic-s3-without-i915: SKIP (2.762s)
[665.796876] [168/171] (354s left) gem_exec_suspend (basic-s0)
[665.934887] Starting subtest: basic-S0
[665.935924] Starting dynamic subtest: smem
[686.575268] Dynamic subtest smem: SUCCESS (5.801s)
[686.585572] Starting dynamic subtest: lmem0
[706.597912] Dynamic subtest lmem0: SUCCESS (5.735s)
[706.599202] Subtest basic-S0: SUCCESS (11.539s)
[706.819520] [169/171] (343s left) gem_exec_suspend (basic-s3)
[706.936335] Starting subtest: basic-S3
[706.937387] Starting dynamic subtest: smem
[727.562889] Dynamic subtest smem: SUCCESS (5.745s)
[727.573475] Starting dynamic subtest: lmem0
[747.584220] Dynamic subtest lmem0: SUCCESS (5.882s)
[747.586015] Subtest basic-S3: SUCCESS (11.631s)
[747.778945] [170/171] (331s left) kms_chamelium_hpd (common-hpd-after-suspend)
[748.015812] Subtest common-hpd-after-suspend: SKIP (0.000s)
[748.157664] [171/171] (330s left) kms_pipe_crc_basic (suspend-read-crc)
[748.315074] Starting subtest: suspend-read-crc
[748.316098] Starting dynamic subtest: pipe-A-DP-1
[765.905244] Dynamic subtest pipe-A-DP-1: SUCCESS (2.840s)
[765.915947] Starting dynamic subtest: pipe-B-DP-1
[783.959244] Dynamic subtest pipe-B-DP-1: SUCCESS (2.919s)
[783.969538] Starting dynamic subtest: pipe-C-DP-1
[802.015220] Dynamic subtest pipe-C-DP-1: SUCCESS (3.018s)
[802.025899] Starting dynamic subtest: pipe-D-DP-1
[820.074763] Dynamic subtest pipe-D-DP-1: SUCCESS (3.059s)
[820.075773] Subtest suspend-read-crc: SUCCESS (11.847s)
[820.242855] Closing watchdogs
Done.