[33.579489] Initializing watchdogs
[33.579552]   /dev/watchdog0
[33.584627] [001/171] (960s left) i915_module_load (load)
[33.636246] Starting subtest: load
[34.681598] Subtest load: SUCCESS (1.044s)
[34.724927] [002/171] (959s left) core_auth (basic-auth)
[34.852865] Starting subtest: basic-auth
[34.853658] Subtest basic-auth: SUCCESS (0.001s)
[34.864044] [003/171] (959s left) debugfs_test (read_all_entries)
[34.929113] Starting subtest: read_all_entries
[35.250694] Subtest read_all_entries: SUCCESS (0.321s)
[35.366134] [004/171] (958s left) debugfs_test (basic-hwmon)
[35.427895] Starting subtest: basic-hwmon
[35.430464] Subtest basic-hwmon: SUCCESS (0.002s)
[35.545844] [005/171] (958s left) fbdev (eof)
[36.238312] Subtest eof: SKIP (0.000s)
[36.246939] [006/171] (957s left) fbdev (info)
[36.303237] Subtest info: SKIP (0.000s)
[36.311810] [007/171] (957s left) fbdev (nullptr)
[36.367032] Subtest nullptr: SKIP (0.000s)
[36.376940] [008/171] (957s left) fbdev (read)
[36.434304] Subtest read: SKIP (0.000s)
[36.442667] [009/171] (957s left) fbdev (write)
[36.497661] Subtest write: SKIP (0.000s)
[36.506249] [010/171] (957s left) gem_basic (bad-close)
[36.563895] Starting subtest: bad-close
[36.565590] Subtest bad-close: SUCCESS (0.000s)
[36.573062] [011/171] (957s left) gem_basic (create-close)
[36.627332] Starting subtest: create-close
[36.629162] Subtest create-close: SUCCESS (0.000s)
[36.647427] [012/171] (957s left) gem_basic (create-fd-close)
[36.703677] Starting subtest: create-fd-close
[36.705256] Subtest create-fd-close: SUCCESS (0.000s)
[36.723066] [013/171] (957s left) gem_busy (busy@all-engines)
[36.790810] Starting subtest: busy
[36.791664] Starting dynamic subtest: all-engines
[36.881405] Dynamic subtest all-engines: SUCCESS (0.091s)
[36.882214] Subtest busy: SUCCESS (0.091s)
[37.221529] [014/171] (957s left) gem_close_race (basic-process)
[37.356114] Starting subtest: basic-process
[37.394187] Subtest basic-process: SUCCESS (0.038s)
[37.552031] [015/171] (956s left) gem_close_race (basic-threads)
[37.641166] Starting subtest: basic-threads
[38.843352] Subtest basic-threads: SUCCESS (1.202s)
[39.021355] [016/171] (955s left) gem_ctx_create (basic)
[39.143284] Starting subtest: basic
[39.144188] Subtest basic: SUCCESS (0.000s)
[39.260835] [017/171] (955s left) gem_ctx_create (basic-files)
[39.337732] Starting subtest: basic-files
[41.348864] Subtest basic-files: SUCCESS (2.011s)
[42.409691] [018/171] (951s left) gem_ctx_exec (basic)
[42.483270] Starting subtest: basic
[42.490035] Subtest basic: SUCCESS (0.007s)
[42.539133] [019/171] (951s left) gem_exec_basic (basic)
[42.639733] Starting subtest: basic
[42.640562] Starting dynamic subtest: rcs0-smem
[42.643220] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[42.647782] Starting dynamic subtest: bcs0-smem
[42.648664] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[42.653829] Starting dynamic subtest: vcs0-smem
[42.654747] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[42.658947] Starting dynamic subtest: vcs1-smem
[42.659827] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[42.663948] Starting dynamic subtest: vecs0-smem
[42.664751] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[42.668840] Starting dynamic subtest: vecs1-smem
[42.669623] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[42.673702] Starting dynamic subtest: ccs0-smem
[42.674862] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[42.679319] Starting dynamic subtest: ccs1-smem
[42.680517] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[42.684830] Starting dynamic subtest: ccs2-smem
[42.685632] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[42.689761] Starting dynamic subtest: ccs3-smem
[42.690537] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[42.694626] Starting dynamic subtest: rcs0-lmem0
[42.695422] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[42.699933] Starting dynamic subtest: bcs0-lmem0
[42.701111] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[42.705617] Starting dynamic subtest: vcs0-lmem0
[42.706790] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[42.711198] Starting dynamic subtest: vcs1-lmem0
[42.712362] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[42.716874] Starting dynamic subtest: vecs0-lmem0
[42.718057] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[42.722546] Starting dynamic subtest: vecs1-lmem0
[42.723613] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[42.727989] Starting dynamic subtest: ccs0-lmem0
[42.729012] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[42.733515] Starting dynamic subtest: ccs1-lmem0
[42.734557] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[42.739052] Starting dynamic subtest: ccs2-lmem0
[42.739894] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[42.744447] Starting dynamic subtest: ccs3-lmem0
[42.745614] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[42.746545] Subtest basic: SUCCESS (0.014s)
[42.777968] [020/171] (951s left) gem_exec_create (basic)
[42.854513] Starting subtest: basic
[42.855433] Starting dynamic subtest: smem
[44.953983] Dynamic subtest smem: SUCCESS (2.099s)
[44.958411] Starting dynamic subtest: lmem0
[47.059998] Dynamic subtest lmem0: SUCCESS (2.106s)
[47.061170] Subtest basic: SUCCESS (4.205s)
[47.187519] [021/171] (947s left) gem_exec_fence (basic-busy)
[47.367165] Starting subtest: basic-busy
[47.368121] Starting dynamic subtest: rcs0
[47.452888] Dynamic subtest rcs0: SUCCESS (0.085s)
[47.459605] Starting dynamic subtest: bcs0
[47.501036] Dynamic subtest bcs0: SUCCESS (0.048s)
[47.510540] Starting dynamic subtest: vcs0
[47.559160] Dynamic subtest vcs0: SUCCESS (0.057s)
[47.575975] Starting dynamic subtest: vcs1
[47.613123] Dynamic subtest vcs1: SUCCESS (0.053s)
[47.631411] Starting dynamic subtest: vecs0
[47.675210] Dynamic subtest vecs0: SUCCESS (0.062s)
[47.693775] Starting dynamic subtest: vecs1
[47.731090] Dynamic subtest vecs1: SUCCESS (0.056s)
[47.749070] Starting dynamic subtest: ccs0
[47.789822] Dynamic subtest ccs0: SUCCESS (0.058s)
[47.808231] Starting dynamic subtest: ccs1
[47.845102] Dynamic subtest ccs1: SUCCESS (0.055s)
[47.863701] Starting dynamic subtest: ccs2
[47.900084] Dynamic subtest ccs2: SUCCESS (0.055s)
[47.918760] Starting dynamic subtest: ccs3
[47.956989] Dynamic subtest ccs3: SUCCESS (0.056s)
[47.958807] Subtest basic-busy: SUCCESS (0.589s)
[49.065025] [022/171] (945s left) gem_exec_fence (basic-wait)
[49.246593] Starting subtest: basic-wait
[49.247554] Starting dynamic subtest: rcs0
[49.327754] Dynamic subtest rcs0: SUCCESS (0.081s)
[49.335295] Starting dynamic subtest: bcs0
[49.383943] Dynamic subtest bcs0: SUCCESS (0.055s)
[49.402884] Starting dynamic subtest: vcs0
[49.442792] Dynamic subtest vcs0: SUCCESS (0.058s)
[49.461845] Starting dynamic subtest: vcs1
[49.494200] Dynamic subtest vcs1: SUCCESS (0.051s)
[49.513297] Starting dynamic subtest: vecs0
[49.547053] Dynamic subtest vecs0: SUCCESS (0.052s)
[49.566114] Starting dynamic subtest: vecs1
[49.606232] Dynamic subtest vecs1: SUCCESS (0.059s)
[49.625524] Starting dynamic subtest: ccs0
[49.661920] Dynamic subtest ccs0: SUCCESS (0.055s)
[49.681083] Starting dynamic subtest: ccs1
[49.718121] Dynamic subtest ccs1: SUCCESS (0.056s)
[49.737402] Starting dynamic subtest: ccs2
[49.779243] Dynamic subtest ccs2: SUCCESS (0.061s)
[49.798526] Starting dynamic subtest: ccs3
[49.840117] Dynamic subtest ccs3: SUCCESS (0.061s)
[49.842057] Subtest basic-wait: SUCCESS (0.593s)
[50.920159] [023/171] (943s left) gem_exec_fence (basic-await)
[51.106175] Starting subtest: basic-await
[51.107417] Starting dynamic subtest: rcs0
[51.235603] Dynamic subtest rcs0: SUCCESS (0.129s)
[51.240127] Starting dynamic subtest: bcs0
[51.327904] Dynamic subtest bcs0: SUCCESS (0.092s)
[51.333209] Starting dynamic subtest: vcs0
[51.424654] Dynamic subtest vcs0: SUCCESS (0.096s)
[51.429841] Starting dynamic subtest: vcs1
[51.522026] Dynamic subtest vcs1: SUCCESS (0.097s)
[51.527521] Starting dynamic subtest: vecs0
[51.618502] Dynamic subtest vecs0: SUCCESS (0.096s)
[51.623873] Starting dynamic subtest: vecs1
[51.714568] Dynamic subtest vecs1: SUCCESS (0.096s)
[51.719598] Starting dynamic subtest: ccs0
[51.809406] Dynamic subtest ccs0: SUCCESS (0.095s)
[51.813970] Starting dynamic subtest: ccs1
[51.899473] Dynamic subtest ccs1: SUCCESS (0.090s)
[51.904543] Starting dynamic subtest: ccs2
[51.993396] Dynamic subtest ccs2: SUCCESS (0.094s)
[51.998873] Starting dynamic subtest: ccs3
[52.088872] Dynamic subtest ccs3: SUCCESS (0.095s)
[52.089726] Subtest basic-await: SUCCESS (0.983s)
[53.188310] [024/171] (941s left) gem_exec_fence (nb-await)
[53.383183] Starting subtest: nb-await
[53.384669] Starting dynamic subtest: rcs0
[53.492172] Dynamic subtest rcs0: SUCCESS (0.109s)
[53.497589] Starting dynamic subtest: bcs0
[53.558471] Dynamic subtest bcs0: SUCCESS (0.065s)
[53.567484] Starting dynamic subtest: vcs0
[53.625931] Dynamic subtest vcs0: SUCCESS (0.068s)
[53.632398] Starting dynamic subtest: vcs1
[53.690771] Dynamic subtest vcs1: SUCCESS (0.065s)
[53.698421] Starting dynamic subtest: vecs0
[53.763848] Dynamic subtest vecs0: SUCCESS (0.072s)
[53.772147] Starting dynamic subtest: vecs1
[53.830235] Dynamic subtest vecs1: SUCCESS (0.067s)
[53.837023] Starting dynamic subtest: ccs0
[53.900946] Dynamic subtest ccs0: SUCCESS (0.069s)
[53.905987] Starting dynamic subtest: ccs1
[53.964398] Dynamic subtest ccs1: SUCCESS (0.064s)
[53.971863] Starting dynamic subtest: ccs2
[54.036409] Dynamic subtest ccs2: SUCCESS (0.071s)
[54.057619] Starting dynamic subtest: ccs3
[54.130440] Dynamic subtest ccs3: SUCCESS (0.094s)
[54.131862] Subtest nb-await: SUCCESS (0.747s)
[55.224469] [025/171] (939s left) gem_exec_gttfill (basic)
[55.295257] Starting subtest: basic
[61.287133] Subtest basic: SUCCESS (5.983s)
[61.440844] [026/171] (933s left) gem_exec_parallel (engines)
[61.550745] Starting subtest: engines
[61.551650] Starting dynamic subtest: basic
[63.539517] Dynamic subtest basic: SUCCESS (1.989s)
[63.544760] Starting dynamic subtest: contexts
[67.335336] Dynamic subtest contexts: SUCCESS (3.796s)
[67.340424] Starting dynamic subtest: fds
[71.092581] Dynamic subtest fds: SUCCESS (3.748s)
[71.097622] Starting dynamic subtest: userptr
[72.726477] Dynamic subtest userptr: SUCCESS (1.643s)
[72.727576] Subtest engines: SUCCESS (11.176s)
[72.927853] [027/171] (921s left) gem_exec_store (basic)
[73.028983] Starting subtest: basic
[73.160992] Subtest basic: SUCCESS (0.132s)
[73.323344] [028/171] (921s left) gem_flink_basic (bad-flink)
[73.418991] Starting subtest: bad-flink
[73.419848] Subtest bad-flink: SUCCESS (0.000s)
[73.429307] [029/171] (921s left) gem_flink_basic (bad-open)
[73.488884] Starting subtest: bad-open
[73.489672] Subtest bad-open: SUCCESS (0.000s)
[73.499476] [030/171] (921s left) gem_flink_basic (basic)
[73.556643] Starting subtest: basic
[73.557466] Subtest basic: SUCCESS (0.000s)
[73.579087] [031/171] (920s left) gem_flink_basic (double-flink)
[73.640641] Starting subtest: double-flink
[73.641643] Subtest double-flink: SUCCESS (0.000s)
[73.664252] [032/171] (920s left) gem_flink_basic (flink-lifetime)
[73.729599] Starting subtest: flink-lifetime
[73.730506] Subtest flink-lifetime: SUCCESS (0.001s)
[73.760719] [033/171] (920s left) gem_huc_copy (huc-copy)
[73.845252] Starting subtest: huc-copy
[73.852143] Subtest huc-copy: SUCCESS (0.007s)
[73.898973] [034/171] (920s left) gem_linear_blits (basic)
[74.047360] Starting subtest: basic
[74.069928] Subtest basic: SUCCESS (0.023s)
[74.142520] [035/171] (920s left) gem_mmap (basic)
[74.249780] Subtest basic: SKIP (0.000s)
[74.259461] [036/171] (920s left) gem_mmap_gtt (basic)
[74.319774] Subtest basic: SKIP (0.000s)
[74.329437] [037/171] (920s left) gem_render_linear_blits (basic)
[74.392387] Starting subtest: basic
[74.449014] Subtest basic: SUCCESS (0.057s)
[74.494683] [038/171] (920s left) gem_render_tiled_blits (basic)
[74.560046] Subtest basic: SKIP (0.000s)
[74.569781] [039/171] (920s left) gem_ringfill (basic-all)
[74.971584] Starting subtest: basic-all
[77.745641] Subtest basic-all: SUCCESS (2.768s)
[77.778545] [040/171] (916s left) gem_softpin (allocator-basic)
[77.867912] Starting subtest: allocator-basic
[78.034435] Subtest allocator-basic: SUCCESS (0.158s)
[78.082720] [041/171] (916s left) gem_softpin (allocator-basic-reserve)
[78.164635] Starting subtest: allocator-basic-reserve
[78.329649] Subtest allocator-basic-reserve: SUCCESS (0.156s)
[78.374591] [042/171] (916s left) gem_softpin (safe-alignment)
[78.448832] Starting subtest: safe-alignment
[78.499674] Subtest safe-alignment: SUCCESS (0.050s)
[78.563833] [043/171] (916s left) gem_sync (basic-all)
[78.637996] Starting subtest: basic-all
[80.703359] Subtest basic-all: SUCCESS (2.065s)
[80.825034] [044/171] (913s left) gem_sync (basic-each)
[80.907364] Starting subtest: basic-each
[83.537318] Subtest basic-each: SUCCESS (2.631s)
[83.709806] [045/171] (911s left) gem_tiled_blits (basic)
[83.806450] Subtest basic: SKIP (0.000s)
[83.817107] [046/171] (910s left) gem_tiled_fence_blits (basic)
[83.880421] Subtest basic: SKIP (0.000s)
[83.890490] [047/171] (910s left) gem_tiled_pread_basic
[83.959446] [048/171] (910s left) gem_wait (busy@all-engines)
[84.031245] Starting subtest: busy
[84.032062] Starting dynamic subtest: all-engines
[84.600145] Dynamic subtest all-engines: SUCCESS (0.569s)
[84.600918] Subtest busy: SUCCESS (0.569s)
[84.779738] [049/171] (910s left) gem_wait (wait@all-engines)
[84.890172] Starting subtest: wait
[84.891035] Starting dynamic subtest: all-engines
[85.980380] Dynamic subtest all-engines: SUCCESS (1.090s)
[85.981545] Subtest wait: SUCCESS (1.090s)
[86.171151] [050/171] (908s left) i915_getparams_basic (basic-eu-total)
[86.231492] Starting subtest: basic-eu-total
[86.233245] Subtest basic-eu-total: SUCCESS (0.000s)
[86.243888] [051/171] (908s left) i915_getparams_basic (basic-subslice-total)
[86.301781] Starting subtest: basic-subslice-total
[86.303542] Subtest basic-subslice-total: SUCCESS (0.000s)
[86.311777] [052/171] (908s left) i915_hangman (error-state-basic)
[86.384642] Starting subtest: error-state-basic
[86.567393] Subtest error-state-basic: SUCCESS (0.183s)
[86.585768] [053/171] (908s left) i915_pciid
[86.655246] [054/171] (908s left) kms_addfb_basic (addfb25-bad-modifier)
[86.713892] Starting subtest: addfb25-bad-modifier
[86.714820] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[86.867231] [055/171] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[86.974792] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[87.126041] [056/171] (907s left) kms_addfb_basic (addfb25-modifier-no-flag)
[87.184616] Starting subtest: addfb25-modifier-no-flag
[87.185536] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[87.341209] [057/171] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[87.401517] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[87.551663] [058/171] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[87.611160] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[87.761190] [059/171] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[87.940837] Starting subtest: addfb25-yf-tiled-legacy
[87.941671] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[87.962652] [060/171] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[88.145920] Starting subtest: addfb25-y-tiled-legacy
[88.146784] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[88.180143] [061/171] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[88.366908] Starting subtest: addfb25-y-tiled-small-legacy
[88.369074] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[88.402214] [062/171] (906s left) kms_addfb_basic (bad-pitch-0)
[88.460685] Starting subtest: bad-pitch-0
[88.461515] Subtest bad-pitch-0: SUCCESS (0.000s)
[88.607084] [063/171] (906s left) kms_addfb_basic (bad-pitch-1024)
[88.665698] Starting subtest: bad-pitch-1024
[88.666510] Subtest bad-pitch-1024: SUCCESS (0.000s)
[88.819732] [064/171] (906s left) kms_addfb_basic (bad-pitch-128)
[88.878722] Starting subtest: bad-pitch-128
[88.879693] Subtest bad-pitch-128: SUCCESS (0.000s)
[89.031690] [065/171] (905s left) kms_addfb_basic (bad-pitch-256)
[89.088493] Starting subtest: bad-pitch-256
[89.089288] Subtest bad-pitch-256: SUCCESS (0.000s)
[89.237319] [066/171] (905s left) kms_addfb_basic (bad-pitch-32)
[89.295110] Starting subtest: bad-pitch-32
[89.295902] Subtest bad-pitch-32: SUCCESS (0.000s)
[89.440502] [067/171] (905s left) kms_addfb_basic (bad-pitch-63)
[89.499505] Starting subtest: bad-pitch-63
[89.500448] Subtest bad-pitch-63: SUCCESS (0.000s)
[89.648263] [068/171] (905s left) kms_addfb_basic (bad-pitch-65536)
[89.706855] Starting subtest: bad-pitch-65536
[89.707753] Subtest bad-pitch-65536: SUCCESS (0.000s)
[89.855473] [069/171] (905s left) kms_addfb_basic (bad-pitch-999)
[89.913482] Starting subtest: bad-pitch-999
[89.914258] Subtest bad-pitch-999: SUCCESS (0.000s)
[90.065309] [070/171] (905s left) kms_addfb_basic (basic)
[90.123812] Starting subtest: basic
[90.124767] Subtest basic: SUCCESS (0.000s)
[90.272286] [071/171] (904s left) kms_addfb_basic (basic-x-tiled-legacy)
[90.331650] Starting subtest: basic-x-tiled-legacy
[90.333386] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[90.472411] [072/171] (904s left) kms_addfb_basic (basic-y-tiled-legacy)
[90.531543] Starting subtest: basic-y-tiled-legacy
[90.533251] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[90.687939] [073/171] (904s left) kms_addfb_basic (bo-too-small)
[90.867730] Starting subtest: bo-too-small
[90.868581] Subtest bo-too-small: SUCCESS (0.000s)
[90.897304] [074/171] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[91.078152] Starting subtest: bo-too-small-due-to-tiling
[91.079740] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[91.115308] [075/171] (904s left) kms_addfb_basic (clobberred-modifier)
[91.173940] Starting subtest: clobberred-modifier
[91.175703] Subtest clobberred-modifier: SKIP (0.000s)
[91.320551] [076/171] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[91.379769] Starting subtest: framebuffer-vs-set-tiling
[91.381403] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[91.538294] [077/171] (903s left) kms_addfb_basic (invalid-get-prop)
[91.598358] Starting subtest: invalid-get-prop
[91.599282] Subtest invalid-get-prop: SUCCESS (0.000s)
[91.746368] [078/171] (903s left) kms_addfb_basic (invalid-get-prop-any)
[91.805305] Starting subtest: invalid-get-prop-any
[91.806203] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[91.955319] [079/171] (903s left) kms_addfb_basic (invalid-set-prop)
[92.013623] Starting subtest: invalid-set-prop
[92.014453] Subtest invalid-set-prop: SUCCESS (0.000s)
[92.162433] [080/171] (903s left) kms_addfb_basic (invalid-set-prop-any)
[92.221265] Starting subtest: invalid-set-prop-any
[92.222163] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[92.371295] [081/171] (902s left) kms_addfb_basic (no-handle)
[92.429964] Starting subtest: no-handle
[92.430871] Subtest no-handle: SUCCESS (0.000s)
[92.589306] [082/171] (902s left) kms_addfb_basic (size-max)
[92.767713] Starting subtest: size-max
[92.768605] Subtest size-max: SUCCESS (0.000s)
[92.790149] [083/171] (902s left) kms_addfb_basic (small-bo)
[92.968707] Starting subtest: small-bo
[92.969514] Subtest small-bo: SUCCESS (0.000s)
[92.992343] [084/171] (902s left) kms_addfb_basic (tile-pitch-mismatch)
[93.052282] Starting subtest: tile-pitch-mismatch
[93.053970] Subtest tile-pitch-mismatch: SKIP (0.000s)
[93.195321] [085/171] (902s left) kms_addfb_basic (too-high)
[93.375789] Starting subtest: too-high
[93.376585] Subtest too-high: SUCCESS (0.000s)
[93.406846] [086/171] (901s left) kms_addfb_basic (too-wide)
[93.587129] Starting subtest: too-wide
[93.588059] Subtest too-wide: SUCCESS (0.000s)
[93.611797] [087/171] (901s left) kms_addfb_basic (unused-handle)
[93.669748] Starting subtest: unused-handle
[93.670700] Subtest unused-handle: SUCCESS (0.000s)
[93.817741] [088/171] (901s left) kms_addfb_basic (unused-modifier)
[93.876464] Starting subtest: unused-modifier
[93.877293] Subtest unused-modifier: SUCCESS (0.000s)
[94.021971] [089/171] (901s left) kms_addfb_basic (unused-offsets)
[94.080743] Starting subtest: unused-offsets
[94.081595] Subtest unused-offsets: SUCCESS (0.000s)
[94.235502] [090/171] (901s left) kms_addfb_basic (unused-pitches)
[94.294171] Starting subtest: unused-pitches
[94.294988] Subtest unused-pitches: SUCCESS (0.000s)
[94.452951] [091/171] (900s left) kms_busy (basic)
[94.637941] Subtest basic: SKIP (0.000s)
[94.649244] [092/171] (900s left) kms_chamelium_hpd (dp-hpd-fast)
[94.836020] Subtest dp-hpd-fast: SKIP (0.000s)
[94.846997] [093/171] (900s left) kms_chamelium_edid (dp-edid-read)
[95.072733] Subtest dp-edid-read: SKIP (0.000s)
[95.084129] [094/171] (900s left) kms_chamelium_frames (dp-crc-fast)
[95.267264] Subtest dp-crc-fast: SKIP (0.000s)
[95.278686] [095/171] (900s left) kms_chamelium_hpd (hdmi-hpd-fast)
[95.462044] Subtest hdmi-hpd-fast: SKIP (0.000s)
[95.473202] [096/171] (899s left) kms_chamelium_edid (hdmi-edid-read)
[95.656421] Subtest hdmi-edid-read: SKIP (0.000s)
[95.666858] [097/171] (899s left) kms_chamelium_frames (hdmi-crc-fast)
[95.849573] Subtest hdmi-crc-fast: SKIP (0.000s)
[95.860539] [098/171] (899s left) kms_chamelium_hpd (vga-hpd-fast)
[96.043528] Subtest vga-hpd-fast: SKIP (0.000s)
[96.054540] [099/171] (899s left) kms_chamelium_edid (vga-edid-read)
[96.237808] Subtest vga-edid-read: SKIP (0.000s)
[96.248255] [100/171] (899s left) kms_prop_blob (basic)
[96.306674] Starting subtest: basic
[96.307489] Subtest basic: SUCCESS (0.000s)
[96.317644] [101/171] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[96.502370] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[96.511667] [102/171] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[96.695314] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[96.704478] [103/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[96.887928] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[96.897542] [104/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[97.080635] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[97.090480] [105/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[97.274956] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[97.284459] [106/171] (898s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[97.467746] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[97.477306] [107/171] (898s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[97.660249] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[97.669633] [108/171] (897s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[97.854831] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[97.864718] [109/171] (897s left) kms_flip (basic-flip-vs-dpms)
[97.982859] Starting subtest: basic-flip-vs-dpms
[97.985700] Subtest basic-flip-vs-dpms: SKIP (0.003s)
[98.014294] [110/171] (897s left) kms_flip (basic-flip-vs-modeset)
[98.129794] Starting subtest: basic-flip-vs-modeset
[98.132491] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[98.150661] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[98.265783] Starting subtest: basic-flip-vs-wf_vblank
[98.269157] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[98.309869] [112/171] (897s left) kms_flip (basic-plain-flip)
[98.428944] Starting subtest: basic-plain-flip
[98.432210] Subtest basic-plain-flip: SKIP (0.003s)
[98.450340] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[98.527859] Starting subtest: force-connector-state
[99.059109] Subtest force-connector-state: SUCCESS (0.531s)
[99.285554] [114/171] (896s left) kms_force_connector_basic (force-edid)
[99.363191] Starting subtest: force-edid
[99.390135] Subtest force-edid: SUCCESS (0.027s)
[99.551223] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[99.627911] Starting subtest: force-load-detect
[99.629469] Subtest force-load-detect: SKIP (0.000s)
[99.729180] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[99.806027] Starting subtest: prune-stale-modes
[99.822246] Subtest prune-stale-modes: SKIP (0.016s)
[99.979681] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[100.161015] Subtest basic: SKIP (0.000s)
[100.191315] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[100.373866] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[100.389025] [119/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[100.569941] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[100.584835] [120/171] (895s left) kms_pipe_crc_basic (hang-read-crc)
[100.765986] Subtest hang-read-crc: SKIP (0.000s)
[100.781343] [121/171] (894s left) kms_pipe_crc_basic (nonblocking-crc)
[100.963015] Subtest nonblocking-crc: SKIP (0.000s)
[100.979017] [122/171] (894s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[101.159612] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[101.174133] [123/171] (894s left) kms_pipe_crc_basic (read-crc)
[101.355113] Subtest read-crc: SKIP (0.000s)
[101.370407] [124/171] (894s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[101.552611] Subtest read-crc-frame-sequence: SKIP (0.000s)
[101.567608] [125/171] (894s left) kms_psr (primary_page_flip)
[101.626429] Subtest primary_page_flip: SKIP (0.000s)
[101.641933] [126/171] (894s left) kms_psr (cursor_plane_move)
[101.706050] Subtest cursor_plane_move: SKIP (0.000s)
[101.720618] [127/171] (894s left) kms_psr (sprite_plane_onoff)
[101.781238] Subtest sprite_plane_onoff: SKIP (0.000s)
[101.796073] [128/171] (893s left) kms_psr (primary_mmap_gtt)
[101.858444] Subtest primary_mmap_gtt: SKIP (0.000s)
[101.873291] [129/171] (893s left) kms_setmode (basic-clone-single-crtc)
[101.931501] Starting subtest: basic-clone-single-crtc
[101.934119] Subtest basic-clone-single-crtc: SKIP (0.000s)
[101.951464] [130/171] (893s left) i915_pm_backlight (basic-brightness)
[102.130680] Subtest basic-brightness: SKIP (0.000s)
[102.146462] [131/171] (893s left) i915_pm_rpm (basic-pci-d3-state)
[104.056316] Starting subtest: basic-pci-d3-state
[104.893307] Subtest basic-pci-d3-state: SUCCESS (0.835s)
[104.980682] [132/171] (890s left) i915_pm_rpm (basic-rte)
[105.027326] Starting subtest: basic-rte
[107.784858] Subtest basic-rte: SUCCESS (2.755s)
[108.852082] [133/171] (886s left) i915_pm_rps (basic-api)
[108.917011] Starting subtest: basic-api
[108.918608] Subtest basic-api: SKIP (0.000s)
[108.937953] [134/171] (886s left) prime_self_import (basic-llseek-bad)
[108.984470] Starting subtest: basic-llseek-bad
[108.995856] Subtest basic-llseek-bad: SUCCESS (0.011s)
[109.030275] [135/171] (886s left) prime_self_import (basic-llseek-size)
[109.077488] Starting subtest: basic-llseek-size
[109.088482] Subtest basic-llseek-size: SUCCESS (0.012s)
[109.121677] [136/171] (886s left) prime_self_import (basic-with_fd_dup)
[109.168033] Starting subtest: basic-with_fd_dup
[109.180083] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[109.227934] [137/171] (886s left) prime_self_import (basic-with_one_bo)
[109.280998] Starting subtest: basic-with_one_bo
[109.293466] Subtest basic-with_one_bo: SUCCESS (0.013s)
[109.315413] [138/171] (886s left) prime_self_import (basic-with_one_bo_two_files)
[109.363502] Starting subtest: basic-with_one_bo_two_files
[109.375804] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[109.419646] [139/171] (886s left) prime_self_import (basic-with_two_bos)
[109.473155] Starting subtest: basic-with_two_bos
[109.485292] Subtest basic-with_two_bos: SUCCESS (0.012s)
[109.525941] [140/171] (886s left) prime_vgem (basic-fence-flip)
[109.594081] Starting subtest: basic-fence-flip
[109.716038] Subtest basic-fence-flip: SKIP (0.120s)
[109.737016] [141/171] (886s left) prime_vgem (basic-fence-mmap)
[109.803113] Starting subtest: basic-fence-mmap
[109.804578] Subtest basic-fence-mmap: SKIP (0.000s)
[109.854607] [142/171] (886s left) prime_vgem (basic-fence-read)
[109.928227] Starting subtest: basic-fence-read
[109.935735] Subtest basic-fence-read: SKIP (0.007s)
[109.985223] [143/171] (885s left) prime_vgem (basic-gtt)
[110.052604] Starting subtest: basic-gtt
[110.054526] Subtest basic-gtt: SKIP (0.000s)
[110.094331] [144/171] (885s left) prime_vgem (basic-read)
[110.176564] Starting subtest: basic-read
[110.181142] Subtest basic-read: SKIP (0.004s)
[110.233306] [145/171] (885s left) prime_vgem (basic-write)
[110.307631] Starting subtest: basic-write
[110.312610] Subtest basic-write: SKIP (0.004s)
[110.359566] [146/171] (885s left) vgem_basic (setversion)
[110.419143] Starting subtest: setversion
[110.420837] Subtest setversion: SUCCESS (0.000s)
[110.434525] [147/171] (885s left) vgem_basic (create)
[110.485410] Starting subtest: create
[110.486302] Subtest create: SUCCESS (0.000s)
[110.501344] [148/171] (885s left) vgem_basic (debugfs)
[110.552149] Starting subtest: debugfs
[110.552977] Subtest debugfs: SUCCESS (0.000s)
[110.568994] [149/171] (885s left) vgem_basic (dmabuf-export)
[110.620211] Starting subtest: dmabuf-export
[110.630904] Subtest dmabuf-export: SUCCESS (0.011s)
[110.675227] [150/171] (885s left) vgem_basic (dmabuf-fence)
[110.728239] Starting subtest: dmabuf-fence
[110.729102] Subtest dmabuf-fence: SUCCESS (0.000s)
[110.744309] [151/171] (885s left) vgem_basic (dmabuf-fence-before)
[110.797443] Starting subtest: dmabuf-fence-before
[110.798327] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[110.814380] [152/171] (885s left) vgem_basic (dmabuf-mmap)
[110.864973] Starting subtest: dmabuf-mmap
[110.872704] Subtest dmabuf-mmap: SUCCESS (0.009s)
[110.890156] [153/171] (885s left) vgem_basic (mmap)
[110.940998] Starting subtest: mmap
[110.945539] Subtest mmap: SUCCESS (0.006s)
[110.962561] [154/171] (885s left) vgem_basic (second-client)
[111.013601] Starting subtest: second-client
[111.018279] Subtest second-client: SUCCESS (0.005s)
[111.034916] [155/171] (885s left) vgem_basic (sysfs)
[111.086031] Starting subtest: sysfs
[111.087210] Subtest sysfs: SUCCESS (0.000s)
[111.102955] [156/171] (885s left) core_hotunplug (unbind-rebind)
[111.185410] Starting subtest: unbind-rebind
[113.038714] Subtest unbind-rebind: SUCCESS (1.853s)
[113.057750] [157/171] (883s left) vgem_basic (unload)
[113.111404] Starting subtest: unload
[141.984100] Subtest unload: SUCCESS (28.838s)
[142.004464] [158/171] (854s left) i915_module_load (reload)
[142.069571] Starting subtest: reload
[144.655608] Subtest reload: SUCCESS (2.586s)
[144.667499] [159/171] (851s left) gem_lmem_swapping (basic)
[147.529688] Starting subtest: basic
[147.530603] Starting dynamic subtest: lmem0
[166.912198] Dynamic subtest lmem0: SUCCESS (19.374s)
[166.913051] Subtest basic: SUCCESS (19.374s)
[169.319741] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[169.861242] Starting subtest: parallel-random-engines
[169.862096] Starting dynamic subtest: lmem0
[170.677351] Dynamic subtest lmem0: SUCCESS (0.816s)
[170.678175] Subtest parallel-random-engines: SUCCESS (0.816s)
[171.956727] [161/171] (824s left) gem_lmem_swapping (random-engines)
[172.461906] Starting subtest: random-engines
[172.462635] Starting dynamic subtest: lmem0
[173.213908] Dynamic subtest lmem0: SUCCESS (0.743s)
[173.214729] Subtest random-engines: SUCCESS (0.744s)
[174.435374] [162/171] (821s left) gem_lmem_swapping (verify-random)
[174.936947] Starting subtest: verify-random
[174.937705] Starting dynamic subtest: lmem0
[182.507946] Dynamic subtest lmem0: SUCCESS (7.536s)
[182.508819] Subtest verify-random: SUCCESS (7.537s)
[183.856817] [163/171] (812s left) i915_pm_rpm (module-reload)
[185.888934] Starting subtest: module-reload
[195.206383] Subtest module-reload: SUCCESS (9.308s)
[195.229280] [164/171] (801s left) i915_selftest (live)
[195.282790] Starting subtest: live
[195.283830] Starting dynamic subtest: sanitycheck
[196.666290] Dynamic subtest sanitycheck: SUCCESS (1.375s)
[196.671181] Starting dynamic subtest: uncore
[198.003369] Dynamic subtest uncore: SUCCESS (1.336s)
[198.009045] Starting dynamic subtest: workarounds
[202.187351] Dynamic subtest workarounds: SUCCESS (4.183s)
[202.192700] Starting dynamic subtest: gt_engines
[204.629192] Dynamic subtest gt_engines: SUCCESS (2.441s)
[204.634223] Starting dynamic subtest: gt_timelines
[232.489138] Dynamic subtest gt_timelines: SUCCESS (27.859s)
[232.494790] Starting dynamic subtest: gt_contexts
[233.940246] Dynamic subtest gt_contexts: SUCCESS (1.450s)
[233.945134] Starting dynamic subtest: gt_lrc
[241.931115] Dynamic subtest gt_lrc: SUCCESS (7.989s)
[241.936858] Starting dynamic subtest: gt_mocs
[245.519380] Dynamic subtest gt_mocs: SUCCESS (3.588s)
[245.525160] Starting dynamic subtest: gt_pm
[247.839352] Dynamic subtest gt_pm: SUCCESS (2.319s)
[247.844346] Starting dynamic subtest: gt_heartbeat
[249.418286] Dynamic subtest gt_heartbeat: SUCCESS (1.578s)
[249.424057] Starting dynamic subtest: gt_tlb
[261.571389] Dynamic subtest gt_tlb: SUCCESS (12.152s)
[261.576745] Starting dynamic subtest: requests
[278.921383] Dynamic subtest requests: SUCCESS (17.349s)
[278.927587] Starting dynamic subtest: migrate
[283.343481] Dynamic subtest migrate: SUCCESS (4.421s)
[283.349218] Starting dynamic subtest: active
[284.727270] Dynamic subtest active: SUCCESS (1.383s)
[284.733052] Starting dynamic subtest: objects
[286.979497] Dynamic subtest objects: SUCCESS (2.251s)
[286.986178] Starting dynamic subtest: mman
[295.735697] Dynamic subtest mman: SUCCESS (8.753s)
[295.740516] Starting dynamic subtest: dmabuf
[297.057110] Dynamic subtest dmabuf: SUCCESS (1.328s)
[297.062153] Starting dynamic subtest: vma
[298.451889] Dynamic subtest vma: SUCCESS (1.389s)
[298.456770] Starting dynamic subtest: coherency
[301.850264] Dynamic subtest coherency: SUCCESS (3.398s)
[301.855167] Starting dynamic subtest: gtt
[310.625253] Dynamic subtest gtt: SUCCESS (8.774s)
[310.630596] Starting dynamic subtest: gem
[312.056219] Dynamic subtest gem: SUCCESS (1.430s)
[312.061311] Starting dynamic subtest: evict
[315.497238] Dynamic subtest evict: SUCCESS (3.440s)
[315.502390] Starting dynamic subtest: hugepages
[332.990239] Dynamic subtest hugepages: SUCCESS (17.492s)
[332.995637] Starting dynamic subtest: gem_contexts
[373.568028] Dynamic subtest gem_contexts: SUCCESS (40.551s)
[373.572793] Starting dynamic subtest: client
[374.945545] Dynamic subtest client: SUCCESS (1.408s)
[374.951826] Starting dynamic subtest: gem_migrate
[379.544264] Dynamic subtest gem_migrate: SUCCESS (4.592s)
[379.550031] Starting dynamic subtest: reset
[381.017408] Dynamic subtest reset: SUCCESS (1.472s)
[381.024400] Starting dynamic subtest: memory_region
[383.875321] Dynamic subtest memory_region: SUCCESS (2.857s)
[383.880862] Starting dynamic subtest: hangcheck
[432.746111] Dynamic subtest hangcheck: SUCCESS (48.870s)
[432.750892] Starting dynamic subtest: execlists
[434.137460] Dynamic subtest execlists: SUCCESS (1.390s)
[434.143829] Starting dynamic subtest: ring_submission
[435.521138] Dynamic subtest ring_submission: SUCCESS (1.383s)
[435.526408] Starting dynamic subtest: perf
[437.017372] Dynamic subtest perf: SUCCESS (1.495s)
[437.023927] Starting dynamic subtest: slpc
[446.226355] Dynamic subtest slpc: SUCCESS (9.208s)
[446.231762] Starting dynamic subtest: guc
[448.829234] Dynamic subtest guc: SUCCESS (2.602s)
[448.834687] Starting dynamic subtest: guc_multi_lrc
[450.277450] Dynamic subtest guc_multi_lrc: SUCCESS (1.447s)
[450.284177] Starting dynamic subtest: guc_hang
[452.459223] Dynamic subtest guc_hang: SUCCESS (2.181s)
[452.465176] Starting dynamic subtest: late_gt_pm
[453.891430] Dynamic subtest late_gt_pm: SUCCESS (1.431s)
[453.892609] Subtest live: SUCCESS (258.600s)
[454.306040] [165/171] (542s left) dmabuf (all-tests)
[454.359548] Starting subtest: all-tests
[454.361177] Starting dynamic subtest: sanitycheck
[454.429556] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[454.437521] Starting dynamic subtest: dma_fence
[454.600419] Dynamic subtest dma_fence: SUCCESS (0.170s)
[454.606166] Starting dynamic subtest: dma_fence_chain
[464.946484] Dynamic subtest dma_fence_chain: SUCCESS (10.345s)
[464.953823] Starting dynamic subtest: dma_fence_unwrap
[465.027053] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[465.033614] Starting dynamic subtest: dma_resv
[465.110317] Dynamic subtest dma_resv: SUCCESS (0.081s)
[465.111992] Subtest all-tests: SUCCESS (10.752s)
[465.154455] [166/171] (531s left) i915_suspend (basic-s2idle-without-i915)
[465.235821] Starting subtest: basic-s2idle-without-i915
[484.470424] Subtest basic-s2idle-without-i915: SUCCESS (4.599s)
[484.500830] [167/171] (526s left) i915_suspend (basic-s3-without-i915)
[484.549763] Starting subtest: basic-s3-without-i915
[506.178686] Subtest basic-s3-without-i915: SUCCESS (5.785s)
[506.209941] [168/171] (520s left) gem_exec_suspend (basic-s0)
[506.300008] Starting subtest: basic-S0
[506.300909] Starting dynamic subtest: smem
[526.205503] Dynamic subtest smem: SUCCESS (4.621s)
[526.212650] Starting dynamic subtest: lmem0
[546.306409] Dynamic subtest lmem0: SUCCESS (4.895s)
[546.307446] Subtest basic-S0: SUCCESS (9.517s)
[546.461772] [169/171] (510s left) gem_exec_suspend (basic-s3)
[546.530188] Starting subtest: basic-S3
[546.531004] Starting dynamic subtest: smem
[567.583238] Dynamic subtest smem: SUCCESS (5.584s)
[567.594696] Starting dynamic subtest: lmem0
[588.598756] Dynamic subtest lmem0: SUCCESS (5.217s)
[588.599887] Subtest basic-S3: SUCCESS (10.803s)
[588.783077] [170/171] (499s left) kms_chamelium_hpd (common-hpd-after-suspend)
[588.988816] Subtest common-hpd-after-suspend: SKIP (0.000s)
[589.001520] [171/171] (499s left) kms_pipe_crc_basic (suspend-read-crc)
[589.199328] Subtest suspend-read-crc: SKIP (0.000s)
[589.210596] Closing watchdogs
Done.