[40.783808] Initializing watchdogs
[40.783860]   /dev/watchdog0
[40.788330] [001/165] (960s left) i915_module_load (load)
[40.881721] Starting subtest: load
[41.913189] Subtest load: SUCCESS (1.026s)
[41.927174] [002/165] (959s left) core_auth (basic-auth)
[42.016838] Starting subtest: basic-auth
[42.017654] Subtest basic-auth: SUCCESS (0.001s)
[42.026690] [003/165] (959s left) debugfs_test (read_all_entries)
[42.076566] Starting subtest: read_all_entries
[42.357983] Subtest read_all_entries: SUCCESS (0.281s)
[42.381125] [004/165] (958s left) debugfs_test (basic-hwmon)
[42.427072] Starting subtest: basic-hwmon
[42.429676] Subtest basic-hwmon: SUCCESS (0.002s)
[42.452320] [005/165] (958s left) fbdev (eof)
[43.172573] Subtest eof: SKIP (0.000s)
[43.181354] [006/165] (958s left) fbdev (info)
[43.227799] Subtest info: SKIP (0.000s)
[43.236204] [007/165] (958s left) fbdev (nullptr)
[43.282467] Subtest nullptr: SKIP (0.000s)
[43.290436] [008/165] (958s left) fbdev (read)
[43.339532] Subtest read: SKIP (0.000s)
[43.348290] [009/165] (958s left) fbdev (write)
[43.397433] Subtest write: SKIP (0.000s)
[43.406303] [010/165] (957s left) gem_basic (bad-close)
[43.446666] Starting subtest: bad-close
[43.448436] Subtest bad-close: SUCCESS (0.000s)
[43.456471] [011/165] (957s left) gem_basic (create-close)
[43.498376] Starting subtest: create-close
[43.499980] Subtest create-close: SUCCESS (0.000s)
[43.523317] [012/165] (957s left) gem_basic (create-fd-close)
[43.572338] Starting subtest: create-fd-close
[43.574068] Subtest create-fd-close: SUCCESS (0.000s)
[43.603646] [013/165] (957s left) gem_busy (busy@all-engines)
[43.658199] Starting subtest: busy
[43.659215] Starting dynamic subtest: all-engines
[43.759988] Dynamic subtest all-engines: SUCCESS (0.102s)
[43.760858] Subtest busy: SUCCESS (0.102s)
[44.120442] [014/165] (957s left) gem_close_race (basic-process)
[44.231041] Starting subtest: basic-process
[44.273226] Subtest basic-process: SUCCESS (0.042s)
[44.427327] [015/165] (957s left) gem_close_race (basic-threads)
[44.497277] Starting subtest: basic-threads
[45.699373] Subtest basic-threads: SUCCESS (1.202s)
[45.879681] [016/165] (955s left) gem_ctx_create (basic)
[45.982306] Starting subtest: basic
[45.983265] Subtest basic: SUCCESS (0.000s)
[46.148108] [017/165] (955s left) gem_ctx_create (basic-files)
[46.258154] Starting subtest: basic-files
[48.269769] Subtest basic-files: SUCCESS (2.012s)
[48.680874] [018/165] (952s left) gem_ctx_exec (basic)
[48.725826] Starting subtest: basic
[48.729760] Subtest basic: SUCCESS (0.004s)
[48.769143] [019/165] (952s left) gem_exec_basic (basic)
[48.816919] Starting subtest: basic
[48.817809] Starting dynamic subtest: rcs0-smem
[48.818710] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[48.823167] Starting dynamic subtest: bcs0-smem
[48.823982] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[48.828462] Starting dynamic subtest: vcs0-smem
[48.829338] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[48.834326] Starting dynamic subtest: vcs1-smem
[48.835138] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[48.839341] Starting dynamic subtest: vecs0-smem
[48.840140] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[48.844286] Starting dynamic subtest: vecs1-smem
[48.845121] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[48.849153] Starting dynamic subtest: ccs0-smem
[48.849989] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[48.853984] Starting dynamic subtest: ccs1-smem
[48.854802] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[48.858850] Starting dynamic subtest: ccs2-smem
[48.859780] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[48.863776] Starting dynamic subtest: ccs3-smem
[48.864578] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[48.868618] Starting dynamic subtest: rcs0-lmem0
[48.869417] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[48.873462] Starting dynamic subtest: bcs0-lmem0
[48.874258] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[48.878292] Starting dynamic subtest: vcs0-lmem0
[48.879093] Dynamic subtest vcs0-lmem0: SUCCESS (0.001s)
[48.883180] Starting dynamic subtest: vcs1-lmem0
[48.883974] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[48.887980] Starting dynamic subtest: vecs0-lmem0
[48.888776] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[48.892738] Starting dynamic subtest: vecs1-lmem0
[48.893507] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[48.897467] Starting dynamic subtest: ccs0-lmem0
[48.898242] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[48.902219] Starting dynamic subtest: ccs1-lmem0
[48.902991] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[48.906922] Starting dynamic subtest: ccs2-lmem0
[48.907718] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[48.911682] Starting dynamic subtest: ccs3-lmem0
[48.912453] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[48.913408] Subtest basic: SUCCESS (0.013s)
[48.952052] [020/165] (952s left) gem_exec_create (basic)
[49.004255] Starting subtest: basic
[49.005097] Starting dynamic subtest: smem
[51.100146] Dynamic subtest smem: SUCCESS (2.096s)
[51.105190] Starting dynamic subtest: lmem0
[53.203338] Dynamic subtest lmem0: SUCCESS (2.103s)
[53.204611] Subtest basic: SUCCESS (4.199s)
[53.355107] [021/165] (948s left) gem_exec_fence (basic-busy)
[53.570636] Starting subtest: basic-busy
[53.572464] Starting dynamic subtest: rcs0
[53.669046] Dynamic subtest rcs0: SUCCESS (0.098s)
[53.676649] Starting dynamic subtest: bcs0
[53.717091] Dynamic subtest bcs0: SUCCESS (0.048s)
[53.725650] Starting dynamic subtest: vcs0
[53.769059] Dynamic subtest vcs0: SUCCESS (0.051s)
[53.777654] Starting dynamic subtest: vcs1
[53.816846] Dynamic subtest vcs1: SUCCESS (0.048s)
[53.824039] Starting dynamic subtest: vecs0
[53.869952] Dynamic subtest vecs0: SUCCESS (0.052s)
[53.886762] Starting dynamic subtest: vecs1
[53.923894] Dynamic subtest vecs1: SUCCESS (0.054s)
[53.940975] Starting dynamic subtest: ccs0
[53.984052] Dynamic subtest ccs0: SUCCESS (0.060s)
[54.000777] Starting dynamic subtest: ccs1
[54.037210] Dynamic subtest ccs1: SUCCESS (0.053s)
[54.055352] Starting dynamic subtest: ccs2
[54.093119] Dynamic subtest ccs2: SUCCESS (0.056s)
[54.111432] Starting dynamic subtest: ccs3
[54.149985] Dynamic subtest ccs3: SUCCESS (0.057s)
[54.151835] Subtest basic-busy: SUCCESS (0.579s)
[55.273527] [022/165] (946s left) gem_exec_fence (basic-wait)
[55.460345] Starting subtest: basic-wait
[55.462384] Starting dynamic subtest: rcs0
[55.555879] Dynamic subtest rcs0: SUCCESS (0.096s)
[55.565495] Starting dynamic subtest: bcs0
[55.616204] Dynamic subtest bcs0: SUCCESS (0.059s)
[55.635392] Starting dynamic subtest: vcs0
[55.670975] Dynamic subtest vcs0: SUCCESS (0.054s)
[55.689984] Starting dynamic subtest: vcs1
[55.730118] Dynamic subtest vcs1: SUCCESS (0.059s)
[55.749274] Starting dynamic subtest: vecs0
[55.789225] Dynamic subtest vecs0: SUCCESS (0.059s)
[55.808219] Starting dynamic subtest: vecs1
[55.849198] Dynamic subtest vecs1: SUCCESS (0.060s)
[55.868223] Starting dynamic subtest: ccs0
[55.910190] Dynamic subtest ccs0: SUCCESS (0.061s)
[55.929334] Starting dynamic subtest: ccs1
[55.966047] Dynamic subtest ccs1: SUCCESS (0.056s)
[55.984873] Starting dynamic subtest: ccs2
[56.027064] Dynamic subtest ccs2: SUCCESS (0.061s)
[56.046123] Starting dynamic subtest: ccs3
[56.080172] Dynamic subtest ccs3: SUCCESS (0.053s)
[56.082238] Subtest basic-wait: SUCCESS (0.620s)
[57.155430] [023/165] (944s left) gem_exec_fence (basic-await)
[57.332489] Starting subtest: basic-await
[57.334164] Starting dynamic subtest: rcs0
[57.445617] Dynamic subtest rcs0: SUCCESS (0.114s)
[57.450700] Starting dynamic subtest: bcs0
[57.539941] Dynamic subtest bcs0: SUCCESS (0.094s)
[57.544882] Starting dynamic subtest: vcs0
[57.635516] Dynamic subtest vcs0: SUCCESS (0.095s)
[57.640447] Starting dynamic subtest: vcs1
[57.731041] Dynamic subtest vcs1: SUCCESS (0.095s)
[57.736114] Starting dynamic subtest: vecs0
[57.825620] Dynamic subtest vecs0: SUCCESS (0.095s)
[57.830496] Starting dynamic subtest: vecs1
[57.919927] Dynamic subtest vecs1: SUCCESS (0.094s)
[57.924954] Starting dynamic subtest: ccs0
[58.017186] Dynamic subtest ccs0: SUCCESS (0.097s)
[58.021919] Starting dynamic subtest: ccs1
[58.111663] Dynamic subtest ccs1: SUCCESS (0.094s)
[58.116660] Starting dynamic subtest: ccs2
[58.206542] Dynamic subtest ccs2: SUCCESS (0.095s)
[58.211486] Starting dynamic subtest: ccs3
[58.301659] Dynamic subtest ccs3: SUCCESS (0.095s)
[58.302719] Subtest basic-await: SUCCESS (0.970s)
[59.380873] [024/165] (942s left) gem_exec_fence (nb-await)
[59.549465] Starting subtest: nb-await
[59.550755] Starting dynamic subtest: rcs0
[59.656395] Dynamic subtest rcs0: SUCCESS (0.107s)
[59.661730] Starting dynamic subtest: bcs0
[59.719235] Dynamic subtest bcs0: SUCCESS (0.062s)
[59.728925] Starting dynamic subtest: vcs0
[59.797971] Dynamic subtest vcs0: SUCCESS (0.078s)
[59.806186] Starting dynamic subtest: vcs1
[59.865021] Dynamic subtest vcs1: SUCCESS (0.068s)
[59.873245] Starting dynamic subtest: vecs0
[59.938458] Dynamic subtest vecs0: SUCCESS (0.072s)
[59.942972] Starting dynamic subtest: vecs1
[60.000429] Dynamic subtest vecs1: SUCCESS (0.062s)
[60.012646] Starting dynamic subtest: ccs0
[60.086043] Dynamic subtest ccs0: SUCCESS (0.085s)
[60.094966] Starting dynamic subtest: ccs1
[60.152373] Dynamic subtest ccs1: SUCCESS (0.067s)
[60.158614] Starting dynamic subtest: ccs2
[60.221939] Dynamic subtest ccs2: SUCCESS (0.068s)
[60.230920] Starting dynamic subtest: ccs3
[60.289144] Dynamic subtest ccs3: SUCCESS (0.068s)
[60.290146] Subtest nb-await: SUCCESS (0.740s)
[61.355053] [025/165] (940s left) gem_exec_gttfill (basic)
[61.408789] Starting subtest: basic
[66.829700] Subtest basic: SUCCESS (5.412s)
[67.031465] [026/165] (934s left) gem_exec_parallel (engines)
[67.124522] Starting subtest: engines
[67.125349] Starting dynamic subtest: basic
[69.540675] Dynamic subtest basic: SUCCESS (2.416s)
[69.558110] Starting dynamic subtest: contexts
[73.158255] Dynamic subtest contexts: SUCCESS (3.618s)
[73.163358] Starting dynamic subtest: fds
[77.698266] Dynamic subtest fds: SUCCESS (4.531s)
[77.703439] Starting dynamic subtest: userptr
[79.148703] Dynamic subtest userptr: SUCCESS (1.459s)
[79.149908] Subtest engines: SUCCESS (12.024s)
[79.355815] [027/165] (922s left) gem_exec_store (basic)
[79.456310] Starting subtest: basic
[79.615889] Subtest basic: SUCCESS (0.159s)
[79.808137] [028/165] (921s left) gem_flink_basic (bad-flink)
[79.885167] Starting subtest: bad-flink
[79.886109] Subtest bad-flink: SUCCESS (0.000s)
[79.896579] [029/165] (921s left) gem_flink_basic (bad-open)
[79.938793] Starting subtest: bad-open
[79.939767] Subtest bad-open: SUCCESS (0.000s)
[79.950328] [030/165] (921s left) gem_flink_basic (basic)
[79.993425] Starting subtest: basic
[79.994355] Subtest basic: SUCCESS (0.000s)
[80.030614] [031/165] (921s left) gem_flink_basic (double-flink)
[80.087936] Starting subtest: double-flink
[80.088808] Subtest double-flink: SUCCESS (0.000s)
[80.111646] [032/165] (921s left) gem_flink_basic (flink-lifetime)
[80.157382] Starting subtest: flink-lifetime
[80.159080] Subtest flink-lifetime: SUCCESS (0.001s)
[80.191317] [033/165] (921s left) gem_huc_copy (huc-copy)
[80.265239] Starting subtest: huc-copy
[80.272379] Subtest huc-copy: SUCCESS (0.005s)
[80.325447] [034/165] (921s left) gem_linear_blits (basic)
[80.467592] Starting subtest: basic
[80.493259] Subtest basic: SUCCESS (0.026s)
[80.569535] [035/165] (921s left) gem_mmap (basic)
[80.656267] Subtest basic: SKIP (0.000s)
[80.667405] [036/165] (921s left) gem_mmap_gtt (basic)
[80.712255] Subtest basic: SKIP (0.000s)
[80.722245] [037/165] (921s left) gem_render_linear_blits (basic)
[80.771470] Starting subtest: basic
[80.825758] Subtest basic: SUCCESS (0.054s)
[80.884046] [038/165] (921s left) gem_render_tiled_blits (basic)
[80.941535] Subtest basic: SKIP (0.000s)
[80.952170] [039/165] (920s left) gem_ringfill (basic-all)
[81.361149] Starting subtest: basic-all
[84.152026] Subtest basic-all: SUCCESS (2.783s)
[84.171878] [040/165] (917s left) gem_softpin (allocator-basic)
[84.229389] Starting subtest: allocator-basic
[84.397725] Subtest allocator-basic: SUCCESS (0.160s)
[84.443017] [041/165] (917s left) gem_softpin (allocator-basic-reserve)
[84.490692] Starting subtest: allocator-basic-reserve
[84.658949] Subtest allocator-basic-reserve: SUCCESS (0.160s)
[84.708637] [042/165] (917s left) gem_softpin (safe-alignment)
[84.759124] Starting subtest: safe-alignment
[84.808800] Subtest safe-alignment: SUCCESS (0.050s)
[84.871100] [043/165] (917s left) gem_sync (basic-all)
[84.933422] Starting subtest: basic-all
[87.115202] Subtest basic-all: SUCCESS (2.182s)
[87.236405] [044/165] (914s left) gem_sync (basic-each)
[87.299943] Starting subtest: basic-each
[89.986439] Subtest basic-each: SUCCESS (2.685s)
[90.155453] [045/165] (911s left) gem_tiled_blits (basic)
[90.240665] Subtest basic: SKIP (0.000s)
[90.254966] [046/165] (911s left) gem_tiled_fence_blits (basic)
[90.306204] Subtest basic: SKIP (0.000s)
[90.316530] [047/165] (911s left) gem_tiled_pread_basic
[90.368726] [048/165] (911s left) gem_wait (busy@all-engines)
[90.427291] Starting subtest: busy
[90.428142] Starting dynamic subtest: all-engines
[91.003189] Dynamic subtest all-engines: SUCCESS (0.576s)
[91.004163] Subtest busy: SUCCESS (0.576s)
[91.166911] [049/165] (910s left) gem_wait (wait@all-engines)
[91.224789] Starting subtest: wait
[91.225649] Starting dynamic subtest: all-engines
[92.310720] Dynamic subtest all-engines: SUCCESS (1.085s)
[92.312746] Subtest wait: SUCCESS (1.085s)
[92.513517] [050/165] (909s left) i915_getparams_basic (basic-eu-total)
[92.596352] Starting subtest: basic-eu-total
[92.598065] Subtest basic-eu-total: SUCCESS (0.000s)
[92.607752] [051/165] (909s left) i915_getparams_basic (basic-subslice-total)
[92.650407] Starting subtest: basic-subslice-total
[92.651993] Subtest basic-subslice-total: SUCCESS (0.000s)
[92.661669] [052/165] (909s left) i915_hangman (error-state-basic)
[92.717867] Starting subtest: error-state-basic
[92.895496] Subtest error-state-basic: SUCCESS (0.178s)
[92.912787] [053/165] (909s left) i915_pciid
[92.966610] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled)
[93.032194] Starting subtest: addfb25-4-tiled
[93.033355] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[93.067331] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[93.115805] Starting subtest: addfb25-bad-modifier
[93.116696] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[93.155299] [056/165] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.200117] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[93.248607] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag)
[93.298665] Starting subtest: addfb25-modifier-no-flag
[93.299609] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[93.344572] [058/165] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[93.389053] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[93.442413] [059/165] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[93.486953] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[93.528191] [060/165] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[93.592197] Starting subtest: addfb25-yf-tiled-legacy
[93.593032] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[93.613873] [061/165] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.676611] Starting subtest: addfb25-y-tiled-legacy
[93.677505] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.696306] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.757375] Starting subtest: addfb25-y-tiled-small-legacy
[93.759116] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[93.785302] [063/165] (908s left) kms_addfb_basic (bad-pitch-0)
[93.829589] Starting subtest: bad-pitch-0
[93.830514] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.884074] [064/165] (908s left) kms_addfb_basic (bad-pitch-1024)
[93.934103] Starting subtest: bad-pitch-1024
[93.934987] Subtest bad-pitch-1024: SUCCESS (0.000s)
[93.972141] [065/165] (908s left) kms_addfb_basic (bad-pitch-128)
[94.015717] Starting subtest: bad-pitch-128
[94.016660] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.068489] [066/165] (908s left) kms_addfb_basic (bad-pitch-256)
[94.113413] Starting subtest: bad-pitch-256
[94.114380] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.151274] [067/165] (908s left) kms_addfb_basic (bad-pitch-32)
[94.194564] Starting subtest: bad-pitch-32
[94.195444] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.236451] [068/165] (908s left) kms_addfb_basic (bad-pitch-63)
[94.283936] Starting subtest: bad-pitch-63
[94.284751] Subtest bad-pitch-63: SUCCESS (0.000s)
[94.325293] [069/165] (908s left) kms_addfb_basic (bad-pitch-65536)
[94.368405] Starting subtest: bad-pitch-65536
[94.369261] Subtest bad-pitch-65536: SUCCESS (0.000s)
[94.407261] [070/165] (907s left) kms_addfb_basic (bad-pitch-999)
[94.449073] Starting subtest: bad-pitch-999
[94.449971] Subtest bad-pitch-999: SUCCESS (0.000s)
[94.507461] [071/165] (907s left) kms_addfb_basic (basic)
[94.560665] Starting subtest: basic
[94.561595] Subtest basic: SUCCESS (0.000s)
[94.601181] [072/165] (907s left) kms_addfb_basic (basic-x-tiled-legacy)
[94.643861] Starting subtest: basic-x-tiled-legacy
[94.645356] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[94.686716] [073/165] (907s left) kms_addfb_basic (basic-y-tiled-legacy)
[94.732989] Starting subtest: basic-y-tiled-legacy
[94.734843] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[94.781079] [074/165] (907s left) kms_addfb_basic (bo-too-small)
[94.843212] Starting subtest: bo-too-small
[94.844127] Subtest bo-too-small: SUCCESS (0.000s)
[94.866294] [075/165] (907s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[94.927839] Starting subtest: bo-too-small-due-to-tiling
[94.929360] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[94.953133] [076/165] (907s left) kms_addfb_basic (clobberred-modifier)
[94.997143] Starting subtest: clobberred-modifier
[94.998758] Subtest clobberred-modifier: SKIP (0.000s)
[95.049272] [077/165] (907s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[95.098121] Starting subtest: framebuffer-vs-set-tiling
[95.099795] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[95.136632] [078/165] (907s left) kms_addfb_basic (invalid-get-prop)
[95.181296] Starting subtest: invalid-get-prop
[95.182201] Subtest invalid-get-prop: SUCCESS (0.000s)
[95.224298] [079/165] (907s left) kms_addfb_basic (invalid-get-prop-any)
[95.267954] Starting subtest: invalid-get-prop-any
[95.268785] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[95.305687] [080/165] (907s left) kms_addfb_basic (invalid-set-prop)
[95.350324] Starting subtest: invalid-set-prop
[95.351203] Subtest invalid-set-prop: SUCCESS (0.000s)
[95.389295] [081/165] (907s left) kms_addfb_basic (invalid-set-prop-any)
[95.432673] Starting subtest: invalid-set-prop-any
[95.433611] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[95.472324] [082/165] (907s left) kms_addfb_basic (no-handle)
[95.516048] Starting subtest: no-handle
[95.516968] Subtest no-handle: SUCCESS (0.000s)
[95.566756] [083/165] (906s left) kms_addfb_basic (size-max)
[95.631223] Starting subtest: size-max
[95.632134] Subtest size-max: SUCCESS (0.000s)
[95.651222] [084/165] (906s left) kms_addfb_basic (small-bo)
[95.713494] Starting subtest: small-bo
[95.714535] Subtest small-bo: SUCCESS (0.000s)
[95.734298] [085/165] (906s left) kms_addfb_basic (tile-pitch-mismatch)
[95.779227] Starting subtest: tile-pitch-mismatch
[95.780915] Subtest tile-pitch-mismatch: SKIP (0.000s)
[95.835209] [086/165] (906s left) kms_addfb_basic (too-high)
[95.904534] Starting subtest: too-high
[95.905463] Subtest too-high: SUCCESS (0.001s)
[95.932907] [087/165] (906s left) kms_addfb_basic (too-wide)
[95.996411] Starting subtest: too-wide
[95.997263] Subtest too-wide: SUCCESS (0.000s)
[96.018804] [088/165] (906s left) kms_addfb_basic (unused-handle)
[96.062741] Starting subtest: unused-handle
[96.063661] Subtest unused-handle: SUCCESS (0.000s)
[96.124043] [089/165] (906s left) kms_addfb_basic (unused-modifier)
[96.171594] Starting subtest: unused-modifier
[96.172526] Subtest unused-modifier: SUCCESS (0.000s)
[96.227798] [090/165] (906s left) kms_addfb_basic (unused-offsets)
[96.272889] Starting subtest: unused-offsets
[96.273755] Subtest unused-offsets: SUCCESS (0.000s)
[96.325447] [091/165] (906s left) kms_addfb_basic (unused-pitches)
[96.375945] Starting subtest: unused-pitches
[96.376763] Subtest unused-pitches: SUCCESS (0.000s)
[96.422594] [092/165] (906s left) kms_busy (basic)
[96.490606] Subtest basic: SKIP (0.000s)
[96.501240] [093/165] (906s left) kms_prop_blob (basic)
[96.544009] Starting subtest: basic
[96.544906] Subtest basic: SUCCESS (0.000s)
[96.554814] [094/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[96.623605] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[96.633861] [095/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[96.701312] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[96.711303] [096/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[96.778504] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[96.788202] [097/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[96.854758] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[96.864315] [098/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[96.930152] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[96.940319] [099/165] (905s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[97.006598] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[97.015829] [100/165] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[97.083216] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[97.093016] [101/165] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[97.159604] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[97.168813] [102/165] (905s left) kms_dsc (dsc-basic)
[97.229978] Subtest dsc-basic: SKIP (0.000s)
[97.239911] [103/165] (905s left) kms_flip (basic-flip-vs-dpms)
[97.288273] Starting subtest: basic-flip-vs-dpms
[97.291360] Subtest basic-flip-vs-dpms: SKIP (0.003s)
[97.324414] [104/165] (905s left) kms_flip (basic-flip-vs-modeset)
[97.371786] Starting subtest: basic-flip-vs-modeset
[97.374607] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[97.406345] [105/165] (905s left) kms_flip (basic-flip-vs-wf_vblank)
[97.458574] Starting subtest: basic-flip-vs-wf_vblank
[97.462737] Subtest basic-flip-vs-wf_vblank: SKIP (0.004s)
[97.511958] [106/165] (905s left) kms_flip (basic-plain-flip)
[97.573913] Starting subtest: basic-plain-flip
[97.576512] Subtest basic-plain-flip: SKIP (0.003s)
[97.594088] [107/165] (905s left) kms_force_connector_basic (force-connector-state)
[97.643488] Starting subtest: force-connector-state
[97.695966] Subtest force-connector-state: SUCCESS (0.051s)
[97.802865] [108/165] (905s left) kms_force_connector_basic (force-edid)
[97.852274] Starting subtest: force-edid
[97.879273] Subtest force-edid: SUCCESS (0.027s)
[97.927298] [109/165] (904s left) kms_force_connector_basic (force-load-detect)
[97.975635] Starting subtest: force-load-detect
[97.977262] Subtest force-load-detect: SKIP (0.000s)
[98.021144] [110/165] (904s left) kms_force_connector_basic (prune-stale-modes)
[98.067995] Starting subtest: prune-stale-modes
[98.084618] Subtest prune-stale-modes: SKIP (0.016s)
[98.137052] [111/165] (904s left) kms_frontbuffer_tracking (basic)
[98.200277] Subtest basic: SKIP (0.000s)
[98.226966] [112/165] (904s left) kms_hdmi_inject (inject-audio)
[98.272763] Starting subtest: inject-audio
[98.372865] Subtest inject-audio: SUCCESS (0.099s)
[98.499131] [113/165] (904s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[98.581045] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[98.594026] [114/165] (904s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[98.657047] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[98.670132] [115/165] (904s left) kms_pipe_crc_basic (hang-read-crc)
[98.733419] Subtest hang-read-crc: SKIP (0.000s)
[98.747781] [116/165] (904s left) kms_pipe_crc_basic (nonblocking-crc)
[98.811554] Subtest nonblocking-crc: SKIP (0.000s)
[98.825251] [117/165] (904s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[98.888250] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[98.901261] [118/165] (904s left) kms_pipe_crc_basic (read-crc)
[98.964867] Subtest read-crc: SKIP (0.000s)
[98.977956] [119/165] (903s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[99.040689] Subtest read-crc-frame-sequence: SKIP (0.000s)
[99.053963] [120/165] (903s left) kms_pm_backlight (basic-brightness)
[99.115502] Subtest basic-brightness: SKIP (0.000s)
[99.134330] [121/165] (903s left) kms_pm_rpm (basic-pci-d3-state)
[100.309256] Starting subtest: basic-pci-d3-state
[100.724091] Subtest basic-pci-d3-state: SUCCESS (0.414s)
[100.801483] [122/165] (902s left) kms_pm_rpm (basic-rte)
[100.844940] Starting subtest: basic-rte
[102.337522] Subtest basic-rte: SUCCESS (1.492s)
[103.332661] [123/165] (899s left) kms_psr (primary_page_flip)
[103.389234] Subtest primary_page_flip: SKIP (0.000s)
[103.404895] [124/165] (899s left) kms_psr (cursor_plane_move)
[103.450725] Subtest cursor_plane_move: SKIP (0.000s)
[103.466323] [125/165] (899s left) kms_psr (sprite_plane_onoff)
[103.509679] Subtest sprite_plane_onoff: SKIP (0.000s)
[103.523052] [126/165] (899s left) kms_psr (primary_mmap_gtt)
[103.568572] Subtest primary_mmap_gtt: SKIP (0.000s)
[103.582308] [127/165] (899s left) kms_setmode (basic-clone-single-crtc)
[103.626367] Starting subtest: basic-clone-single-crtc
[103.628877] Subtest basic-clone-single-crtc: SKIP (0.000s)
[103.641472] [128/165] (899s left) i915_pm_rps (basic-api)
[103.689197] Starting subtest: basic-api
[103.690848] Subtest basic-api: SKIP (0.000s)
[103.706351] [129/165] (899s left) prime_self_import (basic-llseek-bad)
[103.751877] Starting subtest: basic-llseek-bad
[103.753800] Subtest basic-llseek-bad: SUCCESS (0.002s)
[103.782620] [130/165] (899s left) prime_self_import (basic-llseek-size)
[103.831768] Starting subtest: basic-llseek-size
[103.834428] Subtest basic-llseek-size: SUCCESS (0.003s)
[103.889281] [131/165] (899s left) prime_self_import (basic-with_fd_dup)
[103.954729] Starting subtest: basic-with_fd_dup
[103.958570] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[104.006756] [132/165] (899s left) prime_self_import (basic-with_one_bo)
[104.074733] Starting subtest: basic-with_one_bo
[104.077431] Subtest basic-with_one_bo: SUCCESS (0.003s)
[104.093314] [133/165] (899s left) prime_self_import (basic-with_one_bo_two_files)
[104.134763] Starting subtest: basic-with_one_bo_two_files
[104.137201] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[104.178897] [134/165] (898s left) prime_self_import (basic-with_two_bos)
[104.238341] Starting subtest: basic-with_two_bos
[104.241055] Subtest basic-with_two_bos: SUCCESS (0.003s)
[104.271327] [135/165] (898s left) prime_vgem (basic-fence-flip)
[104.324701] Starting subtest: basic-fence-flip
[104.345991] Subtest basic-fence-flip: SKIP (0.020s)
[104.362636] [136/165] (898s left) prime_vgem (basic-fence-mmap)
[104.414489] Starting subtest: basic-fence-mmap
[104.416488] Subtest basic-fence-mmap: SKIP (0.000s)
[104.453244] [137/165] (898s left) prime_vgem (basic-fence-read)
[104.503746] Starting subtest: basic-fence-read
[104.510258] Subtest basic-fence-read: SKIP (0.006s)
[104.549301] [138/165] (898s left) prime_vgem (basic-gtt)
[104.595235] Starting subtest: basic-gtt
[104.596790] Subtest basic-gtt: SKIP (0.000s)
[104.635114] [139/165] (898s left) prime_vgem (basic-read)
[104.701574] Starting subtest: basic-read
[104.706910] Subtest basic-read: SKIP (0.004s)
[104.744986] [140/165] (898s left) prime_vgem (basic-write)
[104.795171] Starting subtest: basic-write
[104.800222] Subtest basic-write: SKIP (0.004s)
[104.839040] [141/165] (898s left) vgem_basic (setversion)
[104.883734] Starting subtest: setversion
[104.885463] Subtest setversion: SUCCESS (0.000s)
[104.897807] [142/165] (898s left) vgem_basic (create)
[104.941061] Starting subtest: create
[104.941958] Subtest create: SUCCESS (0.000s)
[104.954286] [143/165] (898s left) vgem_basic (debugfs)
[105.000312] Starting subtest: debugfs
[105.001263] Subtest debugfs: SUCCESS (0.000s)
[105.013799] [144/165] (898s left) vgem_basic (dmabuf-export)
[105.062654] Starting subtest: dmabuf-export
[105.064559] Subtest dmabuf-export: SUCCESS (0.002s)
[105.100146] [145/165] (898s left) vgem_basic (dmabuf-fence)
[105.149965] Starting subtest: dmabuf-fence
[105.150914] Subtest dmabuf-fence: SUCCESS (0.000s)
[105.164456] [146/165] (898s left) vgem_basic (dmabuf-fence-before)
[105.211195] Starting subtest: dmabuf-fence-before
[105.212269] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[105.223980] [147/165] (898s left) vgem_basic (dmabuf-mmap)
[105.267349] Starting subtest: dmabuf-mmap
[105.274698] Subtest dmabuf-mmap: SUCCESS (0.008s)
[105.288252] [148/165] (898s left) vgem_basic (mmap)
[105.331817] Starting subtest: mmap
[105.336008] Subtest mmap: SUCCESS (0.006s)
[105.349842] [149/165] (898s left) vgem_basic (second-client)
[105.395726] Starting subtest: second-client
[105.397450] Subtest second-client: SUCCESS (0.002s)
[105.411807] [150/165] (897s left) vgem_basic (sysfs)
[105.460063] Starting subtest: sysfs
[105.460892] Subtest sysfs: SUCCESS (0.000s)
[105.472328] [151/165] (897s left) core_hotunplug (unbind-rebind)
[105.537023] Starting subtest: unbind-rebind
[109.339852] Subtest unbind-rebind: SUCCESS (3.803s)
[109.352743] [152/165] (894s left) vgem_basic (unload)
[109.396212] Starting subtest: unload
[138.294462] Subtest unload: SUCCESS (28.863s)
[138.333826] [153/165] (865s left) i915_module_load (reload)
[138.398401] Starting subtest: reload
[140.733288] Subtest reload: SUCCESS (2.334s)
[140.747017] [154/165] (862s left) gem_lmem_swapping (basic)
[143.342437] Starting subtest: basic
[143.343744] Starting dynamic subtest: lmem0
[162.403477] Dynamic subtest lmem0: SUCCESS (19.059s)
[162.404324] Subtest basic: SUCCESS (19.059s)
[164.760184] [155/165] (838s left) gem_lmem_swapping (parallel-random-engines)
[165.185828] Starting subtest: parallel-random-engines
[165.186621] Starting dynamic subtest: lmem0
[165.985010] Dynamic subtest lmem0: SUCCESS (0.796s)
[165.985811] Subtest parallel-random-engines: SUCCESS (0.796s)
[167.049232] [156/165] (836s left) gem_lmem_swapping (random-engines)
[167.473753] Starting subtest: random-engines
[167.474794] Starting dynamic subtest: lmem0
[168.198393] Dynamic subtest lmem0: SUCCESS (0.716s)
[168.199249] Subtest random-engines: SUCCESS (0.716s)
[169.258077] [157/165] (834s left) gem_lmem_swapping (verify-random)
[169.688024] Starting subtest: verify-random
[169.688846] Starting dynamic subtest: lmem0
[177.895186] Dynamic subtest lmem0: SUCCESS (8.174s)
[177.896259] Subtest verify-random: SUCCESS (8.174s)
[179.005887] [158/165] (824s left) i915_pm_rpm (module-reload)
[180.740391] Starting subtest: module-reload
[189.213824] Subtest module-reload: SUCCESS (8.465s)
[189.223151] [159/165] (814s left) i915_selftest (live)
[189.262502] Starting subtest: live
[189.263503] Starting dynamic subtest: sanitycheck
[190.642383] Dynamic subtest sanitycheck: SUCCESS (1.371s)
[190.647784] Starting dynamic subtest: uncore
[192.005473] Dynamic subtest uncore: SUCCESS (1.363s)
[192.011171] Starting dynamic subtest: workarounds
[196.252304] Dynamic subtest workarounds: SUCCESS (4.247s)
[196.257172] Starting dynamic subtest: gt_engines
[198.700263] Dynamic subtest gt_engines: SUCCESS (2.448s)
[198.705109] Starting dynamic subtest: gt_timelines
[226.244372] Dynamic subtest gt_timelines: SUCCESS (27.544s)
[226.250148] Starting dynamic subtest: gt_contexts
[227.649174] Dynamic subtest gt_contexts: SUCCESS (1.404s)
[227.654280] Starting dynamic subtest: gt_lrc
[235.551308] Dynamic subtest gt_lrc: SUCCESS (7.902s)
[235.557054] Starting dynamic subtest: gt_mocs
[238.991721] Dynamic subtest gt_mocs: SUCCESS (3.440s)
[239.001129] Starting dynamic subtest: gt_pm
[241.311445] Dynamic subtest gt_pm: SUCCESS (2.319s)
[241.317561] Starting dynamic subtest: gt_heartbeat
[242.905349] Dynamic subtest gt_heartbeat: SUCCESS (1.593s)
[242.910773] Starting dynamic subtest: gt_tlb
[255.017232] Dynamic subtest gt_tlb: SUCCESS (12.111s)
[255.023389] Starting dynamic subtest: requests
[273.049319] Dynamic subtest requests: SUCCESS (18.031s)
[273.055421] Starting dynamic subtest: migrate
[277.713338] Dynamic subtest migrate: SUCCESS (4.663s)
[277.719143] Starting dynamic subtest: active
[279.074370] Dynamic subtest active: SUCCESS (1.361s)
[279.080797] Starting dynamic subtest: objects
[281.293589] Dynamic subtest objects: SUCCESS (2.219s)
[281.300374] Starting dynamic subtest: mman
[289.972277] Dynamic subtest mman: SUCCESS (8.678s)
[289.978172] Starting dynamic subtest: dmabuf
[291.326036] Dynamic subtest dmabuf: SUCCESS (1.354s)
[291.332809] Starting dynamic subtest: vma
[292.696326] Dynamic subtest vma: SUCCESS (1.368s)
[292.702512] Starting dynamic subtest: coherency
[296.753308] Dynamic subtest coherency: SUCCESS (4.056s)
[296.759752] Starting dynamic subtest: gtt
[305.620894] Dynamic subtest gtt: SUCCESS (8.866s)
[305.625997] Starting dynamic subtest: gem
[307.076315] Dynamic subtest gem: SUCCESS (1.455s)
[307.081526] Starting dynamic subtest: evict
[310.451373] Dynamic subtest evict: SUCCESS (3.374s)
[310.456401] Starting dynamic subtest: hugepages
[328.571579] Dynamic subtest hugepages: SUCCESS (18.119s)
[328.577210] Starting dynamic subtest: gem_contexts
[368.567779] Dynamic subtest gem_contexts: SUCCESS (39.970s)
[368.573389] Starting dynamic subtest: client
[369.969432] Dynamic subtest client: SUCCESS (1.426s)
[369.975548] Starting dynamic subtest: gem_migrate
[374.343538] Dynamic subtest gem_migrate: SUCCESS (4.373s)
[374.349714] Starting dynamic subtest: reset
[375.786258] Dynamic subtest reset: SUCCESS (1.442s)
[375.792249] Starting dynamic subtest: memory_region
[378.695292] Dynamic subtest memory_region: SUCCESS (2.908s)
[378.701283] Starting dynamic subtest: hangcheck
[423.426278] Dynamic subtest hangcheck: SUCCESS (44.733s)
[423.431672] Starting dynamic subtest: execlists
[424.825388] Dynamic subtest execlists: SUCCESS (1.395s)
[424.831413] Starting dynamic subtest: ring_submission
[426.157370] Dynamic subtest ring_submission: SUCCESS (1.331s)
[426.163044] Starting dynamic subtest: perf
[427.629432] Dynamic subtest perf: SUCCESS (1.471s)
[427.636051] Starting dynamic subtest: slpc
[436.851629] Dynamic subtest slpc: SUCCESS (9.221s)
[436.858716] Starting dynamic subtest: guc
[439.432471] Dynamic subtest guc: SUCCESS (2.580s)
[439.439679] Starting dynamic subtest: guc_multi_lrc
[440.872360] Dynamic subtest guc_multi_lrc: SUCCESS (1.439s)
[440.878877] Starting dynamic subtest: guc_hang
[442.967439] Dynamic subtest guc_hang: SUCCESS (2.094s)
[442.973683] Starting dynamic subtest: late_gt_pm
[444.432366] Dynamic subtest late_gt_pm: SUCCESS (1.464s)
[444.433520] Subtest live: SUCCESS (255.162s)
[444.665812] [160/165] (558s left) dmabuf (all-tests)
[444.707162] Starting subtest: all-tests
[444.708655] Starting dynamic subtest: sanitycheck
[444.774905] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[444.790855] Starting dynamic subtest: dma_fence
[444.956552] Dynamic subtest dma_fence: SUCCESS (0.180s)
[444.967803] Starting dynamic subtest: dma_fence_chain
[455.256426] Dynamic subtest dma_fence_chain: SUCCESS (10.299s)
[455.263536] Starting dynamic subtest: dma_fence_unwrap
[455.336198] Dynamic subtest dma_fence_unwrap: SUCCESS (0.078s)
[455.345181] Starting dynamic subtest: dma_resv
[455.413240] Dynamic subtest dma_resv: SUCCESS (0.074s)
[455.415074] Subtest all-tests: SUCCESS (10.707s)
[455.456687] [161/165] (548s left) i915_suspend (basic-s2idle-without-i915)
[455.514146] Starting subtest: basic-s2idle-without-i915
[474.418121] Subtest basic-s2idle-without-i915: SUCCESS (4.402s)
[474.442717] [162/165] (543s left) i915_suspend (basic-s3-without-i915)
[474.496618] Starting subtest: basic-s3-without-i915
[496.018259] Subtest basic-s3-without-i915: SUCCESS (5.395s)
[496.053419] [163/165] (538s left) gem_exec_suspend (basic-s0)
[496.117223] Starting subtest: basic-S0
[496.118120] Starting dynamic subtest: smem
[517.950031] Dynamic subtest smem: SUCCESS (6.776s)
[517.969342] Starting dynamic subtest: lmem0
[538.841492] Dynamic subtest lmem0: SUCCESS (7.021s)
[538.842358] Subtest basic-S0: SUCCESS (13.799s)
[538.978254] [164/165] (524s left) gem_exec_suspend (basic-s3)
[539.031758] Starting subtest: basic-S3
[539.032639] Starting dynamic subtest: smem
[561.804478] Dynamic subtest smem: SUCCESS (6.931s)
[561.823641] Starting dynamic subtest: lmem0
[584.841422] Dynamic subtest lmem0: SUCCESS (6.660s)
[584.842791] Subtest basic-S3: SUCCESS (13.594s)
[584.981276] [165/165] (510s left) kms_pipe_crc_basic (suspend-read-crc)
[585.098412] Subtest suspend-read-crc: SKIP (0.000s)
[585.110193] Closing watchdogs
Done.