[51.313076] Initializing watchdogs
[51.313116]   /dev/watchdog0
[51.327865] [001/165] (960s left) i915_module_load (load)
[51.359679] Starting subtest: load
[52.697804] Subtest load: SUCCESS (1.338s)
[52.707532] [002/165] (959s left) core_auth (basic-auth)
[52.774225] Starting subtest: basic-auth
[52.775312] Subtest basic-auth: SUCCESS (0.001s)
[52.792913] [003/165] (959s left) debugfs_test (read_all_entries)
[52.825432] Starting subtest: read_all_entries
[52.917969] Subtest read_all_entries: SUCCESS (0.092s)
[52.935103] [004/165] (958s left) debugfs_test (basic-hwmon)
[52.964652] Starting subtest: basic-hwmon
[52.966176] Subtest basic-hwmon: SKIP (0.000s)
[52.981037] [005/165] (958s left) fbdev (eof)
[53.457291] Subtest eof: SKIP (0.000s)
[53.464203] [006/165] (958s left) fbdev (info)
[53.497776] Subtest info: SKIP (0.000s)
[53.504062] [007/165] (958s left) fbdev (nullptr)
[53.535753] Subtest nullptr: SKIP (0.000s)
[53.541984] [008/165] (958s left) fbdev (read)
[53.573908] Subtest read: SKIP (0.000s)
[53.580341] [009/165] (958s left) fbdev (write)
[53.609748] Subtest write: SKIP (0.000s)
[53.616563] [010/165] (958s left) gem_basic (bad-close)
[53.641908] Starting subtest: bad-close
[53.643187] Subtest bad-close: SUCCESS (0.000s)
[53.648805] [011/165] (958s left) gem_basic (create-close)
[53.672784] Starting subtest: create-close
[53.674132] Subtest create-close: SUCCESS (0.000s)
[53.710086] [012/165] (958s left) gem_basic (create-fd-close)
[53.739640] Starting subtest: create-fd-close
[53.741171] Subtest create-fd-close: SUCCESS (0.000s)
[53.784464] [013/165] (958s left) gem_busy (busy@all-engines)
[53.821360] Starting subtest: busy
[53.822049] Starting dynamic subtest: all-engines
[53.842447] Dynamic subtest all-engines: SUCCESS (0.021s)
[53.843368] Subtest busy: SUCCESS (0.021s)
[54.125917] [014/165] (957s left) gem_close_race (basic-process)
[54.158153] Starting subtest: basic-process
[54.194677] Subtest basic-process: SUCCESS (0.036s)
[54.317096] [015/165] (957s left) gem_close_race (basic-threads)
[54.354463] Starting subtest: basic-threads
[55.573865] Subtest basic-threads: SUCCESS (1.219s)
[55.701560] [016/165] (956s left) gem_ctx_create (basic)
[55.740726] Starting subtest: basic
[55.741374] Subtest basic: SUCCESS (0.000s)
[55.873317] [017/165] (956s left) gem_ctx_create (basic-files)
[55.906326] Starting subtest: basic-files
[57.914720] Subtest basic-files: SUCCESS (2.008s)
[58.180045] [018/165] (953s left) gem_ctx_exec (basic)
[58.207834] Starting subtest: basic
[58.210675] Subtest basic: SUCCESS (0.003s)
[58.257718] [019/165] (953s left) gem_exec_basic (basic)
[58.294340] Starting subtest: basic
[58.295046] Starting dynamic subtest: rcs0-smem
[58.295778] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[58.298996] Starting dynamic subtest: bcs0-smem
[58.299755] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[58.302902] Starting dynamic subtest: vcs0-smem
[58.303643] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[58.306595] Starting dynamic subtest: vcs1-smem
[58.307268] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[58.310190] Starting dynamic subtest: vecs0-smem
[58.310851] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[58.311561] Subtest basic: SUCCESS (0.002s)
[58.419929] [020/165] (953s left) gem_exec_create (basic)
[58.451753] Starting subtest: basic
[58.452607] Starting dynamic subtest: smem
[60.541466] Dynamic subtest smem: SUCCESS (2.089s)
[60.542892] Subtest basic: SUCCESS (2.089s)
[60.676659] [021/165] (951s left) gem_exec_fence (basic-busy)
[60.823939] Starting subtest: basic-busy
[60.825119] Starting dynamic subtest: rcs0
[60.901854] Dynamic subtest rcs0: SUCCESS (0.076s)
[60.910099] Starting dynamic subtest: bcs0
[60.949968] Dynamic subtest bcs0: SUCCESS (0.048s)
[60.961126] Starting dynamic subtest: vcs0
[60.998875] Dynamic subtest vcs0: SUCCESS (0.048s)
[61.010310] Starting dynamic subtest: vcs1
[61.046726] Dynamic subtest vcs1: SUCCESS (0.047s)
[61.057890] Starting dynamic subtest: vecs0
[61.094279] Dynamic subtest vecs0: SUCCESS (0.047s)
[61.096118] Subtest basic-busy: SUCCESS (0.270s)
[61.525629] [022/165] (950s left) gem_exec_fence (basic-wait)
[61.677177] Starting subtest: basic-wait
[61.678373] Starting dynamic subtest: rcs0
[61.745955] Dynamic subtest rcs0: SUCCESS (0.068s)
[61.756159] Starting dynamic subtest: bcs0
[61.793570] Dynamic subtest bcs0: SUCCESS (0.047s)
[61.804860] Starting dynamic subtest: vcs0
[61.841275] Dynamic subtest vcs0: SUCCESS (0.048s)
[61.851922] Starting dynamic subtest: vcs1
[61.888618] Dynamic subtest vcs1: SUCCESS (0.047s)
[61.897585] Starting dynamic subtest: vecs0
[61.946077] Dynamic subtest vecs0: SUCCESS (0.057s)
[61.947964] Subtest basic-wait: SUCCESS (0.268s)
[62.379928] [023/165] (949s left) gem_exec_fence (basic-await)
[62.540475] Starting subtest: basic-await
[62.541533] Starting dynamic subtest: rcs0
[62.611777] Dynamic subtest rcs0: SUCCESS (0.070s)
[62.620625] Starting dynamic subtest: bcs0
[62.684142] Dynamic subtest bcs0: SUCCESS (0.072s)
[62.690203] Starting dynamic subtest: vcs0
[62.759182] Dynamic subtest vcs0: SUCCESS (0.072s)
[62.764882] Starting dynamic subtest: vcs1
[62.830258] Dynamic subtest vcs1: SUCCESS (0.074s)
[62.837341] Starting dynamic subtest: vecs0
[62.902757] Dynamic subtest vecs0: SUCCESS (0.072s)
[62.904613] Subtest basic-await: SUCCESS (0.362s)
[63.331839] [024/165] (948s left) gem_exec_fence (nb-await)
[63.483383] Starting subtest: nb-await
[63.484229] Starting dynamic subtest: rcs0
[63.541751] Dynamic subtest rcs0: SUCCESS (0.058s)
[63.552400] Starting dynamic subtest: bcs0
[63.603106] Dynamic subtest bcs0: SUCCESS (0.061s)
[63.610513] Starting dynamic subtest: vcs0
[63.662631] Dynamic subtest vcs0: SUCCESS (0.059s)
[63.669267] Starting dynamic subtest: vcs1
[63.720862] Dynamic subtest vcs1: SUCCESS (0.058s)
[63.727571] Starting dynamic subtest: vecs0
[63.779526] Dynamic subtest vecs0: SUCCESS (0.058s)
[63.781165] Subtest nb-await: SUCCESS (0.296s)
[64.209769] [025/165] (947s left) gem_exec_gttfill (basic)
[64.251743] Starting subtest: basic
[66.631449] Subtest basic: SUCCESS (2.380s)
[66.748577] [026/165] (945s left) gem_exec_parallel (engines)
[66.837656] Starting subtest: engines
[66.838613] Starting dynamic subtest: basic
[68.160141] Dynamic subtest basic: SUCCESS (1.322s)
[68.166030] Starting dynamic subtest: contexts
[69.836878] Dynamic subtest contexts: SUCCESS (1.667s)
[69.840799] Starting dynamic subtest: fds
[71.654615] Dynamic subtest fds: SUCCESS (1.827s)
[71.660829] Starting dynamic subtest: userptr
[72.958821] Dynamic subtest userptr: SUCCESS (1.304s)
[72.960873] Subtest engines: SUCCESS (6.121s)
[73.089545] [027/165] (939s left) gem_exec_store (basic)
[73.123184] Starting subtest: basic
[73.202691] Subtest basic: SUCCESS (0.078s)
[73.325580] [028/165] (938s left) gem_flink_basic (bad-flink)
[73.355984] Starting subtest: bad-flink
[73.356736] Subtest bad-flink: SUCCESS (0.000s)
[73.362835] [029/165] (938s left) gem_flink_basic (bad-open)
[73.389142] Starting subtest: bad-open
[73.390058] Subtest bad-open: SUCCESS (0.000s)
[73.397166] [030/165] (938s left) gem_flink_basic (basic)
[73.424726] Starting subtest: basic
[73.425510] Subtest basic: SUCCESS (0.000s)
[73.444107] [031/165] (938s left) gem_flink_basic (double-flink)
[73.469277] Starting subtest: double-flink
[73.470032] Subtest double-flink: SUCCESS (0.000s)
[73.488268] [032/165] (938s left) gem_flink_basic (flink-lifetime)
[73.515662] Starting subtest: flink-lifetime
[73.516410] Subtest flink-lifetime: SUCCESS (0.001s)
[73.541635] [033/165] (938s left) gem_huc_copy (huc-copy)
[73.573525] Starting subtest: huc-copy
[73.575984] Subtest huc-copy: SUCCESS (0.002s)
[73.624996] [034/165] (938s left) gem_linear_blits (basic)
[73.715173] Starting subtest: basic
[73.718777] Subtest basic: SUCCESS (0.004s)
[73.778806] [035/165] (938s left) gem_mmap (basic)
[73.852525] Starting subtest: basic
[73.855600] Subtest basic: SUCCESS (0.000s)
[73.874242] [036/165] (938s left) gem_mmap_gtt (basic)
[73.901301] Starting subtest: basic
[73.902119] Subtest basic: SUCCESS (0.000s)
[73.909517] [037/165] (938s left) gem_render_linear_blits (basic)
[73.936665] Starting subtest: basic
[73.952984] Subtest basic: SUCCESS (0.017s)
[74.000667] [038/165] (938s left) gem_render_tiled_blits (basic)
[74.032234] Starting subtest: basic
[74.053933] Subtest basic: SUCCESS (0.022s)
[74.105380] [039/165] (938s left) gem_ringfill (basic-all)
[74.422523] Starting subtest: basic-all
[75.539875] Subtest basic-all: SUCCESS (1.108s)
[75.576703] [040/165] (936s left) gem_softpin (allocator-basic)
[75.604017] Starting subtest: allocator-basic
[75.650027] Subtest allocator-basic: SUCCESS (0.046s)
[75.701059] [041/165] (936s left) gem_softpin (allocator-basic-reserve)
[75.734089] Starting subtest: allocator-basic-reserve
[75.780539] Subtest allocator-basic-reserve: SUCCESS (0.046s)
[75.827126] [042/165] (936s left) gem_softpin (safe-alignment)
[75.865388] Starting subtest: safe-alignment
[75.873666] Subtest safe-alignment: SUCCESS (0.008s)
[75.911143] [043/165] (936s left) gem_sync (basic-all)
[75.952385] Starting subtest: basic-all
[78.155616] Subtest basic-all: SUCCESS (2.204s)
[78.282366] [044/165] (934s left) gem_sync (basic-each)
[78.320385] Starting subtest: basic-each
[80.569084] Subtest basic-each: SUCCESS (2.249s)
[80.693486] [045/165] (931s left) gem_tiled_blits (basic)
[80.771904] Starting subtest: basic
[80.782687] Subtest basic: SUCCESS (0.011s)
[80.847323] [046/165] (931s left) gem_tiled_fence_blits (basic)
[80.955138] Starting subtest: basic
[80.979827] Subtest basic: SUCCESS (0.025s)
[81.038290] [047/165] (931s left) gem_tiled_pread_basic
[81.128920] [048/165] (931s left) gem_wait (busy@all-engines)
[81.165755] Starting subtest: busy
[81.166402] Starting dynamic subtest: all-engines
[81.719507] Dynamic subtest all-engines: SUCCESS (0.549s)
[81.720736] Subtest busy: SUCCESS (0.550s)
[81.861308] [049/165] (930s left) gem_wait (wait@all-engines)
[81.908153] Starting subtest: wait
[81.909019] Starting dynamic subtest: all-engines
[82.957668] Dynamic subtest all-engines: SUCCESS (1.048s)
[82.959449] Subtest wait: SUCCESS (1.049s)
[83.099567] [050/165] (929s left) i915_getparams_basic (basic-eu-total)
[83.126925] Starting subtest: basic-eu-total
[83.128428] Subtest basic-eu-total: SUCCESS (0.000s)
[83.134923] [051/165] (929s left) i915_getparams_basic (basic-subslice-total)
[83.163021] Starting subtest: basic-subslice-total
[83.164285] Subtest basic-subslice-total: SUCCESS (0.000s)
[83.170109] [052/165] (929s left) i915_hangman (error-state-basic)
[83.201232] Starting subtest: error-state-basic
[83.292694] Subtest error-state-basic: SUCCESS (0.091s)
[83.304270] [053/165] (929s left) i915_pciid
[83.339553] [054/165] (929s left) kms_addfb_basic (addfb25-4-tiled)
[83.382145] Starting subtest: addfb25-4-tiled
[83.382912] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[83.403957] [055/165] (929s left) kms_addfb_basic (addfb25-bad-modifier)
[83.429576] Starting subtest: addfb25-bad-modifier
[83.430503] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[83.469244] [056/165] (929s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[83.496192] Starting subtest: addfb25-framebuffer-vs-set-tiling
[83.496951] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[83.542601] [057/165] (928s left) kms_addfb_basic (addfb25-modifier-no-flag)
[83.570389] Starting subtest: addfb25-modifier-no-flag
[83.571359] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[83.609018] [058/165] (928s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[83.634498] Starting subtest: addfb25-x-tiled-legacy
[83.635148] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[83.679567] [059/165] (928s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[83.706098] Starting subtest: addfb25-x-tiled-mismatch-legacy
[83.706878] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[83.748196] [060/165] (928s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[83.791942] Starting subtest: addfb25-yf-tiled-legacy
[83.792564] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[83.824285] [061/165] (928s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[83.864890] Starting subtest: addfb25-y-tiled-legacy
[83.865618] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[83.889781] [062/165] (928s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[83.928572] Starting subtest: addfb25-y-tiled-small-legacy
[83.929336] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[83.953794] [063/165] (928s left) kms_addfb_basic (bad-pitch-0)
[83.980159] Starting subtest: bad-pitch-0
[83.981089] Subtest bad-pitch-0: SUCCESS (0.000s)
[84.029889] [064/165] (928s left) kms_addfb_basic (bad-pitch-1024)
[84.058923] Starting subtest: bad-pitch-1024
[84.059754] Subtest bad-pitch-1024: SUCCESS (0.000s)
[84.099035] [065/165] (928s left) kms_addfb_basic (bad-pitch-128)
[84.131053] Starting subtest: bad-pitch-128
[84.131834] Subtest bad-pitch-128: SUCCESS (0.000s)
[84.164241] [066/165] (928s left) kms_addfb_basic (bad-pitch-256)
[84.194364] Starting subtest: bad-pitch-256
[84.195212] Subtest bad-pitch-256: SUCCESS (0.000s)
[84.233178] [067/165] (928s left) kms_addfb_basic (bad-pitch-32)
[84.258893] Starting subtest: bad-pitch-32
[84.259733] Subtest bad-pitch-32: SUCCESS (0.000s)
[84.292354] [068/165] (928s left) kms_addfb_basic (bad-pitch-63)
[84.317091] Starting subtest: bad-pitch-63
[84.317923] Subtest bad-pitch-63: SUCCESS (0.000s)
[84.361717] [069/165] (928s left) kms_addfb_basic (bad-pitch-65536)
[84.390162] Starting subtest: bad-pitch-65536
[84.390872] Subtest bad-pitch-65536: SUCCESS (0.000s)
[84.442715] [070/165] (928s left) kms_addfb_basic (bad-pitch-999)
[84.471611] Starting subtest: bad-pitch-999
[84.472439] Subtest bad-pitch-999: SUCCESS (0.000s)
[84.501934] [071/165] (928s left) kms_addfb_basic (basic)
[84.528550] Starting subtest: basic
[84.529467] Subtest basic: SUCCESS (0.000s)
[84.581123] [072/165] (928s left) kms_addfb_basic (basic-x-tiled-legacy)
[84.607110] Starting subtest: basic-x-tiled-legacy
[84.607845] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[84.651914] [073/165] (928s left) kms_addfb_basic (basic-y-tiled-legacy)
[84.684909] Starting subtest: basic-y-tiled-legacy
[84.685646] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[84.730027] [074/165] (927s left) kms_addfb_basic (bo-too-small)
[84.778398] Starting subtest: bo-too-small
[84.779125] Subtest bo-too-small: SUCCESS (0.000s)
[84.814808] [075/165] (927s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[84.865491] Starting subtest: bo-too-small-due-to-tiling
[84.866297] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[84.884340] [076/165] (927s left) kms_addfb_basic (clobberred-modifier)
[84.909082] Starting subtest: clobberred-modifier
[84.909901] Subtest clobberred-modifier: SUCCESS (0.000s)
[84.944897] [077/165] (927s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[84.974076] Starting subtest: framebuffer-vs-set-tiling
[84.974941] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[85.017179] [078/165] (927s left) kms_addfb_basic (invalid-get-prop)
[85.046979] Starting subtest: invalid-get-prop
[85.048041] Subtest invalid-get-prop: SUCCESS (0.000s)
[85.087801] [079/165] (927s left) kms_addfb_basic (invalid-get-prop-any)
[85.113400] Starting subtest: invalid-get-prop-any
[85.114065] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[85.158609] [080/165] (927s left) kms_addfb_basic (invalid-set-prop)
[85.185057] Starting subtest: invalid-set-prop
[85.185849] Subtest invalid-set-prop: SUCCESS (0.000s)
[85.226280] [081/165] (927s left) kms_addfb_basic (invalid-set-prop-any)
[85.253538] Starting subtest: invalid-set-prop-any
[85.254282] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[85.284805] [082/165] (927s left) kms_addfb_basic (no-handle)
[85.311142] Starting subtest: no-handle
[85.311815] Subtest no-handle: SUCCESS (0.000s)
[85.361723] [083/165] (927s left) kms_addfb_basic (size-max)
[85.408476] Starting subtest: size-max
[85.409167] Subtest size-max: SUCCESS (0.000s)
[85.440711] [084/165] (927s left) kms_addfb_basic (small-bo)
[85.482289] Starting subtest: small-bo
[85.482984] Subtest small-bo: SUCCESS (0.000s)
[85.511094] [085/165] (927s left) kms_addfb_basic (tile-pitch-mismatch)
[85.541134] Starting subtest: tile-pitch-mismatch
[85.541944] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[85.578568] [086/165] (927s left) kms_addfb_basic (too-high)
[85.619438] Starting subtest: too-high
[85.620179] Subtest too-high: SUCCESS (0.000s)
[85.643260] [087/165] (927s left) kms_addfb_basic (too-wide)
[85.682188] Starting subtest: too-wide
[85.682941] Subtest too-wide: SUCCESS (0.000s)
[85.707414] [088/165] (927s left) kms_addfb_basic (unused-handle)
[85.734270] Starting subtest: unused-handle
[85.735155] Subtest unused-handle: SUCCESS (0.000s)
[85.770930] [089/165] (927s left) kms_addfb_basic (unused-modifier)
[85.796983] Starting subtest: unused-modifier
[85.797726] Subtest unused-modifier: SUCCESS (0.000s)
[85.833425] [090/165] (927s left) kms_addfb_basic (unused-offsets)
[85.860527] Starting subtest: unused-offsets
[85.861288] Subtest unused-offsets: SUCCESS (0.000s)
[85.900721] [091/165] (926s left) kms_addfb_basic (unused-pitches)
[85.926574] Starting subtest: unused-pitches
[85.927322] Subtest unused-pitches: SUCCESS (0.000s)
[85.966386] [092/165] (926s left) kms_busy (basic)
[86.010578] Subtest basic: SKIP (0.000s)
[86.031265] [093/165] (926s left) kms_prop_blob (basic)
[86.060895] Starting subtest: basic
[86.061733] Subtest basic: SUCCESS (0.000s)
[86.068978] [094/165] (926s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[86.112064] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[86.122178] [095/165] (926s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[86.165548] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[86.173050] [096/165] (926s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.218600] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[86.226196] [097/165] (926s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[86.270334] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[86.277225] [098/165] (926s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[86.320092] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[86.327897] [099/165] (926s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.371936] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.378874] [100/165] (926s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.421404] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[86.428545] [101/165] (926s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[86.471897] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[86.478993] [102/165] (926s left) kms_dsc (dsc-basic)
[86.518351] Subtest dsc-basic: SKIP (0.000s)
[86.526813] [103/165] (926s left) kms_flip (basic-flip-vs-dpms)
[86.556799] Starting subtest: basic-flip-vs-dpms
[86.559441] Subtest basic-flip-vs-dpms: SKIP (0.002s)
[86.606275] [104/165] (926s left) kms_flip (basic-flip-vs-modeset)
[86.637367] Starting subtest: basic-flip-vs-modeset
[86.639721] Subtest basic-flip-vs-modeset: SKIP (0.002s)
[86.665837] [105/165] (926s left) kms_flip (basic-flip-vs-wf_vblank)
[86.695604] Starting subtest: basic-flip-vs-wf_vblank
[86.703424] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[86.724296] [106/165] (926s left) kms_flip (basic-plain-flip)
[86.757877] Starting subtest: basic-plain-flip
[86.760441] Subtest basic-plain-flip: SKIP (0.002s)
[86.800837] [107/165] (926s left) kms_force_connector_basic (force-connector-state)
[86.831981] Starting subtest: force-connector-state
[87.098820] Subtest force-connector-state: SUCCESS (0.267s)
[87.211104] [108/165] (925s left) kms_force_connector_basic (force-edid)
[87.239930] Starting subtest: force-edid
[87.583589] Subtest force-edid: SUCCESS (0.343s)
[87.607110] [109/165] (925s left) kms_force_connector_basic (force-load-detect)
[87.634961] Starting subtest: force-load-detect
[87.636322] Subtest force-load-detect: SKIP (0.000s)
[87.652901] [110/165] (925s left) kms_force_connector_basic (prune-stale-modes)
[87.681270] Starting subtest: prune-stale-modes
[88.092928] Subtest prune-stale-modes: SUCCESS (0.411s)
[88.116368] [111/165] (924s left) kms_frontbuffer_tracking (basic)
[88.159297] Subtest basic: SKIP (0.000s)
[88.180775] [112/165] (924s left) kms_hdmi_inject (inject-audio)
[88.209206] Starting subtest: inject-audio
[88.454515] Subtest inject-audio: SUCCESS (0.241s)
[88.541306] [113/165] (924s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[88.582103] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[88.593148] [114/165] (924s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[88.635637] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[88.646232] [115/165] (924s left) kms_pipe_crc_basic (hang-read-crc)
[88.686874] Subtest hang-read-crc: SKIP (0.000s)
[88.697235] [116/165] (924s left) kms_pipe_crc_basic (nonblocking-crc)
[88.737360] Subtest nonblocking-crc: SKIP (0.000s)
[88.751965] [117/165] (924s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[88.795234] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[88.809852] [118/165] (924s left) kms_pipe_crc_basic (read-crc)
[88.852955] Subtest read-crc: SKIP (0.000s)
[88.866943] [119/165] (924s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[88.908921] Subtest read-crc-frame-sequence: SKIP (0.000s)
[88.922800] [120/165] (924s left) kms_pm_backlight (basic-brightness)
[88.964503] Subtest basic-brightness: SKIP (0.000s)
[88.975113] [121/165] (924s left) kms_pm_rpm (basic-pci-d3-state)
[90.217096] Starting subtest: basic-pci-d3-state
[90.962352] Subtest basic-pci-d3-state: SUCCESS (0.744s)
[90.973427] [122/165] (922s left) kms_pm_rpm (basic-rte)
[91.002339] Starting subtest: basic-rte
[92.405656] Subtest basic-rte: SUCCESS (1.407s)
[92.643085] [123/165] (920s left) kms_psr (primary_page_flip)
[92.670217] Subtest primary_page_flip: SKIP (0.000s)
[92.680847] [124/165] (920s left) kms_psr (cursor_plane_move)
[92.708447] Subtest cursor_plane_move: SKIP (0.000s)
[92.718864] [125/165] (920s left) kms_psr (sprite_plane_onoff)
[92.745490] Subtest sprite_plane_onoff: SKIP (0.000s)
[92.755747] [126/165] (920s left) kms_psr (primary_mmap_gtt)
[92.783018] Subtest primary_mmap_gtt: SKIP (0.000s)
[92.793983] [127/165] (920s left) kms_setmode (basic-clone-single-crtc)
[92.820362] Starting subtest: basic-clone-single-crtc
[92.822908] Subtest basic-clone-single-crtc: SKIP (0.000s)
[92.832134] [128/165] (920s left) i915_pm_rps (basic-api)
[92.863242] Starting subtest: basic-api
[92.865078] Subtest basic-api: SKIP (0.000s)
[92.876785] [129/165] (920s left) prime_self_import (basic-llseek-bad)
[92.904881] Starting subtest: basic-llseek-bad
[92.906341] Subtest basic-llseek-bad: SUCCESS (0.001s)
[92.921290] [130/165] (920s left) prime_self_import (basic-llseek-size)
[92.945769] Starting subtest: basic-llseek-size
[92.947202] Subtest basic-llseek-size: SUCCESS (0.001s)
[92.963474] [131/165] (920s left) prime_self_import (basic-with_fd_dup)
[92.988119] Starting subtest: basic-with_fd_dup
[92.989581] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[93.018462] [132/165] (920s left) prime_self_import (basic-with_one_bo)
[93.042269] Starting subtest: basic-with_one_bo
[93.044174] Subtest basic-with_one_bo: SUCCESS (0.002s)
[93.056372] [133/165] (920s left) prime_self_import (basic-with_one_bo_two_files)
[93.080745] Starting subtest: basic-with_one_bo_two_files
[93.082020] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[93.112532] [134/165] (920s left) prime_self_import (basic-with_two_bos)
[93.137274] Starting subtest: basic-with_two_bos
[93.139921] Subtest basic-with_two_bos: SUCCESS (0.002s)
[93.157880] [135/165] (920s left) prime_vgem (basic-fence-flip)
[93.186740] Starting subtest: basic-fence-flip
[93.201489] Subtest basic-fence-flip: SKIP (0.014s)
[93.215482] [136/165] (920s left) prime_vgem (basic-fence-mmap)
[93.244283] Starting subtest: basic-fence-mmap
[93.261510] Subtest basic-fence-mmap: SUCCESS (0.017s)
[93.299902] [137/165] (920s left) prime_vgem (basic-fence-read)
[93.330685] Starting subtest: basic-fence-read
[93.335051] Subtest basic-fence-read: SKIP (0.004s)
[93.370784] [138/165] (919s left) prime_vgem (basic-gtt)
[93.399966] Starting subtest: basic-gtt
[93.407128] Subtest basic-gtt: SUCCESS (0.008s)
[93.431234] [139/165] (919s left) prime_vgem (basic-read)
[93.470318] Starting subtest: basic-read
[93.471816] Subtest basic-read: SKIP (0.007s)
[93.505837] [140/165] (919s left) prime_vgem (basic-write)
[93.535943] Starting subtest: basic-write
[93.539635] Subtest basic-write: SKIP (0.003s)
[93.571950] [141/165] (919s left) vgem_basic (setversion)
[93.597865] Starting subtest: setversion
[93.599421] Subtest setversion: SUCCESS (0.000s)
[93.606477] [142/165] (919s left) vgem_basic (create)
[93.631092] Starting subtest: create
[93.631957] Subtest create: SUCCESS (0.000s)
[93.640568] [143/165] (919s left) vgem_basic (debugfs)
[93.665404] Starting subtest: debugfs
[93.666140] Subtest debugfs: SUCCESS (0.000s)
[93.675243] [144/165] (919s left) vgem_basic (dmabuf-export)
[93.703638] Starting subtest: dmabuf-export
[93.705049] Subtest dmabuf-export: SUCCESS (0.001s)
[93.743380] [145/165] (919s left) vgem_basic (dmabuf-fence)
[93.773045] Starting subtest: dmabuf-fence
[93.774114] Subtest dmabuf-fence: SUCCESS (0.000s)
[93.782321] [146/165] (919s left) vgem_basic (dmabuf-fence-before)
[93.810340] Starting subtest: dmabuf-fence-before
[93.811074] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[93.819278] [147/165] (919s left) vgem_basic (dmabuf-mmap)
[93.851126] Starting subtest: dmabuf-mmap
[93.853106] Subtest dmabuf-mmap: SUCCESS (0.007s)
[93.863438] [148/165] (919s left) vgem_basic (mmap)
[93.891967] Starting subtest: mmap
[93.895636] Subtest mmap: SUCCESS (0.005s)
[93.906055] [149/165] (919s left) vgem_basic (second-client)
[93.933504] Starting subtest: second-client
[93.935074] Subtest second-client: SUCCESS (0.001s)
[93.947136] [150/165] (919s left) vgem_basic (sysfs)
[93.974577] Starting subtest: sysfs
[93.975273] Subtest sysfs: SUCCESS (0.000s)
[93.983717] [151/165] (919s left) core_hotunplug (unbind-rebind)
[94.023999] Starting subtest: unbind-rebind
[97.771953] Subtest unbind-rebind: SUCCESS (3.743s)
[97.779871] [152/165] (915s left) vgem_basic (unload)
[97.810067] Starting subtest: unload
[126.677420] Subtest unload: SUCCESS (28.833s)
[126.688426] [153/165] (886s left) i915_module_load (reload)
[126.715862] Starting subtest: reload
[128.988089] Subtest reload: SUCCESS (2.272s)
[129.001533] [154/165] (884s left) gem_lmem_swapping (basic)
[129.036365] Subtest basic: SKIP (0.000s)
[129.043341] [155/165] (884s left) gem_lmem_swapping (parallel-random-engines)
[129.069501] Subtest parallel-random-engines: SKIP (0.000s)
[129.076494] [156/165] (884s left) gem_lmem_swapping (random-engines)
[129.103608] Subtest random-engines: SKIP (0.000s)
[129.111093] [157/165] (884s left) gem_lmem_swapping (verify-random)
[129.138120] Subtest verify-random: SKIP (0.000s)
[129.145140] [158/165] (884s left) i915_pm_rpm (module-reload)
[130.289834] Starting subtest: module-reload
[137.229785] Subtest module-reload: SUCCESS (6.932s)
[137.240630] [159/165] (876s left) i915_selftest (live)
[137.278700] Starting subtest: live
[137.279503] Starting dynamic subtest: sanitycheck
[138.931573] Dynamic subtest sanitycheck: SUCCESS (1.643s)
[138.935599] Starting dynamic subtest: uncore
[140.664322] Dynamic subtest uncore: SUCCESS (1.732s)
[140.668819] Starting dynamic subtest: workarounds
[143.280453] Dynamic subtest workarounds: SUCCESS (2.616s)
[143.284019] Starting dynamic subtest: gt_engines
[145.501530] Dynamic subtest gt_engines: SUCCESS (2.220s)
[145.505342] Starting dynamic subtest: gt_timelines
[156.137169] Dynamic subtest gt_timelines: SUCCESS (10.635s)
[156.140845] Starting dynamic subtest: gt_contexts
[157.815396] Dynamic subtest gt_contexts: SUCCESS (1.678s)
[157.820537] Starting dynamic subtest: gt_lrc
[162.399574] Dynamic subtest gt_lrc: SUCCESS (4.584s)
[162.403271] Starting dynamic subtest: gt_mocs
[164.565554] Dynamic subtest gt_mocs: SUCCESS (2.165s)
[164.569120] Starting dynamic subtest: gt_pm
[167.114337] Dynamic subtest gt_pm: SUCCESS (2.548s)
[167.117558] Starting dynamic subtest: gt_heartbeat
[168.916493] Dynamic subtest gt_heartbeat: SUCCESS (1.801s)
[168.920250] Starting dynamic subtest: gt_tlb
[172.082255] Dynamic subtest gt_tlb: SUCCESS (3.165s)
[172.085848] Starting dynamic subtest: requests
[181.645158] Dynamic subtest requests: SUCCESS (9.562s)
[181.648805] Starting dynamic subtest: migrate
[186.630970] Dynamic subtest migrate: FAIL (4.953s)
[186.634350] Starting dynamic subtest: active
[188.285421] Dynamic subtest active: SUCCESS (1.685s)
[188.290795] Starting dynamic subtest: objects
[190.406349] Dynamic subtest objects: SUCCESS (2.119s)
[190.409880] Starting dynamic subtest: mman
[195.704865] Dynamic subtest mman: SUCCESS (5.297s)
[195.708700] Starting dynamic subtest: dmabuf
[197.472864] Dynamic subtest dmabuf: SUCCESS (1.767s)
[197.478036] Starting dynamic subtest: vma
[199.169291] Dynamic subtest vma: SUCCESS (1.695s)
[199.174466] Starting dynamic subtest: coherency
[203.343379] Dynamic subtest coherency: SUCCESS (4.174s)
[203.347127] Starting dynamic subtest: gtt
[212.163352] Dynamic subtest gtt: SUCCESS (8.818s)
[212.166875] Starting dynamic subtest: gem
[213.969281] Dynamic subtest gem: SUCCESS (1.805s)
[213.972916] Starting dynamic subtest: evict
[217.003872] Dynamic subtest evict: SUCCESS (3.034s)
[217.007670] Starting dynamic subtest: hugepages
[225.146756] Dynamic subtest hugepages: SUCCESS (8.141s)
[225.152023] Starting dynamic subtest: gem_contexts
[241.703597] Dynamic subtest gem_contexts: SUCCESS (16.555s)
[241.707300] Starting dynamic subtest: client
[243.421773] Dynamic subtest client: SUCCESS (1.717s)
[243.425567] Starting dynamic subtest: gem_migrate
[245.054737] Dynamic subtest gem_migrate: SUCCESS (1.632s)
[245.060159] Starting dynamic subtest: reset
[250.473518] Dynamic subtest reset: SUCCESS (5.416s)
[250.487145] Starting dynamic subtest: memory_region
[252.160046] Dynamic subtest memory_region: SUCCESS (1.690s)
[252.165578] Starting dynamic subtest: hangcheck
[271.249161] Dynamic subtest hangcheck: SUCCESS (19.085s)
[271.254468] Starting dynamic subtest: execlists
[272.922251] Dynamic subtest execlists: SUCCESS (1.671s)
[272.925954] Starting dynamic subtest: ring_submission
[274.572413] Dynamic subtest ring_submission: SUCCESS (1.649s)
[274.577621] Starting dynamic subtest: perf
[276.329143] Dynamic subtest perf: SUCCESS (1.756s)
[276.332450] Starting dynamic subtest: slpc
[284.495374] Dynamic subtest slpc: SUCCESS (8.165s)
[284.499250] Starting dynamic subtest: guc
[286.942465] Dynamic subtest guc: SUCCESS (2.446s)
[286.946048] Starting dynamic subtest: guc_multi_lrc
[288.633184] Dynamic subtest guc_multi_lrc: SUCCESS (1.690s)
[288.637827] Starting dynamic subtest: guc_hang
[290.956462] Dynamic subtest guc_hang: SUCCESS (2.326s)
[290.960377] Starting dynamic subtest: late_gt_pm
[292.641663] Dynamic subtest late_gt_pm: SUCCESS (1.682s)
[292.642831] Subtest live: FAIL (155.356s)
[292.665806] [160/165] (720s left) dmabuf (all-tests)
[292.707719] Starting subtest: all-tests
[292.708930] Starting dynamic subtest: sanitycheck
[292.768629] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[292.780307] Starting dynamic subtest: dma_fence
[292.941485] Dynamic subtest dma_fence: SUCCESS (0.171s)
[292.949768] Starting dynamic subtest: dma_fence_chain
[302.514542] Dynamic subtest dma_fence_chain: SUCCESS (9.571s)
[302.525141] Starting dynamic subtest: dma_fence_unwrap
[302.586346] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[302.593610] Starting dynamic subtest: dma_resv
[302.657262] Dynamic subtest dma_resv: SUCCESS (0.069s)
[302.659256] Subtest all-tests: SUCCESS (9.950s)
[302.678989] [161/165] (710s left) i915_suspend (basic-s2idle-without-i915)
[302.705187] Starting subtest: basic-s2idle-without-i915
[321.971549] Subtest basic-s2idle-without-i915: SUCCESS (4.838s)
[322.016478] [162/165] (706s left) i915_suspend (basic-s3-without-i915)
[322.047216] Starting subtest: basic-s3-without-i915
[342.545235] Subtest basic-s3-without-i915: SUCCESS (3.973s)
[342.588541] [163/165] (701s left) gem_exec_suspend (basic-s0)
[342.625245] Starting subtest: basic-S0
[342.629050] Starting dynamic subtest: smem
[361.279157] Dynamic subtest smem: SUCCESS (2.791s)
[361.280750] Subtest basic-S0: SUCCESS (2.792s)
[361.413086] [164/165] (699s left) gem_exec_suspend (basic-s3)
[361.450388] Starting subtest: basic-S3
[361.451413] Starting dynamic subtest: smem
[380.249331] Dynamic subtest smem: SUCCESS (3.230s)
[380.250910] Subtest basic-S3: SUCCESS (3.231s)
[380.384180] [165/165] (695s left) kms_pipe_crc_basic (suspend-read-crc)
[380.428493] Subtest suspend-read-crc: SKIP (0.000s)
[380.439031] Closing watchdogs
Done.