[38.024404] Initializing watchdogs
[38.024488]   /dev/watchdog0
[38.030328] [001/171] (960s left) i915_module_load (load)
[38.104153] Starting subtest: load
[38.964934] Subtest load: SUCCESS (0.861s)
[38.979854] [002/171] (959s left) core_auth (basic-auth)
[39.078680] Starting subtest: basic-auth
[39.079229] Subtest basic-auth: SUCCESS (0.001s)
[39.091172] [003/171] (959s left) debugfs_test (read_all_entries)
[39.179787] Starting subtest: read_all_entries
[39.319699] Subtest read_all_entries: SUCCESS (0.140s)
[39.354644] [004/171] (959s left) debugfs_test (basic-hwmon)
[39.424827] Starting subtest: basic-hwmon
[39.425728] Subtest basic-hwmon: SKIP (0.000s)
[39.464980] [005/171] (959s left) fbdev (eof)
[40.627053] Subtest eof: SKIP (0.000s)
[40.637813] [006/171] (957s left) fbdev (info)
[40.715284] Subtest info: SKIP (0.000s)
[40.723668] [007/171] (957s left) fbdev (nullptr)
[40.799933] Subtest nullptr: SKIP (0.000s)
[40.810731] [008/171] (957s left) fbdev (read)
[40.886257] Subtest read: SKIP (0.000s)
[40.896416] [009/171] (957s left) fbdev (write)
[40.973280] Subtest write: SKIP (0.000s)
[40.983190] [010/171] (957s left) gem_basic (bad-close)
[41.051193] Starting subtest: bad-close
[41.052343] Subtest bad-close: SUCCESS (0.000s)
[41.061332] [011/171] (957s left) gem_basic (create-close)
[41.128642] Starting subtest: create-close
[41.129709] Subtest create-close: SUCCESS (0.000s)
[41.169215] [012/171] (957s left) gem_basic (create-fd-close)
[41.237424] Starting subtest: create-fd-close
[41.238235] Subtest create-fd-close: SUCCESS (0.000s)
[41.269978] [013/171] (957s left) gem_busy (busy@all-engines)
[41.346378] Starting subtest: busy
[41.346852] Starting dynamic subtest: all-engines
[41.383458] Dynamic subtest all-engines: SUCCESS (0.037s)
[41.383850] Subtest busy: SUCCESS (0.037s)
[41.723305] [014/171] (956s left) gem_close_race (basic-process)
[41.822899] Starting subtest: basic-process
[41.885070] Subtest basic-process: SUCCESS (0.062s)
[42.006090] [015/171] (956s left) gem_close_race (basic-threads)
[42.085246] Starting subtest: basic-threads
[43.300076] Subtest basic-threads: SUCCESS (1.215s)
[43.451099] [016/171] (955s left) gem_ctx_create (basic)
[43.548909] Starting subtest: basic
[43.549598] Subtest basic: SUCCESS (0.000s)
[43.725302] [017/171] (955s left) gem_ctx_create (basic-files)
[43.827228] Starting subtest: basic-files
[45.841778] Subtest basic-files: SUCCESS (2.014s)
[46.040419] [018/171] (952s left) gem_ctx_exec (basic)
[46.141067] Starting subtest: basic
[46.143874] Subtest basic: SUCCESS (0.004s)
[46.187234] [019/171] (952s left) gem_exec_basic (basic)
[46.271253] Starting subtest: basic
[46.271924] Starting dynamic subtest: rcs0-smem
[46.272491] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[46.276609] Starting dynamic subtest: bcs0-smem
[46.277052] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[46.280910] Starting dynamic subtest: vcs0-smem
[46.281373] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.285405] Starting dynamic subtest: vecs0-smem
[46.285945] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[46.286428] Subtest basic: SUCCESS (0.004s)
[46.480579] [020/171] (952s left) gem_exec_create (basic)
[46.581954] Starting subtest: basic
[46.582555] Starting dynamic subtest: smem
[48.621890] Dynamic subtest smem: SUCCESS (2.040s)
[48.622356] Subtest basic: SUCCESS (2.040s)
[48.793776] [021/171] (950s left) gem_exec_fence (basic-busy)
[49.063770] Starting subtest: basic-busy
[49.065546] Starting dynamic subtest: rcs0
[49.106322] Dynamic subtest rcs0: SUCCESS (0.043s)
[49.116097] Starting dynamic subtest: bcs0
[49.144695] Dynamic subtest bcs0: SUCCESS (0.038s)
[49.160886] Starting dynamic subtest: vcs0
[49.186925] Dynamic subtest vcs0: SUCCESS (0.042s)
[49.203326] Starting dynamic subtest: vecs0
[49.222070] Dynamic subtest vecs0: SUCCESS (0.035s)
[49.223662] Subtest basic-busy: SUCCESS (0.158s)
[49.841297] [022/171] (949s left) gem_exec_fence (basic-wait)
[50.115109] Starting subtest: basic-wait
[50.116389] Starting dynamic subtest: rcs0
[50.157421] Dynamic subtest rcs0: SUCCESS (0.045s)
[50.170885] Starting dynamic subtest: bcs0
[50.201958] Dynamic subtest bcs0: SUCCESS (0.044s)
[50.222345] Starting dynamic subtest: vcs0
[50.238045] Dynamic subtest vcs0: SUCCESS (0.036s)
[50.254087] Starting dynamic subtest: vecs0
[50.265908] Dynamic subtest vecs0: SUCCESS (0.027s)
[50.266850] Subtest basic-wait: SUCCESS (0.153s)
[50.763577] [023/171] (948s left) gem_exec_fence (basic-await)
[50.994267] Starting subtest: basic-await
[50.994876] Starting dynamic subtest: rcs0
[51.074781] Dynamic subtest rcs0: SUCCESS (0.079s)
[51.082607] Starting dynamic subtest: bcs0
[51.165733] Dynamic subtest bcs0: SUCCESS (0.091s)
[51.174318] Starting dynamic subtest: vcs0
[51.258385] Dynamic subtest vcs0: SUCCESS (0.092s)
[51.265930] Starting dynamic subtest: vecs0
[51.349684] Dynamic subtest vecs0: SUCCESS (0.091s)
[51.350477] Subtest basic-await: SUCCESS (0.354s)
[51.910795] [024/171] (947s left) gem_exec_fence (nb-await)
[52.115250] Starting subtest: nb-await
[52.116040] Starting dynamic subtest: rcs0
[52.177972] Dynamic subtest rcs0: SUCCESS (0.061s)
[52.194521] Starting dynamic subtest: bcs0
[52.251898] Dynamic subtest bcs0: SUCCESS (0.071s)
[52.275265] Starting dynamic subtest: vcs0
[52.331425] Dynamic subtest vcs0: SUCCESS (0.080s)
[52.353082] Starting dynamic subtest: vecs0
[52.410307] Dynamic subtest vecs0: SUCCESS (0.079s)
[52.412561] Subtest nb-await: SUCCESS (0.293s)
[53.014923] [025/171] (945s left) gem_exec_gttfill (basic)
[53.102780] Starting subtest: basic
[56.441260] Subtest basic: SUCCESS (3.337s)
[56.561862] [026/171] (942s left) gem_exec_parallel (engines)
[56.709224] Starting subtest: engines
[56.709761] Starting dynamic subtest: basic
[58.434880] Dynamic subtest basic: SUCCESS (1.726s)
[58.439677] Starting dynamic subtest: contexts
[61.130590] Dynamic subtest contexts: SUCCESS (2.692s)
[61.135609] Starting dynamic subtest: fds
[63.621016] Dynamic subtest fds: SUCCESS (2.494s)
[63.626267] Starting dynamic subtest: userptr
[65.681015] Dynamic subtest userptr: SUCCESS (2.060s)
[65.681770] Subtest engines: SUCCESS (8.972s)
[65.868863] [027/171] (933s left) gem_exec_store (basic)
[65.949919] Starting subtest: basic
[65.989019] Subtest basic: SUCCESS (0.039s)
[66.170081] [028/171] (932s left) gem_flink_basic (bad-flink)
[66.267981] Starting subtest: bad-flink
[66.268559] Subtest bad-flink: SUCCESS (0.000s)
[66.279929] [029/171] (932s left) gem_flink_basic (bad-open)
[66.345303] Starting subtest: bad-open
[66.345790] Subtest bad-open: SUCCESS (0.000s)
[66.357934] [030/171] (932s left) gem_flink_basic (basic)
[66.424229] Starting subtest: basic
[66.424824] Subtest basic: SUCCESS (0.000s)
[66.450941] [031/171] (932s left) gem_flink_basic (double-flink)
[66.519327] Starting subtest: double-flink
[66.519842] Subtest double-flink: SUCCESS (0.000s)
[66.554033] [032/171] (932s left) gem_flink_basic (flink-lifetime)
[66.625879] Starting subtest: flink-lifetime
[66.626418] Subtest flink-lifetime: SUCCESS (0.001s)
[66.653929] [033/171] (932s left) gem_huc_copy (huc-copy)
[66.727662] Starting subtest: huc-copy
[66.730519] Subtest huc-copy: SUCCESS (0.003s)
[66.769632] [034/171] (932s left) gem_linear_blits (basic)
[66.938346] Starting subtest: basic
[66.943761] Subtest basic: SUCCESS (0.005s)
[67.004646] [035/171] (932s left) gem_mmap (basic)
[67.152828] Starting subtest: basic
[67.155568] Subtest basic: SUCCESS (0.000s)
[67.178449] [036/171] (931s left) gem_mmap_gtt (basic)
[67.252399] Starting subtest: basic
[67.253028] Subtest basic: SUCCESS (0.000s)
[67.264435] [037/171] (931s left) gem_render_linear_blits (basic)
[67.335051] Starting subtest: basic
[67.355755] Subtest basic: SUCCESS (0.021s)
[67.385679] [038/171] (931s left) gem_render_tiled_blits (basic)
[67.454866] Starting subtest: basic
[67.483286] Subtest basic: SUCCESS (0.029s)
[67.509597] [039/171] (931s left) gem_ringfill (basic-all)
[67.724589] Starting subtest: basic-all
[68.867105] Subtest basic-all: SUCCESS (1.137s)
[68.946328] [040/171] (930s left) gem_softpin (allocator-basic)
[69.054167] Starting subtest: allocator-basic
[69.143541] Subtest allocator-basic: SUCCESS (0.087s)
[69.177638] [041/171] (930s left) gem_softpin (allocator-basic-reserve)
[69.246458] Starting subtest: allocator-basic-reserve
[69.339846] Subtest allocator-basic-reserve: SUCCESS (0.091s)
[69.390892] [042/171] (929s left) gem_softpin (safe-alignment)
[69.463694] Starting subtest: safe-alignment
[69.473575] Subtest safe-alignment: SUCCESS (0.010s)
[69.508491] [043/171] (929s left) gem_sync (basic-all)
[69.609418] Starting subtest: basic-all
[71.851945] Subtest basic-all: SUCCESS (2.266s)
[72.033962] [044/171] (927s left) gem_sync (basic-each)
[72.138204] Starting subtest: basic-each
[74.254901] Subtest basic-each: SUCCESS (2.117s)
[74.381939] [045/171] (924s left) gem_tiled_blits (basic)
[74.541072] Starting subtest: basic
[74.556695] Subtest basic: SUCCESS (0.016s)
[74.623756] [046/171] (924s left) gem_tiled_fence_blits (basic)
[74.871529] Starting subtest: basic
[74.879826] Subtest basic: SUCCESS (0.009s)
[74.944023] [047/171] (924s left) gem_tiled_pread_basic
[75.196802] [048/171] (924s left) gem_wait (busy@all-engines)
[75.276767] Starting subtest: busy
[75.277227] Starting dynamic subtest: all-engines
[75.791996] Dynamic subtest all-engines: SUCCESS (0.515s)
[75.792448] Subtest busy: SUCCESS (0.515s)
[75.926030] [049/171] (923s left) gem_wait (wait@all-engines)
[76.005167] Starting subtest: wait
[76.005641] Starting dynamic subtest: all-engines
[77.056933] Dynamic subtest all-engines: SUCCESS (1.051s)
[77.057638] Subtest wait: SUCCESS (1.052s)
[77.194402] [050/171] (922s left) i915_getparams_basic (basic-eu-total)
[77.262794] Starting subtest: basic-eu-total
[77.263703] Subtest basic-eu-total: SUCCESS (0.000s)
[77.275229] [051/171] (922s left) i915_getparams_basic (basic-subslice-total)
[77.341443] Starting subtest: basic-subslice-total
[77.342383] Subtest basic-subslice-total: SUCCESS (0.000s)
[77.354731] [052/171] (922s left) i915_hangman (error-state-basic)
[77.442640] Starting subtest: error-state-basic
[77.507309] Subtest error-state-basic: SUCCESS (0.065s)
[77.521903] [053/171] (921s left) i915_pciid
[77.603659] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[77.671070] Starting subtest: addfb25-bad-modifier
[77.672388] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[77.781956] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[77.848671] Starting subtest: addfb25-framebuffer-vs-set-tiling
[77.849071] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.947642] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[78.015642] Starting subtest: addfb25-modifier-no-flag
[78.016042] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[78.120059] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[78.186913] Starting subtest: addfb25-x-tiled-legacy
[78.187539] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[78.297713] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[78.364908] Starting subtest: addfb25-x-tiled-mismatch-legacy
[78.365441] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[78.468502] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[78.616386] Starting subtest: addfb25-yf-tiled-legacy
[78.616876] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[78.645828] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[78.788450] Starting subtest: addfb25-y-tiled-legacy
[78.788888] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[78.819352] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[78.963574] Starting subtest: addfb25-y-tiled-small-legacy
[78.964043] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[78.995100] [062/171] (920s left) kms_addfb_basic (bad-pitch-0)
[79.062439] Starting subtest: bad-pitch-0
[79.062828] Subtest bad-pitch-0: SUCCESS (0.000s)
[79.170855] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024)
[79.244600] Starting subtest: bad-pitch-1024
[79.245570] Subtest bad-pitch-1024: SUCCESS (0.000s)
[79.351684] [064/171] (920s left) kms_addfb_basic (bad-pitch-128)
[79.418748] Starting subtest: bad-pitch-128
[79.419228] Subtest bad-pitch-128: SUCCESS (0.000s)
[79.518547] [065/171] (920s left) kms_addfb_basic (bad-pitch-256)
[79.583499] Starting subtest: bad-pitch-256
[79.583922] Subtest bad-pitch-256: SUCCESS (0.000s)
[79.695675] [066/171] (919s left) kms_addfb_basic (bad-pitch-32)
[79.763206] Starting subtest: bad-pitch-32
[79.763796] Subtest bad-pitch-32: SUCCESS (0.000s)
[79.859468] [067/171] (919s left) kms_addfb_basic (bad-pitch-63)
[79.932061] Starting subtest: bad-pitch-63
[79.933356] Subtest bad-pitch-63: SUCCESS (0.000s)
[80.032987] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536)
[80.099149] Starting subtest: bad-pitch-65536
[80.099761] Subtest bad-pitch-65536: SUCCESS (0.000s)
[80.193231] [069/171] (919s left) kms_addfb_basic (bad-pitch-999)
[80.258955] Starting subtest: bad-pitch-999
[80.259509] Subtest bad-pitch-999: SUCCESS (0.000s)
[80.364407] [070/171] (919s left) kms_addfb_basic (basic)
[80.432091] Starting subtest: basic
[80.432632] Subtest basic: SUCCESS (0.000s)
[80.547334] [071/171] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[80.613833] Starting subtest: basic-x-tiled-legacy
[80.614378] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[80.722669] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[80.789785] Starting subtest: basic-y-tiled-legacy
[80.790259] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[80.893972] [073/171] (918s left) kms_addfb_basic (bo-too-small)
[81.040425] Starting subtest: bo-too-small
[81.040909] Subtest bo-too-small: SUCCESS (0.000s)
[81.074515] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[81.214741] Starting subtest: bo-too-small-due-to-tiling
[81.215185] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[81.250695] [075/171] (918s left) kms_addfb_basic (clobberred-modifier)
[81.315726] Starting subtest: clobberred-modifier
[81.316242] Subtest clobberred-modifier: SUCCESS (0.000s)
[81.423510] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.490516] Starting subtest: framebuffer-vs-set-tiling
[81.490995] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[81.597339] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[81.665824] Starting subtest: invalid-get-prop
[81.666360] Subtest invalid-get-prop: SUCCESS (0.000s)
[81.770199] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any)
[81.853574] Starting subtest: invalid-get-prop-any
[81.856160] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[81.993121] [079/171] (917s left) kms_addfb_basic (invalid-set-prop)
[82.064377] Starting subtest: invalid-set-prop
[82.064953] Subtest invalid-set-prop: SUCCESS (0.000s)
[82.166787] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any)
[82.235993] Starting subtest: invalid-set-prop-any
[82.236475] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[82.342521] [081/171] (917s left) kms_addfb_basic (no-handle)
[82.407976] Starting subtest: no-handle
[82.408487] Subtest no-handle: SUCCESS (0.000s)
[82.516683] [082/171] (917s left) kms_addfb_basic (size-max)
[82.658651] Starting subtest: size-max
[82.659103] Subtest size-max: SUCCESS (0.000s)
[82.679446] [083/171] (917s left) kms_addfb_basic (small-bo)
[82.826522] Starting subtest: small-bo
[82.826918] Subtest small-bo: SUCCESS (0.000s)
[82.853484] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[82.920166] Starting subtest: tile-pitch-mismatch
[82.920682] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[83.020766] [085/171] (916s left) kms_addfb_basic (too-high)
[83.161695] Starting subtest: too-high
[83.162108] Subtest too-high: SUCCESS (0.000s)
[83.181766] [086/171] (916s left) kms_addfb_basic (too-wide)
[83.324277] Starting subtest: too-wide
[83.324718] Subtest too-wide: SUCCESS (0.000s)
[83.354317] [087/171] (916s left) kms_addfb_basic (unused-handle)
[83.419615] Starting subtest: unused-handle
[83.420069] Subtest unused-handle: SUCCESS (0.000s)
[83.521534] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[83.587060] Starting subtest: unused-modifier
[83.587531] Subtest unused-modifier: SUCCESS (0.000s)
[83.686741] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[83.754033] Starting subtest: unused-offsets
[83.754603] Subtest unused-offsets: SUCCESS (0.000s)
[83.863647] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[83.928915] Starting subtest: unused-pitches
[83.931405] Subtest unused-pitches: SUCCESS (0.000s)
[84.031166] [091/171] (915s left) kms_busy (basic)
[84.224103] Subtest basic: SKIP (0.000s)
[84.236819] [092/171] (915s left) kms_chamelium_hpd (dp-hpd-fast)
[84.380994] Subtest dp-hpd-fast: SKIP (0.000s)
[84.392746] [093/171] (915s left) kms_chamelium_edid (dp-edid-read)
[84.555281] Subtest dp-edid-read: SKIP (0.000s)
[84.566991] [094/171] (915s left) kms_chamelium_frames (dp-crc-fast)
[84.712789] Subtest dp-crc-fast: SKIP (0.000s)
[84.726594] [095/171] (915s left) kms_chamelium_hpd (hdmi-hpd-fast)
[84.885408] Subtest hdmi-hpd-fast: SKIP (0.000s)
[84.901865] [096/171] (915s left) kms_chamelium_edid (hdmi-edid-read)
[85.070786] Subtest hdmi-edid-read: SKIP (0.000s)
[85.088726] [097/171] (914s left) kms_chamelium_frames (hdmi-crc-fast)
[85.238901] Subtest hdmi-crc-fast: SKIP (0.000s)
[85.253795] [098/171] (914s left) kms_chamelium_hpd (vga-hpd-fast)
[85.399279] Subtest vga-hpd-fast: SKIP (0.000s)
[85.411210] [099/171] (914s left) kms_chamelium_edid (vga-edid-read)
[85.556292] Subtest vga-edid-read: SKIP (0.000s)
[85.569747] [100/171] (914s left) kms_prop_blob (basic)
[85.637034] Starting subtest: basic
[85.637604] Subtest basic: SUCCESS (0.000s)
[85.647614] [101/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[85.792587] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[85.802386] [102/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[85.947164] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[85.957816] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.102350] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[86.112689] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[86.255173] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[86.265895] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[86.412565] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[86.423090] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.566317] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.576937] [107/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.720380] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[86.731610] [108/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[86.879455] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[86.889116] [109/171] (913s left) kms_flip (basic-flip-vs-dpms)
[86.992392] Starting subtest: basic-flip-vs-dpms
[86.993526] Subtest basic-flip-vs-dpms: SKIP (0.001s)
[87.014906] [110/171] (913s left) kms_flip (basic-flip-vs-modeset)
[87.117102] Starting subtest: basic-flip-vs-modeset
[87.118688] Subtest basic-flip-vs-modeset: SKIP (0.001s)
[87.140152] [111/171] (913s left) kms_flip (basic-flip-vs-wf_vblank)
[87.242597] Starting subtest: basic-flip-vs-wf_vblank
[87.244413] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s)
[87.265104] [112/171] (912s left) kms_flip (basic-plain-flip)
[87.378527] Starting subtest: basic-plain-flip
[87.379566] Subtest basic-plain-flip: SKIP (0.001s)
[87.400997] [113/171] (912s left) kms_force_connector_basic (force-connector-state)
[87.553477] Starting subtest: force-connector-state
[87.844043] Subtest force-connector-state: SUCCESS (0.291s)
[88.078481] [114/171] (912s left) kms_force_connector_basic (force-edid)
[88.233546] Starting subtest: force-edid
[88.323529] Subtest force-edid: SUCCESS (0.089s)
[88.516213] [115/171] (911s left) kms_force_connector_basic (force-load-detect)
[88.673296] Starting subtest: force-load-detect
[88.674825] Subtest force-load-detect: SKIP (0.000s)
[88.827823] [116/171] (911s left) kms_force_connector_basic (prune-stale-modes)
[88.980258] Starting subtest: prune-stale-modes
[89.070618] Subtest prune-stale-modes: SUCCESS (0.090s)
[89.271441] [117/171] (911s left) kms_frontbuffer_tracking (basic)
[89.413933] Subtest basic: SKIP (0.000s)
[89.441694] [118/171] (910s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[89.583055] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[89.598544] [119/171] (910s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[89.741024] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[89.755614] [120/171] (910s left) kms_pipe_crc_basic (hang-read-crc)
[89.896081] Subtest hang-read-crc: SKIP (0.000s)
[89.912205] [121/171] (910s left) kms_pipe_crc_basic (nonblocking-crc)
[90.053741] Subtest nonblocking-crc: SKIP (0.000s)
[90.069521] [122/171] (910s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[90.211111] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[90.226575] [123/171] (910s left) kms_pipe_crc_basic (read-crc)
[90.369044] Subtest read-crc: SKIP (0.000s)
[90.385245] [124/171] (910s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[90.527152] Subtest read-crc-frame-sequence: SKIP (0.000s)
[90.544032] [125/171] (909s left) kms_psr (primary_page_flip)
[90.611311] Subtest primary_page_flip: SKIP (0.000s)
[90.628033] [126/171] (909s left) kms_psr (cursor_plane_move)
[90.694984] Subtest cursor_plane_move: SKIP (0.000s)
[90.710890] [127/171] (909s left) kms_psr (sprite_plane_onoff)
[90.778457] Subtest sprite_plane_onoff: SKIP (0.000s)
[90.794054] [128/171] (909s left) kms_psr (primary_mmap_gtt)
[90.867877] Subtest primary_mmap_gtt: SKIP (0.000s)
[90.892806] [129/171] (909s left) kms_setmode (basic-clone-single-crtc)
[90.968132] Starting subtest: basic-clone-single-crtc
[90.971443] Subtest basic-clone-single-crtc: SKIP (0.000s)
[90.998951] [130/171] (909s left) i915_pm_backlight (basic-brightness)
[91.140975] Subtest basic-brightness: SKIP (0.000s)
[91.155398] [131/171] (909s left) i915_pm_rpm (basic-pci-d3-state)
[103.127370] Subtest basic-pci-d3-state: SKIP (0.000s)
[103.365026] [132/171] (897s left) i915_pm_rpm (basic-rte)
[103.435029] Starting subtest: basic-rte
[115.404488] Subtest basic-rte: FAIL (11.941s)
[124.369613] [133/171] (876s left) i915_pm_rps (basic-api)
[124.462449] Starting subtest: basic-api
[124.470129] Subtest basic-api: SUCCESS (0.008s)
[124.497521] [134/171] (876s left) prime_self_import (basic-llseek-bad)
[124.569633] Starting subtest: basic-llseek-bad
[124.571601] Subtest basic-llseek-bad: SUCCESS (0.001s)
[124.600158] [135/171] (875s left) prime_self_import (basic-llseek-size)
[124.665896] Starting subtest: basic-llseek-size
[124.668284] Subtest basic-llseek-size: SUCCESS (0.002s)
[124.706319] [136/171] (875s left) prime_self_import (basic-with_fd_dup)
[124.773577] Starting subtest: basic-with_fd_dup
[124.775596] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[124.813133] [137/171] (875s left) prime_self_import (basic-with_one_bo)
[124.878633] Starting subtest: basic-with_one_bo
[124.881764] Subtest basic-with_one_bo: SUCCESS (0.003s)
[124.911047] [138/171] (875s left) prime_self_import (basic-with_one_bo_two_files)
[124.980784] Starting subtest: basic-with_one_bo_two_files
[124.986527] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[125.036090] [139/171] (875s left) prime_self_import (basic-with_two_bos)
[125.111367] Starting subtest: basic-with_two_bos
[125.116130] Subtest basic-with_two_bos: SUCCESS (0.005s)
[125.168135] [140/171] (875s left) prime_vgem (basic-fence-flip)
[125.245835] Starting subtest: basic-fence-flip
[125.307106] Subtest basic-fence-flip: SKIP (0.062s)
[125.330543] [141/171] (875s left) prime_vgem (basic-fence-mmap)
[125.405847] Starting subtest: basic-fence-mmap
[125.428828] Subtest basic-fence-mmap: SUCCESS (0.023s)
[125.466164] [142/171] (875s left) prime_vgem (basic-fence-read)
[125.539034] Starting subtest: basic-fence-read
[125.575408] Subtest basic-fence-read: SUCCESS (0.035s)
[125.617824] [143/171] (875s left) prime_vgem (basic-gtt)
[125.696239] Starting subtest: basic-gtt
[125.705784] Subtest basic-gtt: SUCCESS (0.009s)
[125.741645] [144/171] (874s left) prime_vgem (basic-read)
[125.814254] Starting subtest: basic-read
[125.830417] Subtest basic-read: SUCCESS (0.016s)
[125.869519] [145/171] (874s left) prime_vgem (basic-write)
[125.942101] Starting subtest: basic-write
[125.960776] Subtest basic-write: SUCCESS (0.018s)
[125.997591] [146/171] (874s left) vgem_basic (setversion)
[126.067279] Starting subtest: setversion
[126.068054] Subtest setversion: SUCCESS (0.000s)
[126.090403] [147/171] (874s left) vgem_basic (create)
[126.159134] Starting subtest: create
[126.159608] Subtest create: SUCCESS (0.000s)
[126.178617] [148/171] (874s left) vgem_basic (debugfs)
[126.247037] Starting subtest: debugfs
[126.247534] Subtest debugfs: SUCCESS (0.000s)
[126.269082] [149/171] (874s left) vgem_basic (dmabuf-export)
[126.337071] Starting subtest: dmabuf-export
[126.338950] Subtest dmabuf-export: SUCCESS (0.001s)
[126.383813] [150/171] (874s left) vgem_basic (dmabuf-fence)
[126.454819] Starting subtest: dmabuf-fence
[126.455273] Subtest dmabuf-fence: SUCCESS (0.000s)
[126.476459] [151/171] (874s left) vgem_basic (dmabuf-fence-before)
[126.547564] Starting subtest: dmabuf-fence-before
[126.547981] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[126.569617] [152/171] (874s left) vgem_basic (dmabuf-mmap)
[126.639162] Starting subtest: dmabuf-mmap
[126.650950] Subtest dmabuf-mmap: SUCCESS (0.012s)
[126.671431] [153/171] (874s left) vgem_basic (mmap)
[126.740996] Starting subtest: mmap
[126.749404] Subtest mmap: SUCCESS (0.008s)
[126.768659] [154/171] (874s left) vgem_basic (second-client)
[126.837440] Starting subtest: second-client
[126.842746] Subtest second-client: SUCCESS (0.005s)
[126.861974] [155/171] (873s left) vgem_basic (sysfs)
[126.931646] Starting subtest: sysfs
[126.932038] Subtest sysfs: SUCCESS (0.000s)
[126.951607] [156/171] (873s left) core_hotunplug (unbind-rebind)
[127.063456] Starting subtest: unbind-rebind
[127.740398] Subtest unbind-rebind: SUCCESS (0.677s)
[127.756767] [157/171] (873s left) vgem_basic (unload)
[127.847724] Starting subtest: unload
[156.692018] Subtest unload: SUCCESS (28.840s)
[156.717381] [158/171] (844s left) i915_module_load (reload)
[156.781797] Starting subtest: reload
[158.415249] Subtest reload: SUCCESS (1.633s)
[158.430285] [159/171] (842s left) gem_lmem_swapping (basic)
[158.524474] Subtest basic: SKIP (0.000s)
[158.540424] [160/171] (842s left) gem_lmem_swapping (parallel-random-engines)
[158.623700] Subtest parallel-random-engines: SKIP (0.000s)
[158.635787] [161/171] (842s left) gem_lmem_swapping (random-engines)
[158.706021] Subtest random-engines: SKIP (0.000s)
[158.718098] [162/171] (842s left) gem_lmem_swapping (verify-random)
[158.788365] Subtest verify-random: SKIP (0.000s)
[158.801782] [163/171] (842s left) i915_pm_rpm (module-reload)
[160.462497] Starting subtest: module-reload
[166.262357] Subtest module-reload: SUCCESS (5.799s)
[166.277324] [164/171] (834s left) i915_selftest (live)
[166.354952] Starting subtest: live
[166.355715] Starting dynamic subtest: sanitycheck
[166.926598] Dynamic subtest sanitycheck: SUCCESS (0.569s)
[166.932957] Starting dynamic subtest: uncore
[167.496416] Dynamic subtest uncore: SUCCESS (0.569s)
[167.501333] Starting dynamic subtest: workarounds
[168.235219] Dynamic subtest workarounds: SUCCESS (0.737s)
[168.241105] Starting dynamic subtest: gt_engines
[169.314350] Dynamic subtest gt_engines: SUCCESS (1.078s)
[169.319580] Starting dynamic subtest: gt_timelines
[176.889297] Dynamic subtest gt_timelines: SUCCESS (7.574s)
[176.893928] Starting dynamic subtest: gt_contexts
[177.550637] Dynamic subtest gt_contexts: SUCCESS (0.661s)
[177.555514] Starting dynamic subtest: gt_lrc
[180.510589] Dynamic subtest gt_lrc: SUCCESS (2.959s)
[180.515205] Starting dynamic subtest: gt_mocs
[181.168634] Dynamic subtest gt_mocs: SUCCESS (0.657s)
[181.174271] Starting dynamic subtest: gt_pm
[183.578626] Dynamic subtest gt_pm: SUCCESS (2.409s)
[183.584635] Starting dynamic subtest: gt_heartbeat
[184.242829] Dynamic subtest gt_heartbeat: SUCCESS (0.663s)
[184.247397] Starting dynamic subtest: gt_tlb
[185.705760] Dynamic subtest gt_tlb: SUCCESS (1.462s)
[185.710136] Starting dynamic subtest: requests
[192.626682] Dynamic subtest requests: SUCCESS (6.919s)
[192.631339] Starting dynamic subtest: migrate
[196.019780] Dynamic subtest migrate: SUCCESS (3.393s)
[196.024423] Starting dynamic subtest: active
[196.617927] Dynamic subtest active: SUCCESS (0.597s)
[196.622877] Starting dynamic subtest: objects
[197.994619] Dynamic subtest objects: SUCCESS (1.375s)
[197.999085] Starting dynamic subtest: mman
[202.099260] Dynamic subtest mman: SUCCESS (4.104s)
[202.104045] Starting dynamic subtest: dmabuf
[202.735313] Dynamic subtest dmabuf: SUCCESS (0.635s)
[202.739998] Starting dynamic subtest: vma
[203.309546] Dynamic subtest vma: SUCCESS (0.574s)
[203.314474] Starting dynamic subtest: coherency
[204.626616] Dynamic subtest coherency: SUCCESS (1.315s)
[204.631246] Starting dynamic subtest: gtt
[212.472928] Dynamic subtest gtt: SUCCESS (7.845s)
[212.478147] Starting dynamic subtest: gem
[213.279767] Dynamic subtest gem: SUCCESS (0.807s)
[213.284394] Starting dynamic subtest: evict
[214.993764] Dynamic subtest evict: SUCCESS (1.713s)
[214.998455] Starting dynamic subtest: hugepages
[222.110401] Dynamic subtest hugepages: SUCCESS (7.115s)
[222.115347] Starting dynamic subtest: gem_contexts
[235.130474] Dynamic subtest gem_contexts: SUCCESS (13.016s)
[235.136054] Starting dynamic subtest: client
[235.757672] Dynamic subtest client: SUCCESS (0.630s)
[235.762409] Starting dynamic subtest: gem_migrate
[236.311962] Dynamic subtest gem_migrate: SUCCESS (0.553s)
[236.317040] Starting dynamic subtest: reset
[237.479742] Dynamic subtest reset: SUCCESS (1.166s)
[237.484447] Starting dynamic subtest: memory_region
[238.047483] Dynamic subtest memory_region: SUCCESS (0.568s)
[238.052558] Starting dynamic subtest: hangcheck
[261.593320] Dynamic subtest hangcheck: SUCCESS (23.544s)
[261.597903] Starting dynamic subtest: execlists
[270.280578] Dynamic subtest execlists: SUCCESS (8.686s)
[270.285696] Starting dynamic subtest: ring_submission
[270.846302] Dynamic subtest ring_submission: SUCCESS (0.566s)
[270.850989] Starting dynamic subtest: perf
[271.482482] Dynamic subtest perf: SUCCESS (0.634s)
[271.487175] Starting dynamic subtest: slpc
[272.034778] Dynamic subtest slpc: SUCCESS (0.552s)
[272.039868] Starting dynamic subtest: guc
[272.603744] Dynamic subtest guc: SUCCESS (0.568s)
[272.608911] Starting dynamic subtest: guc_multi_lrc
[273.178374] Dynamic subtest guc_multi_lrc: SUCCESS (0.574s)
[273.183566] Starting dynamic subtest: guc_hang
[273.784609] Dynamic subtest guc_hang: SUCCESS (0.605s)
[273.789479] Starting dynamic subtest: late_gt_pm
[274.361633] Dynamic subtest late_gt_pm: SUCCESS (0.576s)
[274.362173] Subtest live: SUCCESS (108.005s)
[274.553980] [165/171] (726s left) dmabuf (all-tests)
[274.654212] Starting subtest: all-tests
[274.654712] Starting dynamic subtest: sanitycheck
[274.729667] Dynamic subtest sanitycheck: SUCCESS (0.072s)
[274.739887] Starting dynamic subtest: dma_fence
[274.904357] Dynamic subtest dma_fence: SUCCESS (0.170s)
[274.910776] Starting dynamic subtest: dma_fence_chain
[288.038996] Dynamic subtest dma_fence_chain: SUCCESS (13.132s)
[288.045133] Starting dynamic subtest: dma_fence_unwrap
[288.102256] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s)
[288.134505] Starting dynamic subtest: dma_resv
[288.185061] Dynamic subtest dma_resv: SUCCESS (0.081s)
[288.185867] Subtest all-tests: SUCCESS (13.531s)
[288.200527] [166/171] (712s left) i915_suspend (basic-s2idle-without-i915)
[288.270845] Starting subtest: basic-s2idle-without-i915
[306.022991] Subtest basic-s2idle-without-i915: SUCCESS (2.198s)
[313.066338] [167/171] (710s left) i915_suspend (basic-s3-without-i915)
[313.137103] Starting subtest: basic-s3-without-i915
[331.191458] Subtest basic-s3-without-i915: SUCCESS (2.344s)
[337.812484] [168/171] (708s left) gem_exec_suspend (basic-s0)
[337.897721] Starting subtest: basic-S0
[337.898267] Starting dynamic subtest: smem
[356.154548] Dynamic subtest smem: SUCCESS (1.971s)
[356.156328] Subtest basic-S0: SUCCESS (1.973s)
[360.930790] [169/171] (705s left) gem_exec_suspend (basic-s3)
[361.011413] Starting subtest: basic-S3
[361.011980] Starting dynamic subtest: smem
[379.312523] Dynamic subtest smem: SUCCESS (2.346s)
[379.315920] Subtest basic-S3: SUCCESS (2.348s)
[387.522432] [170/171] (703s left) kms_chamelium_hpd (common-hpd-after-suspend)
[387.706633] Subtest common-hpd-after-suspend: SKIP (0.000s)
[387.723161] [171/171] (703s left) kms_pipe_crc_basic (suspend-read-crc)
[387.864515] Subtest suspend-read-crc: SKIP (0.000s)
[387.877413] Closing watchdogs
Done.