[37.285162] Initializing watchdogs
[37.285225]   /dev/watchdog0
[37.290719] [001/171] (960s left) i915_module_load (load)
[37.342271] Starting subtest: load
[38.430511] Subtest load: SUCCESS (1.087s)
[38.474729] [002/171] (959s left) core_auth (basic-auth)
[38.619494] Starting subtest: basic-auth
[38.621091] Subtest basic-auth: SUCCESS (0.002s)
[38.651357] [003/171] (959s left) debugfs_test (read_all_entries)
[38.759959] Starting subtest: read_all_entries
[39.104148] Subtest read_all_entries: SUCCESS (0.344s)
[39.221235] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.281880] Starting subtest: basic-hwmon
[39.285545] Subtest basic-hwmon: SUCCESS (0.003s)
[39.401282] [005/171] (958s left) fbdev (eof)
[40.062198] Subtest eof: SKIP (0.000s)
[40.071064] [006/171] (957s left) fbdev (info)
[40.126388] Subtest info: SKIP (0.000s)
[40.135250] [007/171] (957s left) fbdev (nullptr)
[40.194178] Subtest nullptr: SKIP (0.000s)
[40.202878] [008/171] (957s left) fbdev (read)
[40.259074] Subtest read: SKIP (0.000s)
[40.267224] [009/171] (957s left) fbdev (write)
[40.323101] Subtest write: SKIP (0.000s)
[40.331850] [010/171] (957s left) gem_basic (bad-close)
[40.387592] Starting subtest: bad-close
[40.389340] Subtest bad-close: SUCCESS (0.000s)
[40.396643] [011/171] (957s left) gem_basic (create-close)
[40.452387] Starting subtest: create-close
[40.454293] Subtest create-close: SUCCESS (0.000s)
[40.473720] [012/171] (957s left) gem_basic (create-fd-close)
[40.529258] Starting subtest: create-fd-close
[40.530828] Subtest create-fd-close: SUCCESS (0.000s)
[40.559341] [013/171] (957s left) gem_busy (busy@all-engines)
[40.630617] Starting subtest: busy
[40.631520] Starting dynamic subtest: all-engines
[40.730248] Dynamic subtest all-engines: SUCCESS (0.100s)
[40.731059] Subtest busy: SUCCESS (0.100s)
[41.099381] [014/171] (956s left) gem_close_race (basic-process)
[41.233535] Starting subtest: basic-process
[41.289480] Subtest basic-process: SUCCESS (0.056s)
[41.436790] [015/171] (956s left) gem_close_race (basic-threads)
[41.517823] Starting subtest: basic-threads
[42.714575] Subtest basic-threads: SUCCESS (1.197s)
[42.900839] [016/171] (955s left) gem_ctx_create (basic)
[43.023910] Starting subtest: basic
[43.024765] Subtest basic: SUCCESS (0.000s)
[43.141308] [017/171] (954s left) gem_ctx_create (basic-files)
[43.219015] Starting subtest: basic-files
[45.228720] Subtest basic-files: SUCCESS (2.010s)
[45.624296] [018/171] (952s left) gem_ctx_exec (basic)
[45.687332] Starting subtest: basic
[45.693184] Subtest basic: SUCCESS (0.006s)
[45.749588] [019/171] (952s left) gem_exec_basic (basic)
[45.849234] Starting subtest: basic
[45.850183] Starting dynamic subtest: rcs0-smem
[45.852665] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[45.856999] Starting dynamic subtest: bcs0-smem
[45.857910] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[45.862664] Starting dynamic subtest: vcs0-smem
[45.863460] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[45.867512] Starting dynamic subtest: vcs1-smem
[45.868308] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[45.872361] Starting dynamic subtest: vecs0-smem
[45.873161] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[45.877164] Starting dynamic subtest: vecs1-smem
[45.877959] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[45.881965] Starting dynamic subtest: ccs0-smem
[45.882771] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[45.886791] Starting dynamic subtest: ccs1-smem
[45.887567] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[45.891592] Starting dynamic subtest: ccs2-smem
[45.892390] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[45.896412] Starting dynamic subtest: ccs3-smem
[45.897249] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[45.901271] Starting dynamic subtest: rcs0-lmem0
[45.902042] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[45.906040] Starting dynamic subtest: bcs0-lmem0
[45.906828] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[45.910839] Starting dynamic subtest: vcs0-lmem0
[45.911577] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[45.915595] Starting dynamic subtest: vcs1-lmem0
[45.916387] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[45.920418] Starting dynamic subtest: vecs0-lmem0
[45.921202] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[45.925214] Starting dynamic subtest: vecs1-lmem0
[45.926013] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[45.930422] Starting dynamic subtest: ccs0-lmem0
[45.931204] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[45.935208] Starting dynamic subtest: ccs1-lmem0
[45.935995] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[45.939998] Starting dynamic subtest: ccs2-lmem0
[45.940806] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[45.944819] Starting dynamic subtest: ccs3-lmem0
[45.945619] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[45.946400] Subtest basic: SUCCESS (0.014s)
[45.983175] [020/171] (952s left) gem_exec_create (basic)
[46.048300] Starting subtest: basic
[46.049266] Starting dynamic subtest: smem
[48.149440] Dynamic subtest smem: SUCCESS (2.099s)
[48.155125] Starting dynamic subtest: lmem0
[50.249593] Dynamic subtest lmem0: SUCCESS (2.102s)
[50.250827] Subtest basic: SUCCESS (4.201s)
[50.376170] [021/171] (947s left) gem_exec_fence (basic-busy)
[50.581268] Starting subtest: basic-busy
[50.585078] Starting dynamic subtest: rcs0
[50.698986] Dynamic subtest rcs0: SUCCESS (0.118s)
[50.707067] Starting dynamic subtest: bcs0
[50.756052] Dynamic subtest bcs0: SUCCESS (0.056s)
[50.773537] Starting dynamic subtest: vcs0
[50.807147] Dynamic subtest vcs0: SUCCESS (0.050s)
[50.825897] Starting dynamic subtest: vcs1
[50.860987] Dynamic subtest vcs1: SUCCESS (0.054s)
[50.879915] Starting dynamic subtest: vecs0
[50.919204] Dynamic subtest vecs0: SUCCESS (0.058s)
[50.937993] Starting dynamic subtest: vecs1
[50.973994] Dynamic subtest vecs1: SUCCESS (0.055s)
[50.992981] Starting dynamic subtest: ccs0
[51.029260] Dynamic subtest ccs0: SUCCESS (0.055s)
[51.037641] Starting dynamic subtest: ccs1
[51.078986] Dynamic subtest ccs1: SUCCESS (0.050s)
[51.087152] Starting dynamic subtest: ccs2
[51.132201] Dynamic subtest ccs2: SUCCESS (0.052s)
[51.150936] Starting dynamic subtest: ccs3
[51.185104] Dynamic subtest ccs3: SUCCESS (0.053s)
[51.187066] Subtest basic-busy: SUCCESS (0.604s)
[52.287591] [022/171] (945s left) gem_exec_fence (basic-wait)
[52.475080] Starting subtest: basic-wait
[52.476563] Starting dynamic subtest: rcs0
[52.589901] Dynamic subtest rcs0: SUCCESS (0.115s)
[52.597712] Starting dynamic subtest: bcs0
[52.637689] Dynamic subtest bcs0: SUCCESS (0.048s)
[52.646553] Starting dynamic subtest: vcs0
[52.690839] Dynamic subtest vcs0: SUCCESS (0.052s)
[52.709924] Starting dynamic subtest: vcs1
[52.747098] Dynamic subtest vcs1: SUCCESS (0.056s)
[52.766124] Starting dynamic subtest: vecs0
[52.802110] Dynamic subtest vecs0: SUCCESS (0.055s)
[52.821288] Starting dynamic subtest: vecs1
[52.860061] Dynamic subtest vecs1: SUCCESS (0.058s)
[52.881113] Starting dynamic subtest: ccs0
[52.916175] Dynamic subtest ccs0: SUCCESS (0.056s)
[52.935106] Starting dynamic subtest: ccs1
[52.975339] Dynamic subtest ccs1: SUCCESS (0.059s)
[52.994586] Starting dynamic subtest: ccs2
[53.032055] Dynamic subtest ccs2: SUCCESS (0.057s)
[53.051065] Starting dynamic subtest: ccs3
[53.089916] Dynamic subtest ccs3: SUCCESS (0.057s)
[53.091776] Subtest basic-wait: SUCCESS (0.615s)
[54.126453] [023/171] (944s left) gem_exec_fence (basic-await)
[54.305046] Starting subtest: basic-await
[54.306010] Starting dynamic subtest: rcs0
[54.422642] Dynamic subtest rcs0: SUCCESS (0.117s)
[54.433537] Starting dynamic subtest: bcs0
[54.531570] Dynamic subtest bcs0: SUCCESS (0.109s)
[54.536534] Starting dynamic subtest: vcs0
[54.626602] Dynamic subtest vcs0: SUCCESS (0.095s)
[54.631496] Starting dynamic subtest: vcs1
[54.721807] Dynamic subtest vcs1: SUCCESS (0.095s)
[54.726739] Starting dynamic subtest: vecs0
[54.816474] Dynamic subtest vecs0: SUCCESS (0.095s)
[54.821752] Starting dynamic subtest: vecs1
[54.916131] Dynamic subtest vecs1: SUCCESS (0.099s)
[54.920772] Starting dynamic subtest: ccs0
[55.008807] Dynamic subtest ccs0: SUCCESS (0.093s)
[55.014135] Starting dynamic subtest: ccs1
[55.105190] Dynamic subtest ccs1: SUCCESS (0.096s)
[55.110879] Starting dynamic subtest: ccs2
[55.204655] Dynamic subtest ccs2: SUCCESS (0.099s)
[55.209081] Starting dynamic subtest: ccs3
[55.295357] Dynamic subtest ccs3: SUCCESS (0.090s)
[55.296422] Subtest basic-await: SUCCESS (0.990s)
[56.393457] [024/171] (941s left) gem_exec_fence (nb-await)
[56.575281] Starting subtest: nb-await
[56.576246] Starting dynamic subtest: rcs0
[56.669227] Dynamic subtest rcs0: SUCCESS (0.094s)
[56.675153] Starting dynamic subtest: bcs0
[56.733033] Dynamic subtest bcs0: SUCCESS (0.064s)
[56.741511] Starting dynamic subtest: vcs0
[56.808217] Dynamic subtest vcs0: SUCCESS (0.074s)
[56.827536] Starting dynamic subtest: vcs1
[56.899531] Dynamic subtest vcs1: SUCCESS (0.091s)
[56.907725] Starting dynamic subtest: vecs0
[56.965791] Dynamic subtest vecs0: SUCCESS (0.067s)
[56.973061] Starting dynamic subtest: vecs1
[57.039136] Dynamic subtest vecs1: SUCCESS (0.072s)
[57.047768] Starting dynamic subtest: ccs0
[57.106607] Dynamic subtest ccs0: SUCCESS (0.068s)
[57.113054] Starting dynamic subtest: ccs1
[57.177189] Dynamic subtest ccs1: SUCCESS (0.070s)
[57.198126] Starting dynamic subtest: ccs2
[57.269916] Dynamic subtest ccs2: SUCCESS (0.092s)
[57.288778] Starting dynamic subtest: ccs3
[57.360243] Dynamic subtest ccs3: SUCCESS (0.090s)
[57.362110] Subtest nb-await: SUCCESS (0.784s)
[58.384036] [025/171] (939s left) gem_exec_gttfill (basic)
[58.461142] Starting subtest: basic
[64.556336] Subtest basic: SUCCESS (6.087s)
[64.735308] [026/171] (933s left) gem_exec_parallel (engines)
[64.854527] Starting subtest: engines
[64.855356] Starting dynamic subtest: basic
[67.839182] Dynamic subtest basic: SUCCESS (2.985s)
[67.844540] Starting dynamic subtest: contexts
[71.647531] Dynamic subtest contexts: SUCCESS (3.799s)
[71.652590] Starting dynamic subtest: fds
[75.501106] Dynamic subtest fds: SUCCESS (3.853s)
[75.506163] Starting dynamic subtest: userptr
[77.221810] Dynamic subtest userptr: SUCCESS (1.729s)
[77.223110] Subtest engines: SUCCESS (12.367s)
[77.381445] [027/171] (920s left) gem_exec_store (basic)
[77.452715] Starting subtest: basic
[77.582399] Subtest basic: SUCCESS (0.129s)
[77.774549] [028/171] (920s left) gem_flink_basic (bad-flink)
[77.849825] Starting subtest: bad-flink
[77.850655] Subtest bad-flink: SUCCESS (0.000s)
[77.859322] [029/171] (920s left) gem_flink_basic (bad-open)
[77.916994] Starting subtest: bad-open
[77.917805] Subtest bad-open: SUCCESS (0.000s)
[77.926473] [030/171] (920s left) gem_flink_basic (basic)
[77.984354] Starting subtest: basic
[77.985179] Subtest basic: SUCCESS (0.000s)
[78.007174] [031/171] (920s left) gem_flink_basic (double-flink)
[78.065409] Starting subtest: double-flink
[78.066309] Subtest double-flink: SUCCESS (0.000s)
[78.103399] [032/171] (920s left) gem_flink_basic (flink-lifetime)
[78.178598] Starting subtest: flink-lifetime
[78.179530] Subtest flink-lifetime: SUCCESS (0.001s)
[78.209489] [033/171] (920s left) gem_huc_copy (huc-copy)
[78.295329] Starting subtest: huc-copy
[78.299927] Subtest huc-copy: SUCCESS (0.005s)
[78.388201] [034/171] (919s left) gem_linear_blits (basic)
[78.531468] Starting subtest: basic
[78.555491] Subtest basic: SUCCESS (0.024s)
[78.624022] [035/171] (919s left) gem_mmap (basic)
[78.749231] Subtest basic: SKIP (0.000s)
[78.759503] [036/171] (919s left) gem_mmap_gtt (basic)
[78.819798] Subtest basic: SKIP (0.000s)
[78.830077] [037/171] (919s left) gem_render_linear_blits (basic)
[78.892611] Starting subtest: basic
[78.944142] Subtest basic: SUCCESS (0.051s)
[78.998913] [038/171] (919s left) gem_render_tiled_blits (basic)
[79.082479] Subtest basic: SKIP (0.000s)
[79.092645] [039/171] (919s left) gem_ringfill (basic-all)
[79.501298] Starting subtest: basic-all
[82.445815] Subtest basic-all: SUCCESS (2.937s)
[82.490840] [040/171] (915s left) gem_softpin (allocator-basic)
[82.557743] Starting subtest: allocator-basic
[82.722562] Subtest allocator-basic: SUCCESS (0.156s)
[82.764618] [041/171] (915s left) gem_softpin (allocator-basic-reserve)
[82.830879] Starting subtest: allocator-basic-reserve
[82.996185] Subtest allocator-basic-reserve: SUCCESS (0.157s)
[83.051253] [042/171] (915s left) gem_softpin (safe-alignment)
[83.129847] Starting subtest: safe-alignment
[83.178683] Subtest safe-alignment: SUCCESS (0.049s)
[83.235593] [043/171] (915s left) gem_sync (basic-all)
[83.328760] Starting subtest: basic-all
[87.192581] Subtest basic-all: SUCCESS (3.864s)
[87.310700] [044/171] (911s left) gem_sync (basic-each)
[87.394408] Starting subtest: basic-each
[90.608463] Subtest basic-each: SUCCESS (3.214s)
[90.780300] [045/171] (907s left) gem_tiled_blits (basic)
[90.878836] Subtest basic: SKIP (0.000s)
[90.889135] [046/171] (907s left) gem_tiled_fence_blits (basic)
[90.952130] Subtest basic: SKIP (0.000s)
[90.962285] [047/171] (907s left) gem_tiled_pread_basic
[91.030212] [048/171] (907s left) gem_wait (busy@all-engines)
[91.100073] Starting subtest: busy
[91.101050] Starting dynamic subtest: all-engines
[91.670572] Dynamic subtest all-engines: SUCCESS (0.571s)
[91.671388] Subtest busy: SUCCESS (0.571s)
[91.854777] [049/171] (906s left) gem_wait (wait@all-engines)
[91.925045] Starting subtest: wait
[91.925989] Starting dynamic subtest: all-engines
[93.006111] Dynamic subtest all-engines: SUCCESS (1.081s)
[93.007057] Subtest wait: SUCCESS (1.081s)
[93.188779] [050/171] (905s left) i915_getparams_basic (basic-eu-total)
[93.254512] Starting subtest: basic-eu-total
[93.256229] Subtest basic-eu-total: SUCCESS (0.000s)
[93.266565] [051/171] (905s left) i915_getparams_basic (basic-subslice-total)
[93.330755] Starting subtest: basic-subslice-total
[93.332500] Subtest basic-subslice-total: SUCCESS (0.000s)
[93.341976] [052/171] (905s left) i915_hangman (error-state-basic)
[93.418502] Starting subtest: error-state-basic
[93.607990] Subtest error-state-basic: SUCCESS (0.189s)
[93.624562] [053/171] (904s left) i915_pciid
[93.693266] [054/171] (904s left) kms_addfb_basic (addfb25-bad-modifier)
[93.751634] Starting subtest: addfb25-bad-modifier
[93.752635] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[93.909417] [055/171] (904s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.968528] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[94.115313] [056/171] (904s left) kms_addfb_basic (addfb25-modifier-no-flag)
[94.172620] Starting subtest: addfb25-modifier-no-flag
[94.173442] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[94.326349] [057/171] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[94.400907] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[94.554489] [058/171] (904s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[94.614084] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[94.766641] [059/171] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[94.947113] Starting subtest: addfb25-yf-tiled-legacy
[94.947999] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[94.981017] [060/171] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[95.161750] Starting subtest: addfb25-y-tiled-legacy
[95.162638] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[95.187011] [061/171] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[95.368159] Starting subtest: addfb25-y-tiled-small-legacy
[95.369905] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[95.386854] [062/171] (903s left) kms_addfb_basic (bad-pitch-0)
[95.444951] Starting subtest: bad-pitch-0
[95.445752] Subtest bad-pitch-0: SUCCESS (0.000s)
[95.589418] [063/171] (903s left) kms_addfb_basic (bad-pitch-1024)
[95.647119] Starting subtest: bad-pitch-1024
[95.647945] Subtest bad-pitch-1024: SUCCESS (0.000s)
[95.801249] [064/171] (902s left) kms_addfb_basic (bad-pitch-128)
[95.859728] Starting subtest: bad-pitch-128
[95.860683] Subtest bad-pitch-128: SUCCESS (0.000s)
[96.001446] [065/171] (902s left) kms_addfb_basic (bad-pitch-256)
[96.059639] Starting subtest: bad-pitch-256
[96.060532] Subtest bad-pitch-256: SUCCESS (0.000s)
[96.210522] [066/171] (902s left) kms_addfb_basic (bad-pitch-32)
[96.268964] Starting subtest: bad-pitch-32
[96.269731] Subtest bad-pitch-32: SUCCESS (0.000s)
[96.414512] [067/171] (902s left) kms_addfb_basic (bad-pitch-63)
[96.473810] Starting subtest: bad-pitch-63
[96.474776] Subtest bad-pitch-63: SUCCESS (0.000s)
[96.624541] [068/171] (902s left) kms_addfb_basic (bad-pitch-65536)
[96.684204] Starting subtest: bad-pitch-65536
[96.685034] Subtest bad-pitch-65536: SUCCESS (0.000s)
[96.859978] [069/171] (901s left) kms_addfb_basic (bad-pitch-999)
[96.918460] Starting subtest: bad-pitch-999
[96.919341] Subtest bad-pitch-999: SUCCESS (0.000s)
[97.081587] [070/171] (901s left) kms_addfb_basic (basic)
[97.139677] Starting subtest: basic
[97.140566] Subtest basic: SUCCESS (0.000s)
[97.289568] [071/171] (901s left) kms_addfb_basic (basic-x-tiled-legacy)
[97.349802] Starting subtest: basic-x-tiled-legacy
[97.351512] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[97.503470] [072/171] (901s left) kms_addfb_basic (basic-y-tiled-legacy)
[97.564474] Starting subtest: basic-y-tiled-legacy
[97.566032] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[97.722451] [073/171] (901s left) kms_addfb_basic (bo-too-small)
[97.903594] Starting subtest: bo-too-small
[97.904429] Subtest bo-too-small: SUCCESS (0.000s)
[97.925225] [074/171] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[98.104977] Starting subtest: bo-too-small-due-to-tiling
[98.106753] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[98.128102] [075/171] (900s left) kms_addfb_basic (clobberred-modifier)
[98.188743] Starting subtest: clobberred-modifier
[98.190393] Subtest clobberred-modifier: SKIP (0.000s)
[98.345052] [076/171] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[98.404197] Starting subtest: framebuffer-vs-set-tiling
[98.405769] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[98.558945] [077/171] (900s left) kms_addfb_basic (invalid-get-prop)
[98.618837] Starting subtest: invalid-get-prop
[98.619767] Subtest invalid-get-prop: SUCCESS (0.000s)
[98.770296] [078/171] (900s left) kms_addfb_basic (invalid-get-prop-any)
[98.827541] Starting subtest: invalid-get-prop-any
[98.828319] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[98.978551] [079/171] (899s left) kms_addfb_basic (invalid-set-prop)
[99.037246] Starting subtest: invalid-set-prop
[99.038189] Subtest invalid-set-prop: SUCCESS (0.000s)
[99.194299] [080/171] (899s left) kms_addfb_basic (invalid-set-prop-any)
[99.253427] Starting subtest: invalid-set-prop-any
[99.254298] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[99.401321] [081/171] (899s left) kms_addfb_basic (no-handle)
[99.459817] Starting subtest: no-handle
[99.460758] Subtest no-handle: SUCCESS (0.000s)
[99.616294] [082/171] (899s left) kms_addfb_basic (size-max)
[99.794998] Starting subtest: size-max
[99.795936] Subtest size-max: SUCCESS (0.000s)
[99.816992] [083/171] (899s left) kms_addfb_basic (small-bo)
[99.997164] Starting subtest: small-bo
[99.997997] Subtest small-bo: SUCCESS (0.000s)
[100.021678] [084/171] (898s left) kms_addfb_basic (tile-pitch-mismatch)
[100.080734] Starting subtest: tile-pitch-mismatch
[100.082356] Subtest tile-pitch-mismatch: SKIP (0.000s)
[100.228437] [085/171] (898s left) kms_addfb_basic (too-high)
[100.427543] Starting subtest: too-high
[100.428632] Subtest too-high: SUCCESS (0.001s)
[100.458228] [086/171] (898s left) kms_addfb_basic (too-wide)
[100.638918] Starting subtest: too-wide
[100.639741] Subtest too-wide: SUCCESS (0.000s)
[100.665438] [087/171] (898s left) kms_addfb_basic (unused-handle)
[100.724773] Starting subtest: unused-handle
[100.725706] Subtest unused-handle: SUCCESS (0.000s)
[100.881139] [088/171] (898s left) kms_addfb_basic (unused-modifier)
[100.939491] Starting subtest: unused-modifier
[100.940425] Subtest unused-modifier: SUCCESS (0.000s)
[101.085137] [089/171] (897s left) kms_addfb_basic (unused-offsets)
[101.143143] Starting subtest: unused-offsets
[101.143924] Subtest unused-offsets: SUCCESS (0.000s)
[101.300661] [090/171] (897s left) kms_addfb_basic (unused-pitches)
[101.359458] Starting subtest: unused-pitches
[101.360391] Subtest unused-pitches: SUCCESS (0.000s)
[101.535733] [091/171] (897s left) kms_busy (basic)
[101.721419] Subtest basic: SKIP (0.000s)
[101.730969] [092/171] (897s left) kms_chamelium_hpd (dp-hpd-fast)
[101.914062] Subtest dp-hpd-fast: SKIP (0.000s)
[101.925255] [093/171] (897s left) kms_chamelium_edid (dp-edid-read)
[102.108709] Subtest dp-edid-read: SKIP (0.000s)
[102.119098] [094/171] (896s left) kms_chamelium_frames (dp-crc-fast)
[102.305929] Subtest dp-crc-fast: SKIP (0.000s)
[102.316366] [095/171] (896s left) kms_chamelium_hpd (hdmi-hpd-fast)
[102.499560] Subtest hdmi-hpd-fast: SKIP (0.000s)
[102.509991] [096/171] (896s left) kms_chamelium_edid (hdmi-edid-read)
[102.712906] Subtest hdmi-edid-read: SKIP (0.000s)
[102.723979] [097/171] (896s left) kms_chamelium_frames (hdmi-crc-fast)
[102.907790] Subtest hdmi-crc-fast: SKIP (0.000s)
[102.918180] [098/171] (896s left) kms_chamelium_hpd (vga-hpd-fast)
[103.104417] Subtest vga-hpd-fast: SKIP (0.000s)
[103.114836] [099/171] (896s left) kms_chamelium_edid (vga-edid-read)
[103.319583] Subtest vga-edid-read: SKIP (0.000s)
[103.332240] [100/171] (895s left) kms_prop_blob (basic)
[103.392383] Starting subtest: basic
[103.393291] Subtest basic: SUCCESS (0.000s)
[103.402836] [101/171] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[103.599961] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[103.609535] [102/171] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[103.792842] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[103.802447] [103/171] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[103.985951] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[103.995221] [104/171] (895s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[104.178723] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[104.188253] [105/171] (895s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[104.371901] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[104.381238] [106/171] (894s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[104.564389] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[104.573448] [107/171] (894s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[104.756968] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[104.766410] [108/171] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[104.950936] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[104.960728] [109/171] (894s left) kms_flip (basic-flip-vs-dpms)
[105.077888] Starting subtest: basic-flip-vs-dpms
[105.080341] Subtest basic-flip-vs-dpms: SKIP (0.003s)
[105.116798] [110/171] (894s left) kms_flip (basic-flip-vs-modeset)
[105.232701] Starting subtest: basic-flip-vs-modeset
[105.235595] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[105.274050] [111/171] (894s left) kms_flip (basic-flip-vs-wf_vblank)
[105.391804] Starting subtest: basic-flip-vs-wf_vblank
[105.394618] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[105.417825] [112/171] (893s left) kms_flip (basic-plain-flip)
[105.532505] Starting subtest: basic-plain-flip
[105.535192] Subtest basic-plain-flip: SKIP (0.003s)
[105.577152] [113/171] (893s left) kms_force_connector_basic (force-connector-state)
[105.656106] Starting subtest: force-connector-state
[106.188377] Subtest force-connector-state: SUCCESS (0.532s)
[106.420765] [114/171] (892s left) kms_force_connector_basic (force-edid)
[106.498047] Starting subtest: force-edid
[106.525271] Subtest force-edid: SUCCESS (0.027s)
[106.688155] [115/171] (892s left) kms_force_connector_basic (force-load-detect)
[106.765118] Starting subtest: force-load-detect
[106.766861] Subtest force-load-detect: SKIP (0.000s)
[106.866255] [116/171] (892s left) kms_force_connector_basic (prune-stale-modes)
[106.942988] Starting subtest: prune-stale-modes
[106.959872] Subtest prune-stale-modes: SKIP (0.016s)
[107.129299] [117/171] (892s left) kms_frontbuffer_tracking (basic)
[107.310069] Subtest basic: SKIP (0.000s)
[107.337141] [118/171] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[107.517860] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[107.532851] [119/171] (891s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[107.715136] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[107.730188] [120/171] (891s left) kms_pipe_crc_basic (hang-read-crc)
[107.910621] Subtest hang-read-crc: SKIP (0.000s)
[107.926106] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[108.107991] Subtest nonblocking-crc: SKIP (0.000s)
[108.123347] [122/171] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[108.302857] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[108.318049] [123/171] (891s left) kms_pipe_crc_basic (read-crc)
[108.497053] Subtest read-crc: SKIP (0.000s)
[108.512563] [124/171] (890s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[108.694607] Subtest read-crc-frame-sequence: SKIP (0.000s)
[108.709608] [125/171] (890s left) kms_psr (primary_page_flip)
[108.770890] Subtest primary_page_flip: SKIP (0.000s)
[108.785698] [126/171] (890s left) kms_psr (cursor_plane_move)
[108.844710] Subtest cursor_plane_move: SKIP (0.000s)
[108.859048] [127/171] (890s left) kms_psr (sprite_plane_onoff)
[108.920285] Subtest sprite_plane_onoff: SKIP (0.000s)
[108.934300] [128/171] (890s left) kms_psr (primary_mmap_gtt)
[108.994170] Subtest primary_mmap_gtt: SKIP (0.000s)
[109.009355] [129/171] (890s left) kms_setmode (basic-clone-single-crtc)
[109.068652] Starting subtest: basic-clone-single-crtc
[109.071283] Subtest basic-clone-single-crtc: SKIP (0.000s)
[109.089095] [130/171] (890s left) i915_pm_backlight (basic-brightness)
[109.306182] Subtest basic-brightness: SKIP (0.000s)
[109.321041] [131/171] (890s left) i915_pm_rpm (basic-pci-d3-state)
[111.403304] Starting subtest: basic-pci-d3-state
[112.457581] Subtest basic-pci-d3-state: SUCCESS (1.052s)
[112.545374] [132/171] (886s left) i915_pm_rpm (basic-rte)
[112.592492] Starting subtest: basic-rte
[115.695322] Subtest basic-rte: SUCCESS (3.100s)
[116.083487] [133/171] (883s left) i915_pm_rps (basic-api)
[116.148047] Starting subtest: basic-api
[116.149886] Subtest basic-api: SKIP (0.000s)
[116.169937] [134/171] (883s left) prime_self_import (basic-llseek-bad)
[116.219587] Starting subtest: basic-llseek-bad
[116.231445] Subtest basic-llseek-bad: SUCCESS (0.011s)
[116.259670] [135/171] (883s left) prime_self_import (basic-llseek-size)
[116.306939] Starting subtest: basic-llseek-size
[116.318311] Subtest basic-llseek-size: SUCCESS (0.012s)
[116.361302] [136/171] (883s left) prime_self_import (basic-with_fd_dup)
[116.408690] Starting subtest: basic-with_fd_dup
[116.421399] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[116.466807] [137/171] (883s left) prime_self_import (basic-with_one_bo)
[116.513613] Starting subtest: basic-with_one_bo
[116.525877] Subtest basic-with_one_bo: SUCCESS (0.012s)
[116.546506] [138/171] (883s left) prime_self_import (basic-with_one_bo_two_files)
[116.593482] Starting subtest: basic-with_one_bo_two_files
[116.605150] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[116.642799] [139/171] (882s left) prime_self_import (basic-with_two_bos)
[116.689109] Starting subtest: basic-with_two_bos
[116.702468] Subtest basic-with_two_bos: SUCCESS (0.013s)
[116.755805] [140/171] (882s left) prime_vgem (basic-fence-flip)
[116.840640] Starting subtest: basic-fence-flip
[116.962895] Subtest basic-fence-flip: SKIP (0.120s)
[116.984162] [141/171] (882s left) prime_vgem (basic-fence-mmap)
[117.050876] Starting subtest: basic-fence-mmap
[117.052392] Subtest basic-fence-mmap: SKIP (0.000s)
[117.097550] [142/171] (882s left) prime_vgem (basic-fence-read)
[117.166049] Starting subtest: basic-fence-read
[117.172404] Subtest basic-fence-read: SKIP (0.006s)
[117.247135] [143/171] (882s left) prime_vgem (basic-gtt)
[117.327966] Starting subtest: basic-gtt
[117.329583] Subtest basic-gtt: SKIP (0.000s)
[117.378360] [144/171] (882s left) prime_vgem (basic-read)
[117.445562] Starting subtest: basic-read
[117.450368] Subtest basic-read: SKIP (0.004s)
[117.497169] [145/171] (882s left) prime_vgem (basic-write)
[117.566153] Starting subtest: basic-write
[117.571424] Subtest basic-write: SKIP (0.004s)
[117.618284] [146/171] (882s left) vgem_basic (setversion)
[117.671936] Starting subtest: setversion
[117.673557] Subtest setversion: SUCCESS (0.000s)
[117.688229] [147/171] (882s left) vgem_basic (create)
[117.738828] Starting subtest: create
[117.739664] Subtest create: SUCCESS (0.000s)
[117.755987] [148/171] (881s left) vgem_basic (debugfs)
[117.808316] Starting subtest: debugfs
[117.809187] Subtest debugfs: SUCCESS (0.000s)
[117.824532] [149/171] (881s left) vgem_basic (dmabuf-export)
[117.877127] Starting subtest: dmabuf-export
[117.897916] Subtest dmabuf-export: SUCCESS (0.021s)
[117.924749] [150/171] (881s left) vgem_basic (dmabuf-fence)
[117.975901] Starting subtest: dmabuf-fence
[117.976721] Subtest dmabuf-fence: SUCCESS (0.000s)
[117.992532] [151/171] (881s left) vgem_basic (dmabuf-fence-before)
[118.042927] Starting subtest: dmabuf-fence-before
[118.043736] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[118.059111] [152/171] (881s left) vgem_basic (dmabuf-mmap)
[118.112161] Starting subtest: dmabuf-mmap
[118.119125] Subtest dmabuf-mmap: SUCCESS (0.009s)
[118.136712] [153/171] (881s left) vgem_basic (mmap)
[118.189196] Starting subtest: mmap
[118.193380] Subtest mmap: SUCCESS (0.006s)
[118.210803] [154/171] (881s left) vgem_basic (second-client)
[118.262536] Starting subtest: second-client
[118.268010] Subtest second-client: SUCCESS (0.006s)
[118.284813] [155/171] (881s left) vgem_basic (sysfs)
[118.336198] Starting subtest: sysfs
[118.337107] Subtest sysfs: SUCCESS (0.000s)
[118.352632] [156/171] (881s left) core_hotunplug (unbind-rebind)
[118.435060] Starting subtest: unbind-rebind
[120.325742] Subtest unbind-rebind: SUCCESS (1.891s)
[120.348583] [157/171] (879s left) vgem_basic (unload)
[120.401628] Starting subtest: unload
[149.287347] Subtest unload: SUCCESS (28.851s)
[149.300075] [158/171] (850s left) i915_module_load (reload)
[149.354330] Starting subtest: reload
[151.967438] Subtest reload: SUCCESS (2.614s)
[151.978756] [159/171] (847s left) gem_lmem_swapping (basic)
[154.973288] Starting subtest: basic
[154.974162] Starting dynamic subtest: lmem0
[174.254306] Dynamic subtest lmem0: SUCCESS (19.246s)
[174.255191] Subtest basic: SUCCESS (19.247s)
[176.532119] [160/171] (823s left) gem_lmem_swapping (parallel-random-engines)
[177.062659] Starting subtest: parallel-random-engines
[177.063448] Starting dynamic subtest: lmem0
[177.866538] Dynamic subtest lmem0: SUCCESS (0.804s)
[177.867357] Subtest parallel-random-engines: SUCCESS (0.805s)
[179.103273] [161/171] (820s left) gem_lmem_swapping (random-engines)
[179.611343] Starting subtest: random-engines
[179.612118] Starting dynamic subtest: lmem0
[180.342679] Dynamic subtest lmem0: SUCCESS (0.722s)
[180.343600] Subtest random-engines: SUCCESS (0.723s)
[181.551839] [162/171] (818s left) gem_lmem_swapping (verify-random)
[182.062598] Starting subtest: verify-random
[182.063391] Starting dynamic subtest: lmem0
[189.544169] Dynamic subtest lmem0: SUCCESS (7.447s)
[189.545372] Subtest verify-random: SUCCESS (7.447s)
[190.813549] [163/171] (809s left) i915_pm_rpm (module-reload)
[193.107769] Starting subtest: module-reload
[202.623492] Subtest module-reload: SUCCESS (9.507s)
[202.647254] [164/171] (797s left) i915_selftest (live)
[202.700776] Starting subtest: live
[202.701648] Starting dynamic subtest: sanitycheck
[204.091374] Dynamic subtest sanitycheck: SUCCESS (1.382s)
[204.096880] Starting dynamic subtest: uncore
[205.519408] Dynamic subtest uncore: SUCCESS (1.427s)
[205.525050] Starting dynamic subtest: workarounds
[209.955376] Dynamic subtest workarounds: SUCCESS (4.435s)
[209.962586] Starting dynamic subtest: gt_engines
[212.484268] Dynamic subtest gt_engines: SUCCESS (2.528s)
[212.489909] Starting dynamic subtest: gt_timelines
[240.166224] Dynamic subtest gt_timelines: SUCCESS (27.681s)
[240.171122] Starting dynamic subtest: gt_contexts
[241.606318] Dynamic subtest gt_contexts: SUCCESS (1.439s)
[241.612847] Starting dynamic subtest: gt_lrc
[249.440158] Dynamic subtest gt_lrc: SUCCESS (7.831s)
[249.444805] Starting dynamic subtest: gt_mocs
[253.114430] Dynamic subtest gt_mocs: SUCCESS (3.675s)
[253.120496] Starting dynamic subtest: gt_pm
[255.409311] Dynamic subtest gt_pm: SUCCESS (2.294s)
[255.415051] Starting dynamic subtest: gt_heartbeat
[257.040320] Dynamic subtest gt_heartbeat: SUCCESS (1.630s)
[257.046577] Starting dynamic subtest: gt_tlb
[269.054216] Dynamic subtest gt_tlb: SUCCESS (12.013s)
[269.059490] Starting dynamic subtest: requests
[286.663633] Dynamic subtest requests: SUCCESS (17.609s)
[286.670586] Starting dynamic subtest: migrate
[291.190319] Dynamic subtest migrate: SUCCESS (4.526s)
[291.195211] Starting dynamic subtest: active
[292.615290] Dynamic subtest active: SUCCESS (1.424s)
[292.621775] Starting dynamic subtest: objects
[294.874267] Dynamic subtest objects: SUCCESS (2.258s)
[294.880245] Starting dynamic subtest: mman
[303.607582] Dynamic subtest mman: SUCCESS (8.736s)
[303.612386] Starting dynamic subtest: dmabuf
[304.994941] Dynamic subtest dmabuf: SUCCESS (1.383s)
[304.999771] Starting dynamic subtest: vma
[306.386031] Dynamic subtest vma: SUCCESS (1.390s)
[306.390878] Starting dynamic subtest: coherency
[309.569989] Dynamic subtest coherency: SUCCESS (3.183s)
[309.574916] Starting dynamic subtest: gtt
[318.340217] Dynamic subtest gtt: SUCCESS (8.769s)
[318.345604] Starting dynamic subtest: gem
[319.774599] Dynamic subtest gem: SUCCESS (1.433s)
[319.780181] Starting dynamic subtest: evict
[323.321483] Dynamic subtest evict: SUCCESS (3.546s)
[323.328171] Starting dynamic subtest: hugepages
[340.813170] Dynamic subtest hugepages: SUCCESS (17.491s)
[340.819376] Starting dynamic subtest: gem_contexts
[381.266236] Dynamic subtest gem_contexts: SUCCESS (40.426s)
[381.270948] Starting dynamic subtest: client
[382.648322] Dynamic subtest client: SUCCESS (1.407s)
[382.654117] Starting dynamic subtest: gem_migrate
[387.330231] Dynamic subtest gem_migrate: SUCCESS (4.681s)
[387.336047] Starting dynamic subtest: reset
[388.798313] Dynamic subtest reset: SUCCESS (1.467s)
[388.805037] Starting dynamic subtest: memory_region
[391.684234] Dynamic subtest memory_region: SUCCESS (2.885s)
[391.689657] Starting dynamic subtest: hangcheck
[437.891928] Dynamic subtest hangcheck: SUCCESS (46.207s)
[437.896812] Starting dynamic subtest: execlists
[439.271293] Dynamic subtest execlists: SUCCESS (1.379s)
[439.276169] Starting dynamic subtest: ring_submission
[440.676316] Dynamic subtest ring_submission: SUCCESS (1.404s)
[440.682442] Starting dynamic subtest: perf
[442.143446] Dynamic subtest perf: SUCCESS (1.466s)
[442.149535] Starting dynamic subtest: slpc
[451.197282] Dynamic subtest slpc: SUCCESS (9.053s)
[451.202657] Starting dynamic subtest: guc
[453.960275] Dynamic subtest guc: SUCCESS (2.762s)
[453.965193] Starting dynamic subtest: guc_multi_lrc
[455.386312] Dynamic subtest guc_multi_lrc: SUCCESS (1.424s)
[455.392169] Starting dynamic subtest: guc_hang
[457.559420] Dynamic subtest guc_hang: SUCCESS (2.172s)
[457.565229] Starting dynamic subtest: late_gt_pm
[458.991025] Dynamic subtest late_gt_pm: SUCCESS (1.429s)
[458.992249] Subtest live: SUCCESS (256.280s)
[459.417997] [165/171] (540s left) dmabuf (all-tests)
[459.504258] Starting subtest: all-tests
[459.505973] Starting dynamic subtest: sanitycheck
[459.573551] Dynamic subtest sanitycheck: SUCCESS (0.069s)
[459.583647] Starting dynamic subtest: dma_fence
[459.758757] Dynamic subtest dma_fence: SUCCESS (0.184s)
[459.774428] Starting dynamic subtest: dma_fence_chain
[470.227560] Dynamic subtest dma_fence_chain: SUCCESS (10.467s)
[470.234373] Starting dynamic subtest: dma_fence_unwrap
[470.306580] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s)
[470.323315] Starting dynamic subtest: dma_resv
[470.394316] Dynamic subtest dma_resv: SUCCESS (0.085s)
[470.396203] Subtest all-tests: SUCCESS (10.891s)
[470.427176] [166/171] (529s left) i915_suspend (basic-s2idle-without-i915)
[470.475299] Starting subtest: basic-s2idle-without-i915
[489.551712] Subtest basic-s2idle-without-i915: SUCCESS (4.708s)
[489.579618] [167/171] (524s left) i915_suspend (basic-s3-without-i915)
[489.629922] Starting subtest: basic-s3-without-i915
[511.180237] Subtest basic-s3-without-i915: SUCCESS (5.691s)
[511.212308] [168/171] (519s left) gem_exec_suspend (basic-s0)
[511.291297] Starting subtest: basic-S0
[511.294647] Starting dynamic subtest: smem
[531.244539] Dynamic subtest smem: SUCCESS (4.746s)
[531.256178] Starting dynamic subtest: lmem0
[551.314272] Dynamic subtest lmem0: SUCCESS (5.329s)
[551.315880] Subtest basic-S0: SUCCESS (10.078s)
[551.480792] [169/171] (508s left) gem_exec_suspend (basic-s3)
[551.549505] Starting subtest: basic-S3
[551.550501] Starting dynamic subtest: smem
[572.620075] Dynamic subtest smem: SUCCESS (5.615s)
[572.627828] Starting dynamic subtest: lmem0
[596.250229] Dynamic subtest lmem0: SUCCESS (7.899s)
[596.251119] Subtest basic-S3: SUCCESS (13.516s)
[596.407333] [170/171] (495s left) kms_chamelium_hpd (common-hpd-after-suspend)
[596.639955] Subtest common-hpd-after-suspend: SKIP (0.000s)
[596.652985] [171/171] (494s left) kms_pipe_crc_basic (suspend-read-crc)
[596.845731] Subtest suspend-read-crc: SKIP (0.000s)
[596.856331] Closing watchdogs
Done.