[41.951545] Initializing watchdogs
[41.951651]   /dev/watchdog0
[41.957204] [001/165] (960s left) i915_module_load (load)
[42.116219] Starting subtest: load
[48.515561] Subtest load: SUCCESS (6.399s)
[48.529769] [002/165] (953s left) core_auth (basic-auth)
[48.655213] Starting subtest: basic-auth
[48.658910] Subtest basic-auth: SUCCESS (0.004s)
[48.757228] [003/165] (953s left) debugfs_test (read_all_entries)
[48.864513] Starting subtest: read_all_entries
[49.444378] Subtest read_all_entries: SUCCESS (0.552s)
[49.553449] [004/165] (952s left) debugfs_test (basic-hwmon)
[49.640359] Starting subtest: basic-hwmon
[49.644896] Subtest basic-hwmon: SUCCESS (0.004s)
[49.769746] [005/165] (952s left) fbdev (eof)
[49.849564] Starting subtest: eof
[49.850761] Subtest eof: SUCCESS (0.000s)
[49.937362] [006/165] (952s left) fbdev (info)
[50.001879] Starting subtest: info
[50.003111] Subtest info: SUCCESS (0.000s)
[50.085642] [007/165] (952s left) fbdev (nullptr)
[50.166224] Starting subtest: nullptr
[50.167435] Subtest nullptr: SUCCESS (0.001s)
[50.235759] [008/165] (952s left) fbdev (read)
[50.315917] Starting subtest: read
[62.641504] Subtest read: SUCCESS (12.325s)
[62.703385] [009/165] (939s left) fbdev (write)
[62.782758] Starting subtest: write
[68.912946] Subtest write: SUCCESS (6.130s)
[68.969636] [010/165] (933s left) gem_basic (bad-close)
[69.050309] Starting subtest: bad-close
[69.052230] Subtest bad-close: SUCCESS (0.000s)
[69.145594] [011/165] (933s left) gem_basic (create-close)
[69.256263] Starting subtest: create-close
[69.258414] Subtest create-close: SUCCESS (0.000s)
[69.358300] [012/165] (933s left) gem_basic (create-fd-close)
[69.467241] Starting subtest: create-fd-close
[69.469292] Subtest create-fd-close: SUCCESS (0.000s)
[69.548355] [013/165] (933s left) gem_busy (busy@all-engines)
[69.666628] Starting subtest: busy
[69.667723] Starting dynamic subtest: all-engines
[69.832734] Dynamic subtest all-engines: SUCCESS (0.166s)
[69.833841] Subtest busy: SUCCESS (0.166s)
[70.273423] [014/165] (932s left) gem_close_race (basic-process)
[70.406524] Starting subtest: basic-process
[70.465477] Subtest basic-process: SUCCESS (0.059s)
[70.687543] [015/165] (932s left) gem_close_race (basic-threads)
[70.818677] Starting subtest: basic-threads
[72.167439] Subtest basic-threads: SUCCESS (1.349s)
[72.416292] [016/165] (930s left) gem_ctx_create (basic)
[72.544083] Starting subtest: basic
[72.545238] Subtest basic: SUCCESS (0.000s)
[72.747353] [017/165] (930s left) gem_ctx_create (basic-files)
[72.841118] Starting subtest: basic-files
[74.863432] Subtest basic-files: SUCCESS (2.022s)
[75.172534] [018/165] (927s left) gem_ctx_exec (basic)
[75.253401] Starting subtest: basic
[75.261097] Subtest basic: SUCCESS (0.008s)
[75.403871] [019/165] (927s left) gem_exec_basic (basic)
[75.500815] Starting subtest: basic
[75.501938] Starting dynamic subtest: rcs0-smem
[75.505070] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[75.512529] Starting dynamic subtest: bcs0-smem
[75.513558] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[75.521741] Starting dynamic subtest: vcs0-smem
[75.522803] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[75.528632] Starting dynamic subtest: vcs1-smem
[75.529606] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[75.535596] Starting dynamic subtest: vecs0-smem
[75.536750] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[75.542655] Starting dynamic subtest: vecs1-smem
[75.543817] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[75.549737] Starting dynamic subtest: ccs0-smem
[75.550863] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[75.556843] Starting dynamic subtest: ccs1-smem
[75.558037] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[75.564067] Starting dynamic subtest: ccs2-smem
[75.565240] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[75.571161] Starting dynamic subtest: ccs3-smem
[75.572229] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[75.578320] Starting dynamic subtest: rcs0-lmem0
[75.579524] Dynamic subtest rcs0-lmem0: SUCCESS (0.002s)
[75.585513] Starting dynamic subtest: bcs0-lmem0
[75.586625] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[75.592573] Starting dynamic subtest: vcs0-lmem0
[75.593454] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[75.599451] Starting dynamic subtest: vcs1-lmem0
[75.600580] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[75.606663] Starting dynamic subtest: vecs0-lmem0
[75.607736] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[75.613720] Starting dynamic subtest: vecs1-lmem0
[75.614842] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[75.620750] Starting dynamic subtest: ccs0-lmem0
[75.621735] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[75.627516] Starting dynamic subtest: ccs1-lmem0
[75.628521] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[75.634462] Starting dynamic subtest: ccs2-lmem0
[75.635635] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[75.641592] Starting dynamic subtest: ccs3-lmem0
[75.642751] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[75.643778] Subtest basic: SUCCESS (0.021s)
[75.704409] [020/165] (927s left) gem_exec_create (basic)
[75.799753] Starting subtest: basic
[75.800855] Starting dynamic subtest: smem
[77.911601] Dynamic subtest smem: SUCCESS (2.112s)
[77.918635] Starting dynamic subtest: lmem0
[80.035275] Dynamic subtest lmem0: SUCCESS (2.123s)
[80.036369] Subtest basic: SUCCESS (4.235s)
[80.255063] [021/165] (922s left) gem_exec_fence (basic-busy)
[80.531111] Starting subtest: basic-busy
[80.532592] Starting dynamic subtest: rcs0
[80.628592] Dynamic subtest rcs0: SUCCESS (0.098s)
[80.636508] Starting dynamic subtest: bcs0
[80.685645] Dynamic subtest bcs0: SUCCESS (0.056s)
[80.713230] Starting dynamic subtest: vcs0
[80.748650] Dynamic subtest vcs0: SUCCESS (0.062s)
[80.775321] Starting dynamic subtest: vcs1
[80.810605] Dynamic subtest vcs1: SUCCESS (0.062s)
[80.833489] Starting dynamic subtest: vecs0
[80.867632] Dynamic subtest vecs0: SUCCESS (0.056s)
[80.894571] Starting dynamic subtest: vecs1
[80.928975] Dynamic subtest vecs1: SUCCESS (0.062s)
[80.940101] Starting dynamic subtest: ccs0
[80.980618] Dynamic subtest ccs0: SUCCESS (0.050s)
[81.007641] Starting dynamic subtest: ccs1
[81.040415] Dynamic subtest ccs1: SUCCESS (0.059s)
[81.067859] Starting dynamic subtest: ccs2
[81.096374] Dynamic subtest ccs2: SUCCESS (0.056s)
[81.110358] Starting dynamic subtest: ccs3
[81.148623] Dynamic subtest ccs3: SUCCESS (0.051s)
[81.151219] Subtest basic-busy: SUCCESS (0.617s)
[82.390883] [022/165] (920s left) gem_exec_fence (basic-wait)
[82.665810] Starting subtest: basic-wait
[82.667318] Starting dynamic subtest: rcs0
[82.783041] Dynamic subtest rcs0: SUCCESS (0.117s)
[82.791978] Starting dynamic subtest: bcs0
[82.831560] Dynamic subtest bcs0: SUCCESS (0.048s)
[82.842606] Starting dynamic subtest: vcs0
[82.888625] Dynamic subtest vcs0: SUCCESS (0.056s)
[82.916990] Starting dynamic subtest: vcs1
[82.948640] Dynamic subtest vcs1: SUCCESS (0.059s)
[82.975332] Starting dynamic subtest: vecs0
[83.008985] Dynamic subtest vecs0: SUCCESS (0.060s)
[83.036817] Starting dynamic subtest: vecs1
[83.071600] Dynamic subtest vecs1: SUCCESS (0.062s)
[83.099066] Starting dynamic subtest: ccs0
[83.131581] Dynamic subtest ccs0: SUCCESS (0.060s)
[83.154706] Starting dynamic subtest: ccs1
[83.188595] Dynamic subtest ccs1: SUCCESS (0.056s)
[83.215279] Starting dynamic subtest: ccs2
[83.248999] Dynamic subtest ccs2: SUCCESS (0.060s)
[83.272123] Starting dynamic subtest: ccs3
[83.303562] Dynamic subtest ccs3: SUCCESS (0.054s)
[83.306184] Subtest basic-wait: SUCCESS (0.637s)
[84.510970] [023/165] (918s left) gem_exec_fence (basic-await)
[84.809744] Starting subtest: basic-await
[84.811367] Starting dynamic subtest: rcs0
[84.972734] Dynamic subtest rcs0: SUCCESS (0.163s)
[84.980279] Starting dynamic subtest: bcs0
[85.096559] Dynamic subtest bcs0: SUCCESS (0.124s)
[85.103892] Starting dynamic subtest: vcs0
[85.219071] Dynamic subtest vcs0: SUCCESS (0.122s)
[85.225253] Starting dynamic subtest: vcs1
[85.337311] Dynamic subtest vcs1: SUCCESS (0.118s)
[85.343727] Starting dynamic subtest: vecs0
[85.454631] Dynamic subtest vecs0: SUCCESS (0.117s)
[85.460860] Starting dynamic subtest: vecs1
[85.571612] Dynamic subtest vecs1: SUCCESS (0.117s)
[85.577896] Starting dynamic subtest: ccs0
[85.689306] Dynamic subtest ccs0: SUCCESS (0.118s)
[85.695859] Starting dynamic subtest: ccs1
[85.805918] Dynamic subtest ccs1: SUCCESS (0.117s)
[85.812313] Starting dynamic subtest: ccs2
[85.923268] Dynamic subtest ccs2: SUCCESS (0.117s)
[85.929618] Starting dynamic subtest: ccs3
[86.042107] Dynamic subtest ccs3: SUCCESS (0.119s)
[86.043051] Subtest basic-await: SUCCESS (1.233s)
[87.310167] [024/165] (915s left) gem_exec_fence (nb-await)
[87.581358] Starting subtest: nb-await
[87.582813] Starting dynamic subtest: rcs0
[87.697548] Dynamic subtest rcs0: SUCCESS (0.116s)
[87.706022] Starting dynamic subtest: bcs0
[87.767815] Dynamic subtest bcs0: SUCCESS (0.070s)
[87.776561] Starting dynamic subtest: vcs0
[87.838520] Dynamic subtest vcs0: SUCCESS (0.070s)
[87.852703] Starting dynamic subtest: vcs1
[87.926117] Dynamic subtest vcs1: SUCCESS (0.086s)
[87.953733] Starting dynamic subtest: vecs0
[88.027470] Dynamic subtest vecs0: SUCCESS (0.102s)
[88.039866] Starting dynamic subtest: vecs1
[88.113375] Dynamic subtest vecs1: SUCCESS (0.085s)
[88.140339] Starting dynamic subtest: ccs0
[88.211139] Dynamic subtest ccs0: SUCCESS (0.098s)
[88.217771] Starting dynamic subtest: ccs1
[88.280673] Dynamic subtest ccs1: SUCCESS (0.069s)
[88.299080] Starting dynamic subtest: ccs2
[88.374792] Dynamic subtest ccs2: SUCCESS (0.094s)
[88.388462] Starting dynamic subtest: ccs3
[88.461175] Dynamic subtest ccs3: SUCCESS (0.086s)
[88.463233] Subtest nb-await: SUCCESS (0.880s)
[89.729074] [025/165] (913s left) gem_exec_gttfill (basic)
[89.836705] Starting subtest: basic
[97.525064] Subtest basic: SUCCESS (7.688s)
[97.789782] [026/165] (905s left) gem_exec_parallel (engines)
[97.946213] Starting subtest: engines
[97.947280] Starting dynamic subtest: basic
[100.028751] Dynamic subtest basic: SUCCESS (2.082s)
[100.040890] Starting dynamic subtest: contexts
[104.731824] Dynamic subtest contexts: SUCCESS (4.703s)
[104.739318] Starting dynamic subtest: fds
[110.077415] Dynamic subtest fds: SUCCESS (5.345s)
[110.084723] Starting dynamic subtest: userptr
[111.887399] Dynamic subtest userptr: SUCCESS (1.810s)
[111.888648] Subtest engines: SUCCESS (13.941s)
[112.176985] [027/165] (890s left) gem_exec_store (basic)
[112.277225] Starting subtest: basic
[112.443563] Subtest basic: SUCCESS (0.166s)
[112.720339] [028/165] (890s left) gem_flink_basic (bad-flink)
[112.807190] Starting subtest: bad-flink
[112.808196] Subtest bad-flink: SUCCESS (0.000s)
[112.923203] [029/165] (890s left) gem_flink_basic (bad-open)
[113.017312] Starting subtest: bad-open
[113.018462] Subtest bad-open: SUCCESS (0.000s)
[113.097044] [030/165] (889s left) gem_flink_basic (basic)
[113.190233] Starting subtest: basic
[113.191266] Subtest basic: SUCCESS (0.000s)
[113.285925] [031/165] (889s left) gem_flink_basic (double-flink)
[113.393299] Starting subtest: double-flink
[113.394423] Subtest double-flink: SUCCESS (0.000s)
[113.504350] [032/165] (889s left) gem_flink_basic (flink-lifetime)
[113.603144] Starting subtest: flink-lifetime
[113.607234] Subtest flink-lifetime: SUCCESS (0.004s)
[113.740506] [033/165] (889s left) gem_huc_copy (huc-copy)
[113.870061] Starting subtest: huc-copy
[113.876401] Subtest huc-copy: SUCCESS (0.006s)
[114.023118] [034/165] (889s left) gem_linear_blits (basic)
[114.258828] Starting subtest: basic
[114.312454] Subtest basic: SUCCESS (0.054s)
[114.469110] [035/165] (888s left) gem_mmap (basic)
[114.591372] Subtest basic: SKIP (0.000s)
[114.626355] [036/165] (888s left) gem_mmap_gtt (basic)
[114.708206] Subtest basic: SKIP (0.000s)
[114.742963] [037/165] (888s left) gem_render_linear_blits (basic)
[114.835790] Starting subtest: basic
[114.932306] Subtest basic: SUCCESS (0.097s)
[115.010451] [038/165] (888s left) gem_render_tiled_blits (basic)
[115.106530] Subtest basic: SKIP (0.000s)
[115.159629] [039/165] (888s left) gem_ringfill (basic-all)
[115.623294] Starting subtest: basic-all
[119.292932] Subtest basic-all: SUCCESS (3.671s)
[119.393309] [040/165] (883s left) gem_softpin (allocator-basic)
[119.488400] Starting subtest: allocator-basic
[119.790055] Subtest allocator-basic: SUCCESS (0.301s)
[119.937042] [041/165] (883s left) gem_softpin (allocator-basic-reserve)
[120.026993] Starting subtest: allocator-basic-reserve
[120.331128] Subtest allocator-basic-reserve: SUCCESS (0.304s)
[120.487575] [042/165] (882s left) gem_softpin (safe-alignment)
[120.597242] Starting subtest: safe-alignment
[120.678156] Subtest safe-alignment: SUCCESS (0.081s)
[120.783117] [043/165] (882s left) gem_sync (basic-all)
[120.881296] Starting subtest: basic-all
[124.980558] Subtest basic-all: SUCCESS (4.099s)
[125.159263] [044/165] (878s left) gem_sync (basic-each)
[125.258542] Starting subtest: basic-each
[127.959706] Subtest basic-each: SUCCESS (2.701s)
[128.159174] [045/165] (875s left) gem_tiled_blits (basic)
[128.250580] Subtest basic: SKIP (0.000s)
[128.276358] [046/165] (875s left) gem_tiled_fence_blits (basic)
[128.370164] Subtest basic: SKIP (0.000s)
[128.426619] [047/165] (874s left) gem_tiled_pread_basic
[128.561927] [048/165] (874s left) gem_wait (busy@all-engines)
[128.678094] Starting subtest: busy
[128.679100] Starting dynamic subtest: all-engines
[129.266635] Dynamic subtest all-engines: SUCCESS (0.588s)
[129.267709] Subtest busy: SUCCESS (0.589s)
[129.519163] [049/165] (873s left) gem_wait (wait@all-engines)
[129.634249] Starting subtest: wait
[129.635254] Starting dynamic subtest: all-engines
[130.742072] Dynamic subtest all-engines: SUCCESS (1.107s)
[130.743539] Subtest wait: SUCCESS (1.107s)
[131.093413] [050/165] (872s left) i915_getparams_basic (basic-eu-total)
[131.174317] Starting subtest: basic-eu-total
[131.176444] Subtest basic-eu-total: SUCCESS (0.000s)
[131.271371] [051/165] (872s left) i915_getparams_basic (basic-subslice-total)
[131.357270] Starting subtest: basic-subslice-total
[131.359414] Subtest basic-subslice-total: SUCCESS (0.000s)
[131.467410] [052/165] (871s left) i915_hangman (error-state-basic)
[131.596704] Starting subtest: error-state-basic
[131.788231] Subtest error-state-basic: SUCCESS (0.191s)
[131.874764] [053/165] (871s left) i915_pciid
[132.059117] [054/165] (871s left) kms_addfb_basic (addfb25-4-tiled)
[132.238398] Starting subtest: addfb25-4-tiled
[132.239443] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[132.324609] [055/165] (871s left) kms_addfb_basic (addfb25-bad-modifier)
[132.419447] Starting subtest: addfb25-bad-modifier
[132.420552] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[132.556795] [056/165] (870s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[132.637787] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[132.792935] [057/165] (870s left) kms_addfb_basic (addfb25-modifier-no-flag)
[132.877383] Starting subtest: addfb25-modifier-no-flag
[132.878449] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[133.023617] [058/165] (870s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[133.106363] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[133.259774] [059/165] (870s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[133.348192] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[133.490277] [060/165] (870s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[133.637490] Starting subtest: addfb25-yf-tiled-legacy
[133.638562] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[133.724812] [061/165] (869s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[133.875883] Starting subtest: addfb25-y-tiled-legacy
[133.876882] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[133.957907] [062/165] (869s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[134.112137] Starting subtest: addfb25-y-tiled-small-legacy
[134.114088] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[134.190248] [063/165] (869s left) kms_addfb_basic (bad-pitch-0)
[134.274369] Starting subtest: bad-pitch-0
[134.275441] Subtest bad-pitch-0: SUCCESS (0.000s)
[134.425091] [064/165] (869s left) kms_addfb_basic (bad-pitch-1024)
[134.515251] Starting subtest: bad-pitch-1024
[134.516271] Subtest bad-pitch-1024: SUCCESS (0.000s)
[134.656775] [065/165] (869s left) kms_addfb_basic (bad-pitch-128)
[134.736317] Starting subtest: bad-pitch-128
[134.737406] Subtest bad-pitch-128: SUCCESS (0.000s)
[134.895020] [066/165] (868s left) kms_addfb_basic (bad-pitch-256)
[134.995253] Starting subtest: bad-pitch-256
[134.996326] Subtest bad-pitch-256: SUCCESS (0.000s)
[135.140698] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[135.225297] Starting subtest: bad-pitch-32
[135.226375] Subtest bad-pitch-32: SUCCESS (0.000s)
[135.375083] [068/165] (868s left) kms_addfb_basic (bad-pitch-63)
[135.462357] Starting subtest: bad-pitch-63
[135.463388] Subtest bad-pitch-63: SUCCESS (0.000s)
[135.627989] [069/165] (868s left) kms_addfb_basic (bad-pitch-65536)
[135.724316] Starting subtest: bad-pitch-65536
[135.725417] Subtest bad-pitch-65536: SUCCESS (0.000s)
[135.875494] [070/165] (867s left) kms_addfb_basic (bad-pitch-999)
[135.970397] Starting subtest: bad-pitch-999
[135.971470] Subtest bad-pitch-999: SUCCESS (0.000s)
[136.126632] [071/165] (867s left) kms_addfb_basic (basic)
[136.217392] Starting subtest: basic
[136.218477] Subtest basic: SUCCESS (0.000s)
[136.356989] [072/165] (867s left) kms_addfb_basic (basic-x-tiled-legacy)
[136.441318] Starting subtest: basic-x-tiled-legacy
[136.443373] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[136.593105] [073/165] (867s left) kms_addfb_basic (basic-y-tiled-legacy)
[136.687365] Starting subtest: basic-y-tiled-legacy
[136.689431] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[136.823767] [074/165] (867s left) kms_addfb_basic (bo-too-small)
[136.974123] Starting subtest: bo-too-small
[136.975191] Subtest bo-too-small: SUCCESS (0.000s)
[137.058141] [075/165] (866s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[137.213316] Starting subtest: bo-too-small-due-to-tiling
[137.215435] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[137.310283] [076/165] (866s left) kms_addfb_basic (clobberred-modifier)
[137.402263] Starting subtest: clobberred-modifier
[137.404281] Subtest clobberred-modifier: SKIP (0.000s)
[137.560129] [077/165] (866s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[137.652184] Starting subtest: framebuffer-vs-set-tiling
[137.660985] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[137.794213] [078/165] (866s left) kms_addfb_basic (invalid-get-prop)
[137.880407] Starting subtest: invalid-get-prop
[137.881472] Subtest invalid-get-prop: SUCCESS (0.000s)
[138.023761] [079/165] (865s left) kms_addfb_basic (invalid-get-prop-any)
[138.109188] Starting subtest: invalid-get-prop-any
[138.110197] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[138.256978] [080/165] (865s left) kms_addfb_basic (invalid-set-prop)
[138.342430] Starting subtest: invalid-set-prop
[138.343539] Subtest invalid-set-prop: SUCCESS (0.000s)
[138.490479] [081/165] (865s left) kms_addfb_basic (invalid-set-prop-any)
[138.571399] Starting subtest: invalid-set-prop-any
[138.572485] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[138.706635] [082/165] (865s left) kms_addfb_basic (no-handle)
[138.788317] Starting subtest: no-handle
[138.789399] Subtest no-handle: SUCCESS (0.000s)
[138.924060] [083/165] (865s left) kms_addfb_basic (size-max)
[139.070094] Starting subtest: size-max
[139.071205] Subtest size-max: SUCCESS (0.000s)
[139.159762] [084/165] (864s left) kms_addfb_basic (small-bo)
[139.311412] Starting subtest: small-bo
[139.312484] Subtest small-bo: SUCCESS (0.000s)
[139.390543] [085/165] (864s left) kms_addfb_basic (tile-pitch-mismatch)
[139.478975] Starting subtest: tile-pitch-mismatch
[139.481030] Subtest tile-pitch-mismatch: SKIP (0.000s)
[139.645656] [086/165] (864s left) kms_addfb_basic (too-high)
[139.819422] Starting subtest: too-high
[139.820511] Subtest too-high: SUCCESS (0.001s)
[139.909757] [087/165] (864s left) kms_addfb_basic (too-wide)
[140.066133] Starting subtest: too-wide
[140.067172] Subtest too-wide: SUCCESS (0.000s)
[140.140303] [088/165] (863s left) kms_addfb_basic (unused-handle)
[140.223242] Starting subtest: unused-handle
[140.224305] Subtest unused-handle: SUCCESS (0.000s)
[140.375035] [089/165] (863s left) kms_addfb_basic (unused-modifier)
[140.464362] Starting subtest: unused-modifier
[140.465461] Subtest unused-modifier: SUCCESS (0.000s)
[140.628963] [090/165] (863s left) kms_addfb_basic (unused-offsets)
[140.722242] Starting subtest: unused-offsets
[140.723278] Subtest unused-offsets: SUCCESS (0.000s)
[140.857513] [091/165] (863s left) kms_addfb_basic (unused-pitches)
[140.943231] Starting subtest: unused-pitches
[140.944160] Subtest unused-pitches: SUCCESS (0.000s)
[141.090575] [092/165] (863s left) kms_busy (basic)
[141.247722] Starting subtest: basic
[141.250199] Starting dynamic subtest: flip
[142.010122] Dynamic subtest flip: SUCCESS (0.761s)
[142.018049] Starting dynamic subtest: modeset
[143.117165] Dynamic subtest modeset: SUCCESS (1.106s)
[143.118151] Subtest basic: SUCCESS (1.869s)
[143.382110] [093/165] (860s left) kms_prop_blob (basic)
[143.474255] Starting subtest: basic
[143.475318] Subtest basic: SUCCESS (0.000s)
[143.579992] [094/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[143.734779] Starting subtest: basic-busy-flip-before-cursor-atomic
[143.736922] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[143.801848] [095/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[143.952130] Starting subtest: basic-busy-flip-before-cursor-legacy
[143.954202] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[144.018730] [096/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[144.166615] Starting subtest: basic-flip-after-cursor-atomic
[145.254450] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.087s)
[145.502672] [097/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[145.651355] Starting subtest: basic-flip-after-cursor-legacy
[146.734753] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.083s)
[146.982774] [098/165] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[147.136730] Starting subtest: basic-flip-after-cursor-varying-size
[148.221824] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.085s)
[148.478533] [099/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[148.652229] Starting subtest: basic-flip-before-cursor-atomic
[149.733844] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.082s)
[149.966344] [100/165] (854s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[150.125489] Starting subtest: basic-flip-before-cursor-legacy
[151.209579] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.084s)
[151.451781] [101/165] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[151.614022] Starting subtest: basic-flip-before-cursor-varying-size
[152.709462] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.096s)
[152.981593] [102/165] (851s left) kms_dsc (dsc-basic)
[153.136115] Starting subtest: dsc-basic
[153.137162] Starting dynamic subtest: pipe-A-DP-1
[153.608676] Dynamic subtest pipe-A-DP-1: SUCCESS (0.473s)
[153.616951] Starting dynamic subtest: pipe-B-DP-1
[154.003892] Dynamic subtest pipe-B-DP-1: SUCCESS (0.394s)
[154.012178] Starting dynamic subtest: pipe-C-DP-1
[154.437348] Dynamic subtest pipe-C-DP-1: SUCCESS (0.433s)
[154.445442] Starting dynamic subtest: pipe-D-DP-1
[154.810724] Dynamic subtest pipe-D-DP-1: SUCCESS (0.373s)
[154.811840] Subtest dsc-basic: SUCCESS (1.676s)
[155.116194] [103/165] (849s left) kms_flip (basic-flip-vs-dpms)
[155.279954] Starting subtest: basic-flip-vs-dpms
[155.284736] Starting dynamic subtest: A-DP1
[156.243209] Dynamic subtest A-DP1: SUCCESS (0.957s)
[156.251593] Starting dynamic subtest: B-DP1
[157.200356] Dynamic subtest B-DP1: SUCCESS (0.956s)
[157.208806] Starting dynamic subtest: C-DP1
[158.125394] Dynamic subtest C-DP1: SUCCESS (0.924s)
[158.133712] Starting dynamic subtest: D-DP1
[159.099410] Dynamic subtest D-DP1: SUCCESS (0.973s)
[159.103557] Subtest basic-flip-vs-dpms: SUCCESS (3.825s)
[159.346619] [104/165] (845s left) kms_flip (basic-flip-vs-modeset)
[159.503011] Starting subtest: basic-flip-vs-modeset
[159.508453] Starting dynamic subtest: A-DP1
[160.479904] Dynamic subtest A-DP1: SUCCESS (0.971s)
[160.492681] Starting dynamic subtest: B-DP1
[161.456904] Dynamic subtest B-DP1: SUCCESS (0.975s)
[161.465610] Starting dynamic subtest: C-DP1
[162.447631] Dynamic subtest C-DP1: SUCCESS (0.990s)
[162.455868] Starting dynamic subtest: D-DP1
[163.408034] Dynamic subtest D-DP1: SUCCESS (0.959s)
[163.412385] Subtest basic-flip-vs-modeset: SUCCESS (3.911s)
[163.682112] [105/165] (840s left) kms_flip (basic-flip-vs-wf_vblank)
[163.856160] Starting subtest: basic-flip-vs-wf_vblank
[163.860319] Starting dynamic subtest: A-DP1
[165.103548] Dynamic subtest A-DP1: SUCCESS (1.243s)
[165.120559] Starting dynamic subtest: B-DP1
[166.244934] Dynamic subtest B-DP1: SUCCESS (1.140s)
[166.255184] Starting dynamic subtest: C-DP1
[167.386128] Dynamic subtest C-DP1: SUCCESS (1.140s)
[167.396651] Starting dynamic subtest: D-DP1
[168.527141] Dynamic subtest D-DP1: SUCCESS (1.140s)
[168.534019] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.680s)
[168.842363] [106/165] (835s left) kms_flip (basic-plain-flip)
[169.002244] Starting subtest: basic-plain-flip
[169.007025] Starting dynamic subtest: A-DP1
[169.959849] Dynamic subtest A-DP1: SUCCESS (0.953s)
[169.972365] Starting dynamic subtest: B-DP1
[170.818482] Dynamic subtest B-DP1: SUCCESS (0.857s)
[170.829423] Starting dynamic subtest: C-DP1
[171.682724] Dynamic subtest C-DP1: SUCCESS (0.863s)
[171.693254] Starting dynamic subtest: D-DP1
[172.546551] Dynamic subtest D-DP1: SUCCESS (0.862s)
[172.552605] Subtest basic-plain-flip: SUCCESS (3.552s)
[172.885282] [107/165] (831s left) kms_force_connector_basic (force-connector-state)
[172.981431] Starting subtest: force-connector-state
[173.233039] Subtest force-connector-state: SUCCESS (0.253s)
[173.519349] [108/165] (831s left) kms_force_connector_basic (force-edid)
[173.606506] Starting subtest: force-edid
[173.623456] Subtest force-edid: SUCCESS (0.016s)
[173.819189] [109/165] (830s left) kms_force_connector_basic (force-load-detect)
[173.907014] Starting subtest: force-load-detect
[173.908999] Subtest force-load-detect: SKIP (0.000s)
[174.034686] [110/165] (830s left) kms_force_connector_basic (prune-stale-modes)
[174.119464] Starting subtest: prune-stale-modes
[174.129282] Subtest prune-stale-modes: SKIP (0.009s)
[174.302803] [111/165] (830s left) kms_frontbuffer_tracking (basic)
[174.456896] Starting subtest: basic
[178.280277] Subtest basic: SUCCESS (3.823s)
[178.434347] [112/165] (826s left) kms_hdmi_inject (inject-audio)
[178.604575] Starting subtest: inject-audio
[178.704722] Subtest inject-audio: SUCCESS (0.101s)
[179.008054] [113/165] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[179.163778] Starting subtest: compare-crc-sanitycheck-xr24
[179.166686] Starting dynamic subtest: pipe-A-DP-1
[179.777198] Dynamic subtest pipe-A-DP-1: SUCCESS (0.610s)
[179.785656] Starting dynamic subtest: pipe-B-DP-1
[180.351554] Dynamic subtest pipe-B-DP-1: SUCCESS (0.573s)
[180.361573] Starting dynamic subtest: pipe-C-DP-1
[180.911918] Dynamic subtest pipe-C-DP-1: SUCCESS (0.557s)
[180.922078] Starting dynamic subtest: pipe-D-DP-1
[181.497867] Dynamic subtest pipe-D-DP-1: SUCCESS (0.584s)
[181.499050] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.335s)
[181.778569] [114/165] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[181.948474] Starting subtest: compare-crc-sanitycheck-nv12
[181.949557] Starting dynamic subtest: pipe-A-DP-1
[183.312603] Dynamic subtest pipe-A-DP-1: SUCCESS (1.363s)
[183.323013] Starting dynamic subtest: pipe-B-DP-1
[184.560617] Dynamic subtest pipe-B-DP-1: SUCCESS (1.245s)
[184.570709] Starting dynamic subtest: pipe-C-DP-1
[185.746424] Dynamic subtest pipe-C-DP-1: SUCCESS (1.183s)
[185.756550] Starting dynamic subtest: pipe-D-DP-1
[186.839574] Dynamic subtest pipe-D-DP-1: SUCCESS (1.090s)
[186.840683] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.893s)
[187.082799] [115/165] (817s left) kms_pipe_crc_basic (hang-read-crc)
[187.253551] Starting subtest: hang-read-crc
[187.254589] Starting dynamic subtest: pipe-A-DP-1
[188.962012] Dynamic subtest pipe-A-DP-1: SUCCESS (1.707s)
[188.973324] Starting dynamic subtest: pipe-B-DP-1
[190.588605] Dynamic subtest pipe-B-DP-1: SUCCESS (1.624s)
[190.598768] Starting dynamic subtest: pipe-C-DP-1
[192.153417] Dynamic subtest pipe-C-DP-1: SUCCESS (1.562s)
[192.163618] Starting dynamic subtest: pipe-D-DP-1
[193.797498] Dynamic subtest pipe-D-DP-1: SUCCESS (1.641s)
[193.798526] Subtest hang-read-crc: SUCCESS (6.545s)
[194.044235] [116/165] (810s left) kms_pipe_crc_basic (nonblocking-crc)
[194.212023] Starting subtest: nonblocking-crc
[194.213154] Starting dynamic subtest: pipe-A-DP-1
[195.011560] Dynamic subtest pipe-A-DP-1: SUCCESS (0.798s)
[195.021539] Starting dynamic subtest: pipe-B-DP-1
[195.770602] Dynamic subtest pipe-B-DP-1: SUCCESS (0.756s)
[195.780798] Starting dynamic subtest: pipe-C-DP-1
[196.532061] Dynamic subtest pipe-C-DP-1: SUCCESS (0.758s)
[196.541871] Starting dynamic subtest: pipe-D-DP-1
[197.247205] Dynamic subtest pipe-D-DP-1: SUCCESS (0.712s)
[197.248281] Subtest nonblocking-crc: SUCCESS (3.035s)
[197.482112] [117/165] (807s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[197.647329] Starting subtest: nonblocking-crc-frame-sequence
[197.650334] Starting dynamic subtest: pipe-A-DP-1
[198.452041] Dynamic subtest pipe-A-DP-1: SUCCESS (0.801s)
[198.461583] Starting dynamic subtest: pipe-B-DP-1
[199.203488] Dynamic subtest pipe-B-DP-1: SUCCESS (0.750s)
[199.213847] Starting dynamic subtest: pipe-C-DP-1
[199.930415] Dynamic subtest pipe-C-DP-1: SUCCESS (0.725s)
[199.940632] Starting dynamic subtest: pipe-D-DP-1
[200.698349] Dynamic subtest pipe-D-DP-1: SUCCESS (0.765s)
[200.699312] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.052s)
[200.950849] [118/165] (803s left) kms_pipe_crc_basic (read-crc)
[201.117555] Starting subtest: read-crc
[201.118699] Starting dynamic subtest: pipe-A-DP-1
[201.848663] Dynamic subtest pipe-A-DP-1: SUCCESS (0.729s)
[201.858688] Starting dynamic subtest: pipe-B-DP-1
[202.545103] Dynamic subtest pipe-B-DP-1: SUCCESS (0.693s)
[202.555031] Starting dynamic subtest: pipe-C-DP-1
[203.204907] Dynamic subtest pipe-C-DP-1: SUCCESS (0.657s)
[203.214803] Starting dynamic subtest: pipe-D-DP-1
[203.869123] Dynamic subtest pipe-D-DP-1: SUCCESS (0.661s)
[203.870216] Subtest read-crc: SUCCESS (2.752s)
[204.125723] [119/165] (800s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[204.283287] Starting subtest: read-crc-frame-sequence
[204.284365] Starting dynamic subtest: pipe-A-DP-1
[205.063589] Dynamic subtest pipe-A-DP-1: SUCCESS (0.779s)
[205.073799] Starting dynamic subtest: pipe-B-DP-1
[205.735610] Dynamic subtest pipe-B-DP-1: SUCCESS (0.670s)
[205.745962] Starting dynamic subtest: pipe-C-DP-1
[206.447077] Dynamic subtest pipe-C-DP-1: SUCCESS (0.708s)
[206.456752] Starting dynamic subtest: pipe-D-DP-1
[207.144729] Dynamic subtest pipe-D-DP-1: SUCCESS (0.695s)
[207.145852] Subtest read-crc-frame-sequence: SUCCESS (2.863s)
[207.396441] [120/165] (797s left) kms_pm_backlight (basic-brightness)
[207.557619] Subtest basic-brightness: SKIP (0.000s)
[207.598047] [121/165] (797s left) kms_pm_rpm (basic-pci-d3-state)
[209.483218] Starting subtest: basic-pci-d3-state
[210.106411] Subtest basic-pci-d3-state: SUCCESS (0.620s)
[210.305907] [122/165] (794s left) kms_pm_rpm (basic-rte)
[210.393696] Starting subtest: basic-rte
[213.109974] Subtest basic-rte: SUCCESS (2.716s)
[213.721471] [123/165] (791s left) kms_psr (psr-primary-page-flip)
[213.886602] Subtest psr-primary-page-flip: SKIP (0.000s)
[213.927340] [124/165] (791s left) kms_psr (psr-cursor-plane-move)
[214.071721] Subtest psr-cursor-plane-move: SKIP (0.000s)
[214.110568] [125/165] (790s left) kms_psr (psr-sprite-plane-onoff)
[214.268814] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[214.310944] [126/165] (790s left) kms_psr (psr-primary-mmap-gtt)
[214.465426] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[214.493841] [127/165] (790s left) kms_setmode (basic-clone-single-crtc)
[214.582583] Starting subtest: basic-clone-single-crtc
[214.585598] Subtest basic-clone-single-crtc: SKIP (0.001s)
[214.723418] [128/165] (790s left) i915_pm_rps (basic-api)
[214.829291] Starting subtest: basic-api
[214.831470] Subtest basic-api: SKIP (0.000s)
[214.945331] [129/165] (790s left) prime_self_import (basic-llseek-bad)
[215.043698] Starting subtest: basic-llseek-bad
[215.056619] Subtest basic-llseek-bad: SUCCESS (0.014s)
[215.161147] [130/165] (789s left) prime_self_import (basic-llseek-size)
[215.253753] Starting subtest: basic-llseek-size
[215.264231] Subtest basic-llseek-size: SUCCESS (0.011s)
[215.381310] [131/165] (789s left) prime_self_import (basic-with_fd_dup)
[215.459226] Starting subtest: basic-with_fd_dup
[215.480858] Subtest basic-with_fd_dup: SUCCESS (0.023s)
[215.604478] [132/165] (789s left) prime_self_import (basic-with_one_bo)
[215.684654] Starting subtest: basic-with_one_bo
[215.689986] Subtest basic-with_one_bo: SUCCESS (0.013s)
[215.816778] [133/165] (789s left) prime_self_import (basic-with_one_bo_two_files)
[215.891798] Starting subtest: basic-with_one_bo_two_files
[215.906549] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[216.011555] [134/165] (789s left) prime_self_import (basic-with_two_bos)
[216.106466] Starting subtest: basic-with_two_bos
[216.122800] Subtest basic-with_two_bos: SUCCESS (0.017s)
[216.222608] [135/165] (789s left) prime_vgem (basic-fence-flip)
[216.350164] Starting subtest: basic-fence-flip
[216.464576] Subtest basic-fence-flip: SKIP (0.113s)
[216.588271] [136/165] (788s left) prime_vgem (basic-fence-mmap)
[216.712112] Starting subtest: basic-fence-mmap
[216.714487] Subtest basic-fence-mmap: SKIP (0.000s)
[216.839334] [137/165] (788s left) prime_vgem (basic-fence-read)
[216.958083] Starting subtest: basic-fence-read
[216.965190] Subtest basic-fence-read: SKIP (0.006s)
[217.108225] [138/165] (788s left) prime_vgem (basic-gtt)
[217.220840] Starting subtest: basic-gtt
[217.222736] Subtest basic-gtt: SKIP (0.000s)
[217.332208] [139/165] (788s left) prime_vgem (basic-read)
[217.441018] Starting subtest: basic-read
[217.447864] Subtest basic-read: SKIP (0.006s)
[217.592712] [140/165] (787s left) prime_vgem (basic-write)
[217.709772] Starting subtest: basic-write
[217.716585] Subtest basic-write: SKIP (0.006s)
[217.829414] [141/165] (787s left) vgem_basic (setversion)
[217.933517] Starting subtest: setversion
[217.935673] Subtest setversion: SUCCESS (0.000s)
[217.990213] [142/165] (787s left) vgem_basic (create)
[218.067067] Starting subtest: create
[218.068204] Subtest create: SUCCESS (0.000s)
[218.128234] [143/165] (787s left) vgem_basic (debugfs)
[218.216755] Starting subtest: debugfs
[218.217912] Subtest debugfs: SUCCESS (0.000s)
[218.276431] [144/165] (787s left) vgem_basic (dmabuf-export)
[218.366926] Starting subtest: dmabuf-export
[218.385088] Subtest dmabuf-export: SUCCESS (0.018s)
[218.505094] [145/165] (786s left) vgem_basic (dmabuf-fence)
[218.583387] Starting subtest: dmabuf-fence
[218.584401] Subtest dmabuf-fence: SUCCESS (0.000s)
[218.642890] [146/165] (786s left) vgem_basic (dmabuf-fence-before)
[218.733497] Starting subtest: dmabuf-fence-before
[218.734588] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[218.793238] [147/165] (786s left) vgem_basic (dmabuf-mmap)
[218.883526] Starting subtest: dmabuf-mmap
[218.895178] Subtest dmabuf-mmap: SUCCESS (0.012s)
[218.940209] [148/165] (786s left) vgem_basic (mmap)
[219.017085] Starting subtest: mmap
[219.025118] Subtest mmap: SUCCESS (0.008s)
[219.073298] [149/165] (786s left) vgem_basic (second-client)
[219.150201] Starting subtest: second-client
[219.183405] Subtest second-client: SUCCESS (0.033s)
[219.255652] [150/165] (786s left) vgem_basic (sysfs)
[219.367105] Starting subtest: sysfs
[219.368180] Subtest sysfs: SUCCESS (0.000s)
[219.425869] [151/165] (786s left) core_hotunplug (unbind-rebind)
[219.550180] Starting subtest: unbind-rebind
[229.236471] Subtest unbind-rebind: SUCCESS (9.687s)
[229.258561] [152/165] (776s left) vgem_basic (unload)
[229.331922] Starting subtest: unload
[258.306324] Subtest unload: SUCCESS (28.972s)
[258.418271] [153/165] (747s left) i915_module_load (reload)
[258.498858] Starting subtest: reload
[266.906241] Subtest reload: SUCCESS (8.408s)
[266.925048] [154/165] (738s left) gem_lmem_swapping (basic)
[275.483354] Starting subtest: basic
[275.484394] Starting dynamic subtest: lmem0
[303.662333] Dynamic subtest lmem0: SUCCESS (28.178s)
[303.663360] Subtest basic: SUCCESS (28.179s)
[306.099293] [155/165] (699s left) gem_lmem_swapping (parallel-random-engines)
[311.965258] Starting subtest: parallel-random-engines
[311.966258] Starting dynamic subtest: lmem0
[345.603080] Dynamic subtest lmem0: SUCCESS (33.637s)
[345.604193] Subtest parallel-random-engines: SUCCESS (33.638s)
[347.040818] [156/165] (658s left) gem_lmem_swapping (random-engines)
[352.946104] Starting subtest: random-engines
[352.947154] Starting dynamic subtest: lmem0
[354.215616] Dynamic subtest lmem0: SUCCESS (1.268s)
[354.216677] Subtest random-engines: SUCCESS (1.270s)
[355.606632] [157/165] (650s left) gem_lmem_swapping (verify-random)
[361.545163] Starting subtest: verify-random
[361.546175] Starting dynamic subtest: lmem0
[372.859500] Dynamic subtest lmem0: SUCCESS (11.313s)
[372.860578] Subtest verify-random: SUCCESS (11.315s)
[374.259442] [158/165] (631s left) i915_pm_rpm (module-reload)
[381.868295] Starting subtest: module-reload
[402.940195] Subtest module-reload: SUCCESS (21.072s)
[402.961849] [159/165] (602s left) i915_selftest (live)
[403.025226] Starting subtest: live
[403.026258] Starting dynamic subtest: sanitycheck
[409.929056] Dynamic subtest sanitycheck: SUCCESS (6.903s)
[409.937725] Starting dynamic subtest: uncore
[416.854082] Dynamic subtest uncore: SUCCESS (6.923s)
[416.861635] Starting dynamic subtest: workarounds
[426.349241] Dynamic subtest workarounds: SUCCESS (9.494s)
[426.356172] Starting dynamic subtest: gt_engines
[434.337478] Dynamic subtest gt_engines: SUCCESS (7.986s)
[434.344827] Starting dynamic subtest: gt_timelines
[479.439982] Dynamic subtest gt_timelines: SUCCESS (45.101s)
[479.447048] Starting dynamic subtest: gt_contexts
[486.410995] Dynamic subtest gt_contexts: SUCCESS (6.970s)
[486.421401] Starting dynamic subtest: gt_lrc
[500.788459] Dynamic subtest gt_lrc: SUCCESS (14.375s)
[500.796303] Starting dynamic subtest: gt_mocs
[509.609058] Dynamic subtest gt_mocs: SUCCESS (8.819s)
[509.618734] Starting dynamic subtest: gt_pm
[517.478251] Dynamic subtest gt_pm: SUCCESS (7.868s)
[517.487616] Starting dynamic subtest: gt_heartbeat
[524.626201] Dynamic subtest gt_heartbeat: SUCCESS (7.146s)
[524.633138] Starting dynamic subtest: gt_tlb
[546.789284] Dynamic subtest gt_tlb: SUCCESS (22.162s)
[546.798655] Starting dynamic subtest: requests
[570.177187] Dynamic subtest requests: SUCCESS (23.386s)
[570.186961] Starting dynamic subtest: migrate
[580.870272] Dynamic subtest migrate: SUCCESS (10.691s)
[580.879904] Starting dynamic subtest: active
[587.801194] Dynamic subtest active: SUCCESS (6.929s)
[587.810991] Starting dynamic subtest: objects
[596.030489] Dynamic subtest objects: SUCCESS (8.228s)
[596.040912] Starting dynamic subtest: mman
[612.676305] Dynamic subtest mman: SUCCESS (16.644s)
[612.686101] Starting dynamic subtest: dmabuf
[619.577029] Dynamic subtest dmabuf: SUCCESS (6.899s)
[619.584055] Starting dynamic subtest: vma
[626.455200] Dynamic subtest vma: SUCCESS (6.877s)
[626.462573] Starting dynamic subtest: coherency
[636.603210] Dynamic subtest coherency: SUCCESS (10.147s)
[636.613136] Starting dynamic subtest: gtt
[652.366268] Dynamic subtest gtt: SUCCESS (15.761s)
[652.374116] Starting dynamic subtest: gem
[659.335664] Dynamic subtest gem: SUCCESS (6.967s)
[659.343481] Starting dynamic subtest: evict
[668.549252] Dynamic subtest evict: SUCCESS (9.212s)
[668.558623] Starting dynamic subtest: hugepages
[692.773117] Dynamic subtest hugepages: SUCCESS (24.222s)
[692.780987] Starting dynamic subtest: gem_contexts
[746.408153] Dynamic subtest gem_contexts: SUCCESS (53.633s)
[746.415755] Starting dynamic subtest: client
[753.349373] Dynamic subtest client: SUCCESS (6.940s)
[753.359092] Starting dynamic subtest: gem_migrate
[763.382393] Dynamic subtest gem_migrate: SUCCESS (10.031s)
[763.392061] Starting dynamic subtest: reset
[770.381172] Dynamic subtest reset: SUCCESS (6.997s)
[770.390936] Starting dynamic subtest: memory_region
[778.803278] Dynamic subtest memory_region: SUCCESS (8.420s)
[778.812740] Starting dynamic subtest: hangcheck
[830.469088] Dynamic subtest hangcheck: SUCCESS (51.664s)
[830.479637] Starting dynamic subtest: execlists
[837.451062] Dynamic subtest execlists: SUCCESS (6.980s)
[837.458481] Starting dynamic subtest: ring_submission
[844.392064] Dynamic subtest ring_submission: SUCCESS (6.940s)
[844.401169] Starting dynamic subtest: perf
[851.470079] Dynamic subtest perf: SUCCESS (7.076s)
[851.477879] Starting dynamic subtest: slpc
[866.274052] Dynamic subtest slpc: SUCCESS (14.803s)
[866.282801] Starting dynamic subtest: guc
[874.769108] Dynamic subtest guc: SUCCESS (8.494s)
[874.777274] Starting dynamic subtest: guc_multi_lrc
[881.717275] Dynamic subtest guc_multi_lrc: SUCCESS (6.947s)
[881.727349] Starting dynamic subtest: guc_hang
[889.364946] Dynamic subtest guc_hang: SUCCESS (7.646s)
[889.373047] Starting dynamic subtest: late_gt_pm
[896.374377] Dynamic subtest late_gt_pm: SUCCESS (7.008s)
[896.375567] Subtest live: SUCCESS (493.349s)
[896.656182] [160/165] (109s left) dmabuf (all-tests)
[896.741312] Starting subtest: all-tests
[896.744276] Starting dynamic subtest: sanitycheck
[896.808628] Dynamic subtest sanitycheck: SUCCESS (0.067s)
[896.825124] Starting dynamic subtest: dma_fence
[897.001093] Dynamic subtest dma_fence: SUCCESS (0.190s)
[897.025536] Starting dynamic subtest: dma_fence_chain
[910.709594] Dynamic subtest dma_fence_chain: SUCCESS (13.704s)
[910.720720] Starting dynamic subtest: dma_fence_unwrap
[910.786238] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[910.799327] Starting dynamic subtest: dma_resv
[910.850608] Dynamic subtest dma_resv: SUCCESS (0.061s)
[910.851967] Subtest all-tests: SUCCESS (14.110s)
[910.891614] [161/165] ( 94s left) i915_suspend (basic-s2idle-without-i915)
[910.974944] Starting subtest: basic-s2idle-without-i915
[941.287189] Subtest basic-s2idle-without-i915: SUCCESS (15.465s)
[941.386737] [162/165] ( 79s left) i915_suspend (basic-s3-without-i915)
[941.457582] Starting subtest: basic-s3-without-i915
[944.016537] Subtest basic-s3-without-i915: SKIP (2.557s)
[949.797140] [163/165] ( 70s left) gem_exec_suspend (basic-s0)
[949.904175] Starting subtest: basic-S0
[949.905336] Starting dynamic subtest: smem
[971.687998] Dynamic subtest smem: SUCCESS (7.892s)
[971.698985] Starting dynamic subtest: lmem0