[34.036716] Initializing watchdogs
[34.036838]   /dev/watchdog0
[34.043972] [001/165] (960s left) i915_module_load (load)
[34.136485] Starting subtest: load
[35.648929] Subtest load: SUCCESS (1.513s)
[35.669433] [002/165] (958s left) core_auth (basic-auth)
[35.757726] Starting subtest: basic-auth
[35.759132] Subtest basic-auth: SUCCESS (0.001s)
[35.825195] [003/165] (958s left) debugfs_test (read_all_entries)
[35.915169] Starting subtest: read_all_entries
[35.969572] Subtest read_all_entries: SUCCESS (0.053s)
[36.104753] [004/165] (958s left) debugfs_test (basic-hwmon)
[36.293793] Starting subtest: basic-hwmon
[36.297819] Subtest basic-hwmon: SKIP (0.000s)
[36.394355] [005/165] (958s left) fbdev (eof)
[36.487139] Starting subtest: eof
[36.489744] Subtest eof: SUCCESS (0.001s)
[36.543621] [006/165] (958s left) fbdev (info)
[36.623988] Starting subtest: info
[36.625113] Subtest info: SUCCESS (0.000s)
[36.697950] [007/165] (958s left) fbdev (nullptr)
[36.788262] Starting subtest: nullptr
[36.789873] Subtest nullptr: SUCCESS (0.000s)
[36.846302] [008/165] (957s left) fbdev (read)
[36.937767] Starting subtest: read
[37.170221] Subtest read: SUCCESS (0.232s)
[37.229190] [009/165] (957s left) fbdev (write)
[37.322382] Starting subtest: write
[37.443896] Subtest write: SUCCESS (0.118s)
[37.498162] [010/165] (957s left) gem_basic (bad-close)
[37.584217] Starting subtest: bad-close
[37.586313] Subtest bad-close: SUCCESS (0.000s)
[37.647108] [011/165] (957s left) gem_basic (create-close)
[37.731190] Starting subtest: create-close
[37.733685] Subtest create-close: SUCCESS (0.000s)
[37.797274] [012/165] (957s left) gem_basic (create-fd-close)
[37.882777] Starting subtest: create-fd-close
[37.885398] Subtest create-fd-close: SUCCESS (0.000s)
[37.949399] [013/165] (956s left) gem_busy (busy@all-engines)
[38.056780] Starting subtest: busy
[38.058135] Starting dynamic subtest: all-engines
[38.084207] Dynamic subtest all-engines: SUCCESS (0.027s)
[38.086532] Subtest busy: SUCCESS (0.028s)
[38.401496] [014/165] (956s left) gem_close_race (basic-process)
[38.500837] Starting subtest: basic-process
[38.547444] Subtest basic-process: SUCCESS (0.047s)
[38.736213] [015/165] (956s left) gem_close_race (basic-threads)
[38.836133] Starting subtest: basic-threads
[40.041676] Subtest basic-threads: SUCCESS (1.206s)
[40.240460] [016/165] (954s left) gem_ctx_create (basic)
[40.406321] Subtest basic: SKIP (0.000s)
[40.458899] [017/165] (954s left) gem_ctx_create (basic-files)
[40.559600] Subtest basic-files: SKIP (0.000s)
[40.592123] [018/165] (954s left) gem_ctx_exec (basic)
[40.698651] Subtest basic: SKIP (0.000s)
[40.742653] [019/165] (954s left) gem_exec_basic (basic)
[40.851270] Starting subtest: basic
[40.852405] Starting dynamic subtest: rcs0-smem
[40.853488] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[40.856646] Subtest basic: SUCCESS (0.001s)
[41.026159] [020/165] (953s left) gem_exec_create (basic)
[41.119599] Starting subtest: basic
[41.120993] Starting dynamic subtest: smem
[43.156424] Dynamic subtest smem: SUCCESS (2.036s)
[43.157560] Subtest basic: SUCCESS (2.037s)
[43.335536] [021/165] (951s left) gem_exec_fence (basic-busy)
[43.557650] Starting subtest: basic-busy
[43.558832] Starting dynamic subtest: rcs0
[43.574199] Dynamic subtest rcs0: SUCCESS (0.018s)
[43.575322] Subtest basic-busy: SUCCESS (0.019s)
[44.055040] [022/165] (950s left) gem_exec_fence (basic-wait)
[44.277280] Starting subtest: basic-wait
[44.278312] Starting dynamic subtest: rcs0
[44.289324] Dynamic subtest rcs0: SUCCESS (0.013s)
[44.290376] Subtest basic-wait: SUCCESS (0.014s)
[44.740030] [023/165] (950s left) gem_exec_fence (basic-await)
[44.962443] Starting subtest: basic-await
[44.963522] Starting dynamic subtest: rcs0
[45.024155] Dynamic subtest rcs0: SUCCESS (0.062s)
[45.025171] Subtest basic-await: SUCCESS (0.062s)
[45.475130] [024/165] (949s left) gem_exec_fence (nb-await)
[45.695852] Starting subtest: nb-await
[45.696985] Starting dynamic subtest: rcs0
[45.748099] Dynamic subtest rcs0: SUCCESS (0.053s)
[45.749203] Subtest nb-await: SUCCESS (0.053s)
[46.195645] [025/165] (948s left) gem_exec_gttfill (basic)
[46.293926] Starting subtest: basic
[49.497729] Subtest basic: SUCCESS (3.203s)
[49.678939] [026/165] (945s left) gem_exec_parallel (engines)
[49.893117] Starting subtest: engines
[49.894258] Starting dynamic subtest: basic
[51.541673] Dynamic subtest basic: SUCCESS (1.648s)
[51.552577] Starting dynamic subtest: contexts
[51.558117] Dynamic subtest contexts: SKIP (0.001s)
[51.566702] Starting dynamic subtest: fds
[51.568813] Dynamic subtest fds: SKIP (0.001s)
[51.576945] Starting dynamic subtest: userptr
[53.226035] Dynamic subtest userptr: SUCCESS (1.684s)
[53.228165] Subtest engines: SUCCESS (3.334s)
[53.403317] [027/165] (941s left) gem_exec_store (basic)
[53.501489] Starting subtest: basic
[53.517551] Subtest basic: SUCCESS (0.017s)
[53.703740] [028/165] (941s left) gem_flink_basic (bad-flink)
[53.790059] Starting subtest: bad-flink
[53.791187] Subtest bad-flink: SUCCESS (0.000s)
[53.855792] [029/165] (941s left) gem_flink_basic (bad-open)
[53.941685] Starting subtest: bad-open
[53.942733] Subtest bad-open: SUCCESS (0.000s)
[54.007882] [030/165] (941s left) gem_flink_basic (basic)
[54.092403] Starting subtest: basic
[54.093499] Subtest basic: SUCCESS (0.000s)
[54.173041] [031/165] (941s left) gem_flink_basic (double-flink)
[54.258262] Starting subtest: double-flink
[54.259349] Subtest double-flink: SUCCESS (0.000s)
[54.338580] [032/165] (940s left) gem_flink_basic (flink-lifetime)
[54.426530] Starting subtest: flink-lifetime
[54.427454] Subtest flink-lifetime: SUCCESS (0.001s)
[54.490613] [033/165] (940s left) gem_huc_copy (huc-copy)
[54.578849] Subtest huc-copy: SKIP (0.000s)
[54.608396] [034/165] (940s left) gem_linear_blits (basic)
[54.993152] Starting subtest: basic
[55.006852] Subtest basic: SUCCESS (0.012s)
[55.128111] [035/165] (940s left) gem_mmap (basic)
[55.336652] Starting subtest: basic
[55.341952] Subtest basic: SUCCESS (0.000s)
[55.409509] [036/165] (939s left) gem_mmap_gtt (basic)
[55.497070] Starting subtest: basic
[55.498194] Subtest basic: SUCCESS (0.001s)
[55.544997] [037/165] (939s left) gem_render_linear_blits (basic)
[55.632351] Starting subtest: basic
[55.680687] Subtest basic: SUCCESS (0.048s)
[55.712828] [038/165] (939s left) gem_render_tiled_blits (basic)
[55.799457] Starting subtest: basic
[55.842462] Subtest basic: SUCCESS (0.041s)
[55.879505] [039/165] (939s left) gem_ringfill (basic-all)
[55.994573] Starting subtest: basic-all
[57.105092] Subtest basic-all: SUCCESS (1.106s)
[57.180179] [040/165] (938s left) gem_softpin (allocator-basic)
[57.267325] Subtest allocator-basic: SKIP (0.000s)
[57.332553] [041/165] (938s left) gem_softpin (allocator-basic-reserve)
[57.419969] Subtest allocator-basic-reserve: SKIP (0.000s)
[57.484107] [042/165] (937s left) gem_softpin (safe-alignment)
[57.573561] Starting subtest: safe-alignment
[57.577061] Subtest safe-alignment: SUCCESS (0.007s)
[57.650219] [043/165] (937s left) gem_sync (basic-all)
[57.749806] Starting subtest: basic-all
[59.863128] Subtest basic-all: SUCCESS (2.114s)
[60.043449] [044/165] (935s left) gem_sync (basic-each)
[60.143050] Starting subtest: basic-each
[62.206985] Subtest basic-each: SUCCESS (2.066s)
[62.383531] [045/165] (933s left) gem_tiled_blits (basic)
[62.712348] Starting subtest: basic
[62.732458] Subtest basic: SUCCESS (0.021s)
[62.835390] [046/165] (932s left) gem_tiled_fence_blits (basic)
[63.295406] Starting subtest: basic
[63.309631] Subtest basic: SUCCESS (0.013s)
[63.421247] [047/165] (932s left) gem_tiled_pread_basic
[63.890043] [048/165] (931s left) gem_wait (busy@all-engines)
[63.997225] Starting subtest: busy
[63.998366] Starting dynamic subtest: all-engines
[64.507642] Dynamic subtest all-engines: SUCCESS (0.510s)
[64.509230] Subtest busy: SUCCESS (0.510s)
[64.726322] [049/165] (930s left) gem_wait (wait@all-engines)
[64.831113] Starting subtest: wait
[64.832257] Starting dynamic subtest: all-engines
[65.846377] Dynamic subtest all-engines: SUCCESS (1.013s)
[65.847370] Subtest wait: SUCCESS (1.013s)
[66.046212] [050/165] (929s left) i915_getparams_basic (basic-eu-total)
[66.130303] Starting subtest: basic-eu-total
[66.132416] Subtest basic-eu-total: SUCCESS (0.000s)
[66.197180] [051/165] (929s left) i915_getparams_basic (basic-subslice-total)
[66.280222] Starting subtest: basic-subslice-total
[66.282455] Subtest basic-subslice-total: SUCCESS (0.000s)
[66.347440] [052/165] (929s left) i915_hangman (error-state-basic)
[66.437340] Starting subtest: error-state-basic
[66.546781] Subtest error-state-basic: SUCCESS (0.107s)
[66.600741] [053/165] (929s left) i915_pciid
[66.747793] [054/165] (928s left) kms_addfb_basic (addfb25-4-tiled)
[66.874853] Starting subtest: addfb25-4-tiled
[66.876162] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[66.949204] [055/165] (928s left) kms_addfb_basic (addfb25-bad-modifier)
[67.036811] Starting subtest: addfb25-bad-modifier
[67.037957] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[67.134417] [056/165] (928s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[67.221560] Starting subtest: addfb25-framebuffer-vs-set-tiling
[67.222994] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[67.331398] [057/165] (928s left) kms_addfb_basic (addfb25-modifier-no-flag)
[67.418236] Starting subtest: addfb25-modifier-no-flag
[67.419420] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[67.518641] [058/165] (928s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[67.604778] Starting subtest: addfb25-x-tiled-legacy
[67.605847] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[67.701243] [059/165] (928s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[67.784876] Starting subtest: addfb25-x-tiled-mismatch-legacy
[67.786785] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[67.886238] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[67.993233] Starting subtest: addfb25-yf-tiled-legacy
[67.994390] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[68.069375] [061/165] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[68.180367] Starting subtest: addfb25-y-tiled-legacy
[68.181467] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[68.255169] [062/165] (927s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[68.360238] Starting subtest: addfb25-y-tiled-small-legacy
[68.362522] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[68.439189] [063/165] (927s left) kms_addfb_basic (bad-pitch-0)
[68.527716] Starting subtest: bad-pitch-0
[68.528843] Subtest bad-pitch-0: SUCCESS (0.000s)
[68.639656] [064/165] (927s left) kms_addfb_basic (bad-pitch-1024)
[68.728942] Starting subtest: bad-pitch-1024
[68.730161] Subtest bad-pitch-1024: SUCCESS (0.000s)
[68.840237] [065/165] (927s left) kms_addfb_basic (bad-pitch-128)
[68.926528] Starting subtest: bad-pitch-128
[68.927669] Subtest bad-pitch-128: SUCCESS (0.000s)
[69.040370] [066/165] (926s left) kms_addfb_basic (bad-pitch-256)
[69.128303] Starting subtest: bad-pitch-256
[69.129661] Subtest bad-pitch-256: SUCCESS (0.000s)
[69.240445] [067/165] (926s left) kms_addfb_basic (bad-pitch-32)
[69.327153] Starting subtest: bad-pitch-32
[69.328323] Subtest bad-pitch-32: SUCCESS (0.000s)
[69.425246] [068/165] (926s left) kms_addfb_basic (bad-pitch-63)
[69.512757] Starting subtest: bad-pitch-63
[69.513848] Subtest bad-pitch-63: SUCCESS (0.000s)
[69.626294] [069/165] (926s left) kms_addfb_basic (bad-pitch-65536)
[69.718900] Starting subtest: bad-pitch-65536
[69.724235] Subtest bad-pitch-65536: SUCCESS (0.000s)
[69.828679] [070/165] (926s left) kms_addfb_basic (bad-pitch-999)
[69.915645] Starting subtest: bad-pitch-999
[69.916758] Subtest bad-pitch-999: SUCCESS (0.000s)
[70.026566] [071/165] (926s left) kms_addfb_basic (basic)
[70.112151] Starting subtest: basic
[70.113236] Subtest basic: SUCCESS (0.000s)
[70.210902] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy)
[70.296838] Starting subtest: basic-x-tiled-legacy
[70.298060] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[70.411572] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy)
[70.493869] Starting subtest: basic-y-tiled-legacy
[70.496554] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[70.596330] [074/165] (925s left) kms_addfb_basic (bo-too-small)
[70.719912] Starting subtest: bo-too-small
[70.720974] Subtest bo-too-small: SUCCESS (0.000s)
[70.798670] [075/165] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[70.920139] Starting subtest: bo-too-small-due-to-tiling
[70.921328] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[70.997390] [076/165] (925s left) kms_addfb_basic (clobberred-modifier)
[71.083603] Starting subtest: clobberred-modifier
[71.084699] Subtest clobberred-modifier: SUCCESS (0.000s)
[71.197642] [077/165] (925s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[71.283054] Starting subtest: framebuffer-vs-set-tiling
[71.285739] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.397357] [078/165] (924s left) kms_addfb_basic (invalid-get-prop)
[71.482989] Starting subtest: invalid-get-prop
[71.485775] Subtest invalid-get-prop: SUCCESS (0.000s)
[71.582334] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any)
[71.667943] Starting subtest: invalid-get-prop-any
[71.672433] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[71.784276] [080/165] (924s left) kms_addfb_basic (invalid-set-prop)
[71.875255] Starting subtest: invalid-set-prop
[71.876366] Subtest invalid-set-prop: SUCCESS (0.000s)
[71.984192] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any)
[72.068606] Starting subtest: invalid-set-prop-any
[72.069714] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[72.168251] [082/165] (924s left) kms_addfb_basic (no-handle)
[72.255142] Starting subtest: no-handle
[72.256303] Subtest no-handle: SUCCESS (0.000s)
[72.353352] [083/165] (924s left) kms_addfb_basic (size-max)
[72.477349] Starting subtest: size-max
[72.478547] Subtest size-max: SUCCESS (0.000s)
[72.552845] [084/165] (923s left) kms_addfb_basic (small-bo)
[72.656717] Starting subtest: small-bo
[72.658573] Subtest small-bo: SUCCESS (0.000s)
[72.736261] [085/165] (923s left) kms_addfb_basic (tile-pitch-mismatch)
[72.821304] Starting subtest: tile-pitch-mismatch
[72.822375] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[72.919839] [086/165] (923s left) kms_addfb_basic (too-high)
[73.027822] Starting subtest: too-high
[73.028971] Subtest too-high: SUCCESS (0.001s)
[73.105185] [087/165] (923s left) kms_addfb_basic (too-wide)
[73.229809] Starting subtest: too-wide
[73.231434] Subtest too-wide: SUCCESS (0.000s)
[73.304263] [088/165] (923s left) kms_addfb_basic (unused-handle)
[73.388883] Starting subtest: unused-handle
[73.389960] Subtest unused-handle: SUCCESS (0.000s)
[73.507400] [089/165] (923s left) kms_addfb_basic (unused-modifier)
[73.592848] Starting subtest: unused-modifier
[73.593926] Subtest unused-modifier: SUCCESS (0.000s)
[73.706199] [090/165] (922s left) kms_addfb_basic (unused-offsets)
[73.795250] Starting subtest: unused-offsets
[73.796340] Subtest unused-offsets: SUCCESS (0.000s)
[73.891389] [091/165] (922s left) kms_addfb_basic (unused-pitches)
[73.976760] Starting subtest: unused-pitches
[73.977841] Subtest unused-pitches: SUCCESS (0.000s)
[74.091822] [092/165] (922s left) kms_busy (basic)
[74.215071] Starting subtest: basic
[74.216300] Starting dynamic subtest: flip
[74.820145] Dynamic subtest flip: SUCCESS (0.602s)
[74.831816] Starting dynamic subtest: modeset
[74.833881] Dynamic subtest modeset: SKIP (0.000s)
[74.834959] Subtest basic: SUCCESS (0.605s)
[74.923199] [093/165] (921s left) kms_prop_blob (basic)
[75.012953] Starting subtest: basic
[75.014113] Subtest basic: SUCCESS (0.000s)
[75.088873] [094/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[75.193686] Starting subtest: basic-busy-flip-before-cursor-atomic
[75.198169] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[75.271912] [095/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[75.381932] Starting subtest: basic-busy-flip-before-cursor-legacy
[76.384717] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.003s)
[76.496378] [096/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[76.600053] Starting subtest: basic-flip-after-cursor-atomic
[76.602775] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[76.680662] [097/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[76.805979] Starting subtest: basic-flip-after-cursor-legacy
[77.802752] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.998s)
[77.921590] [098/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[78.042776] Starting subtest: basic-flip-after-cursor-varying-size
[79.046056] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.003s)
[79.166134] [099/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[79.288906] Starting subtest: basic-flip-before-cursor-atomic
[79.293090] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[79.364808] [100/165] (917s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[79.488925] Starting subtest: basic-flip-before-cursor-legacy
[80.489561] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.001s)
[80.607887] [101/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[80.711249] Starting subtest: basic-flip-before-cursor-varying-size
[81.715255] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.003s)
[81.834844] [102/165] (914s left) kms_dsc (dsc-basic)
[81.963868] Subtest dsc-basic: SKIP (0.000s)
[82.003717] [103/165] (914s left) kms_flip (basic-flip-vs-dpms)
[82.128623] Starting subtest: basic-flip-vs-dpms
[82.129773] Starting dynamic subtest: A-VGA1
[83.417145] Dynamic subtest A-VGA1: SUCCESS (1.289s)
[83.425520] Starting dynamic subtest: B-VGA1
[84.659787] Dynamic subtest B-VGA1: SUCCESS (1.241s)
[84.660862] Subtest basic-flip-vs-dpms: SUCCESS (2.531s)
[84.802999] [104/165] (912s left) kms_flip (basic-flip-vs-modeset)
[84.931821] Starting subtest: basic-flip-vs-modeset
[84.932916] Starting dynamic subtest: A-VGA1
[86.184951] Dynamic subtest A-VGA1: SUCCESS (1.254s)
[86.194112] Starting dynamic subtest: B-VGA1
[87.348179] Dynamic subtest B-VGA1: SUCCESS (1.161s)
[87.350730] Subtest basic-flip-vs-modeset: SUCCESS (2.419s)
[87.488359] [105/165] (909s left) kms_flip (basic-flip-vs-wf_vblank)
[87.610990] Starting subtest: basic-flip-vs-wf_vblank
[87.612127] Starting dynamic subtest: A-VGA1
[89.148912] Dynamic subtest A-VGA1: SUCCESS (1.537s)
[89.167487] Starting dynamic subtest: B-VGA1
[90.654042] Dynamic subtest B-VGA1: SUCCESS (1.501s)
[90.655145] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.040s)
[90.823526] [106/165] (906s left) kms_flip (basic-plain-flip)
[90.945542] Starting subtest: basic-plain-flip
[90.946616] Starting dynamic subtest: A-VGA1
[92.200814] Dynamic subtest A-VGA1: SUCCESS (1.253s)
[92.217769] Starting dynamic subtest: B-VGA1
[93.413259] Dynamic subtest B-VGA1: SUCCESS (1.210s)
[93.414413] Subtest basic-plain-flip: SUCCESS (2.465s)
[93.567477] [107/165] (903s left) kms_force_connector_basic (force-connector-state)
[93.706151] Starting subtest: force-connector-state
[93.853302] Subtest force-connector-state: SUCCESS (0.148s)
[94.116638] [108/165] (902s left) kms_force_connector_basic (force-edid)
[94.253386] Starting subtest: force-edid
[94.339161] Subtest force-edid: SUCCESS (0.084s)
[94.468062] [109/165] (902s left) kms_force_connector_basic (force-load-detect)
[94.606010] Starting subtest: force-load-detect
[94.761626] Subtest force-load-detect: SUCCESS (0.155s)
[94.962843] [110/165] (902s left) kms_force_connector_basic (prune-stale-modes)
[95.119803] Starting subtest: prune-stale-modes
[95.201915] Subtest prune-stale-modes: SUCCESS (0.083s)
[95.332426] [111/165] (901s left) kms_frontbuffer_tracking (basic)
[95.458283] Subtest basic: SKIP (0.000s)
[95.499148] [112/165] (901s left) kms_hdmi_inject (inject-audio)
[95.586898] Subtest inject-audio: SKIP (0.000s)
[95.617372] [113/165] (901s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[95.723987] Starting subtest: compare-crc-sanitycheck-xr24
[95.726583] Starting dynamic subtest: pipe-A-VGA-1
[96.016026] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.285s)
[96.034901] Starting dynamic subtest: pipe-B-VGA-1
[96.324855] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.311s)
[96.325911] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.598s)
[96.448605] [114/165] (900s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[96.554751] Starting subtest: compare-crc-sanitycheck-nv12
[96.555938] Starting dynamic subtest: pipe-A-VGA-1
[96.558515] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[96.568188] Starting dynamic subtest: pipe-B-VGA-1
[96.571127] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[96.573248] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[96.631212] [115/165] (900s left) kms_pipe_crc_basic (hang-read-crc)
[96.738825] Starting subtest: hang-read-crc
[96.739914] Starting dynamic subtest: pipe-A-VGA-1
[97.569724] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.831s)
[97.582132] Starting dynamic subtest: pipe-B-VGA-1
[98.416075] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.845s)
[98.417732] Subtest hang-read-crc: SUCCESS (1.678s)
[98.530746] [116/165] (898s left) kms_pipe_crc_basic (nonblocking-crc)
[98.654899] Starting subtest: nonblocking-crc
[98.656048] Starting dynamic subtest: pipe-A-VGA-1
[99.115808] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.461s)
[99.125700] Starting dynamic subtest: pipe-B-VGA-1
[99.579142] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.463s)
[99.581209] Subtest nonblocking-crc: SUCCESS (0.927s)
[99.690996] [117/165] (897s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[99.797611] Starting subtest: nonblocking-crc-frame-sequence
[99.800603] Starting dynamic subtest: pipe-A-VGA-1
[100.263741] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.466s)
[100.272915] Starting dynamic subtest: pipe-B-VGA-1
[100.739490] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.475s)
[100.742215] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.943s)
[100.879750] [118/165] (896s left) kms_pipe_crc_basic (read-crc)
[101.022057] Starting subtest: read-crc
[101.023983] Starting dynamic subtest: pipe-A-VGA-1
[101.469642] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.448s)
[101.484516] Starting dynamic subtest: pipe-B-VGA-1
[101.895763] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.423s)
[101.897949] Subtest read-crc: SUCCESS (0.873s)
[102.008785] [119/165] (895s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[102.117028] Starting subtest: read-crc-frame-sequence
[102.119570] Starting dynamic subtest: pipe-A-VGA-1
[102.516311] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.399s)
[102.525357] Starting dynamic subtest: pipe-B-VGA-1
[102.922956] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.405s)
[102.926921] Subtest read-crc-frame-sequence: SUCCESS (0.807s)
[103.023762] [120/165] (894s left) kms_pm_backlight (basic-brightness)
[103.149719] Subtest basic-brightness: SKIP (0.000s)
[103.190586] [121/165] (894s left) kms_pm_rpm (basic-pci-d3-state)
[114.451973] Subtest basic-pci-d3-state: SKIP (0.000s)
[114.480793] [122/165] (882s left) kms_pm_rpm (basic-rte)
[114.563422] Starting subtest: basic-rte
[125.737825] Subtest basic-rte: SKIP (11.161s)
[125.775293] [123/165] (871s left) kms_psr (psr-primary-page-flip)
[125.892197] Subtest psr-primary-page-flip: SKIP (0.000s)
[125.935462] [124/165] (871s left) kms_psr (psr-cursor-plane-move)
[126.058612] Subtest psr-cursor-plane-move: SKIP (0.000s)
[126.104605] [125/165] (871s left) kms_psr (psr-sprite-plane-onoff)
[126.228469] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[126.269778] [126/165] (871s left) kms_psr (psr-primary-mmap-gtt)
[126.377600] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[126.404367] [127/165] (870s left) kms_setmode (basic-clone-single-crtc)
[126.493951] Starting subtest: basic-clone-single-crtc
[126.497202] Subtest basic-clone-single-crtc: SKIP (0.000s)
[126.572080] [128/165] (870s left) i915_pm_rps (basic-api)
[126.659655] Subtest basic-api: SKIP (0.000s)
[126.689285] [129/165] (870s left) prime_self_import (basic-llseek-bad)
[126.772944] Starting subtest: basic-llseek-bad
[126.775279] Subtest basic-llseek-bad: SUCCESS (0.003s)
[126.854212] [130/165] (870s left) prime_self_import (basic-llseek-size)
[126.939186] Starting subtest: basic-llseek-size
[126.941433] Subtest basic-llseek-size: SUCCESS (0.003s)
[127.021885] [131/165] (870s left) prime_self_import (basic-with_fd_dup)
[127.103610] Starting subtest: basic-with_fd_dup
[127.106131] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[127.174372] [132/165] (870s left) prime_self_import (basic-with_one_bo)
[127.258151] Starting subtest: basic-with_one_bo
[127.263853] Subtest basic-with_one_bo: SUCCESS (0.005s)
[127.343316] [133/165] (870s left) prime_self_import (basic-with_one_bo_two_files)
[127.428794] Starting subtest: basic-with_one_bo_two_files
[127.430928] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[127.508619] [134/165] (870s left) prime_self_import (basic-with_two_bos)
[127.591156] Starting subtest: basic-with_two_bos
[127.593341] Subtest basic-with_two_bos: SUCCESS (0.003s)
[127.675275] [135/165] (869s left) prime_vgem (basic-fence-flip)
[127.770815] Starting subtest: basic-fence-flip
[128.168996] Subtest basic-fence-flip: SUCCESS (0.399s)
[128.244422] [136/165] (869s left) prime_vgem (basic-fence-mmap)
[128.337311] Starting subtest: basic-fence-mmap
[128.379441] Subtest basic-fence-mmap: SUCCESS (0.042s)
[128.462169] [137/165] (869s left) prime_vgem (basic-fence-read)
[128.556935] Starting subtest: basic-fence-read
[128.621118] Subtest basic-fence-read: SUCCESS (0.065s)
[128.695868] [138/165] (868s left) prime_vgem (basic-gtt)
[128.789818] Starting subtest: basic-gtt
[128.808057] Subtest basic-gtt: SUCCESS (0.019s)
[128.894640] [139/165] (868s left) prime_vgem (basic-read)
[128.991205] Starting subtest: basic-read
[129.019807] Subtest basic-read: SUCCESS (0.031s)
[129.096275] [140/165] (868s left) prime_vgem (basic-write)
[129.190990] Starting subtest: basic-write
[129.222794] Subtest basic-write: SUCCESS (0.033s)
[129.297521] [141/165] (868s left) vgem_basic (setversion)
[129.388297] Starting subtest: setversion
[129.390585] Subtest setversion: SUCCESS (0.000s)
[129.447880] [142/165] (868s left) vgem_basic (create)
[129.538675] Starting subtest: create
[129.539806] Subtest create: SUCCESS (0.000s)
[129.598470] [143/165] (868s left) vgem_basic (debugfs)
[129.690928] Starting subtest: debugfs
[129.692110] Subtest debugfs: SUCCESS (0.001s)
[129.748402] [144/165] (868s left) vgem_basic (dmabuf-export)
[129.841164] Starting subtest: dmabuf-export
[129.843447] Subtest dmabuf-export: SUCCESS (0.003s)
[129.914837] [145/165] (867s left) vgem_basic (dmabuf-fence)
[130.007190] Starting subtest: dmabuf-fence
[130.008311] Subtest dmabuf-fence: SUCCESS (0.001s)
[130.065855] [146/165] (867s left) vgem_basic (dmabuf-fence-before)
[130.157952] Starting subtest: dmabuf-fence-before
[130.159129] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[130.215769] [147/165] (867s left) vgem_basic (dmabuf-mmap)
[130.308039] Starting subtest: dmabuf-mmap
[130.329045] Subtest dmabuf-mmap: SUCCESS (0.022s)
[130.382466] [148/165] (867s left) vgem_basic (mmap)
[130.474281] Starting subtest: mmap
[130.487984] Subtest mmap: SUCCESS (0.015s)
[130.551439] [149/165] (867s left) vgem_basic (second-client)
[130.641642] Starting subtest: second-client
[130.675886] Subtest second-client: SUCCESS (0.033s)
[130.734688] [150/165] (867s left) vgem_basic (sysfs)
[130.827697] Starting subtest: sysfs
[130.828921] Subtest sysfs: SUCCESS (0.001s)
[130.886229] [151/165] (867s left) core_hotunplug (unbind-rebind)
[131.025181] Starting subtest: unbind-rebind
[133.740787] Subtest unbind-rebind: SUCCESS (2.715s)
[133.768756] [152/165] (864s left) vgem_basic (unload)
[133.856048] Starting subtest: unload
[162.718648] Subtest unload: SUCCESS (28.862s)
[162.817567] [153/165] (835s left) i915_module_load (reload)
[162.901238] Starting subtest: reload
[164.673832] Subtest reload: SUCCESS (1.771s)
[164.693675] [154/165] (833s left) gem_lmem_swapping (basic)
[164.789947] Subtest basic: SKIP (0.000s)
[164.815631] [155/165] (833s left) gem_lmem_swapping (parallel-random-engines)
[164.905267] Subtest parallel-random-engines: SKIP (0.000s)
[164.932018] [156/165] (833s left) gem_lmem_swapping (random-engines)
[165.034990] Subtest random-engines: SKIP (0.000s)
[165.084086] [157/165] (832s left) gem_lmem_swapping (verify-random)
[165.217028] Subtest verify-random: SKIP (0.000s)
[165.250660] [158/165] (832s left) i915_pm_rpm (module-reload)
[176.530242] Subtest module-reload: SKIP (0.000s)
[176.562418] [159/165] (821s left) i915_selftest (live)
[177.143059] Starting subtest: live
[177.144137] Starting dynamic subtest: sanitycheck
[177.812128] Dynamic subtest sanitycheck: SUCCESS (0.666s)
[177.822023] Starting dynamic subtest: uncore
[178.425049] Dynamic subtest uncore: SUCCESS (0.613s)
[178.434370] Starting dynamic subtest: workarounds
[179.037942] Dynamic subtest workarounds: SUCCESS (0.613s)
[179.047252] Starting dynamic subtest: gt_engines
[179.662932] Dynamic subtest gt_engines: SUCCESS (0.624s)
[179.672301] Starting dynamic subtest: gt_timelines
[182.551106] Dynamic subtest gt_timelines: SUCCESS (2.887s)
[182.560482] Starting dynamic subtest: gt_contexts
[183.193184] Dynamic subtest gt_contexts: SUCCESS (0.641s)
[183.201774] Starting dynamic subtest: gt_lrc
[183.867151] Dynamic subtest gt_lrc: SUCCESS (0.673s)
[183.875836] Starting dynamic subtest: gt_mocs
[184.482030] Dynamic subtest gt_mocs: SUCCESS (0.614s)
[184.490942] Starting dynamic subtest: gt_pm
[185.593285] Dynamic subtest gt_pm: SUCCESS (1.110s)
[185.602346] Starting dynamic subtest: gt_heartbeat
[186.230199] Dynamic subtest gt_heartbeat: SUCCESS (0.636s)
[186.240251] Starting dynamic subtest: gt_tlb
[186.856034] Dynamic subtest gt_tlb: SUCCESS (0.625s)
[186.865887] Starting dynamic subtest: requests
[190.064865] Dynamic subtest requests: SUCCESS (3.208s)
[190.074096] Starting dynamic subtest: migrate
[190.679161] Dynamic subtest migrate: SUCCESS (0.613s)
[190.689065] Starting dynamic subtest: active
[191.312151] Dynamic subtest active: SUCCESS (0.632s)
[191.321611] Starting dynamic subtest: objects
[192.248195] Dynamic subtest objects: SUCCESS (0.933s)
[192.257564] Starting dynamic subtest: mman
[197.166131] Dynamic subtest mman: SUCCESS (4.919s)
[197.174410] Starting dynamic subtest: dmabuf
[197.849828] Dynamic subtest dmabuf: SUCCESS (0.683s)
[197.858909] Starting dynamic subtest: vma
[198.482155] Dynamic subtest vma: SUCCESS (0.631s)
[198.491966] Starting dynamic subtest: coherency
[200.248302] Dynamic subtest coherency: SUCCESS (1.765s)
[200.257667] Starting dynamic subtest: gtt
[204.501276] Dynamic subtest gtt: SUCCESS (4.252s)
[204.510781] Starting dynamic subtest: gem
[205.151136] Dynamic subtest gem: SUCCESS (0.649s)
[205.160339] Starting dynamic subtest: evict
[205.772138] Dynamic subtest evict: SUCCESS (0.620s)
[205.781742] Starting dynamic subtest: hugepages
[206.401332] Dynamic subtest hugepages: SUCCESS (0.628s)
[206.410615] Starting dynamic subtest: gem_contexts
[207.032341] Dynamic subtest gem_contexts: SUCCESS (0.630s)
[207.041288] Starting dynamic subtest: client
[207.633862] Dynamic subtest client: SUCCESS (0.600s)
[207.642406] Starting dynamic subtest: gem_migrate
[208.264205] Dynamic subtest gem_migrate: SUCCESS (0.628s)
[208.273122] Starting dynamic subtest: reset
[209.224256] Dynamic subtest reset: SUCCESS (0.961s)
[209.233258] Starting dynamic subtest: memory_region
[209.861162] Dynamic subtest memory_region: SUCCESS (0.634s)
[209.870421] Starting dynamic subtest: hangcheck
[211.509094] Dynamic subtest hangcheck: SUCCESS (1.648s)
[211.518130] Starting dynamic subtest: execlists
[212.136284] Dynamic subtest execlists: SUCCESS (0.626s)
[212.145932] Starting dynamic subtest: ring_submission
[212.760128] Dynamic subtest ring_submission: SUCCESS (0.623s)
[212.769929] Starting dynamic subtest: perf
[213.384237] Dynamic subtest perf: SUCCESS (0.621s)
[213.393722] Starting dynamic subtest: slpc
[214.003185] Dynamic subtest slpc: SUCCESS (0.619s)
[214.012103] Starting dynamic subtest: guc
[214.640338] Dynamic subtest guc: SUCCESS (0.636s)
[214.649640] Starting dynamic subtest: guc_multi_lrc
[215.258194] Dynamic subtest guc_multi_lrc: SUCCESS (0.617s)
[215.267756] Starting dynamic subtest: guc_hang
[215.873312] Dynamic subtest guc_hang: SUCCESS (0.614s)
[215.882941] Starting dynamic subtest: late_gt_pm
[216.495170] Dynamic subtest late_gt_pm: SUCCESS (0.621s)
[216.496256] Subtest live: SUCCESS (39.352s)
[216.518707] [160/165] (781s left) dmabuf (all-tests)
[216.613729] Starting subtest: all-tests
[216.614812] Starting dynamic subtest: sanitycheck
[216.668701] Dynamic subtest sanitycheck: SUCCESS (0.058s)
[216.677848] Starting dynamic subtest: dma_fence
[216.840356] Dynamic subtest dma_fence: SUCCESS (0.173s)
[216.852657] Starting dynamic subtest: dma_fence_chain
[234.543304] Dynamic subtest dma_fence_chain: SUCCESS (17.701s)
[234.553753] Starting dynamic subtest: dma_fence_unwrap
[234.603149] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s)
[234.615903] Starting dynamic subtest: dma_resv
[234.660235] Dynamic subtest dma_resv: SUCCESS (0.054s)
[234.661364] Subtest all-tests: SUCCESS (18.051s)
[234.681328] [161/165] (763s left) i915_suspend (basic-s2idle-without-i915)
[234.765836] Starting subtest: basic-s2idle-without-i915
[253.257259] Subtest basic-s2idle-without-i915: SUCCESS (18.491s)
[256.302205] [162/165] (744s left) i915_suspend (basic-s3-without-i915)
[256.391107] Starting subtest: basic-s3-without-i915
[272.945367] Subtest basic-s3-without-i915: SUCCESS (1.837s)
[276.024092] [163/165] (742s left) gem_exec_suspend (basic-s0)
[276.128704] Starting subtest: basic-S0
[276.132450] Starting dynamic subtest: smem
[292.887963] Dynamic subtest smem: SUCCESS (16.757s)
[292.889169] Subtest basic-S0: SUCCESS (16.759s)
[299.089463] [164/165] (725s left) gem_exec_suspend (basic-s3)
[299.194242] Starting subtest: basic-S3
[299.195405] Starting dynamic subtest: smem
[316.803739] Dynamic subtest smem: SUCCESS (1.785s)
[316.804866] Subtest basic-S3: SUCCESS (1.786s)
[321.985237] [165/165] (723s left) kms_pipe_crc_basic (suspend-read-crc)
[322.105455] Starting subtest: suspend-read-crc
[322.106840] Starting dynamic subtest: pipe-A-VGA-1
[339.867626] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.636s)
[339.879421] Starting dynamic subtest: pipe-B-VGA-1
[357.841233] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.613s)
[357.843825] Subtest suspend-read-crc: SUCCESS (3.253s)
[363.956309] Closing watchdogs
Done.