[67.721606] Initializing watchdogs
[67.721832]   /dev/watchdog0
[67.736351] [001/165] (960s left) i915_module_load (load)
[67.824124] Starting subtest: load
[70.043928] Subtest load: SUCCESS (2.220s)
[70.068376] [002/165] (958s left) core_auth (basic-auth)
[70.230906] Starting subtest: basic-auth
[70.234359] Subtest basic-auth: SUCCESS (0.003s)
[70.266459] [003/165] (958s left) debugfs_test (read_all_entries)
[70.363067] Starting subtest: read_all_entries
[70.582456] Subtest read_all_entries: SUCCESS (0.209s)
[70.593519] [004/165] (957s left) debugfs_test (basic-hwmon)
[70.661044] Starting subtest: basic-hwmon
[70.670166] Subtest basic-hwmon: SUCCESS (0.003s)
[70.690352] [005/165] (957s left) fbdev (eof)
[70.766344] Starting subtest: eof
[70.768394] Subtest eof: SUCCESS (0.000s)
[70.797199] [006/165] (957s left) fbdev (info)
[70.871451] Starting subtest: info
[70.873562] Subtest info: SUCCESS (0.000s)
[70.905076] [007/165] (957s left) fbdev (nullptr)
[70.982497] Starting subtest: nullptr
[70.985044] Subtest nullptr: SUCCESS (0.000s)
[71.009953] [008/165] (957s left) fbdev (read)
[71.081988] Starting subtest: read
[71.895085] Subtest read: SUCCESS (0.806s)
[71.923397] [009/165] (956s left) fbdev (write)
[72.009129] Starting subtest: write
[72.533197] Subtest write: SUCCESS (0.525s)
[72.567885] [010/165] (955s left) gem_basic (bad-close)
[72.664902] Starting subtest: bad-close
[72.668226] Subtest bad-close: SUCCESS (0.000s)
[72.677153] [011/165] (955s left) gem_basic (create-close)
[72.755079] Starting subtest: create-close
[72.758457] Subtest create-close: SUCCESS (0.000s)
[72.799190] [012/165] (955s left) gem_basic (create-fd-close)
[72.882492] Starting subtest: create-fd-close
[72.885668] Subtest create-fd-close: SUCCESS (0.000s)
[72.921731] [013/165] (955s left) gem_busy (busy@all-engines)
[73.020054] Starting subtest: busy
[73.022080] Starting dynamic subtest: all-engines
[73.146542] Dynamic subtest all-engines: SUCCESS (0.127s)
[73.147722] Subtest busy: SUCCESS (0.127s)
[73.523621] [014/165] (954s left) gem_close_race (basic-process)
[73.651504] Starting subtest: basic-process
[73.732046] Subtest basic-process: SUCCESS (0.081s)
[73.914380] [015/165] (954s left) gem_close_race (basic-threads)
[74.023462] Starting subtest: basic-threads
[75.808144] Subtest basic-threads: SUCCESS (1.784s)
[76.004047] [016/165] (952s left) gem_ctx_create (basic)
[76.115770] Starting subtest: basic
[76.117869] Subtest basic: SUCCESS (0.000s)
[76.265587] [017/165] (952s left) gem_ctx_create (basic-files)
[76.353406] Starting subtest: basic-files
[78.378452] Subtest basic-files: SUCCESS (2.023s)
[78.697556] [018/165] (949s left) gem_ctx_exec (basic)
[78.788511] Starting subtest: basic
[78.790370] Subtest basic: SUCCESS (0.004s)
[78.870473] [019/165] (949s left) gem_exec_basic (basic)
[78.971648] Starting subtest: basic
[78.973894] Starting dynamic subtest: rcs0-smem
[78.976283] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[78.992830] Starting dynamic subtest: bcs0-smem
[78.994772] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[79.004231] Starting dynamic subtest: vcs0-smem
[79.006068] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[79.013060] Starting dynamic subtest: vcs1-smem
[79.014496] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[79.021410] Starting dynamic subtest: vecs0-smem
[79.023081] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[79.028307] Starting dynamic subtest: vecs1-smem
[79.030146] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[79.034561] Starting dynamic subtest: ccs0-smem
[79.036222] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[79.040666] Starting dynamic subtest: ccs1-smem
[79.042337] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[79.046815] Starting dynamic subtest: ccs2-smem
[79.048303] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[79.052880] Starting dynamic subtest: ccs3-smem
[79.054580] Dynamic subtest ccs3-smem: SUCCESS (0.000s)
[79.059064] Starting dynamic subtest: rcs0-lmem0
[79.060447] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[79.064839] Starting dynamic subtest: bcs0-lmem0
[79.066493] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[79.071025] Starting dynamic subtest: vcs0-lmem0
[79.072423] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[79.076762] Starting dynamic subtest: vcs1-lmem0
[79.078425] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[79.082790] Starting dynamic subtest: vecs0-lmem0
[79.084221] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[79.088749] Starting dynamic subtest: vecs1-lmem0
[79.090479] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[79.095161] Starting dynamic subtest: ccs0-lmem0
[79.096859] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[79.101723] Starting dynamic subtest: ccs1-lmem0
[79.103456] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[79.108022] Starting dynamic subtest: ccs2-lmem0
[79.109660] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[79.123049] Starting dynamic subtest: ccs3-lmem0
[79.124601] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[79.125692] Subtest basic: SUCCESS (0.012s)
[79.162657] [020/165] (949s left) gem_exec_create (basic)
[79.254488] Starting subtest: basic
[79.256575] Starting dynamic subtest: smem
[81.369446] Dynamic subtest smem: SUCCESS (2.115s)
[81.385582] Starting dynamic subtest: lmem0
[83.493342] Dynamic subtest lmem0: SUCCESS (2.123s)
[83.495025] Subtest basic: SUCCESS (4.239s)
[83.646220] [021/165] (945s left) gem_exec_fence (basic-busy)
[83.874309] Starting subtest: basic-busy
[83.876131] Starting dynamic subtest: rcs0
[83.987439] Dynamic subtest rcs0: SUCCESS (0.113s)
[84.001516] Starting dynamic subtest: bcs0
[84.043802] Dynamic subtest bcs0: SUCCESS (0.056s)
[84.058397] Starting dynamic subtest: vcs0
[84.103505] Dynamic subtest vcs0: SUCCESS (0.059s)
[84.118069] Starting dynamic subtest: vcs1
[84.157393] Dynamic subtest vcs1: SUCCESS (0.054s)
[84.171864] Starting dynamic subtest: vecs0
[84.211367] Dynamic subtest vecs0: SUCCESS (0.054s)
[84.225764] Starting dynamic subtest: vecs1
[84.261853] Dynamic subtest vecs1: SUCCESS (0.050s)
[84.276333] Starting dynamic subtest: ccs0
[84.319443] Dynamic subtest ccs0: SUCCESS (0.058s)
[84.333768] Starting dynamic subtest: ccs1
[84.368731] Dynamic subtest ccs1: SUCCESS (0.049s)
[84.382629] Starting dynamic subtest: ccs2
[84.422668] Dynamic subtest ccs2: SUCCESS (0.053s)
[84.436288] Starting dynamic subtest: ccs3
[84.472668] Dynamic subtest ccs3: SUCCESS (0.050s)
[84.474039] Subtest basic-busy: SUCCESS (0.600s)
[85.854135] [022/165] (942s left) gem_exec_fence (basic-wait)
[86.111401] Starting subtest: basic-wait
[86.113074] Starting dynamic subtest: rcs0
[86.228198] Dynamic subtest rcs0: SUCCESS (0.116s)
[86.242935] Starting dynamic subtest: bcs0
[86.279869] Dynamic subtest bcs0: SUCCESS (0.052s)
[86.294789] Starting dynamic subtest: vcs0
[86.329768] Dynamic subtest vcs0: SUCCESS (0.049s)
[86.344757] Starting dynamic subtest: vcs1
[86.383713] Dynamic subtest vcs1: SUCCESS (0.054s)
[86.398275] Starting dynamic subtest: vecs0
[86.433915] Dynamic subtest vecs0: SUCCESS (0.050s)
[86.448797] Starting dynamic subtest: vecs1
[86.487839] Dynamic subtest vecs1: SUCCESS (0.053s)
[86.502636] Starting dynamic subtest: ccs0
[86.541736] Dynamic subtest ccs0: SUCCESS (0.054s)
[86.556164] Starting dynamic subtest: ccs1
[86.596214] Dynamic subtest ccs1: SUCCESS (0.053s)
[86.610540] Starting dynamic subtest: ccs2
[86.646664] Dynamic subtest ccs2: SUCCESS (0.051s)
[86.661175] Starting dynamic subtest: ccs3
[86.701068] Dynamic subtest ccs3: SUCCESS (0.053s)
[86.702673] Subtest basic-wait: SUCCESS (0.590s)
[88.044791] [023/165] (940s left) gem_exec_fence (basic-await)
[88.282078] Starting subtest: basic-await
[88.283488] Starting dynamic subtest: rcs0
[88.433096] Dynamic subtest rcs0: SUCCESS (0.151s)
[88.448997] Starting dynamic subtest: bcs0
[88.563441] Dynamic subtest bcs0: SUCCESS (0.130s)
[88.579988] Starting dynamic subtest: vcs0
[88.697606] Dynamic subtest vcs0: SUCCESS (0.133s)
[88.712853] Starting dynamic subtest: vcs1
[88.826160] Dynamic subtest vcs1: SUCCESS (0.128s)
[88.836988] Starting dynamic subtest: vecs0
[88.923765] Dynamic subtest vecs0: SUCCESS (0.098s)
[88.938497] Starting dynamic subtest: vecs1
[89.054589] Dynamic subtest vecs1: SUCCESS (0.130s)
[89.071849] Starting dynamic subtest: ccs0
[89.152946] Dynamic subtest ccs0: SUCCESS (0.098s)
[89.167948] Starting dynamic subtest: ccs1
[89.280544] Dynamic subtest ccs1: SUCCESS (0.127s)
[89.294900] Starting dynamic subtest: ccs2
[89.379316] Dynamic subtest ccs2: SUCCESS (0.099s)
[89.394532] Starting dynamic subtest: ccs3
[89.508292] Dynamic subtest ccs3: SUCCESS (0.129s)
[89.509535] Subtest basic-await: SUCCESS (1.226s)
[90.897148] [024/165] (937s left) gem_exec_fence (nb-await)
[91.162098] Starting subtest: nb-await
[91.163941] Starting dynamic subtest: rcs0
[91.284407] Dynamic subtest rcs0: SUCCESS (0.122s)
[91.300923] Starting dynamic subtest: bcs0
[91.349104] Dynamic subtest bcs0: SUCCESS (0.065s)
[91.364100] Starting dynamic subtest: vcs0
[91.413254] Dynamic subtest vcs0: SUCCESS (0.064s)
[91.428099] Starting dynamic subtest: vcs1
[91.477663] Dynamic subtest vcs1: SUCCESS (0.064s)
[91.492398] Starting dynamic subtest: vecs0
[91.542402] Dynamic subtest vecs0: SUCCESS (0.064s)
[91.557075] Starting dynamic subtest: vecs1
[91.605379] Dynamic subtest vecs1: SUCCESS (0.064s)
[91.620312] Starting dynamic subtest: ccs0
[91.669908] Dynamic subtest ccs0: SUCCESS (0.064s)
[91.685063] Starting dynamic subtest: ccs1
[91.734107] Dynamic subtest ccs1: SUCCESS (0.064s)
[91.749081] Starting dynamic subtest: ccs2
[91.798498] Dynamic subtest ccs2: SUCCESS (0.064s)
[91.813300] Starting dynamic subtest: ccs3
[91.862247] Dynamic subtest ccs3: SUCCESS (0.063s)
[91.863948] Subtest nb-await: SUCCESS (0.700s)
[93.196808] [025/165] (935s left) gem_exec_gttfill (basic)
[93.314124] Starting subtest: basic
[101.862320] Subtest basic: SUCCESS (8.548s)
[102.087307] [026/165] (926s left) gem_exec_parallel (engines)
[102.217689] Starting subtest: engines
[102.219303] Starting dynamic subtest: basic
[105.411599] Dynamic subtest basic: SUCCESS (3.194s)
[105.427327] Starting dynamic subtest: contexts
[110.283180] Dynamic subtest contexts: SUCCESS (4.870s)
[110.298934] Starting dynamic subtest: fds
[114.741965] Dynamic subtest fds: SUCCESS (4.458s)
[114.761432] Starting dynamic subtest: userptr
[117.654319] Dynamic subtest userptr: SUCCESS (2.913s)
[117.655406] Subtest engines: SUCCESS (15.437s)
[117.897562] [027/165] (910s left) gem_exec_store (basic)
[118.020051] Starting subtest: basic
[118.177663] Subtest basic: SUCCESS (0.157s)
[118.372967] [028/165] (910s left) gem_flink_basic (bad-flink)
[118.485795] Starting subtest: bad-flink
[118.488175] Subtest bad-flink: SUCCESS (0.000s)
[118.506073] [029/165] (910s left) gem_flink_basic (bad-open)
[118.601490] Starting subtest: bad-open
[118.603126] Subtest bad-open: SUCCESS (0.000s)
[118.616412] [030/165] (910s left) gem_flink_basic (basic)
[118.698121] Starting subtest: basic
[118.699738] Subtest basic: SUCCESS (0.000s)
[118.740323] [031/165] (910s left) gem_flink_basic (double-flink)
[118.830623] Starting subtest: double-flink
[118.831454] Subtest double-flink: SUCCESS (0.000s)
[118.876660] [032/165] (910s left) gem_flink_basic (flink-lifetime)
[118.985099] Starting subtest: flink-lifetime
[118.987383] Subtest flink-lifetime: SUCCESS (0.003s)
[119.042993] [033/165] (909s left) gem_huc_copy (huc-copy)
[119.162372] Starting subtest: huc-copy
[119.168729] Subtest huc-copy: SUCCESS (0.006s)
[119.244195] [034/165] (909s left) gem_linear_blits (basic)
[119.504887] Starting subtest: basic
[119.566889] Subtest basic: SUCCESS (0.064s)
[119.637421] [035/165] (909s left) gem_mmap (basic)
[119.754607] Subtest basic: SKIP (0.000s)
[119.774470] [036/165] (909s left) gem_mmap_gtt (basic)
[119.877042] Subtest basic: SKIP (0.000s)
[119.900200] [037/165] (909s left) gem_render_linear_blits (basic)
[119.994402] Starting subtest: basic
[120.076815] Subtest basic: SUCCESS (0.082s)
[120.150238] [038/165] (908s left) gem_render_tiled_blits (basic)
[120.250789] Subtest basic: SKIP (0.000s)
[120.269899] [039/165] (908s left) gem_ringfill (basic-all)
[120.769307] Starting subtest: basic-all
[122.110523] Subtest basic-all: SUCCESS (1.340s)
[122.187694] [040/165] (906s left) gem_softpin (allocator-basic)
[122.303179] Starting subtest: allocator-basic
[122.536527] Subtest allocator-basic: SUCCESS (0.233s)
[122.643462] [041/165] (906s left) gem_softpin (allocator-basic-reserve)
[122.737223] Starting subtest: allocator-basic-reserve
[122.996378] Subtest allocator-basic-reserve: SUCCESS (0.259s)
[123.086499] [042/165] (906s left) gem_softpin (safe-alignment)
[123.182358] Starting subtest: safe-alignment
[123.262789] Subtest safe-alignment: SUCCESS (0.080s)
[123.326664] [043/165] (905s left) gem_sync (basic-all)
[123.439972] Starting subtest: basic-all
[127.615455] Subtest basic-all: SUCCESS (4.174s)
[127.766318] [044/165] (901s left) gem_sync (basic-each)
[127.863344] Starting subtest: basic-each
[130.503696] Subtest basic-each: SUCCESS (2.640s)
[130.660095] [045/165] (898s left) gem_tiled_blits (basic)
[130.763066] Subtest basic: SKIP (0.000s)
[130.786220] [046/165] (898s left) gem_tiled_fence_blits (basic)
[130.888165] Subtest basic: SKIP (0.000s)
[130.912241] [047/165] (898s left) gem_tiled_pread_basic
[131.046207] [048/165] (898s left) gem_wait (busy@all-engines)
[131.159837] Starting subtest: busy
[131.161073] Starting dynamic subtest: all-engines
[131.759066] Dynamic subtest all-engines: SUCCESS (0.599s)
[131.760143] Subtest busy: SUCCESS (0.600s)
[131.994969] [049/165] (897s left) gem_wait (wait@all-engines)
[132.116748] Starting subtest: wait
[132.118039] Starting dynamic subtest: all-engines
[133.208777] Dynamic subtest all-engines: SUCCESS (1.092s)
[133.210329] Subtest wait: SUCCESS (1.092s)
[133.435744] [050/165] (895s left) i915_getparams_basic (basic-eu-total)
[133.529701] Starting subtest: basic-eu-total
[133.532248] Subtest basic-eu-total: SUCCESS (0.000s)
[133.541790] [051/165] (895s left) i915_getparams_basic (basic-subslice-total)
[133.636923] Starting subtest: basic-subslice-total
[133.641631] Subtest basic-subslice-total: SUCCESS (0.000s)
[133.665147] [052/165] (895s left) i915_hangman (error-state-basic)
[133.771699] Starting subtest: error-state-basic
[133.946068] Subtest error-state-basic: SUCCESS (0.175s)
[133.992247] [053/165] (895s left) i915_pciid
[134.106772] [054/165] (895s left) kms_addfb_basic (addfb25-4-tiled)
[134.200455] Subtest addfb25-4-tiled: SKIP (0.000s)
[134.214910] [055/165] (895s left) kms_addfb_basic (addfb25-bad-modifier)
[134.311029] Subtest addfb25-bad-modifier: SKIP (0.000s)
[134.340179] [056/165] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[134.434433] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[134.460242] [057/165] (895s left) kms_addfb_basic (addfb25-modifier-no-flag)
[134.553571] Subtest addfb25-modifier-no-flag: SKIP (0.000s)
[134.577774] [058/165] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[134.671177] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[134.693893] [059/165] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[134.749241] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[134.770673] [060/165] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[134.883071] Subtest addfb25-yf-tiled-legacy: SKIP (0.000s)
[134.896092] [061/165] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[135.001961] Subtest addfb25-y-tiled-legacy: SKIP (0.000s)
[135.020905] [062/165] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[135.104029] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[135.121949] [063/165] (894s left) kms_addfb_basic (bad-pitch-0)
[135.230990] Subtest bad-pitch-0: SKIP (0.000s)
[135.247093] [064/165] (894s left) kms_addfb_basic (bad-pitch-1024)
[135.336347] Subtest bad-pitch-1024: SKIP (0.000s)
[135.349298] [065/165] (894s left) kms_addfb_basic (bad-pitch-128)
[135.438735] Subtest bad-pitch-128: SKIP (0.000s)
[135.459982] [066/165] (894s left) kms_addfb_basic (bad-pitch-256)
[135.553050] Subtest bad-pitch-256: SKIP (0.000s)
[135.575574] [067/165] (894s left) kms_addfb_basic (bad-pitch-32)
[135.683319] Subtest bad-pitch-32: SKIP (0.000s)
[135.702015] [068/165] (894s left) kms_addfb_basic (bad-pitch-63)
[135.794619] Subtest bad-pitch-63: SKIP (0.000s)
[135.812116] [069/165] (893s left) kms_addfb_basic (bad-pitch-65536)
[135.905046] Subtest bad-pitch-65536: SKIP (0.000s)
[135.926297] [070/165] (893s left) kms_addfb_basic (bad-pitch-999)
[136.043592] Subtest bad-pitch-999: SKIP (0.000s)
[136.056881] [071/165] (893s left) kms_addfb_basic (basic)
[136.161293] Subtest basic: SKIP (0.000s)
[136.182268] [072/165] (893s left) kms_addfb_basic (basic-x-tiled-legacy)
[136.275307] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[136.297269] [073/165] (893s left) kms_addfb_basic (basic-y-tiled-legacy)
[136.396864] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[136.420839] [074/165] (893s left) kms_addfb_basic (bo-too-small)
[136.515022] Subtest bo-too-small: SKIP (0.000s)
[136.535956] [075/165] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[136.627370] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[136.645907] [076/165] (893s left) kms_addfb_basic (clobberred-modifier)
[136.737056] Subtest clobberred-modifier: SKIP (0.000s)
[136.756184] [077/165] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[136.872056] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[136.891504] [078/165] (893s left) kms_addfb_basic (invalid-get-prop)
[136.989058] Subtest invalid-get-prop: SKIP (0.000s)
[137.008379] [079/165] (892s left) kms_addfb_basic (invalid-get-prop-any)
[137.101086] Subtest invalid-get-prop-any: SKIP (0.000s)
[137.122639] [080/165] (892s left) kms_addfb_basic (invalid-set-prop)
[137.238035] Subtest invalid-set-prop: SKIP (0.000s)
[137.256242] [081/165] (892s left) kms_addfb_basic (invalid-set-prop-any)
[137.356031] Subtest invalid-set-prop-any: SKIP (0.000s)
[137.379872] [082/165] (892s left) kms_addfb_basic (no-handle)
[137.471022] Subtest no-handle: SKIP (0.000s)
[137.494059] [083/165] (892s left) kms_addfb_basic (size-max)
[137.587901] Subtest size-max: SKIP (0.000s)
[137.606381] [084/165] (892s left) kms_addfb_basic (small-bo)
[137.696989] Subtest small-bo: SKIP (0.000s)
[137.717347] [085/165] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[137.804028] Subtest tile-pitch-mismatch: SKIP (0.000s)
[137.828325] [086/165] (892s left) kms_addfb_basic (too-high)
[137.919760] Subtest too-high: SKIP (0.000s)
[137.943587] [087/165] (892s left) kms_addfb_basic (too-wide)
[138.028925] Subtest too-wide: SKIP (0.000s)
[138.058329] [088/165] (892s left) kms_addfb_basic (unused-handle)
[138.145288] Subtest unused-handle: SKIP (0.000s)
[138.166969] [089/165] (892s left) kms_addfb_basic (unused-modifier)
[138.270050] Subtest unused-modifier: SKIP (0.000s)
[138.293723] [090/165] (891s left) kms_addfb_basic (unused-offsets)
[138.381818] Subtest unused-offsets: SKIP (0.000s)
[138.403645] [091/165] (891s left) kms_addfb_basic (unused-pitches)
[138.494050] Subtest unused-pitches: SKIP (0.000s)
[138.516154] [092/165] (891s left) kms_busy (basic)
[138.628298] Subtest basic: SKIP (0.000s)
[138.673792] [093/165] (891s left) kms_prop_blob (basic)
[138.763051] Subtest basic: SKIP (0.000s)
[138.784903] [094/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[138.877559] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[138.899327] [095/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[138.990050] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[139.013742] [096/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[139.103052] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[139.128264] [097/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[139.218840] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[139.245989] [098/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[139.335039] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[139.358788] [099/165] (891s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[139.446047] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[139.473911] [100/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[139.567051] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[139.592360] [101/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.680052] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[139.704682] [102/165] (890s left) kms_dsc (dsc-basic)
[139.799581] Subtest dsc-basic: SKIP (0.000s)
[139.822761] [103/165] (890s left) kms_flip (basic-flip-vs-dpms)
[139.930220] Subtest basic-flip-vs-dpms: SKIP (0.000s)
[139.992655] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[140.079664] Subtest basic-flip-vs-modeset: SKIP (0.000s)
[140.125719] [105/165] (890s left) kms_flip (basic-flip-vs-wf_vblank)
[140.212538] Subtest basic-flip-vs-wf_vblank: SKIP (0.000s)
[140.258409] [106/165] (890s left) kms_flip (basic-plain-flip)
[140.346585] Subtest basic-plain-flip: SKIP (0.000s)
[140.393560] [107/165] (890s left) kms_force_connector_basic (force-connector-state)
[140.499062] Subtest force-connector-state: SKIP (0.000s)
[140.524355] [108/165] (890s left) kms_force_connector_basic (force-edid)
[140.608626] Subtest force-edid: SKIP (0.000s)
[140.636210] [109/165] (890s left) kms_force_connector_basic (force-load-detect)
[140.725350] Subtest force-load-detect: SKIP (0.000s)
[140.746576] [110/165] (889s left) kms_force_connector_basic (prune-stale-modes)
[140.834056] Subtest prune-stale-modes: SKIP (0.000s)
[140.858949] [111/165] (889s left) kms_frontbuffer_tracking (basic)
[140.947037] Subtest basic: SKIP (0.000s)
[140.972686] [112/165] (889s left) kms_hdmi_inject (inject-audio)
[141.063543] Subtest inject-audio: SKIP (0.000s)
[141.091479] [113/165] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[141.197698] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[141.223390] [114/165] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[141.312504] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[141.336307] [115/165] (889s left) kms_pipe_crc_basic (hang-read-crc)
[141.427727] Subtest hang-read-crc: SKIP (0.000s)
[141.456783] [116/165] (889s left) kms_pipe_crc_basic (nonblocking-crc)
[141.542038] Subtest nonblocking-crc: SKIP (0.000s)
[141.570797] [117/165] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[141.680027] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[141.703630] [118/165] (889s left) kms_pipe_crc_basic (read-crc)
[141.792965] Subtest read-crc: SKIP (0.000s)
[141.814390] [119/165] (889s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[141.918073] Subtest read-crc-frame-sequence: SKIP (0.000s)
[141.945575] [120/165] (888s left) kms_pm_backlight (basic-brightness)
[142.057044] Subtest basic-brightness: SKIP (0.000s)
[142.081550] [121/165] (888s left) kms_pm_rpm (basic-pci-d3-state)
[142.196688] Subtest basic-pci-d3-state: SKIP (0.000s)
[142.213970] [122/165] (888s left) kms_pm_rpm (basic-rte)
[142.283820] Starting subtest: basic-rte
[142.300993] Subtest basic-rte: SKIP (0.012s)
[142.322133] [123/165] (888s left) kms_psr (psr-primary-page-flip)
[142.409036] Subtest psr-primary-page-flip: SKIP (0.000s)
[142.448503] [124/165] (888s left) kms_psr (psr-cursor-plane-move)
[142.534652] Subtest psr-cursor-plane-move: SKIP (0.000s)
[142.572785] [125/165] (888s left) kms_psr (psr-sprite-plane-onoff)
[142.660701] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[142.696180] [126/165] (888s left) kms_psr (psr-primary-mmap-gtt)
[142.783469] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[142.820455] [127/165] (888s left) kms_setmode (basic-clone-single-crtc)
[142.911417] Subtest basic-clone-single-crtc: SKIP (0.000s)
[142.938834] [128/165] (888s left) i915_pm_rps (basic-api)
[143.035061] Starting subtest: basic-api
[143.037609] Subtest basic-api: SKIP (0.000s)
[143.067401] [129/165] (888s left) prime_self_import (basic-llseek-bad)
[143.144969] Starting subtest: basic-llseek-bad
[143.157475] Subtest basic-llseek-bad: SUCCESS (0.013s)
[143.198873] [130/165] (887s left) prime_self_import (basic-llseek-size)
[143.271928] Starting subtest: basic-llseek-size
[143.285777] Subtest basic-llseek-size: SUCCESS (0.014s)
[143.319438] [131/165] (887s left) prime_self_import (basic-with_fd_dup)
[143.395973] Starting subtest: basic-with_fd_dup
[143.424314] Subtest basic-with_fd_dup: SUCCESS (0.030s)
[143.462693] [132/165] (887s left) prime_self_import (basic-with_one_bo)
[143.532973] Starting subtest: basic-with_one_bo
[143.546799] Subtest basic-with_one_bo: SUCCESS (0.015s)
[143.575232] [133/165] (887s left) prime_self_import (basic-with_one_bo_two_files)
[143.652156] Starting subtest: basic-with_one_bo_two_files
[143.666040] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[143.726425] [134/165] (887s left) prime_self_import (basic-with_two_bos)
[143.808574] Starting subtest: basic-with_two_bos
[143.846221] Subtest basic-with_two_bos: SUCCESS (0.038s)
[143.896853] [135/165] (887s left) prime_vgem (basic-fence-flip)
[143.989055] Starting subtest: basic-fence-flip
[143.991324] Subtest basic-fence-flip: SKIP (0.000s)
[144.050424] [136/165] (887s left) prime_vgem (basic-fence-mmap)
[144.133774] Starting subtest: basic-fence-mmap
[144.136060] Subtest basic-fence-mmap: SKIP (0.000s)
[144.195095] [137/165] (887s left) prime_vgem (basic-fence-read)
[144.302981] Starting subtest: basic-fence-read
[144.325227] Subtest basic-fence-read: SKIP (0.021s)
[144.382759] [138/165] (886s left) prime_vgem (basic-gtt)
[144.503497] Starting subtest: basic-gtt
[144.506149] Subtest basic-gtt: SKIP (0.000s)
[144.564534] [139/165] (886s left) prime_vgem (basic-read)
[144.652865] Starting subtest: basic-read
[144.662929] Subtest basic-read: SKIP (0.009s)
[144.722233] [140/165] (886s left) prime_vgem (basic-write)
[144.808615] Starting subtest: basic-write
[144.817726] Subtest basic-write: SKIP (0.008s)
[144.881255] [141/165] (886s left) vgem_basic (setversion)
[144.961960] Starting subtest: setversion
[144.967042] Subtest setversion: SUCCESS (0.000s)
[144.993738] [142/165] (886s left) vgem_basic (create)
[145.069753] Starting subtest: create
[145.072850] Subtest create: SUCCESS (0.000s)
[145.104241] [143/165] (886s left) vgem_basic (debugfs)
[145.181932] Starting subtest: debugfs
[145.183991] Subtest debugfs: SUCCESS (0.000s)
[145.213895] [144/165] (886s left) vgem_basic (dmabuf-export)
[145.293512] Starting subtest: dmabuf-export
[145.325078] Subtest dmabuf-export: SUCCESS (0.032s)
[145.376958] [145/165] (886s left) vgem_basic (dmabuf-fence)
[145.455483] Starting subtest: dmabuf-fence
[145.456461] Subtest dmabuf-fence: SUCCESS (0.001s)
[145.487818] [146/165] (886s left) vgem_basic (dmabuf-fence-before)
[145.563606] Starting subtest: dmabuf-fence-before
[145.565482] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[145.592948] [147/165] (886s left) vgem_basic (dmabuf-mmap)
[145.669899] Starting subtest: dmabuf-mmap
[145.684075] Subtest dmabuf-mmap: SUCCESS (0.016s)
[145.711755] [148/165] (885s left) vgem_basic (mmap)
[145.783898] Starting subtest: mmap
[145.794063] Subtest mmap: SUCCESS (0.011s)
[145.829791] [149/165] (885s left) vgem_basic (second-client)
[145.922559] Starting subtest: second-client
[145.926047] Subtest second-client: SUCCESS (0.002s)
[145.949922] [150/165] (885s left) vgem_basic (sysfs)
[146.025907] Starting subtest: sysfs
[146.029043] Subtest sysfs: SUCCESS (0.000s)
[146.050139] [151/165] (885s left) core_hotunplug (unbind-rebind)
[146.194162] Starting subtest: unbind-rebind
[150.582329] Subtest unbind-rebind: SUCCESS (4.388s)
[150.614034] [152/165] (881s left) vgem_basic (unload)
[150.707637] Starting subtest: unload
[179.597093] Subtest unload: SUCCESS (28.889s)
[179.668666] [153/165] (852s left) i915_module_load (reload)
[179.745796] Starting subtest: reload
[183.097914] Subtest reload: SUCCESS (3.352s)
[183.116887] [154/165] (848s left) gem_lmem_swapping (basic)
[186.189867] Starting subtest: basic
[186.191365] Starting dynamic subtest: lmem0
[224.843111] Dynamic subtest lmem0: SUCCESS (38.652s)
[224.844637] Subtest basic: SUCCESS (38.652s)
[226.767471] [155/165] (805s left) gem_lmem_swapping (parallel-random-engines)
[227.714826] Starting subtest: parallel-random-engines
[227.716692] Starting dynamic subtest: lmem0
[278.867181] Dynamic subtest lmem0: SUCCESS (51.152s)
[278.868751] Subtest parallel-random-engines: SUCCESS (51.152s)
[280.136263] [156/165] (751s left) gem_lmem_swapping (random-engines)
[281.047125] Starting subtest: random-engines
[281.048490] Starting dynamic subtest: lmem0
[282.224885] Dynamic subtest lmem0: SUCCESS (1.177s)
[282.226553] Subtest random-engines: SUCCESS (1.178s)
[283.580467] [157/165] (748s left) gem_lmem_swapping (verify-random)
[284.520247] Starting subtest: verify-random
[284.521488] Starting dynamic subtest: lmem0
[300.691695] Dynamic subtest lmem0: SUCCESS (16.171s)
[300.692961] Subtest verify-random: SUCCESS (16.171s)
[302.157327] [158/165] (729s left) i915_pm_rpm (module-reload)
[314.296058] Starting subtest: module-reload
[344.979787] Subtest module-reload: SUCCESS (30.684s)
[345.010128] [159/165] (686s left) i915_selftest (live)
[345.103649] Starting subtest: live
[345.105214] Starting dynamic subtest: sanitycheck
[347.621802] Dynamic subtest sanitycheck: SUCCESS (2.518s)
[347.634923] Starting dynamic subtest: uncore
[350.182974] Dynamic subtest uncore: SUCCESS (2.561s)
[350.195931] Starting dynamic subtest: workarounds
[354.534598] Dynamic subtest workarounds: SUCCESS (4.351s)
[354.547895] Starting dynamic subtest: gt_engines
[358.160741] Dynamic subtest gt_engines: SUCCESS (3.626s)
[358.175387] Starting dynamic subtest: gt_timelines
[382.784083] Dynamic subtest gt_timelines: SUCCESS (24.623s)
[382.797694] Starting dynamic subtest: gt_contexts
[385.416860] Dynamic subtest gt_contexts: SUCCESS (2.633s)
[385.430290] Starting dynamic subtest: gt_lrc
[394.527362] Dynamic subtest gt_lrc: SUCCESS (9.110s)
[394.541038] Starting dynamic subtest: gt_mocs
[398.532946] Dynamic subtest gt_mocs: SUCCESS (4.006s)
[398.547912] Starting dynamic subtest: gt_pm
[402.077969] Dynamic subtest gt_pm: SUCCESS (3.544s)
[402.092684] Starting dynamic subtest: gt_heartbeat
[404.874909] Dynamic subtest gt_heartbeat: SUCCESS (2.797s)
[404.889406] Starting dynamic subtest: gt_tlb
[421.260168] Dynamic subtest gt_tlb: SUCCESS (16.385s)
[421.274772] Starting dynamic subtest: requests
[443.231193] Dynamic subtest requests: SUCCESS (21.970s)
[443.245672] Starting dynamic subtest: migrate
[451.713719] Dynamic subtest migrate: SUCCESS (8.482s)
[451.727427] Starting dynamic subtest: active
[454.335157] Dynamic subtest active: SUCCESS (2.621s)
[454.350647] Starting dynamic subtest: objects
[458.421335] Dynamic subtest objects: SUCCESS (4.085s)
[458.435121] Starting dynamic subtest: mman
[468.858374] Dynamic subtest mman: SUCCESS (10.438s)
[468.871172] Starting dynamic subtest: dmabuf
[471.403085] Dynamic subtest dmabuf: SUCCESS (2.544s)
[471.416400] Starting dynamic subtest: vma
[473.665362] Dynamic subtest vma: SUCCESS (2.261s)
[473.679502] Starting dynamic subtest: coherency
[478.039585] Dynamic subtest coherency: SUCCESS (4.373s)
[478.054647] Starting dynamic subtest: gtt
[497.792145] Dynamic subtest gtt: SUCCESS (19.751s)
[497.807788] Starting dynamic subtest: gem
[500.426772] Dynamic subtest gem: SUCCESS (2.632s)
[500.441537] Starting dynamic subtest: evict
[505.059381] Dynamic subtest evict: SUCCESS (4.630s)
[505.073069] Starting dynamic subtest: hugepages
[525.074500] Dynamic subtest hugepages: SUCCESS (20.014s)
[525.087818] Starting dynamic subtest: gem_contexts
[572.512192] Dynamic subtest gem_contexts: SUCCESS (47.437s)
[572.526605] Starting dynamic subtest: client
[575.117580] Dynamic subtest client: SUCCESS (2.604s)
[575.132753] Starting dynamic subtest: gem_migrate
[579.556471] Dynamic subtest gem_migrate: SUCCESS (4.437s)
[579.569335] Starting dynamic subtest: reset
[582.248403] Dynamic subtest reset: SUCCESS (2.690s)
[582.259067] Starting dynamic subtest: memory_region
[586.341299] Dynamic subtest memory_region: SUCCESS (4.091s)
[586.354850] Starting dynamic subtest: hangcheck
[627.796600] Dynamic subtest hangcheck: SUCCESS (41.453s)
[627.810227] Starting dynamic subtest: execlists
[630.403645] Dynamic subtest execlists: SUCCESS (2.606s)
[630.416889] Starting dynamic subtest: ring_submission
[632.977252] Dynamic subtest ring_submission: SUCCESS (2.571s)
[632.990900] Starting dynamic subtest: perf
[635.731998] Dynamic subtest perf: SUCCESS (2.753s)
[635.745941] Starting dynamic subtest: slpc
[646.155931] Dynamic subtest slpc: SUCCESS (10.423s)
[646.170291] Starting dynamic subtest: guc
[650.240423] Dynamic subtest guc: SUCCESS (4.083s)
[650.255309] Starting dynamic subtest: guc_multi_lrc
[652.957331] Dynamic subtest guc_multi_lrc: SUCCESS (2.713s)
[652.971160] Starting dynamic subtest: guc_hang
[656.299653] Dynamic subtest guc_hang: SUCCESS (3.341s)
[656.315282] Starting dynamic subtest: late_gt_pm
[658.982407] Dynamic subtest late_gt_pm: SUCCESS (2.680s)
[658.983715] Subtest live: SUCCESS (313.878s)
[659.194491] [160/165] (372s left) dmabuf (all-tests)
[659.279067] Starting subtest: all-tests
[659.282942] Starting dynamic subtest: sanitycheck
[659.348927] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[659.365829] Starting dynamic subtest: dma_fence
[659.538701] Dynamic subtest dma_fence: SUCCESS (0.187s)
[659.555661] Starting dynamic subtest: dma_fence_chain
[670.591642] Dynamic subtest dma_fence_chain: SUCCESS (11.050s)
[670.608099] Starting dynamic subtest: dma_fence_unwrap
[670.670974] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s)
[670.687929] Starting dynamic subtest: dma_resv
[670.755820] Dynamic subtest dma_resv: SUCCESS (0.082s)
[670.757384] Subtest all-tests: SUCCESS (11.478s)
[670.801481] [161/165] (361s left) i915_suspend (basic-s2idle-without-i915)
[670.878630] Starting subtest: basic-s2idle-without-i915
[691.221499] Subtest basic-s2idle-without-i915: SUCCESS (6.619s)
[704.307086] [162/165] (354s left) i915_suspend (basic-s3-without-i915)
[704.409027] Starting subtest: basic-s3-without-i915
[706.703051] Subtest basic-s3-without-i915: SKIP (2.291s)
[707.600125] [163/165] (351s left) gem_exec_suspend (basic-s0)
[707.709546] Starting subtest: basic-S0
[707.711288] Starting dynamic subtest: smem
[728.939861] Dynamic subtest smem: SUCCESS (7.473s)
[728.960619] Starting dynamic subtest: lmem0
[749.887465] Dynamic subtest lmem0: SUCCESS (7.463s)
[749.888802] Subtest basic-S0: SUCCESS (14.941s)
[757.091437] [164/165] (335s left) gem_exec_suspend (basic-s3)
[757.217825] Starting subtest: basic-S3
[757.219333] Starting dynamic subtest: smem
[777.919489] Dynamic subtest smem: SUCCESS (7.395s)
[777.939883] Starting dynamic subtest: lmem0
[798.856240] Dynamic subtest lmem0: SUCCESS (7.558s)
[798.857674] Subtest basic-S3: SUCCESS (14.957s)
[807.038260] [165/165] (320s left) kms_pipe_crc_basic (suspend-read-crc)
[807.138610] Subtest suspend-read-crc: SKIP (0.000s)
[807.155442] Closing watchdogs
Done.