[40.780368] Initializing watchdogs
[40.780490]   /dev/watchdog0
[40.786774] [001/170] (960s left) i915_module_load (load)
[40.852569] Starting subtest: load
[41.777393] Subtest load: SUCCESS (0.921s)
[41.796307] [002/170] (959s left) core_auth (basic-auth)
[41.911369] Starting subtest: basic-auth
[41.912334] Subtest basic-auth: SUCCESS (0.000s)
[41.969755] [003/170] (959s left) debugfs_test (read_all_entries)
[42.034431] Starting subtest: read_all_entries
[42.073669] Subtest read_all_entries: SUCCESS (0.039s)
[42.151371] [004/170] (959s left) debugfs_test (basic-hwmon)
[42.215983] Starting subtest: basic-hwmon
[42.218110] Subtest basic-hwmon: SKIP (0.000s)
[42.284949] [005/170] (959s left) fbdev (eof)
[42.357077] Starting subtest: eof
[42.358346] Subtest eof: SUCCESS (0.000s)
[42.402578] [006/170] (958s left) fbdev (info)
[42.462078] Starting subtest: info
[42.463148] Subtest info: SUCCESS (0.000s)
[42.519965] [007/170] (958s left) fbdev (nullptr)
[42.590089] Starting subtest: nullptr
[42.591270] Subtest nullptr: SUCCESS (0.000s)
[42.635590] [008/170] (958s left) fbdev (read)
[42.706906] Starting subtest: read
[42.787110] Subtest read: SUCCESS (0.080s)
[42.819875] [009/170] (958s left) fbdev (write)
[42.890008] Starting subtest: write
[42.930661] Subtest write: SUCCESS (0.041s)
[42.968942] [010/170] (958s left) gem_basic (bad-close)
[43.030063] Starting subtest: bad-close
[43.032267] Subtest bad-close: SUCCESS (0.000s)
[43.085869] [011/170] (958s left) gem_basic (create-close)
[43.147616] Starting subtest: create-close
[43.149823] Subtest create-close: SUCCESS (0.000s)
[43.218972] [012/170] (958s left) gem_basic (create-fd-close)
[43.282416] Starting subtest: create-fd-close
[43.284466] Subtest create-fd-close: SUCCESS (0.000s)
[43.352042] [013/170] (958s left) gem_busy (busy@all-engines)
[43.422642] Starting subtest: busy
[43.423813] Starting dynamic subtest: all-engines
[43.447935] Dynamic subtest all-engines: SUCCESS (0.025s)
[43.449033] Subtest busy: SUCCESS (0.025s)
[43.752700] [014/170] (957s left) gem_close_race (basic-process)
[43.824602] Starting subtest: basic-process
[43.859494] Subtest basic-process: SUCCESS (0.034s)
[44.018434] [015/170] (957s left) gem_close_race (basic-threads)
[44.088188] Starting subtest: basic-threads
[45.256883] Subtest basic-threads: SUCCESS (1.168s)
[45.418669] [016/170] (956s left) gem_ctx_create (basic)
[45.488210] Starting subtest: basic
[45.489336] Subtest basic: SUCCESS (0.000s)
[45.652593] [017/170] (955s left) gem_ctx_create (basic-files)
[45.720555] Starting subtest: basic-files
[47.737728] Subtest basic-files: SUCCESS (2.017s)
[47.971566] [018/170] (953s left) gem_ctx_exec (basic)
[48.035176] Starting subtest: basic
[48.036139] Subtest basic: SUCCESS (0.002s)
[48.120895] [019/170] (953s left) gem_exec_basic (basic)
[48.187286] Starting subtest: basic
[48.188374] Starting dynamic subtest: rcs0-smem
[48.189466] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[48.194554] Starting dynamic subtest: bcs0-smem
[48.195562] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[48.200750] Starting dynamic subtest: vcs0-smem
[48.201765] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[48.206877] Starting dynamic subtest: vecs0-smem
[48.207931] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[48.209050] Subtest basic: SUCCESS (0.001s)
[48.354640] [020/170] (953s left) gem_exec_create (basic)
[48.423254] Starting subtest: basic
[48.424284] Starting dynamic subtest: smem
[50.463591] Dynamic subtest smem: SUCCESS (2.039s)
[50.465093] Subtest basic: SUCCESS (2.040s)
[50.617373] [021/170] (950s left) gem_exec_fence (basic-busy)
[50.799967] Starting subtest: basic-busy
[50.801092] Starting dynamic subtest: rcs0
[50.832370] Dynamic subtest rcs0: SUCCESS (0.033s)
[50.839055] Starting dynamic subtest: bcs0
[50.860689] Dynamic subtest bcs0: SUCCESS (0.028s)
[50.867059] Starting dynamic subtest: vcs0
[50.894069] Dynamic subtest vcs0: SUCCESS (0.033s)
[50.899569] Starting dynamic subtest: vecs0
[50.916332] Dynamic subtest vecs0: SUCCESS (0.023s)
[50.917485] Subtest basic-busy: SUCCESS (0.117s)
[51.368969] [022/170] (950s left) gem_exec_fence (basic-wait)
[51.551640] Starting subtest: basic-wait
[51.552754] Starting dynamic subtest: rcs0
[51.580718] Dynamic subtest rcs0: SUCCESS (0.029s)
[51.587322] Starting dynamic subtest: bcs0
[51.605510] Dynamic subtest bcs0: SUCCESS (0.025s)
[51.612233] Starting dynamic subtest: vcs0
[51.626246] Dynamic subtest vcs0: SUCCESS (0.021s)
[51.633691] Starting dynamic subtest: vecs0
[51.643230] Dynamic subtest vecs0: SUCCESS (0.016s)
[51.644486] Subtest basic-wait: SUCCESS (0.091s)
[52.068792] [023/170] (949s left) gem_exec_fence (basic-await)
[52.249781] Starting subtest: basic-await
[52.250935] Starting dynamic subtest: rcs0
[52.320193] Dynamic subtest rcs0: SUCCESS (0.070s)
[52.325805] Starting dynamic subtest: bcs0
[52.391307] Dynamic subtest bcs0: SUCCESS (0.071s)
[52.396667] Starting dynamic subtest: vcs0
[52.462283] Dynamic subtest vcs0: SUCCESS (0.070s)
[52.468883] Starting dynamic subtest: vecs0
[52.535306] Dynamic subtest vecs0: SUCCESS (0.073s)
[52.536420] Subtest basic-await: SUCCESS (0.285s)
[52.966892] [024/170] (948s left) gem_exec_fence (nb-await)
[53.147867] Starting subtest: nb-await
[53.149031] Starting dynamic subtest: rcs0
[53.203483] Dynamic subtest rcs0: SUCCESS (0.055s)
[53.209373] Starting dynamic subtest: bcs0
[53.257762] Dynamic subtest bcs0: SUCCESS (0.054s)
[53.263489] Starting dynamic subtest: vcs0
[53.311035] Dynamic subtest vcs0: SUCCESS (0.053s)
[53.316641] Starting dynamic subtest: vecs0
[53.364457] Dynamic subtest vecs0: SUCCESS (0.053s)
[53.365928] Subtest nb-await: SUCCESS (0.217s)
[53.801051] [025/170] (947s left) gem_exec_gttfill (basic)
[53.870414] Starting subtest: basic
[56.878268] Subtest basic: SUCCESS (3.007s)
[57.035685] [026/170] (944s left) gem_exec_parallel (engines)
[57.166451] Starting subtest: engines
[57.167471] Starting dynamic subtest: basic
[58.575203] Dynamic subtest basic: SUCCESS (1.408s)
[58.582279] Starting dynamic subtest: contexts
[60.111895] Dynamic subtest contexts: SUCCESS (1.537s)
[60.118624] Starting dynamic subtest: fds
[61.852201] Dynamic subtest fds: SUCCESS (1.740s)
[61.858519] Starting dynamic subtest: userptr
[63.268792] Dynamic subtest userptr: SUCCESS (1.416s)
[63.269957] Subtest engines: SUCCESS (6.102s)
[63.434615] [027/170] (938s left) gem_exec_store (basic)
[63.505463] Starting subtest: basic
[63.541116] Subtest basic: SUCCESS (0.035s)
[63.700930] [028/170] (937s left) gem_flink_basic (bad-flink)
[63.763471] Starting subtest: bad-flink
[63.764576] Subtest bad-flink: SUCCESS (0.000s)
[63.815369] [029/170] (937s left) gem_flink_basic (bad-open)
[63.876816] Starting subtest: bad-open
[63.877905] Subtest bad-open: SUCCESS (0.000s)
[63.936414] [030/170] (937s left) gem_flink_basic (basic)
[63.998048] Starting subtest: basic
[63.999125] Subtest basic: SUCCESS (0.000s)
[64.065675] [031/170] (937s left) gem_flink_basic (double-flink)
[64.124378] Starting subtest: double-flink
[64.125490] Subtest double-flink: SUCCESS (0.000s)
[64.197720] [032/170] (937s left) gem_flink_basic (flink-lifetime)
[64.259285] Starting subtest: flink-lifetime
[64.260375] Subtest flink-lifetime: SUCCESS (0.001s)
[64.331782] [033/170] (937s left) gem_huc_copy (huc-copy)
[64.394560] Subtest huc-copy: SKIP (0.000s)
[64.409485] [034/170] (937s left) gem_linear_blits (basic)
[64.543269] Starting subtest: basic
[64.549411] Subtest basic: SUCCESS (0.006s)
[64.653236] [035/170] (937s left) gem_mmap (basic)
[64.790238] Starting subtest: basic
[64.795430] Subtest basic: SUCCESS (0.000s)
[64.865120] [036/170] (936s left) gem_mmap_gtt (basic)
[64.926294] Starting subtest: basic
[64.927395] Subtest basic: SUCCESS (0.000s)
[64.978100] [037/170] (936s left) gem_render_linear_blits (basic)
[65.041286] Starting subtest: basic
[65.057312] Subtest basic: SUCCESS (0.016s)
[65.095858] [038/170] (936s left) gem_render_tiled_blits (basic)
[65.160330] Starting subtest: basic
[65.178823] Subtest basic: SUCCESS (0.019s)
[65.211682] [039/170] (936s left) gem_ringfill (basic-all)
[65.393312] Starting subtest: basic-all
[66.500576] Subtest basic-all: SUCCESS (1.108s)
[66.582366] [040/170] (935s left) gem_softpin (allocator-basic)
[66.647473] Subtest allocator-basic: SKIP (0.000s)
[66.697836] [041/170] (935s left) gem_softpin (allocator-basic-reserve)
[66.763722] Subtest allocator-basic-reserve: SKIP (0.000s)
[66.816684] [042/170] (935s left) gem_softpin (safe-alignment)
[66.879941] Starting subtest: safe-alignment
[66.887220] Subtest safe-alignment: SUCCESS (0.008s)
[66.964312] [043/170] (934s left) gem_sync (basic-all)
[67.032847] Starting subtest: basic-all
[69.151419] Subtest basic-all: SUCCESS (2.118s)
[69.317806] [044/170] (932s left) gem_sync (basic-each)
[69.385315] Starting subtest: basic-each
[71.443594] Subtest basic-each: SUCCESS (2.057s)
[71.614248] [045/170] (930s left) gem_tiled_blits (basic)
[71.743398] Starting subtest: basic
[71.753388] Subtest basic: SUCCESS (0.010s)
[71.852997] [046/170] (930s left) gem_tiled_fence_blits (basic)
[72.047181] Starting subtest: basic
[72.052845] Subtest basic: SUCCESS (0.006s)
[72.154667] [047/170] (929s left) gem_tiled_pread_basic
[72.448678] [048/170] (929s left) gem_wait (busy@all-engines)
[72.520896] Starting subtest: busy
[72.522046] Starting dynamic subtest: all-engines
[73.036069] Dynamic subtest all-engines: SUCCESS (0.514s)
[73.037339] Subtest busy: SUCCESS (0.515s)
[73.215270] [049/170] (928s left) gem_wait (wait@all-engines)
[73.287818] Starting subtest: wait
[73.288910] Starting dynamic subtest: all-engines
[74.303906] Dynamic subtest all-engines: SUCCESS (1.016s)
[74.305175] Subtest wait: SUCCESS (1.016s)
[74.481362] [050/170] (927s left) i915_getparams_basic (basic-eu-total)
[74.544026] Starting subtest: basic-eu-total
[74.546225] Subtest basic-eu-total: SUCCESS (0.000s)
[74.595578] [051/170] (927s left) i915_getparams_basic (basic-subslice-total)
[74.656339] Starting subtest: basic-subslice-total
[74.658369] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.712680] [052/170] (927s left) i915_hangman (error-state-basic)
[74.780374] Starting subtest: error-state-basic
[74.785030] Subtest error-state-basic: SUCCESS (0.004s)
[74.846344] [053/170] (927s left) i915_pciid
[74.963849] [054/170] (927s left) kms_addfb_basic (addfb25-bad-modifier)
[75.026188] Starting subtest: addfb25-bad-modifier
[75.028808] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[75.128882] [055/170] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.190329] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.191364] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.278595] [056/170] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[75.338127] Starting subtest: addfb25-modifier-no-flag
[75.339235] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[75.428686] [057/170] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[75.492246] Starting subtest: addfb25-x-tiled-legacy
[75.493271] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[75.580110] [058/170] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[75.642723] Starting subtest: addfb25-x-tiled-mismatch-legacy
[75.643863] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[75.730875] [059/170] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[75.816977] Starting subtest: addfb25-yf-tiled-legacy
[75.817985] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[75.895426] [060/170] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[75.977493] Starting subtest: addfb25-y-tiled-legacy
[75.978518] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[76.046746] [061/170] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[76.133438] Starting subtest: addfb25-y-tiled-small-legacy
[76.135524] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[76.196173] [062/170] (925s left) kms_addfb_basic (bad-pitch-0)
[76.258503] Starting subtest: bad-pitch-0
[76.259689] Subtest bad-pitch-0: SUCCESS (0.000s)
[76.345694] [063/170] (925s left) kms_addfb_basic (bad-pitch-1024)
[76.407141] Starting subtest: bad-pitch-1024
[76.408165] Subtest bad-pitch-1024: SUCCESS (0.000s)
[76.496633] [064/170] (925s left) kms_addfb_basic (bad-pitch-128)
[76.556370] Starting subtest: bad-pitch-128
[76.557350] Subtest bad-pitch-128: SUCCESS (0.000s)
[76.645188] [065/170] (925s left) kms_addfb_basic (bad-pitch-256)
[76.707314] Starting subtest: bad-pitch-256
[76.708475] Subtest bad-pitch-256: SUCCESS (0.000s)
[76.811931] [066/170] (925s left) kms_addfb_basic (bad-pitch-32)
[76.872603] Starting subtest: bad-pitch-32
[76.873701] Subtest bad-pitch-32: SUCCESS (0.000s)
[76.961527] [067/170] (925s left) kms_addfb_basic (bad-pitch-63)
[77.021525] Starting subtest: bad-pitch-63
[77.022545] Subtest bad-pitch-63: SUCCESS (0.000s)
[77.111756] [068/170] (925s left) kms_addfb_basic (bad-pitch-65536)
[77.173043] Starting subtest: bad-pitch-65536
[77.174142] Subtest bad-pitch-65536: SUCCESS (0.000s)
[77.261243] [069/170] (925s left) kms_addfb_basic (bad-pitch-999)
[77.321844] Starting subtest: bad-pitch-999
[77.323040] Subtest bad-pitch-999: SUCCESS (0.000s)
[77.411625] [070/170] (924s left) kms_addfb_basic (basic)
[77.472032] Starting subtest: basic
[77.473121] Subtest basic: SUCCESS (0.000s)
[77.561936] [071/170] (924s left) kms_addfb_basic (basic-x-tiled-legacy)
[77.623250] Starting subtest: basic-x-tiled-legacy
[77.624251] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[77.711863] [072/170] (924s left) kms_addfb_basic (basic-y-tiled-legacy)
[77.774715] Starting subtest: basic-y-tiled-legacy
[77.775829] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[77.861650] [073/170] (924s left) kms_addfb_basic (bo-too-small)
[77.943992] Starting subtest: bo-too-small
[77.944995] Subtest bo-too-small: SUCCESS (0.000s)
[78.011784] [074/170] (924s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[78.095226] Starting subtest: bo-too-small-due-to-tiling
[78.096212] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[78.161555] [075/170] (924s left) kms_addfb_basic (clobberred-modifier)
[78.221857] Starting subtest: clobberred-modifier
[78.222825] Subtest clobberred-modifier: SUCCESS (0.000s)
[78.311562] [076/170] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[78.372743] Starting subtest: framebuffer-vs-set-tiling
[78.373797] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[78.463344] [077/170] (923s left) kms_addfb_basic (invalid-get-prop)
[78.525394] Starting subtest: invalid-get-prop
[78.526466] Subtest invalid-get-prop: SUCCESS (0.000s)
[78.611223] [078/170] (923s left) kms_addfb_basic (invalid-get-prop-any)
[78.672239] Starting subtest: invalid-get-prop-any
[78.673275] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.761100] [079/170] (923s left) kms_addfb_basic (invalid-set-prop)
[78.822416] Starting subtest: invalid-set-prop
[78.823523] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.911427] [080/170] (923s left) kms_addfb_basic (invalid-set-prop-any)
[78.971488] Starting subtest: invalid-set-prop-any
[78.972585] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[79.063517] [081/170] (923s left) kms_addfb_basic (no-handle)
[79.124531] Starting subtest: no-handle
[79.125584] Subtest no-handle: SUCCESS (0.000s)
[79.210666] [082/170] (923s left) kms_addfb_basic (size-max)
[79.295221] Starting subtest: size-max
[79.296326] Subtest size-max: SUCCESS (0.000s)
[79.361306] [083/170] (923s left) kms_addfb_basic (small-bo)
[79.443770] Starting subtest: small-bo
[79.444816] Subtest small-bo: SUCCESS (0.000s)
[79.510773] [084/170] (922s left) kms_addfb_basic (tile-pitch-mismatch)
[79.572308] Starting subtest: tile-pitch-mismatch
[79.573299] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[79.663938] [085/170] (922s left) kms_addfb_basic (too-high)
[79.744890] Starting subtest: too-high
[79.745993] Subtest too-high: SUCCESS (0.001s)
[79.811146] [086/170] (922s left) kms_addfb_basic (too-wide)
[79.895377] Starting subtest: too-wide
[79.896388] Subtest too-wide: SUCCESS (0.000s)
[79.960515] [087/170] (922s left) kms_addfb_basic (unused-handle)
[80.023671] Starting subtest: unused-handle
[80.024769] Subtest unused-handle: SUCCESS (0.000s)
[80.111636] [088/170] (922s left) kms_addfb_basic (unused-modifier)
[80.173773] Starting subtest: unused-modifier
[80.174884] Subtest unused-modifier: SUCCESS (0.000s)
[80.277640] [089/170] (922s left) kms_addfb_basic (unused-offsets)
[80.337634] Starting subtest: unused-offsets
[80.338741] Subtest unused-offsets: SUCCESS (0.000s)
[80.427616] [090/170] (922s left) kms_addfb_basic (unused-pitches)
[80.488281] Starting subtest: unused-pitches
[80.489287] Subtest unused-pitches: SUCCESS (0.000s)
[80.580494] [091/170] (922s left) kms_busy (basic)
[80.668687] Starting subtest: basic
[80.669788] Starting dynamic subtest: flip
[81.103383] Dynamic subtest flip: SUCCESS (0.434s)
[81.110052] Starting dynamic subtest: modeset
[81.611805] Dynamic subtest modeset: SUCCESS (0.508s)
[81.612895] Subtest basic: SUCCESS (0.943s)
[81.754617] [092/170] (920s left) kms_chamelium_hpd (dp-hpd-fast)
[81.877011] Subtest dp-hpd-fast: SKIP (0.000s)
[81.957810] [093/170] (920s left) kms_chamelium_edid (dp-edid-read)
[82.088258] Subtest dp-edid-read: SKIP (0.000s)
[82.170179] [094/170] (920s left) kms_chamelium_frames (dp-crc-fast)
[82.301307] Subtest dp-crc-fast: SKIP (0.000s)
[82.384248] [095/170] (920s left) kms_chamelium_hpd (hdmi-hpd-fast)
[82.516037] Subtest hdmi-hpd-fast: SKIP (0.000s)
[82.598282] [096/170] (920s left) kms_chamelium_edid (hdmi-edid-read)
[82.728959] Subtest hdmi-edid-read: SKIP (0.000s)
[82.810258] [097/170] (919s left) kms_chamelium_frames (hdmi-crc-fast)
[82.924210] Subtest hdmi-crc-fast: SKIP (0.000s)
[83.004939] [098/170] (919s left) kms_chamelium_hpd (vga-hpd-fast)
[83.135489] Subtest vga-hpd-fast: SKIP (0.000s)
[83.216340] [099/170] (919s left) kms_chamelium_edid (vga-edid-read)
[83.347074] Subtest vga-edid-read: SKIP (0.000s)
[83.431095] [100/170] (919s left) kms_prop_blob (basic)
[83.498061] Starting subtest: basic
[83.499157] Subtest basic: SUCCESS (0.000s)
[83.550481] [101/170] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[83.639033] Starting subtest: basic-busy-flip-before-cursor-atomic
[84.574143] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.935s)
[84.703349] [102/170] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[84.786578] Starting subtest: basic-busy-flip-before-cursor-legacy
[85.709733] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.923s)
[85.839599] [103/170] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[85.927895] Starting subtest: basic-flip-after-cursor-atomic
[86.863430] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.936s)
[86.991478] [104/170] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[87.073621] Starting subtest: basic-flip-after-cursor-legacy
[87.999050] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s)
[88.127803] [105/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[88.213150] Starting subtest: basic-flip-after-cursor-varying-size
[89.151657] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.939s)
[89.292837] [106/170] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[89.376735] Starting subtest: basic-flip-before-cursor-atomic
[90.297477] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.920s)
[90.423944] [107/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[90.513064] Starting subtest: basic-flip-before-cursor-legacy
[91.447775] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.935s)
[91.578140] [108/170] (911s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[91.665945] Starting subtest: basic-flip-before-cursor-varying-size
[92.615940] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.950s)
[92.739886] [109/170] (910s left) kms_flip (basic-flip-vs-dpms)
[92.813438] Starting subtest: basic-flip-vs-dpms
[92.814504] Starting dynamic subtest: A-VGA1
[93.734751] Dynamic subtest A-VGA1: SUCCESS (0.921s)
[93.741212] Starting dynamic subtest: B-VGA1
[94.616157] Dynamic subtest B-VGA1: SUCCESS (0.881s)
[94.623906] Starting dynamic subtest: C-VGA1
[95.506875] Dynamic subtest C-VGA1: SUCCESS (0.889s)
[95.507852] Subtest basic-flip-vs-dpms: SUCCESS (2.696s)
[95.646827] [110/170] (907s left) kms_flip (basic-flip-vs-modeset)
[95.722848] Starting subtest: basic-flip-vs-modeset
[95.724903] Starting dynamic subtest: A-VGA1
[96.688752] Dynamic subtest A-VGA1: SUCCESS (0.964s)
[96.696257] Starting dynamic subtest: B-VGA1
[97.471516] Dynamic subtest B-VGA1: SUCCESS (0.783s)
[97.478138] Starting dynamic subtest: C-VGA1
[98.258255] Dynamic subtest C-VGA1: SUCCESS (0.786s)
[98.260403] Subtest basic-flip-vs-modeset: SUCCESS (2.537s)
[98.393989] [111/170] (904s left) kms_flip (basic-flip-vs-wf_vblank)
[98.471661] Starting subtest: basic-flip-vs-wf_vblank
[98.474145] Starting dynamic subtest: A-VGA1
[99.619298] Dynamic subtest A-VGA1: SUCCESS (1.144s)
[99.626213] Starting dynamic subtest: B-VGA1
[100.740712] Dynamic subtest B-VGA1: SUCCESS (1.121s)
[100.748201] Starting dynamic subtest: C-VGA1
[101.864317] Dynamic subtest C-VGA1: SUCCESS (1.123s)
[101.865876] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.395s)
[102.034146] [112/170] (900s left) kms_flip (basic-plain-flip)
[102.106824] Starting subtest: basic-plain-flip
[102.108981] Starting dynamic subtest: A-VGA1
[102.957664] Dynamic subtest A-VGA1: SUCCESS (0.849s)
[102.964376] Starting dynamic subtest: B-VGA1
[103.795412] Dynamic subtest B-VGA1: SUCCESS (0.837s)
[103.801660] Starting dynamic subtest: C-VGA1
[104.632288] Dynamic subtest C-VGA1: SUCCESS (0.836s)
[104.633718] Subtest basic-plain-flip: SUCCESS (2.528s)
[104.784853] [113/170] (898s left) kms_force_connector_basic (force-connector-state)
[104.859415] Starting subtest: force-connector-state
[104.996735] Subtest force-connector-state: SUCCESS (0.138s)
[105.173990] [114/170] (897s left) kms_force_connector_basic (force-edid)
[105.246564] Starting subtest: force-edid
[105.264025] Subtest force-edid: SUCCESS (0.017s)
[105.357576] [115/170] (897s left) kms_force_connector_basic (force-load-detect)
[105.431328] Starting subtest: force-load-detect
[105.577520] Subtest force-load-detect: SUCCESS (0.147s)
[105.763475] [116/170] (897s left) kms_force_connector_basic (prune-stale-modes)
[105.834652] Starting subtest: prune-stale-modes
[105.851444] Subtest prune-stale-modes: SUCCESS (0.017s)
[105.946606] [117/170] (897s left) kms_frontbuffer_tracking (basic)
[106.039422] Starting subtest: basic
[107.866293] Subtest basic: SUCCESS (1.830s)
[107.933086] [118/170] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[108.019333] Starting subtest: compare-crc-sanitycheck
[108.020483] Starting dynamic subtest: pipe-A-VGA-1
[108.286885] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.267s)
[108.293485] Starting dynamic subtest: pipe-B-VGA-1
[108.548113] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.260s)
[108.555780] Starting dynamic subtest: pipe-C-VGA-1
[108.825986] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.275s)
[108.827012] Subtest compare-crc-sanitycheck: SUCCESS (0.806s)
[108.967034] [119/170] (894s left) kms_pipe_crc_basic (hang-read-crc)
[109.051367] Starting subtest: hang-read-crc
[109.052500] Starting dynamic subtest: pipe-A-VGA-1
[109.780192] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.727s)
[109.786904] Starting dynamic subtest: pipe-B-VGA-1
[110.505121] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.724s)
[110.511808] Starting dynamic subtest: pipe-C-VGA-1
[111.244727] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.739s)
[111.245872] Subtest hang-read-crc: SUCCESS (2.194s)
[111.359093] [120/170] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[111.443729] Starting subtest: nonblocking-crc
[111.444758] Starting dynamic subtest: pipe-A-VGA-1
[111.882970] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.438s)
[111.889697] Starting dynamic subtest: pipe-B-VGA-1
[112.310446] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s)
[112.317267] Starting dynamic subtest: pipe-C-VGA-1
[112.744745] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.434s)
[112.745809] Subtest nonblocking-crc: SUCCESS (1.301s)
[112.860488] [121/170] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[112.946226] Starting subtest: nonblocking-crc-frame-sequence
[112.947318] Starting dynamic subtest: pipe-A-VGA-1
[113.385808] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.438s)
[113.394580] Starting dynamic subtest: pipe-B-VGA-1
[113.816187] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.430s)
[113.822742] Starting dynamic subtest: pipe-C-VGA-1
[114.254989] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s)
[114.256156] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.309s)
[114.368659] [122/170] (888s left) kms_pipe_crc_basic (read-crc)
[114.452297] Starting subtest: read-crc
[114.453368] Starting dynamic subtest: pipe-A-VGA-1
[114.826998] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.374s)
[114.833471] Starting dynamic subtest: pipe-B-VGA-1
[115.187979] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s)
[115.196382] Starting dynamic subtest: pipe-C-VGA-1
[115.556405] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.369s)
[115.557462] Subtest read-crc: SUCCESS (1.105s)
[115.673270] [123/170] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[115.757924] Starting subtest: read-crc-frame-sequence
[115.758939] Starting dynamic subtest: pipe-A-VGA-1
[116.131372] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s)
[116.139693] Starting dynamic subtest: pipe-B-VGA-1
[116.495451] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.363s)
[116.502223] Starting dynamic subtest: pipe-C-VGA-1
[116.867962] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s)
[116.869101] Subtest read-crc-frame-sequence: SUCCESS (1.110s)
[116.984303] [124/170] (886s left) kms_psr (primary_page_flip)
[117.047150] Subtest primary_page_flip: SKIP (0.000s)
[117.063431] [125/170] (886s left) kms_psr (cursor_plane_move)
[117.127878] Subtest cursor_plane_move: SKIP (0.000s)
[117.146587] [126/170] (885s left) kms_psr (sprite_plane_onoff)
[117.208751] Subtest sprite_plane_onoff: SKIP (0.000s)
[117.229985] [127/170] (885s left) kms_psr (primary_mmap_gtt)
[117.292328] Subtest primary_mmap_gtt: SKIP (0.000s)
[117.312912] [128/170] (885s left) kms_setmode (basic-clone-single-crtc)
[117.375181] Starting subtest: basic-clone-single-crtc
[117.378188] Subtest basic-clone-single-crtc: SKIP (0.000s)
[117.434788] [129/170] (885s left) i915_pm_backlight (basic-brightness)
[117.518662] Subtest basic-brightness: SKIP (0.000s)
[117.545683] [130/170] (885s left) i915_pm_rpm (basic-pci-d3-state)
[118.910509] Starting subtest: basic-pci-d3-state
[119.113943] Subtest basic-pci-d3-state: SUCCESS (0.201s)
[119.361197] [131/170] (883s left) i915_pm_rpm (basic-rte)
[119.423220] Starting subtest: basic-rte
[120.944827] Subtest basic-rte: SUCCESS (1.519s)
[121.384690] [132/170] (881s left) i915_pm_rps (basic-api)
[121.451529] Starting subtest: basic-api
[121.453809] Subtest basic-api: SUCCESS (0.002s)
[121.549470] [133/170] (881s left) prime_self_import (basic-llseek-bad)
[121.611231] Starting subtest: basic-llseek-bad
[121.613648] Subtest basic-llseek-bad: SUCCESS (0.001s)
[121.684224] [134/170] (881s left) prime_self_import (basic-llseek-size)
[121.743617] Starting subtest: basic-llseek-size
[121.746075] Subtest basic-llseek-size: SUCCESS (0.002s)
[121.819018] [135/170] (881s left) prime_self_import (basic-with_fd_dup)
[121.879329] Starting subtest: basic-with_fd_dup
[121.881777] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[121.950879] [136/170] (881s left) prime_self_import (basic-with_one_bo)
[122.014144] Starting subtest: basic-with_one_bo
[122.016463] Subtest basic-with_one_bo: SUCCESS (0.004s)
[122.063598] [137/170] (881s left) prime_self_import (basic-with_one_bo_two_files)
[122.123820] Starting subtest: basic-with_one_bo_two_files
[122.126242] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[122.185070] [138/170] (881s left) prime_self_import (basic-with_two_bos)
[122.245889] Starting subtest: basic-with_two_bos
[122.248572] Subtest basic-with_two_bos: SUCCESS (0.002s)
[122.317569] [139/170] (881s left) prime_vgem (basic-fence-flip)
[122.391054] Starting subtest: basic-fence-flip
[122.719778] Subtest basic-fence-flip: SUCCESS (0.329s)
[122.802224] [140/170] (880s left) prime_vgem (basic-fence-mmap)
[122.874926] Starting subtest: basic-fence-mmap
[122.896668] Subtest basic-fence-mmap: SUCCESS (0.022s)
[122.969260] [141/170] (880s left) prime_vgem (basic-fence-read)
[123.040036] Starting subtest: basic-fence-read
[123.072661] Subtest basic-fence-read: SUCCESS (0.033s)
[123.151213] [142/170] (880s left) prime_vgem (basic-gtt)
[123.222930] Starting subtest: basic-gtt
[123.234221] Subtest basic-gtt: SUCCESS (0.011s)
[123.317498] [143/170] (880s left) prime_vgem (basic-read)
[123.389686] Starting subtest: basic-read
[123.405587] Subtest basic-read: SUCCESS (0.016s)
[123.486261] [144/170] (879s left) prime_vgem (basic-write)
[123.556805] Starting subtest: basic-write
[123.574497] Subtest basic-write: SUCCESS (0.018s)
[123.651254] [145/170] (879s left) vgem_basic (setversion)
[123.720125] Starting subtest: setversion
[123.722296] Subtest setversion: SUCCESS (0.000s)
[123.769203] [146/170] (879s left) vgem_basic (create)
[123.836698] Starting subtest: create
[123.837835] Subtest create: SUCCESS (0.000s)
[123.884556] [147/170] (879s left) vgem_basic (debugfs)
[123.953584] Starting subtest: debugfs
[123.954656] Subtest debugfs: SUCCESS (0.000s)
[124.003124] [148/170] (879s left) vgem_basic (dmabuf-export)
[124.069938] Starting subtest: dmabuf-export
[124.072798] Subtest dmabuf-export: SUCCESS (0.001s)
[124.150806] [149/170] (879s left) vgem_basic (dmabuf-fence)
[124.221201] Starting subtest: dmabuf-fence
[124.222247] Subtest dmabuf-fence: SUCCESS (0.001s)
[124.268382] [150/170] (879s left) vgem_basic (dmabuf-fence-before)
[124.336595] Starting subtest: dmabuf-fence-before
[124.337797] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[124.386098] [151/170] (879s left) vgem_basic (dmabuf-mmap)
[124.453416] Starting subtest: dmabuf-mmap
[124.469042] Subtest dmabuf-mmap: SUCCESS (0.016s)
[124.519930] [152/170] (879s left) vgem_basic (mmap)
[124.586290] Starting subtest: mmap
[124.596184] Subtest mmap: SUCCESS (0.010s)
[124.634916] [153/170] (878s left) vgem_basic (second-client)
[124.703163] Starting subtest: second-client
[124.752818] Subtest second-client: SUCCESS (0.050s)
[124.802365] [154/170] (878s left) vgem_basic (sysfs)
[124.870162] Starting subtest: sysfs
[124.871234] Subtest sysfs: SUCCESS (0.001s)
[124.918440] [155/170] (878s left) core_hotunplug (unbind-rebind)
[125.021173] Starting subtest: unbind-rebind
[125.874846] Subtest unbind-rebind: SUCCESS (0.854s)
[125.896101] [156/170] (877s left) vgem_basic (unload)
[125.966553] Starting subtest: unload
[154.871885] Subtest unload: SUCCESS (28.904s)
[154.952354] [157/170] (848s left) i915_module_load (reload)
[155.013127] Starting subtest: reload
[156.977484] Subtest reload: SUCCESS (1.964s)
[156.998218] [158/170] (846s left) gem_lmem_swapping (basic)
[157.071653] Subtest basic: SKIP (0.000s)
[157.101973] [159/170] (846s left) gem_lmem_swapping (parallel-random-engines)
[157.167327] Subtest parallel-random-engines: SKIP (0.000s)
[157.185697] [160/170] (846s left) gem_lmem_swapping (random-engines)
[157.249561] Subtest random-engines: SKIP (0.000s)
[157.270140] [161/170] (846s left) gem_lmem_swapping (verify-random)
[157.335556] Subtest verify-random: SKIP (0.000s)
[157.354096] [162/170] (846s left) i915_pm_rpm (module-reload)
[159.097790] Starting subtest: module-reload
[166.040068] Subtest module-reload: SUCCESS (6.941s)
[166.053776] [163/170] (837s left) i915_selftest (live)
[166.125139] Starting subtest: live
[166.126226] Starting dynamic subtest: sanitycheck
[166.785604] Dynamic subtest sanitycheck: SUCCESS (0.659s)
[166.792197] Starting dynamic subtest: uncore
[167.428111] Dynamic subtest uncore: SUCCESS (0.641s)
[167.434358] Starting dynamic subtest: workarounds
[168.046872] Dynamic subtest workarounds: SUCCESS (0.618s)
[168.052357] Starting dynamic subtest: gt_engines
[168.591478] Dynamic subtest gt_engines: SUCCESS (0.544s)
[168.597029] Starting dynamic subtest: gt_timelines
[174.124765] Dynamic subtest gt_timelines: SUCCESS (5.532s)
[174.131897] Starting dynamic subtest: gt_contexts
[174.817703] Dynamic subtest gt_contexts: SUCCESS (0.691s)
[174.823861] Starting dynamic subtest: gt_lrc
[175.444396] Dynamic subtest gt_lrc: SUCCESS (0.625s)
[175.450066] Starting dynamic subtest: gt_mocs
[176.012040] Dynamic subtest gt_mocs: SUCCESS (0.567s)
[176.019422] Starting dynamic subtest: gt_pm
[186.429646] Dynamic subtest gt_pm: SUCCESS (10.417s)
[186.434972] Starting dynamic subtest: gt_heartbeat
[187.214607] Dynamic subtest gt_heartbeat: SUCCESS (0.783s)
[187.220291] Starting dynamic subtest: gt_tlb
[187.719187] Dynamic subtest gt_tlb: SUCCESS (0.504s)
[187.725838] Starting dynamic subtest: requests
[193.923328] Dynamic subtest requests: SUCCESS (6.203s)
[193.930139] Starting dynamic subtest: migrate
[194.469759] Dynamic subtest migrate: SUCCESS (0.545s)
[194.475818] Starting dynamic subtest: active
[195.107598] Dynamic subtest active: SUCCESS (0.636s)
[195.113636] Starting dynamic subtest: objects
[196.048612] Dynamic subtest objects: SUCCESS (0.939s)
[196.055777] Starting dynamic subtest: mman
[200.092026] Dynamic subtest mman: SUCCESS (4.042s)
[200.098450] Starting dynamic subtest: dmabuf
[200.730707] Dynamic subtest dmabuf: SUCCESS (0.637s)
[200.737236] Starting dynamic subtest: vma
[201.439658] Dynamic subtest vma: SUCCESS (0.707s)
[201.446367] Starting dynamic subtest: coherency
[202.999984] Dynamic subtest coherency: SUCCESS (1.560s)
[203.005553] Starting dynamic subtest: gtt
[206.836057] Dynamic subtest gtt: SUCCESS (3.835s)
[206.842605] Starting dynamic subtest: gem
[207.624029] Dynamic subtest gem: SUCCESS (0.786s)
[207.630733] Starting dynamic subtest: evict
[208.220859] Dynamic subtest evict: SUCCESS (0.596s)
[208.226470] Starting dynamic subtest: hugepages
[209.456671] Dynamic subtest hugepages: SUCCESS (1.235s)
[209.462820] Starting dynamic subtest: gem_contexts
[214.257874] Dynamic subtest gem_contexts: SUCCESS (4.800s)
[214.263377] Starting dynamic subtest: client
[214.970669] Dynamic subtest client: SUCCESS (0.711s)
[214.976680] Starting dynamic subtest: gem_migrate
[215.598932] Dynamic subtest gem_migrate: SUCCESS (0.628s)
[215.604559] Starting dynamic subtest: reset
[217.299845] Dynamic subtest reset: SUCCESS (1.700s)
[217.307196] Starting dynamic subtest: memory_region
[217.957732] Dynamic subtest memory_region: SUCCESS (0.657s)
[217.963377] Starting dynamic subtest: hangcheck
[235.386579] Dynamic subtest hangcheck: SUCCESS (17.427s)
[235.392207] Starting dynamic subtest: execlists
[236.090620] Dynamic subtest execlists: SUCCESS (0.703s)
[236.096205] Starting dynamic subtest: ring_submission
[236.750341] Dynamic subtest ring_submission: SUCCESS (0.658s)
[236.755698] Starting dynamic subtest: perf
[237.564302] Dynamic subtest perf: SUCCESS (0.812s)
[237.570294] Starting dynamic subtest: slpc
[238.089456] Dynamic subtest slpc: SUCCESS (0.524s)
[238.095865] Starting dynamic subtest: guc
[238.607058] Dynamic subtest guc: SUCCESS (0.518s)
[238.613423] Starting dynamic subtest: guc_multi_lrc
[239.192611] Dynamic subtest guc_multi_lrc: SUCCESS (0.585s)
[239.198233] Starting dynamic subtest: guc_hang
[239.824446] Dynamic subtest guc_hang: SUCCESS (0.630s)
[239.830096] Starting dynamic subtest: late_gt_pm
[240.500400] Dynamic subtest late_gt_pm: SUCCESS (0.675s)
[240.501659] Subtest live: SUCCESS (74.374s)
[240.658711] [164/170] (763s left) dmabuf (all-tests)
[240.725158] Starting subtest: all-tests
[240.728701] Starting dynamic subtest: sanitycheck
[240.789360] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[240.795727] Starting dynamic subtest: dma_fence
[240.967128] Dynamic subtest dma_fence: SUCCESS (0.177s)
[240.974884] Starting dynamic subtest: dma_fence_chain
[252.464523] Dynamic subtest dma_fence_chain: SUCCESS (11.497s)
[252.470186] Starting dynamic subtest: dma_fence_unwrap
[252.531378] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[252.538223] Starting dynamic subtest: dma_resv
[252.596219] Dynamic subtest dma_resv: SUCCESS (0.065s)
[252.597369] Subtest all-tests: SUCCESS (11.871s)
[252.610147] [165/170] (751s left) i915_suspend (basic-s2idle-without-i915)
[252.669900] Starting subtest: basic-s2idle-without-i915
[270.788629] Subtest basic-s2idle-without-i915: SUCCESS (2.063s)
[276.670986] [166/170] (748s left) i915_suspend (basic-s3-without-i915)
[276.734007] Starting subtest: basic-s3-without-i915
[294.828724] Subtest basic-s3-without-i915: SUCCESS (1.870s)
[301.008150] [167/170] (746s left) gem_exec_suspend (basic-s0)
[301.088456] Starting subtest: basic-S0
[301.089566] Starting dynamic subtest: smem
[317.681677] Dynamic subtest smem: SUCCESS (1.257s)
[317.682714] Subtest basic-S0: SUCCESS (1.257s)
[330.827283] [168/170] (745s left) gem_exec_suspend (basic-s3)
[330.902714] Starting subtest: basic-S3
[330.903815] Starting dynamic subtest: smem
[348.687820] Dynamic subtest smem: SUCCESS (1.271s)
[348.688886] Subtest basic-S3: SUCCESS (1.272s)
[354.819382] [169/170] (743s left) kms_chamelium_hpd (common-hpd-after-suspend)
[354.952445] Subtest common-hpd-after-suspend: SKIP (0.000s)
[355.035304] [170/170] (743s left) kms_pipe_crc_basic (suspend-read-crc)
[355.122090] Starting subtest: suspend-read-crc
[355.124450] Starting dynamic subtest: pipe-A-VGA-1
[372.850141] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.450s)
[372.858355] Starting dynamic subtest: pipe-B-VGA-1
[390.870040] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.449s)
[390.878110] Starting dynamic subtest: pipe-C-VGA-1
[408.872931] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.478s)
[408.874026] Subtest suspend-read-crc: SUCCESS (4.382s)
[412.960505] Closing watchdogs
Done.