[34.687974] Initializing watchdogs
[34.688048]   /dev/watchdog0
[34.692547] [001/165] (960s left) i915_module_load (load)
[34.724037] Starting subtest: load
[35.255240] Subtest load: SUCCESS (0.531s)
[35.263346] [002/165] (959s left) core_auth (basic-auth)
[35.325731] Starting subtest: basic-auth
[35.327307] Subtest basic-auth: SUCCESS (0.001s)
[35.385611] [003/165] (959s left) debugfs_test (read_all_entries)
[35.416651] Starting subtest: read_all_entries
[35.562329] Subtest read_all_entries: SUCCESS (0.145s)
[35.624879] [004/165] (959s left) debugfs_test (basic-hwmon)
[35.658376] Starting subtest: basic-hwmon
[35.660581] Subtest basic-hwmon: SKIP (0.000s)
[35.725285] [005/165] (959s left) fbdev (eof)
[35.763158] Starting subtest: eof
[35.764846] Subtest eof: SUCCESS (0.001s)
[35.807856] [006/165] (959s left) fbdev (info)
[35.835191] Starting subtest: info
[35.836802] Subtest info: SUCCESS (0.000s)
[35.892310] [007/165] (959s left) fbdev (nullptr)
[35.927777] Starting subtest: nullptr
[35.929148] Subtest nullptr: SUCCESS (0.000s)
[35.974902] [008/165] (959s left) fbdev (read)
[36.012380] Starting subtest: read
[36.818799] Subtest read: SUCCESS (0.804s)
[36.858783] [009/165] (958s left) fbdev (write)
[36.895681] Starting subtest: write
[37.436911] Subtest write: SUCCESS (0.540s)
[37.492184] [010/165] (957s left) gem_basic (bad-close)
[37.523417] Starting subtest: bad-close
[37.525722] Subtest bad-close: SUCCESS (0.000s)
[37.575015] [011/165] (957s left) gem_basic (create-close)
[37.602886] Starting subtest: create-close
[37.605932] Subtest create-close: SUCCESS (0.000s)
[37.675656] [012/165] (957s left) gem_basic (create-fd-close)
[37.705212] Starting subtest: create-fd-close
[37.707228] Subtest create-fd-close: SUCCESS (0.000s)
[37.775347] [013/165] (957s left) gem_busy (busy@all-engines)
[37.811319] Starting subtest: busy
[37.812300] Starting dynamic subtest: all-engines
[37.829920] Dynamic subtest all-engines: SUCCESS (0.019s)
[37.830720] Subtest busy: SUCCESS (0.019s)
[38.156183] [014/165] (957s left) gem_close_race (basic-process)
[38.190100] Starting subtest: basic-process
[38.222379] Subtest basic-process: SUCCESS (0.032s)
[38.400703] [015/165] (956s left) gem_close_race (basic-threads)
[38.435898] Starting subtest: basic-threads
[39.641762] Subtest basic-threads: SUCCESS (1.205s)
[39.821273] [016/165] (955s left) gem_ctx_create (basic)
[39.856421] Starting subtest: basic
[39.857505] Subtest basic: SUCCESS (0.000s)
[40.038932] [017/165] (955s left) gem_ctx_create (basic-files)
[40.072676] Starting subtest: basic-files
[42.081552] Subtest basic-files: SUCCESS (2.009s)
[42.265932] [018/165] (953s left) gem_ctx_exec (basic)
[42.299115] Starting subtest: basic
[42.300170] Subtest basic: SUCCESS (0.002s)
[42.399246] [019/165] (952s left) gem_exec_basic (basic)
[42.431815] Starting subtest: basic
[42.432997] Starting dynamic subtest: rcs0-smem
[42.434076] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[42.437646] Starting dynamic subtest: bcs0-smem
[42.438606] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[42.442805] Starting dynamic subtest: vcs0-smem
[42.443815] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[42.447140] Starting dynamic subtest: vecs0-smem
[42.448123] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[42.449169] Subtest basic: SUCCESS (0.003s)
[42.615227] [020/165] (952s left) gem_exec_create (basic)
[42.651184] Starting subtest: basic
[42.652269] Starting dynamic subtest: smem
[44.694339] Dynamic subtest smem: SUCCESS (2.043s)
[44.695567] Subtest basic: SUCCESS (2.043s)
[44.876629] [021/165] (950s left) gem_exec_fence (basic-busy)
[45.022964] Starting subtest: basic-busy
[45.023809] Starting dynamic subtest: rcs0
[45.087071] Dynamic subtest rcs0: SUCCESS (0.065s)
[45.094679] Starting dynamic subtest: bcs0
[45.116031] Dynamic subtest bcs0: SUCCESS (0.029s)
[45.123121] Starting dynamic subtest: vcs0
[45.143095] Dynamic subtest vcs0: SUCCESS (0.027s)
[45.150211] Starting dynamic subtest: vecs0
[45.181900] Dynamic subtest vecs0: SUCCESS (0.039s)
[45.183291] Subtest basic-busy: SUCCESS (0.161s)
[45.623969] [022/165] (949s left) gem_exec_fence (basic-wait)
[45.774097] Starting subtest: basic-wait
[45.775608] Starting dynamic subtest: rcs0
[45.825311] Dynamic subtest rcs0: SUCCESS (0.053s)
[45.833479] Starting dynamic subtest: bcs0
[45.860123] Dynamic subtest bcs0: SUCCESS (0.035s)
[45.866684] Starting dynamic subtest: vcs0
[45.880064] Dynamic subtest vcs0: SUCCESS (0.020s)
[45.887234] Starting dynamic subtest: vecs0
[45.906199] Dynamic subtest vecs0: SUCCESS (0.026s)
[45.907955] Subtest basic-wait: SUCCESS (0.134s)
[46.329685] [023/165] (949s left) gem_exec_fence (basic-await)
[46.479444] Starting subtest: basic-await
[46.480517] Starting dynamic subtest: rcs0
[46.545372] Dynamic subtest rcs0: SUCCESS (0.067s)
[46.552122] Starting dynamic subtest: bcs0
[46.618451] Dynamic subtest bcs0: SUCCESS (0.069s)
[46.622868] Starting dynamic subtest: vcs0
[46.683040] Dynamic subtest vcs0: SUCCESS (0.068s)
[46.690259] Starting dynamic subtest: vecs0
[46.751573] Dynamic subtest vecs0: SUCCESS (0.068s)
[46.753323] Subtest basic-await: SUCCESS (0.274s)
[47.176923] [024/165] (948s left) gem_exec_fence (nb-await)
[47.325453] Starting subtest: nb-await
[47.326382] Starting dynamic subtest: rcs0
[47.379614] Dynamic subtest rcs0: SUCCESS (0.055s)
[47.386122] Starting dynamic subtest: bcs0
[47.437067] Dynamic subtest bcs0: SUCCESS (0.057s)
[47.444520] Starting dynamic subtest: vcs0
[47.495063] Dynamic subtest vcs0: SUCCESS (0.058s)
[47.502063] Starting dynamic subtest: vecs0
[47.552242] Dynamic subtest vecs0: SUCCESS (0.057s)
[47.553785] Subtest nb-await: SUCCESS (0.228s)
[47.977146] [025/165] (947s left) gem_exec_gttfill (basic)
[48.014063] Starting subtest: basic
[50.129264] Subtest basic: SUCCESS (2.115s)
[50.311205] [026/165] (945s left) gem_exec_parallel (engines)
[50.378454] Starting subtest: engines
[50.379707] Starting dynamic subtest: basic
[51.662264] Dynamic subtest basic: SUCCESS (1.284s)
[51.666631] Starting dynamic subtest: contexts
[53.346261] Dynamic subtest contexts: SUCCESS (1.682s)
[53.352611] Starting dynamic subtest: fds
[55.096907] Dynamic subtest fds: SUCCESS (1.752s)
[55.104671] Starting dynamic subtest: userptr
[56.377645] Dynamic subtest userptr: SUCCESS (1.280s)
[56.379281] Subtest engines: SUCCESS (5.999s)
[56.564374] [027/165] (938s left) gem_exec_store (basic)
[56.599359] Starting subtest: basic
[56.663242] Subtest basic: SUCCESS (0.063s)
[56.844069] [028/165] (938s left) gem_flink_basic (bad-flink)
[56.874645] Starting subtest: bad-flink
[56.875673] Subtest bad-flink: SUCCESS (0.000s)
[56.926327] [029/165] (938s left) gem_flink_basic (bad-open)
[56.955666] Starting subtest: bad-open
[56.956847] Subtest bad-open: SUCCESS (0.000s)
[57.010827] [030/165] (938s left) gem_flink_basic (basic)
[57.041750] Starting subtest: basic
[57.043227] Subtest basic: SUCCESS (0.000s)
[57.111512] [031/165] (938s left) gem_flink_basic (double-flink)
[57.142193] Starting subtest: double-flink
[57.143632] Subtest double-flink: SUCCESS (0.000s)
[57.211401] [032/165] (938s left) gem_flink_basic (flink-lifetime)
[57.241694] Starting subtest: flink-lifetime
[57.242802] Subtest flink-lifetime: SUCCESS (0.001s)
[57.328881] [033/165] (938s left) gem_huc_copy (huc-copy)
[57.360704] Starting subtest: huc-copy
[57.363174] Subtest huc-copy: SUCCESS (0.001s)
[57.445197] [034/165] (938s left) gem_linear_blits (basic)
[57.524682] Starting subtest: basic
[57.529284] Subtest basic: SUCCESS (0.005s)
[57.665237] [035/165] (937s left) gem_mmap (basic)
[57.729750] Starting subtest: basic
[57.736839] Subtest basic: SUCCESS (0.000s)
[57.816793] [036/165] (937s left) gem_mmap_gtt (basic)
[57.847679] Starting subtest: basic
[57.848782] Subtest basic: SUCCESS (0.000s)
[57.896291] [037/165] (937s left) gem_render_linear_blits (basic)
[57.930167] Starting subtest: basic
[57.948565] Subtest basic: SUCCESS (0.019s)
[57.996863] [038/165] (937s left) gem_render_tiled_blits (basic)
[58.028605] Starting subtest: basic
[58.044369] Subtest basic: SUCCESS (0.017s)
[58.113639] [039/165] (937s left) gem_ringfill (basic-all)
[58.278063] Starting subtest: basic-all
[59.377884] Subtest basic-all: SUCCESS (1.099s)
[59.468412] [040/165] (936s left) gem_softpin (allocator-basic)
[59.500198] Starting subtest: allocator-basic
[59.547116] Subtest allocator-basic: SUCCESS (0.047s)
[59.635160] [041/165] (935s left) gem_softpin (allocator-basic-reserve)
[59.665241] Starting subtest: allocator-basic-reserve
[59.710686] Subtest allocator-basic-reserve: SUCCESS (0.045s)
[59.801642] [042/165] (935s left) gem_softpin (safe-alignment)
[59.833885] Starting subtest: safe-alignment
[59.839766] Subtest safe-alignment: SUCCESS (0.006s)
[59.934829] [043/165] (935s left) gem_sync (basic-all)
[59.974980] Starting subtest: basic-all
[61.997683] Subtest basic-all: SUCCESS (2.026s)
[62.180828] [044/165] (933s left) gem_sync (basic-each)
[62.220433] Starting subtest: basic-each
[64.283378] Subtest basic-each: SUCCESS (2.066s)
[64.466057] [045/165] (931s left) gem_tiled_blits (basic)
[64.539184] Starting subtest: basic
[64.549441] Subtest basic: SUCCESS (0.010s)
[64.686754] [046/165] (930s left) gem_tiled_fence_blits (basic)
[64.818235] Starting subtest: basic
[64.839565] Subtest basic: SUCCESS (0.021s)
[64.962948] [047/165] (930s left) gem_tiled_pread_basic
[65.058563] [048/165] (930s left) gem_wait (busy@all-engines)
[65.095087] Starting subtest: busy
[65.096396] Starting dynamic subtest: all-engines
[65.637278] Dynamic subtest all-engines: SUCCESS (0.542s)
[65.639267] Subtest busy: SUCCESS (0.542s)
[65.816250] [049/165] (929s left) gem_wait (wait@all-engines)
[65.853083] Starting subtest: wait
[65.854231] Starting dynamic subtest: all-engines
[66.881301] Dynamic subtest all-engines: SUCCESS (1.027s)
[66.883112] Subtest wait: SUCCESS (1.028s)
[67.076675] [050/165] (928s left) i915_getparams_basic (basic-eu-total)
[67.106193] Starting subtest: basic-eu-total
[67.108195] Subtest basic-eu-total: SUCCESS (0.000s)
[67.160851] [051/165] (928s left) i915_getparams_basic (basic-subslice-total)
[67.191846] Starting subtest: basic-subslice-total
[67.194507] Subtest basic-subslice-total: SUCCESS (0.000s)
[67.244824] [052/165] (928s left) i915_hangman (error-state-basic)
[67.279246] Starting subtest: error-state-basic
[67.381191] Subtest error-state-basic: SUCCESS (0.101s)
[67.455703] [053/165] (928s left) i915_pciid
[67.538788] [054/165] (928s left) kms_addfb_basic (addfb25-4-tiled)
[67.581742] Starting subtest: addfb25-4-tiled
[67.582689] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[67.656439] [055/165] (928s left) kms_addfb_basic (addfb25-bad-modifier)
[67.685116] Starting subtest: addfb25-bad-modifier
[67.686279] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[67.773204] [056/165] (928s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[67.801927] Starting subtest: addfb25-framebuffer-vs-set-tiling
[67.802937] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[67.888576] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag)
[67.915435] Starting subtest: addfb25-modifier-no-flag
[67.916633] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[67.989966] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[68.020919] Starting subtest: addfb25-x-tiled-legacy
[68.021973] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[68.106408] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[68.136338] Starting subtest: addfb25-x-tiled-mismatch-legacy
[68.137342] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[68.239782] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[68.281682] Starting subtest: addfb25-yf-tiled-legacy
[68.282919] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[68.356040] [061/165] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[68.396207] Starting subtest: addfb25-y-tiled-legacy
[68.397524] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[68.473837] [062/165] (927s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[68.515627] Starting subtest: addfb25-y-tiled-small-legacy
[68.516756] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[68.589635] [063/165] (927s left) kms_addfb_basic (bad-pitch-0)
[68.618295] Starting subtest: bad-pitch-0
[68.619415] Subtest bad-pitch-0: SUCCESS (0.000s)
[68.706197] [064/165] (927s left) kms_addfb_basic (bad-pitch-1024)
[68.735967] Starting subtest: bad-pitch-1024
[68.736982] Subtest bad-pitch-1024: SUCCESS (0.000s)
[68.807419] [065/165] (927s left) kms_addfb_basic (bad-pitch-128)
[68.835722] Starting subtest: bad-pitch-128
[68.836648] Subtest bad-pitch-128: SUCCESS (0.000s)
[68.937100] [066/165] (926s left) kms_addfb_basic (bad-pitch-256)
[68.968337] Starting subtest: bad-pitch-256
[68.969420] Subtest bad-pitch-256: SUCCESS (0.000s)
[69.057322] [067/165] (926s left) kms_addfb_basic (bad-pitch-32)
[69.084118] Starting subtest: bad-pitch-32
[69.085026] Subtest bad-pitch-32: SUCCESS (0.000s)
[69.189228] [068/165] (926s left) kms_addfb_basic (bad-pitch-63)
[69.220937] Starting subtest: bad-pitch-63
[69.222095] Subtest bad-pitch-63: SUCCESS (0.000s)
[69.290102] [069/165] (926s left) kms_addfb_basic (bad-pitch-65536)
[69.318087] Starting subtest: bad-pitch-65536
[69.319234] Subtest bad-pitch-65536: SUCCESS (0.000s)
[69.406789] [070/165] (926s left) kms_addfb_basic (bad-pitch-999)
[69.436613] Starting subtest: bad-pitch-999
[69.437593] Subtest bad-pitch-999: SUCCESS (0.000s)
[69.523035] [071/165] (926s left) kms_addfb_basic (basic)
[69.551913] Starting subtest: basic
[69.552918] Subtest basic: SUCCESS (0.000s)
[69.641271] [072/165] (926s left) kms_addfb_basic (basic-x-tiled-legacy)
[69.670774] Starting subtest: basic-x-tiled-legacy
[69.671921] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[69.757068] [073/165] (926s left) kms_addfb_basic (basic-y-tiled-legacy)
[69.786947] Starting subtest: basic-y-tiled-legacy
[69.787983] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[69.856452] [074/165] (926s left) kms_addfb_basic (bo-too-small)
[69.896655] Starting subtest: bo-too-small
[69.897725] Subtest bo-too-small: SUCCESS (0.000s)
[69.974370] [075/165] (926s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[70.012653] Starting subtest: bo-too-small-due-to-tiling
[70.013652] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[70.089839] [076/165] (925s left) kms_addfb_basic (clobberred-modifier)
[70.118906] Starting subtest: clobberred-modifier
[70.119983] Subtest clobberred-modifier: SUCCESS (0.000s)
[70.207964] [077/165] (925s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[70.237191] Starting subtest: framebuffer-vs-set-tiling
[70.238501] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.324279] [078/165] (925s left) kms_addfb_basic (invalid-get-prop)
[70.352576] Starting subtest: invalid-get-prop
[70.353636] Subtest invalid-get-prop: SUCCESS (0.000s)
[70.441135] [079/165] (925s left) kms_addfb_basic (invalid-get-prop-any)
[70.474834] Starting subtest: invalid-get-prop-any
[70.475927] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[70.557134] [080/165] (925s left) kms_addfb_basic (invalid-set-prop)
[70.587786] Starting subtest: invalid-set-prop
[70.588691] Subtest invalid-set-prop: SUCCESS (0.000s)
[70.674749] [081/165] (925s left) kms_addfb_basic (invalid-set-prop-any)
[70.704358] Starting subtest: invalid-set-prop-any
[70.705322] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[70.791318] [082/165] (925s left) kms_addfb_basic (no-handle)
[70.819293] Starting subtest: no-handle
[70.820314] Subtest no-handle: SUCCESS (0.000s)
[70.890512] [083/165] (925s left) kms_addfb_basic (size-max)
[70.930682] Starting subtest: size-max
[70.931815] Subtest size-max: SUCCESS (0.000s)
[71.007657] [084/165] (925s left) kms_addfb_basic (small-bo)
[71.046490] Starting subtest: small-bo
[71.047632] Subtest small-bo: SUCCESS (0.000s)
[71.107867] [085/165] (924s left) kms_addfb_basic (tile-pitch-mismatch)
[71.139120] Starting subtest: tile-pitch-mismatch
[71.140120] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[71.224805] [086/165] (924s left) kms_addfb_basic (too-high)
[71.267054] Starting subtest: too-high
[71.268299] Subtest too-high: SUCCESS (0.000s)
[71.325707] [087/165] (924s left) kms_addfb_basic (too-wide)
[71.367279] Starting subtest: too-wide
[71.368452] Subtest too-wide: SUCCESS (0.000s)
[71.441808] [088/165] (924s left) kms_addfb_basic (unused-handle)
[71.473045] Starting subtest: unused-handle
[71.474082] Subtest unused-handle: SUCCESS (0.000s)
[71.575072] [089/165] (924s left) kms_addfb_basic (unused-modifier)
[71.605192] Starting subtest: unused-modifier
[71.606391] Subtest unused-modifier: SUCCESS (0.000s)
[71.676599] [090/165] (924s left) kms_addfb_basic (unused-offsets)
[71.706550] Starting subtest: unused-offsets
[71.707436] Subtest unused-offsets: SUCCESS (0.000s)
[71.791522] [091/165] (924s left) kms_addfb_basic (unused-pitches)
[71.817828] Starting subtest: unused-pitches
[71.819246] Subtest unused-pitches: SUCCESS (0.000s)
[71.908463] [092/165] (924s left) kms_busy (basic)
[71.951363] Starting subtest: basic
[71.952491] Starting dynamic subtest: flip
[72.665960] Dynamic subtest flip: SUCCESS (0.714s)
[72.670841] Starting dynamic subtest: modeset
[76.320286] Dynamic subtest modeset: SUCCESS (3.653s)
[76.321297] Subtest basic: SUCCESS (4.368s)
[77.223742] [093/165] (918s left) kms_prop_blob (basic)
[77.255197] Starting subtest: basic
[77.256545] Subtest basic: SUCCESS (0.000s)
[77.305711] [094/165] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[77.345637] Starting subtest: basic-busy-flip-before-cursor-atomic
[77.348026] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[77.406370] [095/165] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[77.447640] Starting subtest: basic-busy-flip-before-cursor-legacy
[77.449882] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[77.507314] [096/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[77.549393] Starting subtest: basic-flip-after-cursor-atomic
[78.723431] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.174s)
[79.653800] [097/165] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[79.695423] Starting subtest: basic-flip-after-cursor-legacy
[80.868573] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.173s)
[81.766057] [098/165] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[81.806545] Starting subtest: basic-flip-after-cursor-varying-size
[82.985913] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.179s)
[83.899872] [099/165] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[83.941744] Starting subtest: basic-flip-before-cursor-atomic
[85.118438] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.177s)
[86.053954] [100/165] (910s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.095119] Starting subtest: basic-flip-before-cursor-legacy
[87.270320] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.175s)
[88.181267] [101/165] (908s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[88.221569] Starting subtest: basic-flip-before-cursor-varying-size
[89.398051] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.175s)
[90.341918] [102/165] (905s left) kms_dsc (dsc-basic)
[90.384418] Subtest dsc-basic: SKIP (0.000s)
[90.399973] [103/165] (905s left) kms_flip (basic-flip-vs-dpms)
[90.436483] Starting subtest: basic-flip-vs-dpms
[90.437629] Starting dynamic subtest: A-eDP1
[93.152547] Dynamic subtest A-eDP1: SUCCESS (2.716s)
[93.157181] Starting dynamic subtest: B-eDP1
[95.517981] Dynamic subtest B-eDP1: SUCCESS (2.366s)
[95.519030] Subtest basic-flip-vs-dpms: SUCCESS (5.085s)
[96.422099] [104/165] (899s left) kms_flip (basic-flip-vs-modeset)
[96.457923] Starting subtest: basic-flip-vs-modeset
[96.459116] Starting dynamic subtest: A-eDP1
[99.165718] Dynamic subtest A-eDP1: SUCCESS (2.707s)
[99.170208] Starting dynamic subtest: B-eDP1
[101.535471] Dynamic subtest B-eDP1: SUCCESS (2.369s)
[101.536423] Subtest basic-flip-vs-modeset: SUCCESS (5.080s)
[102.437164] [105/165] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[102.473144] Starting subtest: basic-flip-vs-wf_vblank
[102.474450] Starting dynamic subtest: A-eDP1
[104.998483] Dynamic subtest A-eDP1: SUCCESS (2.524s)
[105.005817] Starting dynamic subtest: B-eDP1
[107.547289] Dynamic subtest B-eDP1: SUCCESS (2.547s)
[107.553203] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.081s)
[108.772492] [106/165] (887s left) kms_flip (basic-plain-flip)
[108.807443] Starting subtest: basic-plain-flip
[108.808533] Starting dynamic subtest: A-eDP1
[111.038385] Dynamic subtest A-eDP1: SUCCESS (2.229s)
[111.046384] Starting dynamic subtest: B-eDP1
[113.280105] Dynamic subtest B-eDP1: SUCCESS (2.240s)
[113.283774] Subtest basic-plain-flip: SUCCESS (4.477s)
[114.531172] [107/165] (881s left) kms_force_connector_basic (force-connector-state)
[114.565162] Starting subtest: force-connector-state
[114.963890] Subtest force-connector-state: SUCCESS (0.399s)
[116.139993] [108/165] (880s left) kms_force_connector_basic (force-edid)
[116.171101] Starting subtest: force-edid
[116.191083] Subtest force-edid: SUCCESS (0.021s)
[116.289447] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[116.318826] Starting subtest: force-load-detect
[116.320715] Subtest force-load-detect: SKIP (0.000s)
[116.406347] [110/165] (879s left) kms_force_connector_basic (prune-stale-modes)
[116.437259] Starting subtest: prune-stale-modes
[116.455946] Subtest prune-stale-modes: SUCCESS (0.019s)
[116.573628] [111/165] (879s left) kms_frontbuffer_tracking (basic)
[116.616206] Starting subtest: basic
[119.277693] Subtest basic: SUCCESS (2.662s)
[119.374422] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[119.693716] Starting subtest: inject-audio
[119.789480] Subtest inject-audio: SUCCESS (0.095s)
[120.595382] [113/165] (875s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[120.635491] Starting subtest: compare-crc-sanitycheck-xr24
[120.636510] Starting dynamic subtest: pipe-A-eDP-1
[121.229179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[121.233909] Starting dynamic subtest: pipe-B-eDP-1
[122.630601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[122.631662] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.995s)
[123.555853] [114/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[123.597273] Starting subtest: compare-crc-sanitycheck-nv12
[123.598579] Starting dynamic subtest: pipe-A-eDP-1
[124.256523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.658s)
[124.261188] Starting dynamic subtest: pipe-B-eDP-1
[125.636136] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[125.637261] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.039s)
[126.565374] [115/165] (869s left) kms_pipe_crc_basic (hang-read-crc)
[126.606061] Starting subtest: hang-read-crc
[126.607088] Starting dynamic subtest: pipe-A-eDP-1
[128.769703] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.163s)
[128.774680] Starting dynamic subtest: pipe-B-eDP-1
[131.735721] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.965s)
[131.736691] Subtest hang-read-crc: SUCCESS (5.130s)
[132.644104] [116/165] (863s left) kms_pipe_crc_basic (nonblocking-crc)
[132.686580] Starting subtest: nonblocking-crc
[132.687894] Starting dynamic subtest: pipe-A-eDP-1
[133.462531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s)
[133.468293] Starting dynamic subtest: pipe-B-eDP-1
[135.005982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[135.007025] Subtest nonblocking-crc: SUCCESS (2.320s)
[135.907370] [117/165] (860s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[135.951365] Starting subtest: nonblocking-crc-frame-sequence
[135.952498] Starting dynamic subtest: pipe-A-eDP-1
[136.725401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.772s)
[136.730083] Starting dynamic subtest: pipe-B-eDP-1
[138.270214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.544s)
[138.271175] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.319s)
[139.171647] [118/165] (857s left) kms_pipe_crc_basic (read-crc)
[139.212708] Starting subtest: read-crc
[139.213848] Starting dynamic subtest: pipe-A-eDP-1
[139.923425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[139.928374] Starting dynamic subtest: pipe-B-eDP-1
[141.403574] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[141.404640] Subtest read-crc: SUCCESS (2.192s)
[142.309752] [119/165] (854s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[142.351286] Starting subtest: read-crc-frame-sequence
[142.352509] Starting dynamic subtest: pipe-A-eDP-1
[143.060155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[143.065242] Starting dynamic subtest: pipe-B-eDP-1
[144.537971] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[144.539026] Subtest read-crc-frame-sequence: SUCCESS (2.187s)
[145.444165] [120/165] (851s left) kms_pm_backlight (basic-brightness)
[145.488361] Starting subtest: basic-brightness
[145.514470] Starting dynamic subtest: eDP-1
[145.811448] Dynamic subtest eDP-1: SUCCESS (0.297s)
[145.812533] Subtest basic-brightness: SUCCESS (0.323s)
[146.725983] [121/165] (849s left) kms_pm_rpm (basic-pci-d3-state)
[148.398196] Starting subtest: basic-pci-d3-state
[152.794967] Subtest basic-pci-d3-state: SUCCESS (4.397s)
[152.953987] [122/165] (843s left) kms_pm_rpm (basic-rte)
[152.983709] Starting subtest: basic-rte
[159.003845] Subtest basic-rte: SUCCESS (6.019s)
[164.333358] [123/165] (832s left) kms_psr (primary_page_flip)
[164.376533] Starting subtest: primary_page_flip
[166.284062] Subtest primary_page_flip: SUCCESS (1.908s)
[167.205437] [124/165] (829s left) kms_psr (cursor_plane_move)
[167.249020] Starting subtest: cursor_plane_move
[169.145201] Subtest cursor_plane_move: SUCCESS (1.895s)
[170.085932] [125/165] (826s left) kms_psr (sprite_plane_onoff)
[170.128304] Starting subtest: sprite_plane_onoff
[172.106753] Subtest sprite_plane_onoff: SUCCESS (1.979s)
[173.028161] [126/165] (823s left) kms_psr (primary_mmap_gtt)
[173.068855] Starting subtest: primary_mmap_gtt
[174.989861] Subtest primary_mmap_gtt: SUCCESS (1.921s)
[175.910557] [127/165] (820s left) kms_setmode (basic-clone-single-crtc)
[175.941933] Starting subtest: basic-clone-single-crtc
[175.946143] Subtest basic-clone-single-crtc: SKIP (0.000s)
[175.993063] [128/165] (820s left) i915_pm_rps (basic-api)
[176.024744] Starting subtest: basic-api
[176.027153] Subtest basic-api: SUCCESS (0.002s)
[176.092272] [129/165] (820s left) prime_self_import (basic-llseek-bad)
[176.121060] Starting subtest: basic-llseek-bad
[176.123195] Subtest basic-llseek-bad: SUCCESS (0.001s)
[176.192905] [130/165] (820s left) prime_self_import (basic-llseek-size)
[176.221651] Starting subtest: basic-llseek-size
[176.223891] Subtest basic-llseek-size: SUCCESS (0.001s)
[176.293300] [131/165] (820s left) prime_self_import (basic-with_fd_dup)
[176.322123] Starting subtest: basic-with_fd_dup
[176.323819] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[176.392339] [132/165] (820s left) prime_self_import (basic-with_one_bo)
[176.421453] Starting subtest: basic-with_one_bo
[176.423234] Subtest basic-with_one_bo: SUCCESS (0.002s)
[176.473826] [133/165] (820s left) prime_self_import (basic-with_one_bo_two_files)
[176.503645] Starting subtest: basic-with_one_bo_two_files
[176.505819] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[176.577079] [134/165] (820s left) prime_self_import (basic-with_two_bos)
[176.605111] Starting subtest: basic-with_two_bos
[176.607644] Subtest basic-with_two_bos: SUCCESS (0.002s)
[176.676631] [135/165] (819s left) prime_vgem (basic-fence-flip)
[176.717609] Starting subtest: basic-fence-flip
[177.044599] Subtest basic-fence-flip: SUCCESS (0.327s)
[177.127083] [136/165] (819s left) prime_vgem (basic-fence-mmap)
[177.164964] Starting subtest: basic-fence-mmap
[177.181064] Subtest basic-fence-mmap: SUCCESS (0.017s)
[177.260094] [137/165] (819s left) prime_vgem (basic-fence-read)
[177.301684] Starting subtest: basic-fence-read
[177.306178] Subtest basic-fence-read: SKIP (0.003s)
[177.377324] [138/165] (819s left) prime_vgem (basic-gtt)
[177.415009] Starting subtest: basic-gtt
[177.423124] Subtest basic-gtt: SUCCESS (0.008s)
[177.512032] [139/165] (819s left) prime_vgem (basic-read)
[177.548881] Starting subtest: basic-read
[177.552838] Subtest basic-read: SKIP (0.003s)
[177.628917] [140/165] (819s left) prime_vgem (basic-write)
[177.665329] Starting subtest: basic-write
[177.669306] Subtest basic-write: SKIP (0.003s)
[177.761489] [141/165] (818s left) vgem_basic (setversion)
[177.796582] Starting subtest: setversion
[177.799066] Subtest setversion: SUCCESS (0.000s)
[177.844377] [142/165] (818s left) vgem_basic (create)
[177.880213] Starting subtest: create
[177.881917] Subtest create: SUCCESS (0.000s)
[177.926650] [143/165] (818s left) vgem_basic (debugfs)
[177.964519] Starting subtest: debugfs
[177.965877] Subtest debugfs: SUCCESS (0.001s)
[178.011967] [144/165] (818s left) vgem_basic (dmabuf-export)
[178.047237] Starting subtest: dmabuf-export
[178.050069] Subtest dmabuf-export: SUCCESS (0.002s)
[178.127203] [145/165] (818s left) vgem_basic (dmabuf-fence)
[178.163528] Starting subtest: dmabuf-fence
[178.164694] Subtest dmabuf-fence: SUCCESS (0.001s)
[178.210363] [146/165] (818s left) vgem_basic (dmabuf-fence-before)
[178.246426] Starting subtest: dmabuf-fence-before
[178.247649] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[178.294977] [147/165] (818s left) vgem_basic (dmabuf-mmap)
[178.329686] Starting subtest: dmabuf-mmap
[178.336013] Subtest dmabuf-mmap: SUCCESS (0.007s)
[178.377320] [148/165] (818s left) vgem_basic (mmap)
[178.414125] Starting subtest: mmap
[178.418440] Subtest mmap: SUCCESS (0.006s)
[178.470593] [149/165] (818s left) vgem_basic (second-client)
[178.514319] Starting subtest: second-client
[178.547840] Subtest second-client: SUCCESS (0.033s)
[178.593671] [150/165] (818s left) vgem_basic (sysfs)
[178.631140] Starting subtest: sysfs
[178.632525] Subtest sysfs: SUCCESS (0.001s)
[178.677932] [151/165] (818s left) core_hotunplug (unbind-rebind)
[178.730043] Starting subtest: unbind-rebind
[182.726661] Subtest unbind-rebind: SUCCESS (3.996s)
[182.741784] [152/165] (814s left) vgem_basic (unload)
[182.773575] Starting subtest: unload
[211.626709] Subtest unload: SUCCESS (28.850s)
[211.711539] [153/165] (785s left) i915_module_load (reload)
[211.741187] Starting subtest: reload
[214.180071] Subtest reload: SUCCESS (2.439s)
[214.190207] [154/165] (782s left) gem_lmem_swapping (basic)
[214.226692] Subtest basic: SKIP (0.000s)
[214.258493] [155/165] (782s left) gem_lmem_swapping (parallel-random-engines)
[214.289608] Subtest parallel-random-engines: SKIP (0.000s)
[214.303634] [156/165] (782s left) gem_lmem_swapping (random-engines)
[214.334336] Subtest random-engines: SKIP (0.000s)
[214.357698] [157/165] (782s left) gem_lmem_swapping (verify-random)
[214.389186] Subtest verify-random: SKIP (0.000s)
[214.402591] [158/165] (782s left) i915_pm_rpm (module-reload)
[216.845230] Starting subtest: module-reload
[227.112623] Subtest module-reload: SUCCESS (10.266s)
[227.122363] [159/165] (769s left) i915_selftest (live)
[227.155874] Starting subtest: live
[227.156940] Starting dynamic subtest: sanitycheck
[228.518874] Dynamic subtest sanitycheck: SUCCESS (1.360s)
[228.523289] Starting dynamic subtest: uncore
[229.927902] Dynamic subtest uncore: SUCCESS (1.407s)
[229.932835] Starting dynamic subtest: workarounds
[231.523753] Dynamic subtest workarounds: SUCCESS (1.594s)
[231.528191] Starting dynamic subtest: gt_engines
[233.328818] Dynamic subtest gt_engines: SUCCESS (1.803s)
[233.333293] Starting dynamic subtest: gt_timelines
[238.815126] Dynamic subtest gt_timelines: SUCCESS (5.485s)
[238.819840] Starting dynamic subtest: gt_contexts
[240.294785] Dynamic subtest gt_contexts: SUCCESS (1.478s)
[240.299252] Starting dynamic subtest: gt_lrc
[243.960993] Dynamic subtest gt_lrc: SUCCESS (3.665s)
[243.965294] Starting dynamic subtest: gt_mocs
[245.426098] Dynamic subtest gt_mocs: SUCCESS (1.464s)
[245.430410] Starting dynamic subtest: gt_pm
[258.997977] Dynamic subtest gt_pm: SUCCESS (13.570s)
[259.002236] Starting dynamic subtest: gt_heartbeat
[260.470758] Dynamic subtest gt_heartbeat: SUCCESS (1.471s)
[260.475233] Starting dynamic subtest: gt_tlb
[262.950721] Dynamic subtest gt_tlb: SUCCESS (2.479s)
[262.955060] Starting dynamic subtest: requests
[269.854966] Dynamic subtest requests: SUCCESS (6.903s)
[269.859877] Starting dynamic subtest: migrate
[274.053893] Dynamic subtest migrate: SUCCESS (4.197s)
[274.058436] Starting dynamic subtest: active
[275.446068] Dynamic subtest active: SUCCESS (1.390s)
[275.450659] Starting dynamic subtest: objects
[277.426994] Dynamic subtest objects: SUCCESS (1.979s)
[277.431547] Starting dynamic subtest: mman
[281.824818] Dynamic subtest mman: SUCCESS (4.396s)
[281.829152] Starting dynamic subtest: dmabuf
[283.264731] Dynamic subtest dmabuf: SUCCESS (1.438s)
[283.269333] Starting dynamic subtest: vma
[284.651903] Dynamic subtest vma: SUCCESS (1.385s)
[284.656344] Starting dynamic subtest: coherency
[286.692065] Dynamic subtest coherency: SUCCESS (2.039s)
[286.696439] Starting dynamic subtest: gtt
[294.943857] Dynamic subtest gtt: SUCCESS (8.250s)
[294.948161] Starting dynamic subtest: gem
[296.442849] Dynamic subtest gem: SUCCESS (1.497s)
[296.447368] Starting dynamic subtest: evict
[298.347039] Dynamic subtest evict: SUCCESS (1.902s)
[298.351534] Starting dynamic subtest: hugepages
[305.546837] Dynamic subtest hugepages: SUCCESS (7.199s)
[305.551076] Starting dynamic subtest: gem_contexts
[317.148064] Dynamic subtest gem_contexts: SUCCESS (11.599s)
[317.152633] Starting dynamic subtest: client
[318.570799] Dynamic subtest client: SUCCESS (1.422s)
[318.575303] Starting dynamic subtest: gem_migrate
[319.927049] Dynamic subtest gem_migrate: SUCCESS (1.354s)
[319.931610] Starting dynamic subtest: reset
[324.186975] Dynamic subtest reset: SUCCESS (4.259s)
[324.191701] Starting dynamic subtest: memory_region
[325.560978] Dynamic subtest memory_region: SUCCESS (1.372s)
[325.565334] Starting dynamic subtest: hangcheck
[349.452180] Dynamic subtest hangcheck: SUCCESS (23.890s)
[349.456565] Starting dynamic subtest: execlists
[357.532140] Dynamic subtest execlists: SUCCESS (8.078s)
[357.536670] Starting dynamic subtest: ring_submission
[358.903947] Dynamic subtest ring_submission: SUCCESS (1.371s)
[358.908292] Starting dynamic subtest: perf
[360.296138] Dynamic subtest perf: SUCCESS (1.390s)
[360.300905] Starting dynamic subtest: slpc
[361.640868] Dynamic subtest slpc: SUCCESS (1.343s)
[361.645300] Starting dynamic subtest: guc
[362.998129] Dynamic subtest guc: SUCCESS (1.356s)
[363.002566] Starting dynamic subtest: guc_multi_lrc
[364.390749] Dynamic subtest guc_multi_lrc: SUCCESS (1.391s)
[364.395310] Starting dynamic subtest: guc_hang
[365.730032] Dynamic subtest guc_hang: SUCCESS (1.338s)
[365.734297] Starting dynamic subtest: late_gt_pm
[367.149818] Dynamic subtest late_gt_pm: SUCCESS (1.418s)
[367.151340] Subtest live: SUCCESS (139.992s)
[367.161744] [160/165] (629s left) dmabuf (all-tests)
[367.194539] Starting subtest: all-tests
[367.195914] Starting dynamic subtest: sanitycheck
[367.255328] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[367.261932] Starting dynamic subtest: dma_fence
[367.428131] Dynamic subtest dma_fence: SUCCESS (0.171s)
[367.433991] Starting dynamic subtest: dma_fence_chain
[377.012340] Dynamic subtest dma_fence_chain: SUCCESS (9.581s)
[377.017279] Starting dynamic subtest: dma_fence_unwrap
[377.076037] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[377.083080] Starting dynamic subtest: dma_resv
[377.140075] Dynamic subtest dma_resv: SUCCESS (0.062s)
[377.141701] Subtest all-tests: SUCCESS (9.946s)
[377.153019] [161/165] (619s left) i915_suspend (basic-s2idle-without-i915)
[377.182525] Starting subtest: basic-s2idle-without-i915
[396.489134] Subtest basic-s2idle-without-i915: SUCCESS (3.488s)
[396.776815] [162/165] (615s left) i915_suspend (basic-s3-without-i915)
[396.816252] Starting subtest: basic-s3-without-i915
[416.821905] Subtest basic-s3-without-i915: SUCCESS (2.781s)
[416.841364] [163/165] (613s left) gem_exec_suspend (basic-s0)
[416.881371] Starting subtest: basic-S0
[416.882756] Starting dynamic subtest: smem
[434.578023] Dynamic subtest smem: SUCCESS (1.824s)
[434.579239] Subtest basic-S0: SUCCESS (1.825s)
[434.728209] [164/165] (611s left) gem_exec_suspend (basic-s3)
[434.762625] Starting subtest: basic-S3
[434.763805] Starting dynamic subtest: smem
[453.631206] Dynamic subtest smem: SUCCESS (1.860s)
[453.632152] Subtest basic-S3: SUCCESS (1.861s)
[453.781490] [165/165] (609s left) kms_pipe_crc_basic (suspend-read-crc)
[453.823146] Starting subtest: suspend-read-crc
[453.824467] Starting dynamic subtest: pipe-A-eDP-1
[474.064338] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.239s)
[474.069978] Starting dynamic subtest: pipe-B-eDP-1
[495.071389] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.031s)
[495.072585] Subtest suspend-read-crc: SUCCESS (5.272s)
[495.938677] Closing watchdogs
Done.